builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1452880873.44 results: success (0) buildid: 20160115073123 builduid: 57cfa3be1f394d90be356b87c613d90d revision: 02398f2be72b9bbf5ee79348b73ef122c915aae0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.443296) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.443656) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.443957) ========= 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=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006566 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.466491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.466767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.479875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.480127) ========= 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=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.529051) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.529327) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.529672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.529933) ========= 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=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 10:01:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-15 10:01:13 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169201 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.710849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.711117) ========= 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=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022888 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.764377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 10:01:13.764720) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 02398f2be72b9bbf5ee79348b73ef122c915aae0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 02398f2be72b9bbf5ee79348b73ef122c915aae0 --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=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 10:01:14,092 truncating revision to first 12 chars 2016-01-15 10:01:14,093 Setting DEBUG logging. 2016-01-15 10:01:14,093 attempt 1/10 2016-01-15 10:01:14,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/02398f2be72b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 10:01:14,924 unpacking tar archive at: mozilla-central-02398f2be72b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.138555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 10:01:14.919153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:14.919555) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004724 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:14.969513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:14.969865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:14.987662) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:14.988032) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:14.988478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-15 10:01:14.988769) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:15 INFO - MultiFileLogger online at 20160115 10:01:15 in /builds/slave/test-pgo 10:01:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:01:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:01:15 INFO - {'append_to_log': False, 10:01:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:01:15 INFO - 'blob_upload_branch': 'Firefox', 10:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:01:15 INFO - 'branch': 'Firefox', 10:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:15 INFO - 'config_files': ('talos/linux_config.py',), 10:01:15 INFO - 'default_actions': ('clobber', 10:01:15 INFO - 'read-buildbot-config', 10:01:15 INFO - 'download-and-extract', 10:01:15 INFO - 'populate-webroot', 10:01:15 INFO - 'create-virtualenv', 10:01:15 INFO - 'install', 10:01:15 INFO - 'run-tests'), 10:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:15 INFO - 'download_minidump_stackwalk': True, 10:01:15 INFO - 'download_symbols': 'ondemand', 10:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:15 INFO - 'installer_path': 'installer.exe', 10:01:15 INFO - 'log_level': 'info', 10:01:15 INFO - 'log_name': 'talos', 10:01:15 INFO - 'log_to_console': True, 10:01:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:15 INFO - 'opt_config_files': (), 10:01:15 INFO - 'pip_index': False, 10:01:15 INFO - 'sps_profile': False, 10:01:15 INFO - 'sps_profile_interval': 0, 10:01:15 INFO - 'suite': 'dromaeojs', 10:01:15 INFO - 'system_bits': '32', 10:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:15 INFO - 'title': 'talos-linux64-ix-028', 10:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:15 INFO - 'use_talos_json': True, 10:01:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:15 INFO - 'work_dir': 'build'} 10:01:15 INFO - ##### 10:01:15 INFO - ##### Running clobber step. 10:01:15 INFO - ##### 10:01:15 INFO - Running pre-action listener: _resource_record_pre_action 10:01:15 INFO - Running main action method: clobber 10:01:15 INFO - rmtree: /builds/slave/test-pgo/build 10:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:01:16 INFO - Running post-action listener: _resource_record_post_action 10:01:16 INFO - ##### 10:01:16 INFO - ##### Running read-buildbot-config step. 10:01:16 INFO - ##### 10:01:16 INFO - Running pre-action listener: _resource_record_pre_action 10:01:16 INFO - Running main action method: read_buildbot_config 10:01:16 INFO - Using buildbot properties: 10:01:16 INFO - { 10:01:16 INFO - "project": "", 10:01:16 INFO - "product": "firefox", 10:01:16 INFO - "script_repo_revision": "production", 10:01:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:01:16 INFO - "repository": "", 10:01:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:01:16 INFO - "buildid": "20160115073123", 10:01:16 INFO - "pgo_build": "True", 10:01:16 INFO - "basedir": "/builds/slave/test-pgo", 10:01:16 INFO - "buildnumber": 306, 10:01:16 INFO - "slavename": "talos-linux64-ix-028", 10:01:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:01:16 INFO - "platform": "ubuntu64_hw", 10:01:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:01:16 INFO - "branch": "mozilla-central", 10:01:16 INFO - "repo_path": "mozilla-central", 10:01:16 INFO - "revision": "02398f2be72b9bbf5ee79348b73ef122c915aae0", 10:01:16 INFO - "stage_platform": "linux64-pgo", 10:01:16 INFO - "builduid": "57cfa3be1f394d90be356b87c613d90d", 10:01:16 INFO - "slavebuilddir": "test" 10:01:16 INFO - } 10:01:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:01:16 INFO - Running post-action listener: _resource_record_post_action 10:01:16 INFO - ##### 10:01:16 INFO - ##### Running download-and-extract step. 10:01:16 INFO - ##### 10:01:16 INFO - Running pre-action listener: _resource_record_pre_action 10:01:16 INFO - Running main action method: download_and_extract 10:01:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:16 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json 10:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json 10:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:01:18 INFO - Downloaded 1448 bytes. 10:01:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:01:18 INFO - Using the following test package requirements: 10:01:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:18 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:01:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'jsshell-linux-x86_64.zip'], 10:01:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:18 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:20 INFO - Downloaded 22440718 bytes. 10:01:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:01:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:01:21 INFO - Return code: 0 10:01:21 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 10:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:21 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:26 INFO - Downloaded 22440718 bytes. 10:01:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:01:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:01:27 INFO - Return code: 0 10:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:27 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:29 INFO - Downloaded 11132144 bytes. 10:01:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:01:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:01:30 INFO - Return code: 0 10:01: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')]} 10:01:30 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:32 INFO - Downloaded 55929998 bytes. 10:01:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:32 INFO - mkdir: /builds/slave/test-pgo/properties 10:01:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:01:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:01:32 INFO - Contents: 10:01:32 INFO - build_url:https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:32 INFO - Running post-action listener: _resource_record_post_action 10:01:32 INFO - Running post-action listener: set_extra_try_arguments 10:01:32 INFO - ##### 10:01:32 INFO - ##### Running populate-webroot step. 10:01:32 INFO - ##### 10:01:32 INFO - Running pre-action listener: _resource_record_pre_action 10:01:32 INFO - Running main action method: populate_webroot 10:01:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:32 INFO - '--tppagecycles', 10:01:32 INFO - '7'], 10:01:32 INFO - 'tests': ['tsvgm']}}, 10:01:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:01:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'tests': ['damp', 'tps']}, 10:01:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['damp', 'tps']}, 10:01:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:01:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:32 INFO - 'other': {'tests': ['a11yr', 10:01:32 INFO - 'ts_paint', 10:01:32 INFO - 'tpaint', 10:01:32 INFO - 'sessionrestore', 10:01:32 INFO - 'sessionrestore_no_auto_restore']}, 10:01:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['a11yr', 10:01:32 INFO - 'ts_paint', 10:01:32 INFO - 'tpaint', 10:01:32 INFO - 'sessionrestore', 10:01:32 INFO - 'sessionrestore_no_auto_restore']}, 10:01:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['a11yr', 10:01:32 INFO - 'ts_paint', 10:01:32 INFO - 'tpaint', 10:01:32 INFO - 'sessionrestore', 10:01:32 INFO - 'sessionrestore_no_auto_restore']}, 10:01:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['a11yr', 10:01:32 INFO - 'ts_paint', 10:01:32 INFO - 'tpaint', 10:01:32 INFO - 'sessionrestore', 10:01:32 INFO - 'sessionrestore_no_auto_restore']}, 10:01:32 INFO - 'other_l64': {'tests': ['a11yr', 10:01:32 INFO - 'ts_paint', 10:01:32 INFO - 'tpaint', 10:01:32 INFO - 'sessionrestore', 10:01:32 INFO - 'sessionrestore_no_auto_restore']}, 10:01:32 INFO - 'other_nol64': {'tests': ['a11yr', 10:01:32 INFO - 'ts_paint', 10:01:32 INFO - 'tpaint', 10:01:32 INFO - 'sessionrestore', 10:01:32 INFO - 'sessionrestore_no_auto_restore']}, 10:01:32 INFO - 'svgr': {'tests': ['tsvgx', 10:01:32 INFO - 'tsvgr_opacity', 10:01:32 INFO - 'tart', 10:01:32 INFO - 'tscrollx', 10:01:32 INFO - 'cart']}, 10:01:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['tsvgx', 10:01:32 INFO - 'tsvgr_opacity', 10:01:32 INFO - 'tart', 10:01:32 INFO - 'tscrollx', 10:01:32 INFO - 'cart']}, 10:01:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'tests': ['tp5o']}, 10:01:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'talos_options': ['--e10s'], 10:01:32 INFO - 'tests': ['tp5o']}, 10:01:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'talos_options': ['--xperf_path', 10:01:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:32 INFO - 'tests': ['tp5n']}, 10:01:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:32 INFO - 'talos_options': ['--e10s', 10:01:32 INFO - '--xperf_path', 10:01:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:32 INFO - 'tests': ['tp5n']}}, 10:01:32 INFO - 'talos.zip': {'path': '', 10:01:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:32 INFO - Running post-action listener: _resource_record_post_action 10:01:32 INFO - ##### 10:01:32 INFO - ##### Running create-virtualenv step. 10:01:32 INFO - ##### 10:01:32 INFO - Running pre-action listener: _resource_record_pre_action 10:01:32 INFO - Running main action method: create_virtualenv 10:01:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:01:32 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 10:01:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:01:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:33 INFO - Using real prefix '/usr' 10:01:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:01:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:35 INFO - Installing pip.................done. 10:01:35 INFO - Return code: 0 10:01:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:01: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')]} 10:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:35 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:35 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 10:01:35 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 10:01:35 INFO - Using env: {'DISPLAY': ':0', 10:01:35 INFO - 'HOME': '/home/cltbld', 10:01:35 INFO - 'LANG': 'en_US.UTF-8', 10:01:35 INFO - 'LANGUAGE': 'en_US:en', 10:01:35 INFO - 'LOGNAME': 'cltbld', 10:01:35 INFO - 'MAIL': '/var/mail/cltbld', 10:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:35 INFO - 'MOZ_NO_REMOTE': '1', 10:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:35 INFO - 'NO_EM_RESTART': '1', 10:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:35 INFO - 'SHELL': '/bin/bash', 10:01:35 INFO - 'SHLVL': '1', 10:01:35 INFO - 'TERM': 'linux', 10:01:35 INFO - 'TMOUT': '86400', 10:01:35 INFO - 'USER': 'cltbld', 10:01:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:35 INFO - '_': '/tools/buildbot/bin/python'} 10:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:35 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 10:01:35 INFO - Cleaning up... 10:01:35 INFO - Return code: 0 10:01:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:01: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')]} 10:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:35 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:35 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 10:01:35 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 10:01:35 INFO - Using env: {'DISPLAY': ':0', 10:01:35 INFO - 'HOME': '/home/cltbld', 10:01:35 INFO - 'LANG': 'en_US.UTF-8', 10:01:35 INFO - 'LANGUAGE': 'en_US:en', 10:01:35 INFO - 'LOGNAME': 'cltbld', 10:01:35 INFO - 'MAIL': '/var/mail/cltbld', 10:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:35 INFO - 'MOZ_NO_REMOTE': '1', 10:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:35 INFO - 'NO_EM_RESTART': '1', 10:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:35 INFO - 'SHELL': '/bin/bash', 10:01:35 INFO - 'SHLVL': '1', 10:01:35 INFO - 'TERM': 'linux', 10:01:35 INFO - 'TMOUT': '86400', 10:01:35 INFO - 'USER': 'cltbld', 10:01:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:35 INFO - '_': '/tools/buildbot/bin/python'} 10:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:35 INFO - Downloading/unpacking psutil>=0.7.1 10:01:35 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 10:01:35 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 10:01:35 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 10:01:35 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 10:01:35 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 10:01:35 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 10:01:37 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:01:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:01:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:37 INFO - Installing collected packages: psutil 10:01:37 INFO - Running setup.py install for psutil 10:01:37 INFO - building 'psutil._psutil_linux' extension 10:01:37 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 10:01:38 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 10:01:38 INFO - building 'psutil._psutil_posix' extension 10:01:38 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 10:01:38 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 10:01:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:38 INFO - Successfully installed psutil 10:01:38 INFO - Cleaning up... 10:01:38 INFO - Return code: 0 10:01:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:01: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')]} 10:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:38 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:38 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 10:01:38 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 10:01:38 INFO - Using env: {'DISPLAY': ':0', 10:01:38 INFO - 'HOME': '/home/cltbld', 10:01:38 INFO - 'LANG': 'en_US.UTF-8', 10:01:38 INFO - 'LANGUAGE': 'en_US:en', 10:01:38 INFO - 'LOGNAME': 'cltbld', 10:01:38 INFO - 'MAIL': '/var/mail/cltbld', 10:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:38 INFO - 'MOZ_NO_REMOTE': '1', 10:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:38 INFO - 'NO_EM_RESTART': '1', 10:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:38 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:38 INFO - 'SHELL': '/bin/bash', 10:01:38 INFO - 'SHLVL': '1', 10:01:38 INFO - 'TERM': 'linux', 10:01:38 INFO - 'TMOUT': '86400', 10:01:38 INFO - 'USER': 'cltbld', 10:01:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:38 INFO - '_': '/tools/buildbot/bin/python'} 10:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:01:38 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 10:01:38 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 10:01:38 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 10:01:38 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 10:01:38 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 10:01:38 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 10:01:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:01:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:01:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:01:40 INFO - Installing collected packages: mozsystemmonitor 10:01:40 INFO - Running setup.py install for mozsystemmonitor 10:01:40 INFO - Successfully installed mozsystemmonitor 10:01:40 INFO - Cleaning up... 10:01:40 INFO - Return code: 0 10:01:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:01:40 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')]} 10:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:40 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')]} 10:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:40 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:40 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 10:01:40 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 10:01:40 INFO - Using env: {'DISPLAY': ':0', 10:01:40 INFO - 'HOME': '/home/cltbld', 10:01:40 INFO - 'LANG': 'en_US.UTF-8', 10:01:40 INFO - 'LANGUAGE': 'en_US:en', 10:01:40 INFO - 'LOGNAME': 'cltbld', 10:01:40 INFO - 'MAIL': '/var/mail/cltbld', 10:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:40 INFO - 'MOZ_NO_REMOTE': '1', 10:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:40 INFO - 'NO_EM_RESTART': '1', 10:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:40 INFO - 'SHELL': '/bin/bash', 10:01:40 INFO - 'SHLVL': '1', 10:01:40 INFO - 'TERM': 'linux', 10:01:40 INFO - 'TMOUT': '86400', 10:01:40 INFO - 'USER': 'cltbld', 10:01:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:40 INFO - '_': '/tools/buildbot/bin/python'} 10:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:40 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:40 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 10:01:40 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 10:01:40 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 10:01:40 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 10:01:40 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 10:01:40 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 10:01:42 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:01:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:01:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:01:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:43 INFO - Downloading docopt-0.6.1.tar.gz 10:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:43 INFO - Running setup.py install for blobuploader 10:01:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:01:43 INFO - Running setup.py install for requests 10:01:43 INFO - Running setup.py install for docopt 10:01:43 INFO - Successfully installed blobuploader requests docopt 10:01:43 INFO - Cleaning up... 10:01:43 INFO - Return code: 0 10:01:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:43 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:43 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 10:01:43 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 10:01:43 INFO - Using env: {'DISPLAY': ':0', 10:01:43 INFO - 'HOME': '/home/cltbld', 10:01:43 INFO - 'LANG': 'en_US.UTF-8', 10:01:43 INFO - 'LANGUAGE': 'en_US:en', 10:01:43 INFO - 'LOGNAME': 'cltbld', 10:01:43 INFO - 'MAIL': '/var/mail/cltbld', 10:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:43 INFO - 'MOZ_NO_REMOTE': '1', 10:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:43 INFO - 'NO_EM_RESTART': '1', 10:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:43 INFO - 'SHELL': '/bin/bash', 10:01:43 INFO - 'SHLVL': '1', 10:01:43 INFO - 'TERM': 'linux', 10:01:43 INFO - 'TMOUT': '86400', 10:01:43 INFO - 'USER': 'cltbld', 10:01:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:43 INFO - '_': '/tools/buildbot/bin/python'} 10:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:43 INFO - Running setup.py (path:/tmp/pip-Q1jFZ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:43 INFO - Running setup.py (path:/tmp/pip-raFBWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:44 INFO - Running setup.py (path:/tmp/pip-lcyz_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:44 INFO - Running setup.py (path:/tmp/pip-DRbfls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:44 INFO - Running setup.py (path:/tmp/pip-AW0p2G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:44 INFO - Running setup.py (path:/tmp/pip-ZEvIds-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:44 INFO - Running setup.py (path:/tmp/pip-zonZtN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:44 INFO - Running setup.py (path:/tmp/pip-eKnaat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:44 INFO - Running setup.py (path:/tmp/pip-_GRI3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:44 INFO - Running setup.py (path:/tmp/pip-3h3TeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:44 INFO - Running setup.py (path:/tmp/pip-9PsB8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:44 INFO - Running setup.py (path:/tmp/pip-y3rtAZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:44 INFO - Running setup.py (path:/tmp/pip-zYYSlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:44 INFO - Running setup.py (path:/tmp/pip-LFjpGj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:44 INFO - Running setup.py (path:/tmp/pip-I53rZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:44 INFO - Running setup.py (path:/tmp/pip-MVDQF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:45 INFO - Running setup.py (path:/tmp/pip-_74vt6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:45 INFO - Running setup.py install for manifestparser 10:01:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Running setup.py install for mozcrash 10:01:45 INFO - Running setup.py install for mozdebug 10:01:45 INFO - Running setup.py install for mozdevice 10:01:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Running setup.py install for mozfile 10:01:45 INFO - Running setup.py install for mozhttpd 10:01:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Running setup.py install for mozinfo 10:01:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Running setup.py install for mozInstall 10:01:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:01:45 INFO - Running setup.py install for mozleak 10:01:46 INFO - Running setup.py install for mozlog 10:01:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:01:46 INFO - Running setup.py install for moznetwork 10:01:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:01:46 INFO - Running setup.py install for mozprocess 10:01:46 INFO - Running setup.py install for mozprofile 10:01:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:01:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:01:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:01:46 INFO - Running setup.py install for mozrunner 10:01:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:01:46 INFO - Running setup.py install for mozscreenshot 10:01:46 INFO - Running setup.py install for moztest 10:01:46 INFO - Running setup.py install for mozversion 10:01:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:01:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:46 INFO - Cleaning up... 10:01:46 INFO - Return code: 0 10:01:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01: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')]} 10:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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', '-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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:46 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 10:01:46 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 10:01:46 INFO - Using env: {'DISPLAY': ':0', 10:01:46 INFO - 'HOME': '/home/cltbld', 10:01:46 INFO - 'LANG': 'en_US.UTF-8', 10:01:46 INFO - 'LANGUAGE': 'en_US:en', 10:01:46 INFO - 'LOGNAME': 'cltbld', 10:01:46 INFO - 'MAIL': '/var/mail/cltbld', 10:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:46 INFO - 'MOZ_NO_REMOTE': '1', 10:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:46 INFO - 'NO_EM_RESTART': '1', 10:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:46 INFO - 'SHELL': '/bin/bash', 10:01:46 INFO - 'SHLVL': '1', 10:01:46 INFO - 'TERM': 'linux', 10:01:46 INFO - 'TMOUT': '86400', 10:01:46 INFO - 'USER': 'cltbld', 10:01:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:46 INFO - '_': '/tools/buildbot/bin/python'} 10:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:47 INFO - Running setup.py (path:/tmp/pip-mVCgke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:47 INFO - Running setup.py (path:/tmp/pip-qqeQpO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:47 INFO - Running setup.py (path:/tmp/pip-z2sApr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:47 INFO - Running setup.py (path:/tmp/pip-hUstE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:47 INFO - Running setup.py (path:/tmp/pip-_KiXb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:47 INFO - Running setup.py (path:/tmp/pip-LptMqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:47 INFO - Running setup.py (path:/tmp/pip-o3_Ldk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:47 INFO - Running setup.py (path:/tmp/pip-1junBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:47 INFO - Running setup.py (path:/tmp/pip-oawys5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:47 INFO - Running setup.py (path:/tmp/pip-1xjIJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:47 INFO - Running setup.py (path:/tmp/pip-iORGkK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:47 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)) 10:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:47 INFO - Running setup.py (path:/tmp/pip-imFjt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:48 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)) 10:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:48 INFO - Running setup.py (path:/tmp/pip-lHbVFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:48 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)) 10:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:48 INFO - Running setup.py (path:/tmp/pip-W0RUuX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:48 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)) 10:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:48 INFO - Running setup.py (path:/tmp/pip-3rFgNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:48 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)) 10:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:48 INFO - Running setup.py (path:/tmp/pip-h_Ufm7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:48 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)) 10:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:48 INFO - Running setup.py (path:/tmp/pip-7kZZ4h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:48 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)) 10:01:48 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)) 10:01:48 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)) 10:01:48 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)) 10:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:48 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 10:01:48 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 10:01:48 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 10:01:48 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 10:01:48 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 10:01:48 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 10:01:50 INFO - Downloading blessings-1.5.1.tar.gz 10:01:50 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 10:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:50 INFO - Installing collected packages: blessings 10:01:50 INFO - Running setup.py install for blessings 10:01:50 INFO - Successfully installed blessings 10:01:50 INFO - Cleaning up... 10:01:50 INFO - Return code: 0 10:01:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:01:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:01:50 INFO - Reading from file tmpfile_stdout 10:01:50 INFO - Current package versions: 10:01:50 INFO - argparse == 1.2.1 10:01:50 INFO - blessings == 1.5.1 10:01:50 INFO - blobuploader == 1.2.4 10:01:50 INFO - docopt == 0.6.1 10:01:50 INFO - manifestparser == 1.1 10:01:50 INFO - mozInstall == 1.12 10:01:50 INFO - mozcrash == 0.16 10:01:50 INFO - mozdebug == 0.1 10:01:50 INFO - mozdevice == 0.48 10:01:50 INFO - mozfile == 1.2 10:01:50 INFO - mozhttpd == 0.7 10:01:50 INFO - mozinfo == 0.9 10:01:50 INFO - mozleak == 0.1 10:01:50 INFO - mozlog == 3.1 10:01:50 INFO - moznetwork == 0.27 10:01:50 INFO - mozprocess == 0.22 10:01:50 INFO - mozprofile == 0.28 10:01:50 INFO - mozrunner == 6.11 10:01:50 INFO - mozscreenshot == 0.1 10:01:50 INFO - mozsystemmonitor == 0.0 10:01:50 INFO - moztest == 0.7 10:01:50 INFO - mozversion == 1.4 10:01:50 INFO - psutil == 3.1.1 10:01:50 INFO - requests == 1.2.3 10:01:50 INFO - wsgiref == 0.1.2 10:01:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:50 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 10:01:50 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 10:01:50 INFO - Using env: {'DISPLAY': ':0', 10:01:50 INFO - 'HOME': '/home/cltbld', 10:01:50 INFO - 'LANG': 'en_US.UTF-8', 10:01:50 INFO - 'LANGUAGE': 'en_US:en', 10:01:50 INFO - 'LOGNAME': 'cltbld', 10:01:50 INFO - 'MAIL': '/var/mail/cltbld', 10:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:50 INFO - 'MOZ_NO_REMOTE': '1', 10:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:50 INFO - 'NO_EM_RESTART': '1', 10:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:50 INFO - 'SHELL': '/bin/bash', 10:01:50 INFO - 'SHLVL': '1', 10:01:50 INFO - 'TERM': 'linux', 10:01:50 INFO - 'TMOUT': '86400', 10:01:50 INFO - 'USER': 'cltbld', 10:01:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:50 INFO - '_': '/tools/buildbot/bin/python'} 10:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 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)) 10:01:50 INFO - Cleaning up... 10:01:50 INFO - Return code: 0 10:01:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:50 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:50 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 10:01:50 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 10:01:50 INFO - Using env: {'DISPLAY': ':0', 10:01:50 INFO - 'HOME': '/home/cltbld', 10:01:50 INFO - 'LANG': 'en_US.UTF-8', 10:01:50 INFO - 'LANGUAGE': 'en_US:en', 10:01:50 INFO - 'LOGNAME': 'cltbld', 10:01:50 INFO - 'MAIL': '/var/mail/cltbld', 10:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:50 INFO - 'MOZ_NO_REMOTE': '1', 10:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:50 INFO - 'NO_EM_RESTART': '1', 10:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:50 INFO - 'SHELL': '/bin/bash', 10:01:50 INFO - 'SHLVL': '1', 10:01:50 INFO - 'TERM': 'linux', 10:01:50 INFO - 'TMOUT': '86400', 10:01:50 INFO - 'USER': 'cltbld', 10:01:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:50 INFO - '_': '/tools/buildbot/bin/python'} 10:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:50 INFO - Downloading/unpacking jsonschema 10:01:50 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 10:01:50 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 10:01:50 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 10:01:50 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 10:01:50 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 10:01:50 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 10:01:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:52 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 10:01:52 INFO - Downloading/unpacking functools32 (from jsonschema) 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:01:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:52 INFO - warning: no files found matching '*.txt' 10:01:52 INFO - no previously-included directories found matching 'build' 10:01:52 INFO - no previously-included directories found matching 'dist' 10:01:52 INFO - no previously-included directories found matching '.git*' 10:01:52 INFO - Installing collected packages: jsonschema, functools32 10:01:52 INFO - Running setup.py install for functools32 10:01:53 INFO - warning: no files found matching '*.txt' 10:01:53 INFO - no previously-included directories found matching 'build' 10:01:53 INFO - no previously-included directories found matching 'dist' 10:01:53 INFO - no previously-included directories found matching '.git*' 10:01:53 INFO - Successfully installed jsonschema functools32 10:01:53 INFO - Cleaning up... 10:01:53 INFO - Return code: 0 10:01:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:53 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 0x7fdca7f30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', '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 10:01:53 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 10:01:53 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 10:01:53 INFO - Using env: {'DISPLAY': ':0', 10:01:53 INFO - 'HOME': '/home/cltbld', 10:01:53 INFO - 'LANG': 'en_US.UTF-8', 10:01:53 INFO - 'LANGUAGE': 'en_US:en', 10:01:53 INFO - 'LOGNAME': 'cltbld', 10:01:53 INFO - 'MAIL': '/var/mail/cltbld', 10:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:53 INFO - 'MOZ_NO_REMOTE': '1', 10:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:53 INFO - 'NO_EM_RESTART': '1', 10:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:53 INFO - 'SHELL': '/bin/bash', 10:01:53 INFO - 'SHLVL': '1', 10:01:53 INFO - 'TERM': 'linux', 10:01:53 INFO - 'TMOUT': '86400', 10:01:53 INFO - 'USER': 'cltbld', 10:01:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:53 INFO - '_': '/tools/buildbot/bin/python'} 10:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:53 INFO - Downloading/unpacking flake8 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:01:55 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 10:01:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:01:55 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 10:01:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:01:55 INFO - no previously-included directories found matching 'docs/_build' 10:01:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:01:55 INFO - Running setup.py install for pep8 10:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:01:55 INFO - no previously-included directories found matching 'docs/_build' 10:01:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:01:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:01:55 INFO - Cleaning up... 10:01:55 INFO - Return code: 0 10:01:55 INFO - Running post-action listener: _resource_record_post_action 10:01:55 INFO - Running post-action listener: _start_resource_monitoring 10:01:55 INFO - Starting resource monitoring. 10:01:55 INFO - ##### 10:01:55 INFO - ##### Running install step. 10:01:55 INFO - ##### 10:01:55 INFO - Running pre-action listener: _resource_record_pre_action 10:01:55 INFO - Running main action method: install 10:01:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:01:56 INFO - Reading from file tmpfile_stdout 10:01:56 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:01:56 INFO - Reading from file tmpfile_stdout 10:01:56 INFO - Output received: 10:01:56 INFO - Usage: mozinstall [options] installer 10:01:56 INFO - Options: 10:01:56 INFO - -h, --help show this help message and exit 10:01:56 INFO - -d DEST, --destination=DEST 10:01:56 INFO - Directory to install application into. [default: 10:01:56 INFO - "/builds/slave/test-pgo"] 10:01:56 INFO - --app=APP Application being installed. [default: firefox] 10:01:56 INFO - mkdir: /builds/slave/test-pgo/build/application 10:01:56 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'] 10:01:56 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 10:02:12 INFO - Reading from file tmpfile_stdout 10:02:12 INFO - Output received: 10:02:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:02:12 INFO - Running post-action listener: _resource_record_post_action 10:02:12 INFO - ##### 10:02:12 INFO - ##### Running run-tests step. 10:02:12 INFO - ##### 10:02:12 INFO - Running pre-action listener: _resource_record_pre_action 10:02:12 INFO - Running main action method: run_tests 10:02:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:02:12 INFO - Python 2.7.3 10:02:12 INFO - Return code: 0 10:02:12 INFO - grabbing minidump binary from tooltool 10:02:12 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')]} 10:02:12 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 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:02:12 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 10:02:12 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 10:02:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:12 INFO - Return code: 0 10:02:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:02:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:02:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:02:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:02:13 INFO - Return code: 0 10:02:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 10:02:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 10:02:13 INFO - Using env: {'DISPLAY': ':0', 10:02:13 INFO - 'HOME': '/home/cltbld', 10:02:13 INFO - 'LANG': 'en_US.UTF-8', 10:02:13 INFO - 'LANGUAGE': 'en_US:en', 10:02:13 INFO - 'LOGNAME': 'cltbld', 10:02:13 INFO - 'MAIL': '/var/mail/cltbld', 10:02:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:13 INFO - 'MOZ_NO_REMOTE': '1', 10:02:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:13 INFO - 'NO_EM_RESTART': '1', 10:02:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:13 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:02:13 INFO - 'SHELL': '/bin/bash', 10:02:13 INFO - 'SHLVL': '1', 10:02:13 INFO - 'TERM': 'linux', 10:02:13 INFO - 'TMOUT': '86400', 10:02:13 INFO - 'USER': 'cltbld', 10:02:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167', 10:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:13 INFO - '_': '/tools/buildbot/bin/python'} 10:02:13 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:02:13 INFO - mozversion application_buildid: 20160115073123 10:02:13 INFO - mozversion application_changeset: 02398f2be72b9bbf5ee79348b73ef122c915aae0 10:02:13 INFO - mozversion application_display_name: Nightly 10:02:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:13 INFO - mozversion application_name: Firefox 10:02:13 INFO - mozversion application_remotingname: firefox 10:02:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:13 INFO - mozversion application_vendor: Mozilla 10:02:13 INFO - mozversion application_version: 46.0a1 10:02:13 INFO - mozversion platform_buildid: 20160115073123 10:02:13 INFO - mozversion platform_changeset: 02398f2be72b9bbf5ee79348b73ef122c915aae0 10:02:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:13 INFO - mozversion platform_version: 46.0a1 10:02:13 INFO - using testdate: 1452880933 10:02:13 INFO - actual date: 1452880933 10:02:13 INFO - starting webserver on 'localhost:57017' 10:02:13 INFO - SUITE-START | Running 3 tests 10:02:13 INFO - TEST-START | dromaeo_css 10:02:13 INFO - operating with platform_type : linux_ 10:02:13 INFO - Initialising browser for dromaeo_css test... 10:02:13 INFO - TEST-INFO | started process 30707 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY86Osz/profile http://localhost:57017/getInfo.html) 10:02:17 INFO - PROCESS | 30707 | __metrics Screen width/height:1600/1200 10:02:17 INFO - PROCESS | 30707 | colorDepth:24 10:02:17 INFO - PROCESS | 30707 | Browser inner width/height: 1024/697 10:02:17 INFO - PROCESS | 30707 | __metrics 10:02:17 INFO - PROCESS | 30707 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:02:17 INFO - PROCESS | 30707 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:02:18 INFO - TEST-INFO | 30707: exit 0 10:02:18 INFO - Browser initialized. 10:02:18 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:18 INFO - TEST-INFO | started process 30800 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY86Osz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:30 INFO - PROCESS | 30800 | RSS: Main: 149889024 10:02:30 INFO - PROCESS | 30800 | 10:03:22 INFO - PROCESS | 30800 | 1452881002251 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:05:30 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:57017/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57017/tests/dromaeo/cssquery-ext.html) 10:05:31 INFO - PROCESS | 30800 | RSS: Main: 270479360 10:05:31 INFO - PROCESS | 30800 | 10:08:33 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:57017/tests/dromaeo/cssquery-ext.html (next: http://localhost:57017/tests/dromaeo/cssquery-jquery.html) 10:08:34 INFO - PROCESS | 30800 | RSS: Main: 236277760 10:08:34 INFO - PROCESS | 30800 | 10:11:36 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:57017/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57017/tests/dromaeo/cssquery-mootools.html) 10:11:37 INFO - PROCESS | 30800 | RSS: Main: 249524224 10:11:37 INFO - PROCESS | 30800 | 10:14:39 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:57017/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57017/tests/dromaeo/cssquery-prototype.html) 10:14:39 INFO - PROCESS | 30800 | RSS: Main: 216510464 10:14:39 INFO - PROCESS | 30800 | 10:17:42 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:57017/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57017/tests/dromaeo/cssquery-yui.html) 10:17:42 INFO - PROCESS | 30800 | RSS: Main: 216965120 10:17:42 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | Cycle 1(1): loaded http://localhost:57017/tests/dromaeo/cssquery-yui.html (next: http://localhost:57017/tests/dromaeo/cssquery-dojo.html) 10:20:45 INFO - PROCESS | 30800 | RSS: Main: 246484992 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | __start_tp_report 10:20:45 INFO - PROCESS | 30800 | _x_x_mozilla_page_load 10:20:45 INFO - PROCESS | 30800 | _x_x_mozilla_page_load_details 10:20:45 INFO - PROCESS | 30800 | |i|pagename|runs| 10:20:45 INFO - PROCESS | 30800 | |0;dojo.html;3174.4286028514866;3180.5706229659004;3210.2616398228392;3234.239953610901;3235.870565177393;5077.263796749469;5100.132977393842;5135.22971554267;5148.562372198363;5157.097507936115;5192.247124167003;5193.662411943231;5206.140986737193;5249.763760630772;5277.6305658603815;4759.452662943762;4767.380240568721;4789.305550695147;4820.445648750404;4846.975765121169;4786.952130478686;4810.446798618152;4839.3466881970835;4862.3922009748785;4865.562099411052;4675.719456832601;4717.9292310615365;4769.093872164295;4782.545658162469;4805.183118869801;4783.856484305442;4790.640701947368;4803.471618122004;4823.686460380064;4826.420829500447;4754;4756.571908528214;4761.642876784255;4761.761911904426;4766.880827979294;4931.038447502702;5039.420466646309;5097.337346145015;5122.410922743895;5210.426853046162;5553.7778488860395;5559.388467268597;5564.610477266593;5568.777248910039;5572.192032155314;5583.190437386556;5596.244506991586;5597.720113994284;5601.187827764992;5607.691576963265;5133.076046311662;5199.532042116228;5231.503007214346;5312.73436328182;5334.1732031535175;5718.085106383042;5725.942740572541;5729.684867332337;5732.656040637575;5755.740991655385;5396.298481197419;5517.034518959166;5521.475459831309;5529.281193444826;5532.778688852401;5558.138488534284;5573.414791446839;5598.1602759586385;5611.466910643482;5640.238567793295;5497.147942068986;5504.394516603171;5506.531944784738;5514.5864060195645;5514.751836167382;5444;5526.47498487643;5538.252335934678;5568.303962004749;5571.415001424792;4272.636825869774;4362.629176520031;4389.1660584488845;4417.646588272931;4424.823007079681;3877.747946383476;3880.9223815524097;3894.7078969077434;3915.686745060388;3917.8236979335998;5161.819336323286;5203.089459344599;5241.711705856214;5243.580513558906;5246.029484545371;5542;5542.667439953616;5546.805861794818;5583.3858275589655;5605.747741351649;5169.06956747789;5201.08980928336;5206.349206349207;5208.088584497774;5224.138017227115;4630.976845115752;4721.244600863845;4724.196886529298;4725.149473094807;4756.048790241965;5710.914336284959;5764.279465066867;5770.971145144332;5777.277840270051;5828.766849326064;5515.420880807618;5528.170774383874;5535.114381698909;5539.196816461671;5539.584531160099;5670.319561652628;5687;5692.089265717631;5702.45826646468;5705.058665320342;5496.917546236889;5551.944480555143;5553;5557.888842223214;5606.85982850432;5555.972220138873;5612.045952188219;5612.971935140298;5618.6628802272;5638.2670252866865;5409.891802164014;5416.7020813855615;5482.259894914295;5498.780048798003;5547.5007249347755;5494.752736126964;5529.253550770594;5541.2796336476;5541.916871246854;5550.8057217997175;5415.268938693226;5438.428964958623;5446.074167391474;5449.700266485382;5500.367457742251;5469.644473109235;5475.4524547544925;5540.833774986757;5544.833654990357;5545.584081194007;5393.703346315833;5394.865128371665;5395.865103372447;5417.1874218865905;5452.809151679672 10:20:45 INFO - PROCESS | 30800 | |1;ext.html;544.6568661743102;545.2965674280179;563.3071322273605;574.184657785944;579.0070029898723;29000.709992900065;29485.705142948536;29501.40997180058;29508.704912950863;29546.40907181855;35951;36393.45409818855;36437;36503;36577;8238.835223295515;8344.332453403744;8347.332213422911;8377.539235342054;8391.076981532056;8098;8208.179182081803;8210.548419836907;8213.055498617647;8213.137620549845;8185.099639039701;8260.710875119372;8262.628181731836;8467.703630372938;8477.448965817202;8320.043195032587;8342.332613390914;8367.83264334713;8370.497770133812;8421.95789021054;8370.288525475342;8530.019047809457;8560.443571167916;8567.657293708244;8569.185927336894;38648.03379915497;39100.608993909984;39155.60844391548;39165.804170979245;39199.60800392017;3463.41122009259;3652.977166393414;3803.6766874815676;3996.660283875874;4133.42132101506;29937.101886943427;29971;30266;30402;30411.695883041106;3044.8173109613494;3073.9231519211976;3206.0381885434276;3302.9834850825832;3332.4001679697644;265376;265822;265950.6702466495;266203;268677;55403.44596554063;55676.16485752717;55942.720286398304;55949;55957.999999999185;59604;59618;59636.40363596395;59734.402655973754;59915.400845991855;14453.710925781426;14557.12657240569;14642.707145857235;14649.267536623127;14650.120992740469;10599.576016959236;10640.361578305326;10651.09465695409;10655.30740501865;10660.840087398696;18360.449186524427;18549.35077272289;18683.532911677317;18791.34230301933;18864.339748109025;6504.38208370204;7350.485466017328;7570.545767253872;7696.345810606049;7718.459707820511;937.4188003437775;940.6331530703031;1016.506994107857;1056.5456853553046;1059.7880423915249;26307.34231644186;28594.857025715155;29215.415691686474;30118.536368317487;31177;1028.6759670703705;1042.1454407386022;1044.8171569975375;1115.9163062770324;1121.3103941076342;14017.649558760908;14068.366923488467;14234.857651423561;14236.786448203286;14250.857491424953;302681;312669;348670;439819;455095;44821;45328.77335613301;45417.77291113589;45447;45501.31748023782;1321.2931081871345;1337.8595247499068;1350.4193196925416;1350.7501112294258;1352.5468967895667;23786.40533986664;27916.30209244785;28277.57583636288;28609.570856436752;28760.71239287664;41616;41974.58025419829;41982;42017.78991105147;42037.11480392809;204860;205781;206366;206498;206818;30606;30934.845325774128;30997;31032;31888.68111318857;41255.58744412517;42459.57540424556;42674;42689.5731042698;42762.35856462093;34486.03410607712;35093;35679.46480802842;36116.45825312675;36349;35240;35666.63347605235;35813.64186358103;36676.26647467089;36755;34786;35065.824670876485;35513.82243088768;35601.28797424089;35642.46536302009;29488.852555737085;30382.696173037988;31625;32393.676063240007;32447.837760811046;24868.37829054288;25289.49421011533;25429.491410172064;25544.61683074718;25560.616590750782 10:20:45 INFO - PROCESS | 30800 | |2;jquery.html;366.54731406712705;366.6938106680921;367.18668150047654;368.9262147570485;378.9204267103908;14303.356348964295;14815.481458148966;15598.220088995547;17172.398966036177;18074.367397141104;16456.27209143041;16498.587535311624;16511.17444127792;16808.32766689331;16900;5226.686398816064;5436.456354364552;5441.809536666217;5444.8366549003595;5446.754896029688;3993.460882780831;4120.876373708794;5314.282571852808;5606.187102870082;5817.650940943557;5576.107822748361;5685.886282274373;5776.046952252894;5780.710964451781;5799;5728.341240757304;5736;5755.309362876482;5764.538836893039;5778;4960.826371076995;5126.026055049529;5151.072806894757;5152.458991805881;5152.845414637567;19577.21691132353;19822.306219282254;19891.50271243216;20014.69977950332;20020.49948751278;1844.4282272495436;1944.8735832170864;2046.3349411441193;2110.89445527723;2202.856814307081;9001.864972025425;9367.76580585484;9500.809983800355;11133.72165695856;12361.458307551455;1850.2691436882355;1899.7530321058312;1911.923523059076;1916.1185854506944;1922.0581914861616;54351;54446.45553544453;54582.45417545814;55731.442685573435;55917;9534.332596718163;9710.368826026286;9728.221742260603;9732.513374331254;9793.90206097944;12510.437030333656;12520.87479125197;12521.311327876872;12528.81206781899;12529.624111276677;6598.967005165039;6742.157230346207;6805.3875151236625;6810.080639113657;6921.307869213139;6372.872542549216;6396.9360306397275;6427.903581446189;6464.741410343628;6514.185726784152;3960.366341385422;4158.397032430281;4182.790860456965;4192.434021407132;4219.894502637459;1724.1637805664243;1756.7891852977468;1800.090954068187;1808.2405389736343;1824.3432364348823;417.4614746976427;422.6323098903973;426.1966193724851;444.355684257821;956.9425784508157;9481.762955926157;9572.521373931275;10610.522526486327;10668.253222274367;10782.56869725218;453.26118426964496;454.06462686865166;454.8976480291908;458.72476514091943;458.7866642011414;9427.575759090858;10122.848157277647;10245.7438564035;10277.171291161736;10383.63657272007;540458.568499849;541104;541927;543037;545215;72329;72705.2729472709;72785.27214727785;73003.26996730072;73682;1012.1143999000874;1040.0691381213921;1041.6406339812752;1043.4939054558533;1044.185535282481;13965.720685586435;14002.859971400563;14399.568012959628;15020.774688379464;15313.234338282818;30836.84581577078;31194.376112478076;31296.843515782275;31424.214394640316;32413.027609171764;33904.83047584746;38213.617863821004;39454;39716.602833971294;40039;6800.93199068003;6974.895376569457;7327.926720732725;7384.52000619958;7403.111626604842;9212.723618291462;10196.4391958443;11135.10919126484;11269.492872820907;11653.6503904883;9062.592183351633;9246.815063698823;9641.27690423235;9766.414015159113;9812.215022798016;9390.577424016072;9443.952780236055;9456.432614043179;9719.805603888024;9781.41311521311;9318.627254909728;9393.154616084585;9636.662716805158;9872.703818885446;10131.898681013095;7141;7325.853482930205;7351.713450146096;7406.481546291708;7414.147373051952;9690.903090969001;10023.548940297558;10075.697729068139;10141.543630536496;10361.481925903825 10:20:45 INFO - PROCESS | 30800 | |3;mootools.html;1321.7686904791672;1417.3267697843523;1453.694724107937;1606.767018782276;1808.312841120374;7032.12098487689;7630.969819074423;7737.999999999986;7740.419468539861;7745.806354841117;7669.808254793633;7834.686612535492;7846.176151504095;7848.686052557905;7850.175731548191;2065.4216819290546;2125.415510734545;2335.8364914455997;2378.072551704841;2403.831731778776;2361.645753137026;2373.8100951923807;2376.4296568823443;2378;2378.3221781792195;2313.2366319114653;2393.509330587234;2393.5811233034237;2396.364963284731;2404.699412573428;2351.3651314145172;2364.929052128439;2411.1319924827135;2411.686480757508;2412.3969007748065;2339.836211465198;2366.408397900525;2379.6787433696404;2385.3559538924565;2386.284114765581;7953.323967462773;7991.24083212094;8037.919620803776;8038.075621303567;8048.034235891672;4861.149298872719;4968.080905032544;4974.278729584226;4994.200927851526;4997.50024997501;3145.921351966196;3173.6826317368077;3233.337165880989;3243.6431992481043;3251.6748325167296;1039.8492218628332;1054.504382940017;1059.8463222832645;1067.210264404343;1071.2554774431774;10965.61620343284;11023.283486573348;11024.50389732464;11026.779464410747;11034.172437067253;4480.641548676098;4512.142692888341;4520.050789334211;4585.839495617704;4614.838480653161;9365.719028429157;9366.859497107549;9368.531573421438;9371.109744574254;9371.953140234255;4934.259861020804;4947.82682606107;4975.154223781966;4980.05378977993;4982.451930287665;4504.324351347259;4508.368828364031;4547.954520454753;4551;4555.043440877386;3448.3620530201492;3492.1793378556526;3756.492873462102;3802.296575133609;3826.3877779555137;1275.661949583361;1277.5847849448967;1278.4119305119564;1284.4220100954608;1292.1988367212389;1306.7843805772131;1312.3831799054428;1313.2317594207495;1315.4409376015155;1335.2589312931416;7007.404370628554;7096.219415864251;7116.964415177891;7117.608531530712;7121.216666166718;1079.8164312066967;1087.0868470484832;1104.6354702948008;1109.3011402816173;1117.944102794857;5829.446202610745;5912.852178695567;5915.201447804578;5917.911231331534;5923.7926672566255;9445.716628501155;9639.18066964316;9753.122219000325;9937.900620993698;9948.452835093995;9695.90304096964;9838.950805245928;9845.212383009342;9847.606095756233;9861.556229969668;7227.385672217921;7358.153812311546;7391;7394.149672787591;7564.810879728051;7262.527935684164;7309.342159205697;7324.340809327186;7326.120865496175;7328;8181.386396020442;8279.254867061993;8384.874226886725;8547;8549.316054715733;8431.072582015851;8555.272801811916;8688.26149777276;8693.782655433664;8697.434666746642;6342.841428964312;6977.232504424611;7097.538659987084;7111.431085513043;7121.643917804193;6927.549709268881;7014.894776578458;7198.280171982759;7225.63871806397;7231.096112985877;6656.23453302857;6732.562383445061;6806.625635589892;6893.034975103389;6925.826854328682;6803.414573796857;6825.180978282638;6831.9658401707675;6848.8287792803585;7028.226895041644;6752.426043786333;6771.52599318043;6774.051632771318;6786.457083433413;6792.320767923168;6387.425131738166;6464;6467.838304042437;6469.223693156851;6483.935160648333;6523.31505191967;6538.673066346569;6564.4748420127235;6566.244881838458;6575.112359831553 10:20:45 INFO - PROCESS | 30800 | |4;prototype.html;341.0824881069922;341.50311297062774;346.82312020869347;348.520783922107;351.223795412139;5695.74369153388;5781.62419442736;5802.303723553175;5844.503217226541;5845.357010728816;5595.300587426572;5739.512141467981;5743.138529220619;5756.712164391784;5760.193572899787;4499.280115181572;4527.660425468087;4527.773611319429;4530.546945305476;4533.320001999694;4320.546342634026;4408.86773396797;4436.64506839452;4497.910041799162;4515.61617262533;4454.53227411122;4459.840441485221;4478.955210447886;4480.52954439784;4496.4829044659955;4476.261416866213;4480.305552639346;4480.686351955364;4485.1254005468945;4492.14649216651;3989.960100398988;3994.7802870842092;3998.260321840469;4000.159966407058;4000.3599424092004;5385.757640906129;5522.392536820947;5555.8888822223735;5558;5583.8883222335735;5174.275601415805;5177.58579313654;5179;5179.792808287664;5180.6373553851245;5832.416758324133;6144.692765361714;6147.754089836401;6152.323244443108;6155.907661385038;4246.171996460692;4251.171021650779;4317;4337;4343.630791382736;6273.62358258506;6359.109724638554;6381.978883378683;6423.807285781434;6429.807105786787;4423.800928958204;4425.513193548707;4425.955740442619;4428.6678499112695;4435.002124521957;4349.434573505488;4466.709663871838;4472.306792447176;4474.664400170001;4480.865574032784;5099.821506247264;5118.692878427306;5161.535461808456;5167.560757335668;5167.793288268427;6120.44915957566;6146.139540464339;6148.9692551536955;6161.014237722033;6161.106639537242;1565.037501936301;1585.7145713771401;1586.5319730679478;1587.5872273208818;1588.9126098064487;1061.0397590180899;1064.882862885082;1067.556963860005;1068.407034096084;1093.2511229807449;5836.970815145897;5839.036558967723;5844.707764611752;5851.356350801409;5851.9707401463575;6283.434490895841;6287.874242515124;6290.528210384148;6291.496680265568;6317.052442133717;5830;5835.124731290341;5838.941610583925;5843.24037875082;5846.1523079153285;3292.8353582320788;3383.5263063171174;3394.6605339465855;3398.5242066110764;3406.659334066623;6520.119783829123;6521.739130434825;6531.118299029666;6533.314002029813;6557.311482294386;6491.253505846794;6500.252470965899;6542.3130571290285;6570.441512471493;6571.310012448624;6355.682215889279;6524.249711283168;6525.836854078591;6527.771527996498;6551.0500977358015;6104.4200800923845;6303.36966303366;6309.558330916791;6315.4947604192475;6318.873622527615;6099.695015249308;6239.06414037898;6250.937490625036;6261.530385221035;6262.68686565679;6559.6064236145985;6572.474202063728;6580.736770529125;6590.769323073861;6593.934060659332;4353.586409291112;4440.933385999278;4442.977785111054;4447.7998490067375;4450.844220452269;6340.239171299474;6341.619502829845;6360.459360954371;6365.904511432424;6371.23545174582;6184.567080304336;6201.162843016135;6205.379462053758;6207.472364849038;6211.627302361872;6034.09488576717;6184.5052395809125;6184.752609895554;6186.721597528032;6196.1635179250225;6069.757209711562;6073.392660733891;6078.513718902389;6084.269887613515;6090.025595904634;6206.410391012847;6214.471769899609;6214.9689251553455;6218.284897236695;6218.409251121137;5909.556783241188;6070.605410648293;6074.119252708421;6080.7567697291615;6084.574079814371 10:20:45 INFO - PROCESS | 30800 | |5;yui.html;852.4996898647811;858.7337925243176;863.335231871459;881.5988725130067;884.8584226523756;12527.937360313197;12769.93615031926;12780.872191278107;12809.423575939094;12833.294168820723;12843.678908027305;13008.93495532521;13082.607521774338;13083.934580327084;13085.934570327136;676;687.1273482677022;818.1368656067846;827.8675411934091;828.7513745876213;673.2123415603755;801.2708435323857;819.6311659753105;820.4871955028108;821.1296026212204;849.9745007649749;852.9530875801828;855.1576696953496;855.9443636163629;857;706.58311596158;717.7631381644045;849.562475325208;850.6044689219511;850.8936382952162;524.44408926538;625.6715224507125;628.9779857705004;635.6027482823235;636.1475622665604;12890.87109128906;13013.934930325382;13045.608631741063;13081.28052957087;13082.672933176651;12175.208611440317;12404.317762523058;12613.306268155247;12831.935840320832;13207.40566674502;10347.379157250589;10497.4226417547;10537.683869483928;10648.307859989076;10762.677119686421;3523.788572685647;3549.964500355015;3560.6795388414907;3586.659267369596;3674.1365779041903;43682.34476482855;43841.78079109584;43874;44201.33697994501;44314.556854431685;10004.749881253027;10098;10214.795704085876;10221.795564088825;10250.538725757358;16679.166041697867;16751;16759.748603770953;16773;16801.579960501087;7547.547147171187;7632.618369081523;7654.885176722353;7848.215178482106;7968.681252749825;4045.7370270932297;4048.2510735514024;4078.592140785957;4086.3053280942313;4091.0590564170407;3173.4129186100645;3197.9840100799347;3203.0711093782543;3212.2932954750386;3218.726408255278;586.718375179916;602.9246344206974;604.6039843902252;614.5513774944316;628.6385328436077;545.1241671714109;573.2776701356238;587.4683411512588;606.7481994972037;607.0257237134335;8002;8218.465799723119;8326.209010144026;8386.166715717407;8554.101819308882;513.5326852564149;559.1808001278147;575.7955925646335;586.4985437451003;605.5912259225006;3722.181120153562;3753.4932784074344;3792.715546334036;3932.3315036443873;3958.4562020811904;50829.23756143661;51676;52257;52573;52709.209361859605;46889.53110468852;47304.7634761824;47448.762756186;47608.285875711896;47625.76187119042;43239.135217296105;43283.783581081894;43797;43935.34096988484;43943;7518.624068796429;7906;7974.720884769237;7990.400719945911;8035.437519373588;29892.70107298986;30858.228544285674;31099.533506997865;31162.688373116885;31883.840580796947;38225.4266186013;40821.38767918543;40917.1816563673;41127.58872411238;41310.586894130676;9001.459912405277;9743;9866.802663946537;10674.306170098918;10963.397013164353;11014;11394.601188958346;11758.764824703629;11828.940855295668;12215.511379544718;10940.835887461853;10962.780744385227;11000.22998390137;11507.942460287644;11581.710457238636;10562.788744225227;10705.143588512745;11133.332000080021;11154.609588664358;11547.538098475967;10648.84026739584;10997.835032474359;11082.778344433227;11322.26405283654;11528.884711152781;9131.497767622579;9375.765605859908;9583.904160958302;9725.319227653996;9740.853887191555;9008;9138.77153071152;9348.1119293667;9793.412395256308;9850.408975461496 10:20:45 INFO - PROCESS | 30800 | __end_tp_report 10:20:45 INFO - PROCESS | 30800 | __start_cc_report 10:20:45 INFO - PROCESS | 30800 | _x_x_mozilla_cycle_collect,1028 10:20:45 INFO - PROCESS | 30800 | __end_cc_report 10:20:45 INFO - PROCESS | 30800 | __startTimestamp1452882045862__endTimestamp 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | ------- Summary: start ------- 10:20:45 INFO - PROCESS | 30800 | Number of tests: 6 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | [#0] dojo.html Cycles:165 Average:5192.40 Median:5417.19 stddev:552.64 (10.2%) stddev-sans-first:531.18 10:20:45 INFO - PROCESS | 30800 | Values: 3174.4 3180.6 3210.3 3234.2 3235.9 5077.3 5100.1 5135.2 5148.6 5157.1 5192.2 5193.7 5206.1 5249.8 5277.6 4759.5 4767.4 4789.3 4820.4 4847.0 4787.0 4810.4 4839.3 4862.4 4865.6 4675.7 4717.9 4769.1 4782.5 4805.2 4783.9 4790.6 4803.5 4823.7 4826.4 4754.0 4756.6 4761.6 4761.8 4766.9 4931.0 5039.4 5097.3 5122.4 5210.4 5553.8 5559.4 5564.6 5568.8 5572.2 5583.2 5596.2 5597.7 5601.2 5607.7 5133.1 5199.5 5231.5 5312.7 5334.2 5718.1 5725.9 5729.7 5732.7 5755.7 5396.3 5517.0 5521.5 5529.3 5532.8 5558.1 5573.4 5598.2 5611.5 5640.2 5497.1 5504.4 5506.5 5514.6 5514.8 5444.0 5526.5 5538.3 5568.3 5571.4 4272.6 4362.6 4389.2 4417.6 4424.8 3877.7 3880.9 3894.7 3915.7 3917.8 5161.8 5203.1 5241.7 5243.6 5246.0 5542.0 5542.7 5546.8 5583.4 5605.7 5169.1 5201.1 5206.3 5208.1 5224.1 4631.0 4721.2 4724.2 4725.1 4756.0 5710.9 5764.3 5771.0 5777.3 5828.8 5515.4 5528.2 5535.1 5539.2 5539.6 5670.3 5687.0 5692.1 5702.5 5705.1 5496.9 5551.9 5553.0 5557.9 5606.9 5556.0 5612.0 5613.0 5618.7 5638.3 5409.9 5416.7 5482.3 5498.8 5547.5 5494.8 5529.3 5541.3 5541.9 5550.8 5415.3 5438.4 5446.1 5449.7 5500.4 5469.6 5475.5 5540.8 5544.8 5545.6 5393.7 5394.9 5395.9 5417.2 5452.8 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | [#1] ext.html Cycles:180 Average:44268.19 Median:35166.50 stddev:76845.43 (218.5%) stddev-sans-first:76990.88 10:20:45 INFO - PROCESS | 30800 | Values: 544.7 545.3 563.3 574.2 579.0 29000.7 29485.7 29501.4 29508.7 29546.4 35951.0 36393.5 36437.0 36503.0 36577.0 8238.8 8344.3 8347.3 8377.5 8391.1 8098.0 8208.2 8210.5 8213.1 8213.1 8185.1 8260.7 8262.6 8467.7 8477.4 8320.0 8342.3 8367.8 8370.5 8422.0 8370.3 8530.0 8560.4 8567.7 8569.2 38648.0 39100.6 39155.6 39165.8 39199.6 3463.4 3653.0 3803.7 3996.7 4133.4 29937.1 29971.0 30266.0 30402.0 30411.7 3044.8 3073.9 3206.0 3303.0 3332.4 265376.0 265822.0 265950.7 266203.0 268677.0 55403.4 55676.2 55942.7 55949.0 55958.0 59604.0 59618.0 59636.4 59734.4 59915.4 14453.7 14557.1 14642.7 14649.3 14650.1 10599.6 10640.4 10651.1 10655.3 10660.8 18360.4 18549.4 18683.5 18791.3 18864.3 6504.4 7350.5 7570.5 7696.3 7718.5 937.4 940.6 1016.5 1056.5 1059.8 26307.3 28594.9 29215.4 30118.5 31177.0 1028.7 1042.1 1044.8 1115.9 1121.3 14017.6 14068.4 14234.9 14236.8 14250.9 302681.0 312669.0 348670.0 439819.0 455095.0 44821.0 45328.8 45417.8 45447.0 45501.3 1321.3 1337.9 1350.4 1350.8 1352.5 23786.4 27916.3 28277.6 28609.6 28760.7 41616.0 41974.6 41982.0 42017.8 42037.1 204860.0 205781.0 206366.0 206498.0 206818.0 30606.0 30934.8 30997.0 31032.0 31888.7 41255.6 42459.6 42674.0 42689.6 42762.4 34486.0 35093.0 35679.5 36116.5 36349.0 35240.0 35666.6 35813.6 36676.3 36755.0 34786.0 35065.8 35513.8 35601.3 35642.5 29488.9 30382.7 31625.0 32393.7 32447.8 24868.4 25289.5 25429.5 25544.6 25560.6 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | [#2] jquery.html Cycles:180 Average:27116.83 Median:454.48 stddev:88601.47 (19495.1%) stddev-sans-first:88827.25 10:20:45 INFO - PROCESS | 30800 | Values: 366.5 366.7 367.2 368.9 378.9 14303.4 14815.5 15598.2 17172.4 18074.4 16456.3 16498.6 16511.2 16808.3 16900.0 5226.7 5436.5 5441.8 5444.8 5446.8 3993.5 4120.9 5314.3 5606.2 5817.7 5576.1 5685.9 5776.0 5780.7 5799.0 5728.3 5736.0 5755.3 5764.5 5778.0 4960.8 5126.0 5151.1 5152.5 5152.8 19577.2 19822.3 19891.5 20014.7 20020.5 1844.4 1944.9 2046.3 2110.9 2202.9 9001.9 9367.8 9500.8 11133.7 12361.5 1850.3 1899.8 1911.9 1916.1 1922.1 54351.0 54446.5 54582.5 55731.4 55917.0 9534.3 9710.4 9728.2 9732.5 9793.9 12510.4 12520.9 12521.3 12528.8 12529.6 6599.0 6742.2 6805.4 6810.1 6921.3 6372.9 6396.9 6427.9 6464.7 6514.2 3960.4 4158.4 4182.8 4192.4 4219.9 1724.2 1756.8 1800.1 1808.2 1824.3 417.5 422.6 426.2 444.4 956.9 9481.8 9572.5 10610.5 10668.3 10782.6 453.3 454.1 454.9 458.7 458.8 9427.6 10122.8 10245.7 10277.2 10383.6 540458.6 541104.0 541927.0 543037.0 545215.0 72329.0 72705.3 72785.3 73003.3 73682.0 1012.1 1040.1 1041.6 1043.5 1044.2 13965.7 14002.9 14399.6 15020.8 15313.2 30836.8 31194.4 31296.8 31424.2 32413.0 33904.8 38213.6 39454.0 39716.6 40039.0 6800.9 6974.9 7327.9 7384.5 7403.1 9212.7 10196.4 11135.1 11269.5 11653.7 9062.6 9246.8 9641.3 9766.4 9812.2 9390.6 9444.0 9456.4 9719.8 9781.4 9318.6 9393.2 9636.7 9872.7 10131.9 7141.0 7325.9 7351.7 7406.5 7414.1 9690.9 10023.5 10075.7 10141.5 10361.5 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | [#3] mootools.html Cycles:180 Average:5540.85 Median:6365.13 stddev:2838.72 (44.6%) stddev-sans-first:2828.96 10:20:45 INFO - PROCESS | 30800 | Values: 1321.8 1417.3 1453.7 1606.8 1808.3 7032.1 7631.0 7738.0 7740.4 7745.8 7669.8 7834.7 7846.2 7848.7 7850.2 2065.4 2125.4 2335.8 2378.1 2403.8 2361.6 2373.8 2376.4 2378.0 2378.3 2313.2 2393.5 2393.6 2396.4 2404.7 2351.4 2364.9 2411.1 2411.7 2412.4 2339.8 2366.4 2379.7 2385.4 2386.3 7953.3 7991.2 8037.9 8038.1 8048.0 4861.1 4968.1 4974.3 4994.2 4997.5 3145.9 3173.7 3233.3 3243.6 3251.7 1039.8 1054.5 1059.8 1067.2 1071.3 10965.6 11023.3 11024.5 11026.8 11034.2 4480.6 4512.1 4520.1 4585.8 4614.8 9365.7 9366.9 9368.5 9371.1 9372.0 4934.3 4947.8 4975.2 4980.1 4982.5 4504.3 4508.4 4548.0 4551.0 4555.0 3448.4 3492.2 3756.5 3802.3 3826.4 1275.7 1277.6 1278.4 1284.4 1292.2 1306.8 1312.4 1313.2 1315.4 1335.3 7007.4 7096.2 7117.0 7117.6 7121.2 1079.8 1087.1 1104.6 1109.3 1117.9 5829.4 5912.9 5915.2 5917.9 5923.8 9445.7 9639.2 9753.1 9937.9 9948.5 9695.9 9839.0 9845.2 9847.6 9861.6 7227.4 7358.2 7391.0 7394.1 7564.8 7262.5 7309.3 7324.3 7326.1 7328.0 8181.4 8279.3 8384.9 8547.0 8549.3 8431.1 8555.3 8688.3 8693.8 8697.4 6342.8 6977.2 7097.5 7111.4 7121.6 6927.5 7014.9 7198.3 7225.6 7231.1 6656.2 6732.6 6806.6 6893.0 6925.8 6803.4 6825.2 6832.0 6848.8 7028.2 6752.4 6771.5 6774.1 6786.5 6792.3 6387.4 6464.0 6467.8 6469.2 6483.9 6523.3 6538.7 6564.5 6566.2 6575.1 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | [#4] prototype.html Cycles:180 Average:5153.39 Median:5836.05 stddev:1532.11 (26.3%) stddev-sans-first:1493.23 10:20:45 INFO - PROCESS | 30800 | Values: 341.1 341.5 346.8 348.5 351.2 5695.7 5781.6 5802.3 5844.5 5845.4 5595.3 5739.5 5743.1 5756.7 5760.2 4499.3 4527.7 4527.8 4530.5 4533.3 4320.5 4408.9 4436.6 4497.9 4515.6 4454.5 4459.8 4479.0 4480.5 4496.5 4476.3 4480.3 4480.7 4485.1 4492.1 3990.0 3994.8 3998.3 4000.2 4000.4 5385.8 5522.4 5555.9 5558.0 5583.9 5174.3 5177.6 5179.0 5179.8 5180.6 5832.4 6144.7 6147.8 6152.3 6155.9 4246.2 4251.2 4317.0 4337.0 4343.6 6273.6 6359.1 6382.0 6423.8 6429.8 4423.8 4425.5 4426.0 4428.7 4435.0 4349.4 4466.7 4472.3 4474.7 4480.9 5099.8 5118.7 5161.5 5167.6 5167.8 6120.4 6146.1 6149.0 6161.0 6161.1 1565.0 1585.7 1586.5 1587.6 1588.9 1061.0 1064.9 1067.6 1068.4 1093.3 5837.0 5839.0 5844.7 5851.4 5852.0 6283.4 6287.9 6290.5 6291.5 6317.1 5830.0 5835.1 5838.9 5843.2 5846.2 3292.8 3383.5 3394.7 3398.5 3406.7 6520.1 6521.7 6531.1 6533.3 6557.3 6491.3 6500.3 6542.3 6570.4 6571.3 6355.7 6524.2 6525.8 6527.8 6551.1 6104.4 6303.4 6309.6 6315.5 6318.9 6099.7 6239.1 6250.9 6261.5 6262.7 6559.6 6572.5 6580.7 6590.8 6593.9 4353.6 4440.9 4443.0 4447.8 4450.8 6340.2 6341.6 6360.5 6365.9 6371.2 6184.6 6201.2 6205.4 6207.5 6211.6 6034.1 6184.5 6184.8 6186.7 6196.2 6069.8 6073.4 6078.5 6084.3 6090.0 6206.4 6214.5 6215.0 6218.3 6218.4 5909.6 6070.6 6074.1 6080.8 6084.6 10:20:45 INFO - PROCESS | 30800 | 10:20:45 INFO - PROCESS | 30800 | [#5] yui.html Cycles:180 Average:12954.84 Median:43819.39 stddev:14514.15 (33.1%) stddev-sans-first:14526.41 10:20:45 INFO - PROCESS | 30800 | Values: 852.5 858.7 863.3 881.6 884.9 12527.9 12769.9 12780.9 12809.4 12833.3 12843.7 13008.9 13082.6 13083.9 13085.9 676.0 687.1 818.1 827.9 828.8 673.2 801.3 819.6 820.5 821.1 850.0 853.0 855.2 855.9 857.0 706.6 717.8 849.6 850.6 850.9 524.4 625.7 629.0 635.6 636.1 12890.9 13013.9 13045.6 13081.3 13082.7 12175.2 12404.3 12613.3 12831.9 13207.4 10347.4 10497.4 10537.7 10648.3 10762.7 3523.8 3550.0 3560.7 3586.7 3674.1 43682.3 43841.8 43874.0 44201.3 44314.6 10004.7 10098.0 10214.8 10221.8 10250.5 16679.2 16751.0 16759.7 16773.0 16801.6 7547.5 7632.6 7654.9 7848.2 7968.7 4045.7 4048.3 4078.6 4086.3 4091.1 3173.4 3198.0 3203.1 3212.3 3218.7 586.7 602.9 604.6 614.6 628.6 545.1 573.3 587.5 606.7 607.0 8002.0 8218.5 8326.2 8386.2 8554.1 513.5 559.2 575.8 586.5 605.6 3722.2 3753.5 3792.7 3932.3 3958.5 50829.2 51676.0 52257.0 52573.0 52709.2 46889.5 47304.8 47448.8 47608.3 47625.8 43239.1 43283.8 43797.0 43935.3 43943.0 7518.6 7906.0 7974.7 7990.4 8035.4 29892.7 30858.2 31099.5 31162.7 31883.8 38225.4 40821.4 40917.2 41127.6 41310.6 9001.5 9743.0 9866.8 10674.3 10963.4 11014.0 11394.6 11758.8 11828.9 12215.5 10940.8 10962.8 11000.2 11507.9 11581.7 10562.8 10705.1 11133.3 11154.6 11547.5 10648.8 10997.8 11082.8 11322.3 11528.9 9131.5 9375.8 9583.9 9725.3 9740.9 9008.0 9138.8 9348.1 9793.4 9850.4 10:20:45 INFO - PROCESS | 30800 | -------- Summary: end -------- 10:20:45 INFO - PROCESS | 30800 | 10:20:46 INFO - TEST-INFO | 30800: exit 0 10:20:46 INFO - TEST-OK | dromaeo_css | took 1113004ms 10:20:46 INFO - TEST-START | kraken 10:20:46 INFO - operating with platform_type : linux_ 10:20:46 INFO - Initialising browser for kraken test... 10:20:46 INFO - TEST-INFO | started process 31003 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n_5XW/profile http://localhost:57017/getInfo.html) 10:20:50 INFO - PROCESS | 31003 | __metrics Screen width/height:1600/1200 10:20:50 INFO - PROCESS | 31003 | colorDepth:24 10:20:50 INFO - PROCESS | 31003 | Browser inner width/height: 1024/697 10:20:50 INFO - PROCESS | 31003 | __metrics 10:20:50 INFO - PROCESS | 31003 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:20:50 INFO - PROCESS | 31003 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:51 INFO - TEST-INFO | 31003: exit 0 10:20:51 INFO - Browser initialized. 10:20:51 INFO - Running cycle 1/1 for kraken test... 10:20:51 INFO - TEST-INFO | started process 31088 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n_5XW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:03 INFO - PROCESS | 31088 | RSS: Main: 150532096 10:21:03 INFO - PROCESS | 31088 | 10:21:05 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57017/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:06 INFO - PROCESS | 31088 | RSS: Main: 186871808 10:21:06 INFO - PROCESS | 31088 | 10:21:09 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57017/tests/kraken/driver.html?testName=audio-dft) 10:21:09 INFO - PROCESS | 31088 | RSS: Main: 177496064 10:21:09 INFO - PROCESS | 31088 | 10:21:12 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57017/tests/kraken/driver.html?testName=audio-fft) 10:21:13 INFO - PROCESS | 31088 | RSS: Main: 162336768 10:21:13 INFO - PROCESS | 31088 | 10:21:15 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57017/tests/kraken/driver.html?testName=audio-oscillator) 10:21:15 INFO - PROCESS | 31088 | RSS: Main: 164745216 10:21:15 INFO - PROCESS | 31088 | 10:21:17 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57017/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:18 INFO - PROCESS | 31088 | RSS: Main: 165769216 10:21:18 INFO - PROCESS | 31088 | 10:21:21 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57017/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:22 INFO - PROCESS | 31088 | RSS: Main: 166866944 10:21:22 INFO - PROCESS | 31088 | 10:21:25 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57017/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:25 INFO - PROCESS | 31088 | RSS: Main: 166612992 10:21:25 INFO - PROCESS | 31088 | 10:21:28 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57017/tests/kraken/driver.html?testName=json-parse-financial) 10:21:29 INFO - PROCESS | 31088 | RSS: Main: 166473728 10:21:29 INFO - PROCESS | 31088 | 10:21:30 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57017/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:31 INFO - PROCESS | 31088 | RSS: Main: 175370240 10:21:31 INFO - PROCESS | 31088 | 10:21:33 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:33 INFO - PROCESS | 31088 | RSS: Main: 174141440 10:21:33 INFO - PROCESS | 31088 | 10:21:35 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:36 INFO - PROCESS | 31088 | RSS: Main: 183668736 10:21:36 INFO - PROCESS | 31088 | 10:21:38 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:39 INFO - PROCESS | 31088 | RSS: Main: 190701568 10:21:39 INFO - PROCESS | 31088 | 10:21:41 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:42 INFO - PROCESS | 31088 | RSS: Main: 189132800 10:21:42 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | Cycle 1(1): loaded http://localhost:57017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57017/tests/kraken/driver.html?testName=ai-astar) 10:21:44 INFO - PROCESS | 31088 | RSS: Main: 246370304 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | __start_tp_report 10:21:44 INFO - PROCESS | 31088 | _x_x_mozilla_page_load 10:21:44 INFO - PROCESS | 31088 | _x_x_mozilla_page_load_details 10:21:44 INFO - PROCESS | 31088 | |i|pagename|runs| 10:21:44 INFO - PROCESS | 31088 | |0;ai-astar;108;111;104;109;110;110;99;109;109;108 10:21:44 INFO - PROCESS | 31088 | |1;audio-beat-detection;153;126;148;169;123;151;152;125;174;124 10:21:44 INFO - PROCESS | 31088 | |2;audio-dft;161;161;159;159;160;161;160;162;162;163 10:21:44 INFO - PROCESS | 31088 | |3;audio-fft;74;72;96;93;73;73;70;123;91;71 10:21:44 INFO - PROCESS | 31088 | |4;audio-oscillator;95;96;142;97;95;96;140;96;96;139 10:21:44 INFO - PROCESS | 31088 | |5;imaging-gaussian-blur;110;109;109;109;109;109;109;110;110;109 10:21:44 INFO - PROCESS | 31088 | |6;imaging-darkroom;147;146;146;145;145;145;146;146;146;145 10:21:44 INFO - PROCESS | 31088 | |7;imaging-desaturate;97;96;97;97;97;97;96;95;95;95 10:21:44 INFO - PROCESS | 31088 | |8;json-parse-financial;57;55;57;54;55;56;55;64;54;53 10:21:44 INFO - PROCESS | 31088 | |9;json-stringify-tinderbox;68;67;66;67;67;67;68;69;67;68 10:21:44 INFO - PROCESS | 31088 | |10;stanford-crypto-aes;81;82;89;82;82;83;83;83;82;81 10:21:44 INFO - PROCESS | 31088 | |11;stanford-crypto-ccm;115;116;115;118;111;116;112;115;112;114 10:21:44 INFO - PROCESS | 31088 | |12;stanford-crypto-pbkdf2;143;142;144;137;145;133;143;141;140;143 10:21:44 INFO - PROCESS | 31088 | |13;stanford-crypto-sha256-iterative;69;67;76;69;69;67;66;67;66;67 10:21:44 INFO - PROCESS | 31088 | __end_tp_report 10:21:44 INFO - PROCESS | 31088 | __start_cc_report 10:21:44 INFO - PROCESS | 31088 | _x_x_mozilla_cycle_collect,961 10:21:44 INFO - PROCESS | 31088 | __end_cc_report 10:21:44 INFO - PROCESS | 31088 | __startTimestamp1452882104340__endTimestamp 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | ------- Summary: start ------- 10:21:44 INFO - PROCESS | 31088 | Number of tests: 14 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:3.59 (3.3%) stddev-sans-first:3.81 10:21:44 INFO - PROCESS | 31088 | Values: 108.0 111.0 104.0 109.0 110.0 110.0 99.0 109.0 109.0 108.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.50 stddev:19.03 (12.6%) stddev-sans-first:19.93 10:21:44 INFO - PROCESS | 31088 | Values: 153.0 126.0 148.0 169.0 123.0 151.0 152.0 125.0 174.0 124.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 10:21:44 INFO - PROCESS | 31088 | Values: 161.0 161.0 159.0 159.0 160.0 161.0 160.0 162.0 162.0 163.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#3] audio-fft Cycles:10 Average:83.60 Median:73.50 stddev:17.14 (23.3%) stddev-sans-first:17.83 10:21:44 INFO - PROCESS | 31088 | Values: 74.0 72.0 96.0 93.0 73.0 73.0 70.0 123.0 91.0 71.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.50 (22.4%) stddev-sans-first:22.19 10:21:44 INFO - PROCESS | 31088 | Values: 95.0 96.0 142.0 97.0 95.0 96.0 140.0 96.0 96.0 139.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:21:44 INFO - PROCESS | 31088 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 10:21:44 INFO - PROCESS | 31088 | Values: 147.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.93 10:21:44 INFO - PROCESS | 31088 | Values: 97.0 96.0 97.0 97.0 97.0 97.0 96.0 95.0 95.0 95.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:3.09 (5.6%) stddev-sans-first:3.26 10:21:44 INFO - PROCESS | 31088 | Values: 57.0 55.0 57.0 54.0 55.0 56.0 55.0 64.0 54.0 53.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 10:21:44 INFO - PROCESS | 31088 | Values: 68.0 67.0 66.0 67.0 67.0 67.0 68.0 69.0 67.0 68.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.30 (2.8%) stddev-sans-first:2.35 10:21:44 INFO - PROCESS | 31088 | Values: 81.0 82.0 89.0 82.0 82.0 83.0 83.0 83.0 82.0 81.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:115.00 stddev:2.17 (1.9%) stddev-sans-first:2.29 10:21:44 INFO - PROCESS | 31088 | Values: 115.0 116.0 115.0 118.0 111.0 116.0 112.0 115.0 112.0 114.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:143.00 stddev:3.63 (2.5%) stddev-sans-first:3.79 10:21:44 INFO - PROCESS | 31088 | Values: 143.0 142.0 144.0 137.0 145.0 133.0 143.0 141.0 140.0 143.0 10:21:44 INFO - PROCESS | 31088 | 10:21:44 INFO - PROCESS | 31088 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.95 (4.3%) stddev-sans-first:3.11 10:21:44 INFO - PROCESS | 31088 | Values: 69.0 67.0 76.0 69.0 69.0 67.0 66.0 67.0 66.0 67.0 10:21:44 INFO - PROCESS | 31088 | -------- Summary: end -------- 10:21:44 INFO - PROCESS | 31088 | 10:21:45 INFO - TEST-INFO | 31088: exit 0 10:21:45 INFO - TEST-OK | kraken | took 58711ms 10:21:45 INFO - TEST-START | v8_7 10:21:45 INFO - operating with platform_type : linux_ 10:21:45 INFO - Initialising browser for v8_7 test... 10:21:45 INFO - TEST-INFO | started process 31335 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLKNeJF/profile http://localhost:57017/getInfo.html) 10:21:49 INFO - PROCESS | 31335 | __metrics Screen width/height:1600/1200 10:21:49 INFO - PROCESS | 31335 | colorDepth:24 10:21:49 INFO - PROCESS | 31335 | Browser inner width/height: 1024/697 10:21:49 INFO - PROCESS | 31335 | __metrics 10:21:49 INFO - PROCESS | 31335 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:21:49 INFO - PROCESS | 31335 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:50 INFO - TEST-INFO | 31335: exit 0 10:21:50 INFO - Browser initialized. 10:21:50 INFO - Running cycle 1/1 for v8_7 test... 10:21:50 INFO - TEST-INFO | started process 31418 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLKNeJF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:02 INFO - PROCESS | 31418 | RSS: Main: 149401600 10:22:02 INFO - PROCESS | 31418 | 10:22:24 INFO - PROCESS | 31418 | Cycle 1(1): loaded http://localhost:57017/tests/v8_7/run.html (next: http://localhost:57017/tests/v8_7/run.html) 10:22:25 INFO - PROCESS | 31418 | RSS: Main: 564887552 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | __start_tp_report 10:22:25 INFO - PROCESS | 31418 | _x_x_mozilla_page_load 10:22:25 INFO - PROCESS | 31418 | _x_x_mozilla_page_load_details 10:22:25 INFO - PROCESS | 31418 | |i|pagename|runs| 10:22:25 INFO - PROCESS | 31418 | |0;Richards;167.33601070950468 10:22:25 INFO - PROCESS | 31418 | |1;DeltaBlue;188.85741265344666 10:22:25 INFO - PROCESS | 31418 | |2;Encrypt;279.4076557697681 10:22:25 INFO - PROCESS | 31418 | |3;Decrypt;5153.846153846154 10:22:25 INFO - PROCESS | 31418 | |4;RayTrace;1126.126126126126 10:22:25 INFO - PROCESS | 31418 | |5;Earley;783.0853563038371 10:22:25 INFO - PROCESS | 31418 | |6;Boyer;12023.809523809523 10:22:25 INFO - PROCESS | 31418 | |7;RegExp;43510.63829787234 10:22:25 INFO - PROCESS | 31418 | |8;Splay;552.0833333333334 10:22:25 INFO - PROCESS | 31418 | |9;NavierStokes;4830.917874396136 10:22:25 INFO - PROCESS | 31418 | __end_tp_report 10:22:25 INFO - PROCESS | 31418 | __startTimestamp1452882145228__endTimestamp 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | ------- Summary: start ------- 10:22:25 INFO - PROCESS | 31418 | Number of tests: 10 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 167.3 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#1] DeltaBlue Cycles:1 Average:188.86 Median:188.86 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 188.9 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 279.4 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#3] Decrypt Cycles:1 Average:5153.85 Median:5153.85 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 5153.8 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#4] RayTrace Cycles:1 Average:1126.13 Median:1126.13 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 1126.1 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 783.1 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#6] Boyer Cycles:1 Average:12023.81 Median:12023.81 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 12023.8 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#7] RegExp Cycles:1 Average:43510.64 Median:43510.64 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 43510.6 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#8] Splay Cycles:1 Average:552.08 Median:552.08 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 552.1 10:22:25 INFO - PROCESS | 31418 | 10:22:25 INFO - PROCESS | 31418 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:22:25 INFO - PROCESS | 31418 | Values: 4830.9 10:22:25 INFO - PROCESS | 31418 | -------- Summary: end -------- 10:22:25 INFO - PROCESS | 31418 | 10:22:26 INFO - TEST-INFO | 31418: exit 0 10:22:26 INFO - TEST-OK | v8_7 | took 40892ms 10:22:26 INFO - SUITE-END | took 1212s 10:22:26 INFO - Completed test suite (00:20:12) 10:22:26 INFO - Working with test: dromaeo_css 10:22:26 INFO - Generating results file: dromaeo_css 10:22:26 INFO - Working with test: kraken 10:22:26 INFO - Generating results file: kraken 10:22:26 INFO - javascript benchmark 10:22:26 INFO - Working with test: v8_7 10:22:26 INFO - Generating results file: v8_7 10:22:26 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 10:22:26 INFO - process_Request line: dromaeo_css 6702.29 graph.html#tests=[[72,1,35]] 10:22:26 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:26 INFO - process_Request line: kraken 1487.00 graph.html#tests=[[232,1,35]] 10:22:26 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:26 INFO - process_Request line: v8_7 20199.08 graph.html#tests=[[230,1,35]] 10:22:26 INFO - RETURN: dromaeo_css: 6702.29 10:22:26 INFO - RETURN: kraken: 1487.00 10:22:26 INFO - RETURN: v8_7: 20199.08 10:22:26 INFO - javascript benchmark 10:22:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3174.4286028514866, 3180.5706229659004, 3210.2616398228392, 3234.239953610901, 3235.870565177393, 5077.263796749469, 5100.132977393842, 5135.22971554267, 5148.562372198363, 5157.097507936115, 5192.247124167003, 5193.662411943231, 5206.140986737193, 5249.763760630772, 5277.6305658603815, 4759.452662943762, 4767.380240568721, 4789.305550695147, 4820.445648750404, 4846.975765121169, 4786.952130478686, 4810.446798618152, 4839.3466881970835, 4862.3922009748785, 4865.562099411052, 4675.719456832601, 4717.9292310615365, 4769.093872164295, 4782.545658162469, 4805.183118869801, 4783.856484305442, 4790.640701947368, 4803.471618122004, 4823.686460380064, 4826.420829500447, 4754.0, 4756.571908528214, 4761.642876784255, 4761.761911904426, 4766.880827979294, 4931.038447502702, 5039.420466646309, 5097.337346145015, 5122.410922743895, 5210.426853046162, 5553.7778488860395, 5559.388467268597, 5564.610477266593, 5568.777248910039, 5572.192032155314, 5583.190437386556, 5596.244506991586, 5597.720113994284, 5601.187827764992, 5607.691576963265, 5133.076046311662, 5199.532042116228, 5231.503007214346, 5312.73436328182, 5334.1732031535175, 5718.085106383042, 5725.942740572541, 5729.684867332337, 5732.656040637575, 5755.740991655385, 5396.298481197419, 5517.034518959166, 5521.475459831309, 5529.281193444826, 5532.778688852401, 5558.138488534284, 5573.414791446839, 5598.1602759586385, 5611.466910643482, 5640.238567793295, 5497.147942068986, 5504.394516603171, 5506.531944784738, 5514.5864060195645, 5514.751836167382, 5444.0, 5526.47498487643, 5538.252335934678, 5568.303962004749, 5571.415001424792, 4272.636825869774, 4362.629176520031, 4389.1660584488845, 4417.646588272931, 4424.823007079681, 3877.747946383476, 3880.9223815524097, 3894.7078969077434, 3915.686745060388, 3917.8236979335998, 5161.819336323286, 5203.089459344599, 5241.711705856214, 5243.580513558906, 5246.029484545371, 5542.0, 5542.667439953616, 5546.805861794818, 5583.3858275589655, 5605.747741351649, 5169.06956747789, 5201.08980928336, 5206.349206349207, 5208.088584497774, 5224.138017227115, 4630.976845115752, 4721.244600863845, 4724.196886529298, 4725.149473094807, 4756.048790241965, 5710.914336284959, 5764.279465066867, 5770.971145144332, 5777.277840270051, 5828.766849326064, 5515.420880807618, 5528.170774383874, 5535.114381698909, 5539.196816461671, 5539.584531160099, 5670.319561652628, 5687.0, 5692.089265717631, 5702.45826646468, 5705.058665320342, 5496.917546236889, 5551.944480555143, 5553.0, 5557.888842223214, 5606.85982850432, 5555.972220138873, 5612.045952188219, 5612.971935140298, 5618.6628802272, 5638.2670252866865, 5409.891802164014, 5416.7020813855615, 5482.259894914295, 5498.780048798003, 5547.5007249347755, 5494.752736126964, 5529.253550770594, 5541.2796336476, 5541.916871246854, 5550.8057217997175, 5415.268938693226, 5438.428964958623, 5446.074167391474, 5449.700266485382, 5500.367457742251, 5469.644473109235, 5475.4524547544925, 5540.833774986757, 5544.833654990357, 5545.584081194007, 5393.703346315833, 5394.865128371665, 5395.865103372447, 5417.1874218865905, 5452.809151679672], "unit": "score", "name": "dojo.html", "value": 5158.228201336449}, {"lowerIsBetter": false, "replicates": [544.6568661743102, 545.2965674280179, 563.3071322273605, 574.184657785944, 579.0070029898723, 29000.709992900065, 29485.705142948536, 29501.40997180058, 29508.704912950863, 29546.40907181855, 35951.0, 36393.45409818855, 36437.0, 36503.0, 36577.0, 8238.835223295515, 8344.332453403744, 8347.332213422911, 8377.539235342054, 8391.076981532056, 8098.0, 8208.179182081803, 8210.548419836907, 8213.055498617647, 8213.137620549845, 8185.099639039701, 8260.710875119372, 8262.628181731836, 8467.703630372938, 8477.448965817202, 8320.043195032587, 8342.332613390914, 8367.83264334713, 8370.497770133812, 8421.95789021054, 8370.288525475342, 8530.019047809457, 8560.443571167916, 8567.657293708244, 8569.185927336894, 38648.03379915497, 39100.608993909984, 39155.60844391548, 39165.804170979245, 39199.60800392017, 3463.41122009259, 3652.977166393414, 3803.6766874815676, 3996.660283875874, 4133.42132101506, 29937.101886943427, 29971.0, 30266.0, 30402.0, 30411.695883041106, 3044.8173109613494, 3073.9231519211976, 3206.0381885434276, 3302.9834850825832, 3332.4001679697644, 265376.0, 265822.0, 265950.6702466495, 266203.0, 268677.0, 55403.44596554063, 55676.16485752717, 55942.720286398304, 55949.0, 55957.999999999185, 59604.0, 59618.0, 59636.40363596395, 59734.402655973754, 59915.400845991855, 14453.710925781426, 14557.12657240569, 14642.707145857235, 14649.267536623127, 14650.120992740469, 10599.576016959236, 10640.361578305326, 10651.09465695409, 10655.30740501865, 10660.840087398696, 18360.449186524427, 18549.35077272289, 18683.532911677317, 18791.34230301933, 18864.339748109025, 6504.38208370204, 7350.485466017328, 7570.545767253872, 7696.345810606049, 7718.459707820511, 937.4188003437775, 940.6331530703031, 1016.506994107857, 1056.5456853553046, 1059.7880423915249, 26307.34231644186, 28594.857025715155, 29215.415691686474, 30118.536368317487, 31177.0, 1028.6759670703705, 1042.1454407386022, 1044.8171569975375, 1115.9163062770324, 1121.3103941076342, 14017.649558760908, 14068.366923488467, 14234.857651423561, 14236.786448203286, 14250.857491424953, 302681.0, 312669.0, 348670.0, 439819.0, 455095.0, 44821.0, 45328.77335613301, 45417.77291113589, 45447.0, 45501.31748023782, 1321.2931081871345, 1337.8595247499068, 1350.4193196925416, 1350.7501112294258, 1352.5468967895667, 23786.40533986664, 27916.30209244785, 28277.57583636288, 28609.570856436752, 28760.71239287664, 41616.0, 41974.58025419829, 41982.0, 42017.78991105147, 42037.11480392809, 204860.0, 205781.0, 206366.0, 206498.0, 206818.0, 30606.0, 30934.845325774128, 30997.0, 31032.0, 31888.68111318857, 41255.58744412517, 42459.57540424556, 42674.0, 42689.5731042698, 42762.35856462093, 34486.03410607712, 35093.0, 35679.46480802842, 36116.45825312675, 36349.0, 35240.0, 35666.63347605235, 35813.64186358103, 36676.26647467089, 36755.0, 34786.0, 35065.824670876485, 35513.82243088768, 35601.28797424089, 35642.46536302009, 29488.852555737085, 30382.696173037988, 31625.0, 32393.676063240007, 32447.837760811046, 24868.37829054288, 25289.49421011533, 25429.491410172064, 25544.61683074718, 25560.616590750782], "unit": "score", "name": "ext.html", "value": 17636.833057951517}, {"lowerIsBetter": false, "replicates": [366.54731406712705, 366.6938106680921, 367.18668150047654, 368.9262147570485, 378.9204267103908, 14303.356348964295, 14815.481458148966, 15598.220088995547, 17172.398966036177, 18074.367397141104, 16456.27209143041, 16498.587535311624, 16511.17444127792, 16808.32766689331, 16900.0, 5226.686398816064, 5436.456354364552, 5441.809536666217, 5444.8366549003595, 5446.754896029688, 3993.460882780831, 4120.876373708794, 5314.282571852808, 5606.187102870082, 5817.650940943557, 5576.107822748361, 5685.886282274373, 5776.046952252894, 5780.710964451781, 5799.0, 5728.341240757304, 5736.0, 5755.309362876482, 5764.538836893039, 5778.0, 4960.826371076995, 5126.026055049529, 5151.072806894757, 5152.458991805881, 5152.845414637567, 19577.21691132353, 19822.306219282254, 19891.50271243216, 20014.69977950332, 20020.49948751278, 1844.4282272495436, 1944.8735832170864, 2046.3349411441193, 2110.89445527723, 2202.856814307081, 9001.864972025425, 9367.76580585484, 9500.809983800355, 11133.72165695856, 12361.458307551455, 1850.2691436882355, 1899.7530321058312, 1911.923523059076, 1916.1185854506944, 1922.0581914861616, 54351.0, 54446.45553544453, 54582.45417545814, 55731.442685573435, 55917.0, 9534.332596718163, 9710.368826026286, 9728.221742260603, 9732.513374331254, 9793.90206097944, 12510.437030333656, 12520.87479125197, 12521.311327876872, 12528.81206781899, 12529.624111276677, 6598.967005165039, 6742.157230346207, 6805.3875151236625, 6810.080639113657, 6921.307869213139, 6372.872542549216, 6396.9360306397275, 6427.903581446189, 6464.741410343628, 6514.185726784152, 3960.366341385422, 4158.397032430281, 4182.790860456965, 4192.434021407132, 4219.894502637459, 1724.1637805664243, 1756.7891852977468, 1800.090954068187, 1808.2405389736343, 1824.3432364348823, 417.4614746976427, 422.6323098903973, 426.1966193724851, 444.355684257821, 956.9425784508157, 9481.762955926157, 9572.521373931275, 10610.522526486327, 10668.253222274367, 10782.56869725218, 453.26118426964496, 454.06462686865166, 454.8976480291908, 458.72476514091943, 458.7866642011414, 9427.575759090858, 10122.848157277647, 10245.7438564035, 10277.171291161736, 10383.63657272007, 540458.568499849, 541104.0, 541927.0, 543037.0, 545215.0, 72329.0, 72705.2729472709, 72785.27214727785, 73003.26996730072, 73682.0, 1012.1143999000874, 1040.0691381213921, 1041.6406339812752, 1043.4939054558533, 1044.185535282481, 13965.720685586435, 14002.859971400563, 14399.568012959628, 15020.774688379464, 15313.234338282818, 30836.84581577078, 31194.376112478076, 31296.843515782275, 31424.214394640316, 32413.027609171764, 33904.83047584746, 38213.617863821004, 39454.0, 39716.602833971294, 40039.0, 6800.93199068003, 6974.895376569457, 7327.926720732725, 7384.52000619958, 7403.111626604842, 9212.723618291462, 10196.4391958443, 11135.10919126484, 11269.492872820907, 11653.6503904883, 9062.592183351633, 9246.815063698823, 9641.27690423235, 9766.414015159113, 9812.215022798016, 9390.577424016072, 9443.952780236055, 9456.432614043179, 9719.805603888024, 9781.41311521311, 9318.627254909728, 9393.154616084585, 9636.662716805158, 9872.703818885446, 10131.898681013095, 7141.0, 7325.853482930205, 7351.713450146096, 7406.481546291708, 7414.147373051952, 9690.903090969001, 10023.548940297558, 10075.697729068139, 10141.543630536496, 10361.481925903825], "unit": "score", "name": "jquery.html", "value": 7659.277919532325}, {"lowerIsBetter": false, "replicates": [1321.7686904791672, 1417.3267697843523, 1453.694724107937, 1606.767018782276, 1808.312841120374, 7032.12098487689, 7630.969819074423, 7737.999999999986, 7740.419468539861, 7745.806354841117, 7669.808254793633, 7834.686612535492, 7846.176151504095, 7848.686052557905, 7850.175731548191, 2065.4216819290546, 2125.415510734545, 2335.8364914455997, 2378.072551704841, 2403.831731778776, 2361.645753137026, 2373.8100951923807, 2376.4296568823443, 2378.0, 2378.3221781792195, 2313.2366319114653, 2393.509330587234, 2393.5811233034237, 2396.364963284731, 2404.699412573428, 2351.3651314145172, 2364.929052128439, 2411.1319924827135, 2411.686480757508, 2412.3969007748065, 2339.836211465198, 2366.408397900525, 2379.6787433696404, 2385.3559538924565, 2386.284114765581, 7953.323967462773, 7991.24083212094, 8037.919620803776, 8038.075621303567, 8048.034235891672, 4861.149298872719, 4968.080905032544, 4974.278729584226, 4994.200927851526, 4997.50024997501, 3145.921351966196, 3173.6826317368077, 3233.337165880989, 3243.6431992481043, 3251.6748325167296, 1039.8492218628332, 1054.504382940017, 1059.8463222832645, 1067.210264404343, 1071.2554774431774, 10965.61620343284, 11023.283486573348, 11024.50389732464, 11026.779464410747, 11034.172437067253, 4480.641548676098, 4512.142692888341, 4520.050789334211, 4585.839495617704, 4614.838480653161, 9365.719028429157, 9366.859497107549, 9368.531573421438, 9371.109744574254, 9371.953140234255, 4934.259861020804, 4947.82682606107, 4975.154223781966, 4980.05378977993, 4982.451930287665, 4504.324351347259, 4508.368828364031, 4547.954520454753, 4551.0, 4555.043440877386, 3448.3620530201492, 3492.1793378556526, 3756.492873462102, 3802.296575133609, 3826.3877779555137, 1275.661949583361, 1277.5847849448967, 1278.4119305119564, 1284.4220100954608, 1292.1988367212389, 1306.7843805772131, 1312.3831799054428, 1313.2317594207495, 1315.4409376015155, 1335.2589312931416, 7007.404370628554, 7096.219415864251, 7116.964415177891, 7117.608531530712, 7121.216666166718, 1079.8164312066967, 1087.0868470484832, 1104.6354702948008, 1109.3011402816173, 1117.944102794857, 5829.446202610745, 5912.852178695567, 5915.201447804578, 5917.911231331534, 5923.7926672566255, 9445.716628501155, 9639.18066964316, 9753.122219000325, 9937.900620993698, 9948.452835093995, 9695.90304096964, 9838.950805245928, 9845.212383009342, 9847.606095756233, 9861.556229969668, 7227.385672217921, 7358.153812311546, 7391.0, 7394.149672787591, 7564.810879728051, 7262.527935684164, 7309.342159205697, 7324.340809327186, 7326.120865496175, 7328.0, 8181.386396020442, 8279.254867061993, 8384.874226886725, 8547.0, 8549.316054715733, 8431.072582015851, 8555.272801811916, 8688.26149777276, 8693.782655433664, 8697.434666746642, 6342.841428964312, 6977.232504424611, 7097.538659987084, 7111.431085513043, 7121.643917804193, 6927.549709268881, 7014.894776578458, 7198.280171982759, 7225.63871806397, 7231.096112985877, 6656.23453302857, 6732.562383445061, 6806.625635589892, 6893.034975103389, 6925.826854328682, 6803.414573796857, 6825.180978282638, 6831.9658401707675, 6848.8287792803585, 7028.226895041644, 6752.426043786333, 6771.52599318043, 6774.051632771318, 6786.457083433413, 6792.320767923168, 6387.425131738166, 6464.0, 6467.838304042437, 6469.223693156851, 6483.935160648333, 6523.31505191967, 6538.673066346569, 6564.4748420127235, 6566.244881838458, 6575.112359831553], "unit": "score", "name": "mootools.html", "value": 4587.0725033553335}, {"lowerIsBetter": false, "replicates": [341.0824881069922, 341.50311297062774, 346.82312020869347, 348.520783922107, 351.223795412139, 5695.74369153388, 5781.62419442736, 5802.303723553175, 5844.503217226541, 5845.357010728816, 5595.300587426572, 5739.512141467981, 5743.138529220619, 5756.712164391784, 5760.193572899787, 4499.280115181572, 4527.660425468087, 4527.773611319429, 4530.546945305476, 4533.320001999694, 4320.546342634026, 4408.86773396797, 4436.64506839452, 4497.910041799162, 4515.61617262533, 4454.53227411122, 4459.840441485221, 4478.955210447886, 4480.52954439784, 4496.4829044659955, 4476.261416866213, 4480.305552639346, 4480.686351955364, 4485.1254005468945, 4492.14649216651, 3989.960100398988, 3994.7802870842092, 3998.260321840469, 4000.159966407058, 4000.3599424092004, 5385.757640906129, 5522.392536820947, 5555.8888822223735, 5558.0, 5583.8883222335735, 5174.275601415805, 5177.58579313654, 5179.0, 5179.792808287664, 5180.6373553851245, 5832.416758324133, 6144.692765361714, 6147.754089836401, 6152.323244443108, 6155.907661385038, 4246.171996460692, 4251.171021650779, 4317.0, 4337.0, 4343.630791382736, 6273.62358258506, 6359.109724638554, 6381.978883378683, 6423.807285781434, 6429.807105786787, 4423.800928958204, 4425.513193548707, 4425.955740442619, 4428.6678499112695, 4435.002124521957, 4349.434573505488, 4466.709663871838, 4472.306792447176, 4474.664400170001, 4480.865574032784, 5099.821506247264, 5118.692878427306, 5161.535461808456, 5167.560757335668, 5167.793288268427, 6120.44915957566, 6146.139540464339, 6148.9692551536955, 6161.014237722033, 6161.106639537242, 1565.037501936301, 1585.7145713771401, 1586.5319730679478, 1587.5872273208818, 1588.9126098064487, 1061.0397590180899, 1064.882862885082, 1067.556963860005, 1068.407034096084, 1093.2511229807449, 5836.970815145897, 5839.036558967723, 5844.707764611752, 5851.356350801409, 5851.9707401463575, 6283.434490895841, 6287.874242515124, 6290.528210384148, 6291.496680265568, 6317.052442133717, 5830.0, 5835.124731290341, 5838.941610583925, 5843.24037875082, 5846.1523079153285, 3292.8353582320788, 3383.5263063171174, 3394.6605339465855, 3398.5242066110764, 3406.659334066623, 6520.119783829123, 6521.739130434825, 6531.118299029666, 6533.314002029813, 6557.311482294386, 6491.253505846794, 6500.252470965899, 6542.3130571290285, 6570.441512471493, 6571.310012448624, 6355.682215889279, 6524.249711283168, 6525.836854078591, 6527.771527996498, 6551.0500977358015, 6104.4200800923845, 6303.36966303366, 6309.558330916791, 6315.4947604192475, 6318.873622527615, 6099.695015249308, 6239.06414037898, 6250.937490625036, 6261.530385221035, 6262.68686565679, 6559.6064236145985, 6572.474202063728, 6580.736770529125, 6590.769323073861, 6593.934060659332, 4353.586409291112, 4440.933385999278, 4442.977785111054, 4447.7998490067375, 4450.844220452269, 6340.239171299474, 6341.619502829845, 6360.459360954371, 6365.904511432424, 6371.23545174582, 6184.567080304336, 6201.162843016135, 6205.379462053758, 6207.472364849038, 6211.627302361872, 6034.09488576717, 6184.5052395809125, 6184.752609895554, 6186.721597528032, 6196.1635179250225, 6069.757209711562, 6073.392660733891, 6078.513718902389, 6084.269887613515, 6090.025595904634, 6206.410391012847, 6214.471769899609, 6214.9689251553455, 6218.284897236695, 6218.409251121137, 5909.556783241188, 6070.605410648293, 6074.119252708421, 6080.7567697291615, 6084.574079814371], "unit": "score", "name": "prototype.html", "value": 4662.838576334627}, {"lowerIsBetter": false, "replicates": [852.4996898647811, 858.7337925243176, 863.335231871459, 881.5988725130067, 884.8584226523756, 12527.937360313197, 12769.93615031926, 12780.872191278107, 12809.423575939094, 12833.294168820723, 12843.678908027305, 13008.93495532521, 13082.607521774338, 13083.934580327084, 13085.934570327136, 676.0, 687.1273482677022, 818.1368656067846, 827.8675411934091, 828.7513745876213, 673.2123415603755, 801.2708435323857, 819.6311659753105, 820.4871955028108, 821.1296026212204, 849.9745007649749, 852.9530875801828, 855.1576696953496, 855.9443636163629, 857.0, 706.58311596158, 717.7631381644045, 849.562475325208, 850.6044689219511, 850.8936382952162, 524.44408926538, 625.6715224507125, 628.9779857705004, 635.6027482823235, 636.1475622665604, 12890.87109128906, 13013.934930325382, 13045.608631741063, 13081.28052957087, 13082.672933176651, 12175.208611440317, 12404.317762523058, 12613.306268155247, 12831.935840320832, 13207.40566674502, 10347.379157250589, 10497.4226417547, 10537.683869483928, 10648.307859989076, 10762.677119686421, 3523.788572685647, 3549.964500355015, 3560.6795388414907, 3586.659267369596, 3674.1365779041903, 43682.34476482855, 43841.78079109584, 43874.0, 44201.33697994501, 44314.556854431685, 10004.749881253027, 10098.0, 10214.795704085876, 10221.795564088825, 10250.538725757358, 16679.166041697867, 16751.0, 16759.748603770953, 16773.0, 16801.579960501087, 7547.547147171187, 7632.618369081523, 7654.885176722353, 7848.215178482106, 7968.681252749825, 4045.7370270932297, 4048.2510735514024, 4078.592140785957, 4086.3053280942313, 4091.0590564170407, 3173.4129186100645, 3197.9840100799347, 3203.0711093782543, 3212.2932954750386, 3218.726408255278, 586.718375179916, 602.9246344206974, 604.6039843902252, 614.5513774944316, 628.6385328436077, 545.1241671714109, 573.2776701356238, 587.4683411512588, 606.7481994972037, 607.0257237134335, 8002.0, 8218.465799723119, 8326.209010144026, 8386.166715717407, 8554.101819308882, 513.5326852564149, 559.1808001278147, 575.7955925646335, 586.4985437451003, 605.5912259225006, 3722.181120153562, 3753.4932784074344, 3792.715546334036, 3932.3315036443873, 3958.4562020811904, 50829.23756143661, 51676.0, 52257.0, 52573.0, 52709.209361859605, 46889.53110468852, 47304.7634761824, 47448.762756186, 47608.285875711896, 47625.76187119042, 43239.135217296105, 43283.783581081894, 43797.0, 43935.34096988484, 43943.0, 7518.624068796429, 7906.0, 7974.720884769237, 7990.400719945911, 8035.437519373588, 29892.70107298986, 30858.228544285674, 31099.533506997865, 31162.688373116885, 31883.840580796947, 38225.4266186013, 40821.38767918543, 40917.1816563673, 41127.58872411238, 41310.586894130676, 9001.459912405277, 9743.0, 9866.802663946537, 10674.306170098918, 10963.397013164353, 11014.0, 11394.601188958346, 11758.764824703629, 11828.940855295668, 12215.511379544718, 10940.835887461853, 10962.780744385227, 11000.22998390137, 11507.942460287644, 11581.710457238636, 10562.788744225227, 10705.143588512745, 11133.332000080021, 11154.609588664358, 11547.538098475967, 10648.84026739584, 10997.835032474359, 11082.778344433227, 11322.26405283654, 11528.884711152781, 9131.497767622579, 9375.765605859908, 9583.904160958302, 9725.319227653996, 9740.853887191555, 9008.0, 9138.77153071152, 9348.1119293667, 9793.412395256308, 9850.408975461496], "unit": "score", "name": "yui.html", "value": 6081.459648708085}], "name": "dromaeo_css", "value": 6702.2886124867655}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 109.0, 110.0, 110.0, 99.0, 109.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 148.0, 169.0, 123.0, 151.0, 152.0, 125.0, 174.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 159.0, 160.0, 161.0, 160.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 96.0, 93.0, 73.0, 73.0, 70.0, 123.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 97.0, 95.0, 96.0, 140.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 57.0, 54.0, 55.0, 56.0, 55.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 68.0, 69.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 89.0, 82.0, 82.0, 83.0, 83.0, 83.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [115.0, 116.0, 115.0, 118.0, 111.0, 116.0, 112.0, 115.0, 112.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.4}, {"lowerIsBetter": true, "replicates": [143.0, 142.0, 144.0, 137.0, 145.0, 133.0, 143.0, 141.0, 140.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 76.0, 69.0, 69.0, 67.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1487.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [188.85741265344666], "unit": "score", "name": "DeltaBlue", "value": 350.09481000000017}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5153.846153846154], "unit": "score", "name": "Decrypt", "value": 51.647059701492495}, {"lowerIsBetter": false, "replicates": [1126.126126126126], "unit": "score", "name": "RayTrace", "value": 657.110232}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12023.809523809523], "unit": "score", "name": "Boyer", "value": 55.42860594059401}, {"lowerIsBetter": false, "replicates": [43510.63829787234], "unit": "score", "name": "RegExp", "value": 20.93706356968216}, {"lowerIsBetter": false, "replicates": [552.0833333333334], "unit": "score", "name": "Splay", "value": 147.60633962264157}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20199.077496089812}]} 10:22:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20199.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1487.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6702.29"}}} 10:22:26 INFO - Return code: 0 10:22:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:22:26 INFO - # TBPL SUCCESS # 10:22:26 INFO - Running post-action listener: _resource_record_post_action 10:22:26 INFO - Running post-run listener: _resource_record_post_run 10:22:27 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538693632; Read time: 392; Write time: 475560 10:22:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 236920832; Read time: 128; Write time: 215904 10:22:27 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301772800; Read time: 264; Write time: 259656 10:22:27 INFO - Running post-run listener: _upload_blobber_files 10:22:27 INFO - Blob upload gear active. 10:22:27 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:22:27 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:22:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:22:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:29 INFO - (blobuploader) - INFO - Done attempting. 10:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:29 INFO - (blobuploader) - INFO - Done attempting. 10:22:29 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:29 INFO - Return code: 0 10:22:29 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:22:29 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b47bb0181fcb2cffd584c9a57f9e471817d2767cbb893c7e022cfc9582cac43627b724bef0725b7e6e3600e9d8450b68632bf1d71854170aa64a2634dcd0559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b6199528c92afe4c7154be24d9e429b6d804738fcf165c6675dc14c22691c7201226948263f1723ea1fba4f06733b87786663158708694d50d5b0a0481a072"} 10:22:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:22:29 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:22:29 INFO - Contents: 10:22:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b47bb0181fcb2cffd584c9a57f9e471817d2767cbb893c7e022cfc9582cac43627b724bef0725b7e6e3600e9d8450b68632bf1d71854170aa64a2634dcd0559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b6199528c92afe4c7154be24d9e429b6d804738fcf165c6675dc14c22691c7201226948263f1723ea1fba4f06733b87786663158708694d50d5b0a0481a072"} 10:22:29 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:29 INFO - Copying logs to upload dir... 10:22:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:22:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.622699 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-15 10:22:29.621915) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:29.624938) ========= 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=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b47bb0181fcb2cffd584c9a57f9e471817d2767cbb893c7e022cfc9582cac43627b724bef0725b7e6e3600e9d8450b68632bf1d71854170aa64a2634dcd0559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b6199528c92afe4c7154be24d9e429b6d804738fcf165c6675dc14c22691c7201226948263f1723ea1fba4f06733b87786663158708694d50d5b0a0481a072"} build_url:https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b47bb0181fcb2cffd584c9a57f9e471817d2767cbb893c7e022cfc9582cac43627b724bef0725b7e6e3600e9d8450b68632bf1d71854170aa64a2634dcd0559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b6199528c92afe4c7154be24d9e429b6d804738fcf165c6675dc14c22691c7201226948263f1723ea1fba4f06733b87786663158708694d50d5b0a0481a072"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:29.649995) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:29.650405) ========= 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=836cfdc75598d54cb747368e000001a9-1452873775.256229-1536887167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:29.736764) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:22:29.737262) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:22:29.737715) ========= ========= Total master_lag: 0.27 =========