builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1453074372.56 results: success (0) buildid: 20160117133002 builduid: 74ed9581aa394b2b831295cb764ad5f3 revision: 0a4331e7d7ba21c3a54d9f17fb6ed1f42b7c29ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.558975) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.559399) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.559735) ========= 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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006304 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.608296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.608635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.693952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.694250) ========= 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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.761445) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.761783) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.762168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.762469) ========= 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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-17 15:46: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% 222M=0s 2016-01-17 15:46:13 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.952909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:12.953624) ========= 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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013484 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.007317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.007664) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a4331e7d7ba21c3a54d9f17fb6ed1f42b7c29ec --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 0a4331e7d7ba21c3a54d9f17fb6ed1f42b7c29ec --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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-17 15:46:13,573 truncating revision to first 12 chars 2016-01-17 15:46:13,573 Setting DEBUG logging. 2016-01-17 15:46:13,573 attempt 1/10 2016-01-17 15:46:13,573 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a4331e7d7ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-17 15:46:13,844 unpacking tar archive at: mozilla-central-0a4331e7d7ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.610785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.611100) ========= 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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004687 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.663182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.663485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.684519) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.684826) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 15:46:13.685219) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-17 15:46:13.685533) ========= /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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:46:14 INFO - MultiFileLogger online at 20160117 15:46:14 in /builds/slave/test-pgo 15:46:14 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 15:46:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:46:14 INFO - {'append_to_log': False, 15:46:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:46:14 INFO - 'blob_upload_branch': 'Firefox', 15:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:46:14 INFO - 'branch': 'Firefox', 15:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:46:14 INFO - 'config_files': ('talos/linux_config.py',), 15:46:14 INFO - 'default_actions': ('clobber', 15:46:14 INFO - 'read-buildbot-config', 15:46:14 INFO - 'download-and-extract', 15:46:14 INFO - 'populate-webroot', 15:46:14 INFO - 'create-virtualenv', 15:46:14 INFO - 'install', 15:46:14 INFO - 'run-tests'), 15:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:46:14 INFO - 'download_minidump_stackwalk': True, 15:46:14 INFO - 'download_symbols': 'ondemand', 15:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:46:14 INFO - 'installer_path': 'installer.exe', 15:46:14 INFO - 'log_level': 'info', 15:46:14 INFO - 'log_name': 'talos', 15:46:14 INFO - 'log_to_console': True, 15:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:46:14 INFO - 'opt_config_files': (), 15:46:14 INFO - 'pip_index': False, 15:46:14 INFO - 'sps_profile': False, 15:46:14 INFO - 'sps_profile_interval': 0, 15:46:14 INFO - 'suite': 'dromaeojs', 15:46:14 INFO - 'system_bits': '32', 15:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:46:14 INFO - 'title': 'talos-linux64-ix-028', 15:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:46:14 INFO - 'use_talos_json': True, 15:46:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:46:14 INFO - 'work_dir': 'build'} 15:46:14 INFO - ##### 15:46:14 INFO - ##### Running clobber step. 15:46:14 INFO - ##### 15:46:14 INFO - Running pre-action listener: _resource_record_pre_action 15:46:14 INFO - Running main action method: clobber 15:46:14 INFO - rmtree: /builds/slave/test-pgo/build 15:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:46:15 INFO - Running post-action listener: _resource_record_post_action 15:46:15 INFO - ##### 15:46:15 INFO - ##### Running read-buildbot-config step. 15:46:15 INFO - ##### 15:46:15 INFO - Running pre-action listener: _resource_record_pre_action 15:46:15 INFO - Running main action method: read_buildbot_config 15:46:15 INFO - Using buildbot properties: 15:46:15 INFO - { 15:46:15 INFO - "project": "", 15:46:15 INFO - "product": "firefox", 15:46:15 INFO - "script_repo_revision": "production", 15:46:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:46:15 INFO - "repository": "", 15:46:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 15:46:15 INFO - "buildid": "20160117133002", 15:46:15 INFO - "pgo_build": "True", 15:46:15 INFO - "basedir": "/builds/slave/test-pgo", 15:46:15 INFO - "buildnumber": 310, 15:46:15 INFO - "slavename": "talos-linux64-ix-028", 15:46:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:46:15 INFO - "platform": "ubuntu64_hw", 15:46:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 15:46:15 INFO - "branch": "mozilla-central", 15:46:15 INFO - "repo_path": "mozilla-central", 15:46:15 INFO - "revision": "0a4331e7d7ba21c3a54d9f17fb6ed1f42b7c29ec", 15:46:15 INFO - "stage_platform": "linux64-pgo", 15:46:15 INFO - "builduid": "74ed9581aa394b2b831295cb764ad5f3", 15:46:15 INFO - "slavebuilddir": "test" 15:46:15 INFO - } 15:46:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:46:15 INFO - Running post-action listener: _resource_record_post_action 15:46:15 INFO - ##### 15:46:15 INFO - ##### Running download-and-extract step. 15:46:15 INFO - ##### 15:46:15 INFO - Running pre-action listener: _resource_record_pre_action 15:46:15 INFO - Running main action method: download_and_extract 15:46:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:15 INFO - https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:46:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/test_packages.json 15:46:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/test_packages.json 15:46:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:46:17 INFO - Downloaded 1448 bytes. 15:46:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:46:17 INFO - Using the following test package requirements: 15:46:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:46:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:46:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'jsshell-linux-x86_64.zip'], 15:46:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:46:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:46:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:46:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:46:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:46:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:17 INFO - https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:29 INFO - Downloaded 22484106 bytes. 15:46:29 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'] 15:46:29 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 15:46:30 INFO - Return code: 0 15:46:30 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 15:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:30 INFO - https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:39 INFO - Downloaded 22484106 bytes. 15:46:39 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'] 15:46:39 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 15:46:40 INFO - Return code: 0 15:46: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')]} 15:46:40 INFO - https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:42 INFO - Downloaded 11132144 bytes. 15:46:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:46:42 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 15:46:42 INFO - Return code: 0 15:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:42 INFO - https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KiE8WmswTsql7qZOkANtmQ/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 15:46:45 INFO - Downloaded 55957716 bytes. 15:46:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:46:45 INFO - mkdir: /builds/slave/test-pgo/properties 15:46:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:46:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:46:45 INFO - Contents: 15:46:45 INFO - build_url:https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:46:45 INFO - Running post-action listener: _resource_record_post_action 15:46:45 INFO - Running post-action listener: set_extra_try_arguments 15:46:45 INFO - ##### 15:46:45 INFO - ##### Running populate-webroot step. 15:46:45 INFO - ##### 15:46:45 INFO - Running pre-action listener: _resource_record_pre_action 15:46:45 INFO - Running main action method: populate_webroot 15:46:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:46:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:46:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:46:45 INFO - '--tppagecycles', 15:46:45 INFO - '7'], 15:46:45 INFO - 'tests': ['tsvgm']}}, 15:46:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:46:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:46:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:46:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:46:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:46:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:46:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'tests': ['damp', 'tps']}, 15:46:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['damp', 'tps']}, 15:46:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:46:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:46:45 INFO - 'other': {'tests': ['a11yr', 15:46:45 INFO - 'ts_paint', 15:46:45 INFO - 'tpaint', 15:46:45 INFO - 'sessionrestore', 15:46:45 INFO - 'sessionrestore_no_auto_restore']}, 15:46:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['a11yr', 15:46:45 INFO - 'ts_paint', 15:46:45 INFO - 'tpaint', 15:46:45 INFO - 'sessionrestore', 15:46:45 INFO - 'sessionrestore_no_auto_restore']}, 15:46:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['a11yr', 15:46:45 INFO - 'ts_paint', 15:46:45 INFO - 'tpaint', 15:46:45 INFO - 'sessionrestore', 15:46:45 INFO - 'sessionrestore_no_auto_restore']}, 15:46:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['a11yr', 15:46:45 INFO - 'ts_paint', 15:46:45 INFO - 'tpaint', 15:46:45 INFO - 'sessionrestore', 15:46:45 INFO - 'sessionrestore_no_auto_restore']}, 15:46:45 INFO - 'other_l64': {'tests': ['a11yr', 15:46:45 INFO - 'ts_paint', 15:46:45 INFO - 'tpaint', 15:46:45 INFO - 'sessionrestore', 15:46:45 INFO - 'sessionrestore_no_auto_restore']}, 15:46:45 INFO - 'other_nol64': {'tests': ['a11yr', 15:46:45 INFO - 'ts_paint', 15:46:45 INFO - 'tpaint', 15:46:45 INFO - 'sessionrestore', 15:46:45 INFO - 'sessionrestore_no_auto_restore']}, 15:46:45 INFO - 'svgr': {'tests': ['tsvgx', 15:46:45 INFO - 'tsvgr_opacity', 15:46:45 INFO - 'tart', 15:46:45 INFO - 'tscrollx', 15:46:45 INFO - 'cart']}, 15:46:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['tsvgx', 15:46:45 INFO - 'tsvgr_opacity', 15:46:45 INFO - 'tart', 15:46:45 INFO - 'tscrollx', 15:46:45 INFO - 'cart']}, 15:46:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'tests': ['tp5o']}, 15:46:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'talos_options': ['--e10s'], 15:46:45 INFO - 'tests': ['tp5o']}, 15:46:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'talos_options': ['--xperf_path', 15:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:46:45 INFO - 'tests': ['tp5n']}, 15:46:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:45 INFO - 'talos_options': ['--e10s', 15:46:45 INFO - '--xperf_path', 15:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:46:45 INFO - 'tests': ['tp5n']}}, 15:46:45 INFO - 'talos.zip': {'path': '', 15:46:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:46:45 INFO - Running post-action listener: _resource_record_post_action 15:46:45 INFO - ##### 15:46:45 INFO - ##### Running create-virtualenv step. 15:46:45 INFO - ##### 15:46:45 INFO - Running pre-action listener: _resource_record_pre_action 15:46:45 INFO - Running main action method: create_virtualenv 15:46:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:46:45 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 15:46:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:46:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:46:45 INFO - Using real prefix '/usr' 15:46:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 15:46:47 INFO - Installing pip.................done. 15:46:47 INFO - Return code: 0 15:46:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:46:47 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')]} 15:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:47 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')]} 15:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:47 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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:46:47 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 15:46:47 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 15:46:47 INFO - Using env: {'DISPLAY': ':0', 15:46:47 INFO - 'HOME': '/home/cltbld', 15:46:47 INFO - 'LANG': 'en_US.UTF-8', 15:46:47 INFO - 'LANGUAGE': 'en_US:en', 15:46:47 INFO - 'LOGNAME': 'cltbld', 15:46:47 INFO - 'MAIL': '/var/mail/cltbld', 15:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:47 INFO - 'MOZ_NO_REMOTE': '1', 15:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:47 INFO - 'NO_EM_RESTART': '1', 15:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:47 INFO - 'SHELL': '/bin/bash', 15:46:47 INFO - 'SHLVL': '1', 15:46:47 INFO - 'TERM': 'linux', 15:46:47 INFO - 'TMOUT': '86400', 15:46:47 INFO - 'USER': 'cltbld', 15:46:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:47 INFO - '_': '/tools/buildbot/bin/python'} 15:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:48 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 15:46:48 INFO - Cleaning up... 15:46:48 INFO - Return code: 0 15:46:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:48 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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:46:48 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 15:46:48 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 15:46:48 INFO - Using env: {'DISPLAY': ':0', 15:46:48 INFO - 'HOME': '/home/cltbld', 15:46:48 INFO - 'LANG': 'en_US.UTF-8', 15:46:48 INFO - 'LANGUAGE': 'en_US:en', 15:46:48 INFO - 'LOGNAME': 'cltbld', 15:46:48 INFO - 'MAIL': '/var/mail/cltbld', 15:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:48 INFO - 'MOZ_NO_REMOTE': '1', 15:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:48 INFO - 'NO_EM_RESTART': '1', 15:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:48 INFO - 'SHELL': '/bin/bash', 15:46:48 INFO - 'SHLVL': '1', 15:46:48 INFO - 'TERM': 'linux', 15:46:48 INFO - 'TMOUT': '86400', 15:46:48 INFO - 'USER': 'cltbld', 15:46:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:48 INFO - '_': '/tools/buildbot/bin/python'} 15:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:48 INFO - Downloading/unpacking psutil>=0.7.1 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:46:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:46:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:46:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:46:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:46:50 INFO - Installing collected packages: psutil 15:46:50 INFO - Running setup.py install for psutil 15:46:50 INFO - building 'psutil._psutil_linux' extension 15:46:50 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 15:46:50 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 15:46:50 INFO - building 'psutil._psutil_posix' extension 15:46:50 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 15:46:50 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 15:46:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:46:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:46:50 INFO - Successfully installed psutil 15:46:50 INFO - Cleaning up... 15:46:50 INFO - Return code: 0 15:46:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:46: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')]} 15:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46: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')]} 15:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46: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', '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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:46: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:46: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 mozsystemmonitor==0.0.0 15:46:50 INFO - Using env: {'DISPLAY': ':0', 15:46:50 INFO - 'HOME': '/home/cltbld', 15:46:50 INFO - 'LANG': 'en_US.UTF-8', 15:46:50 INFO - 'LANGUAGE': 'en_US:en', 15:46:50 INFO - 'LOGNAME': 'cltbld', 15:46:50 INFO - 'MAIL': '/var/mail/cltbld', 15:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:50 INFO - 'MOZ_NO_REMOTE': '1', 15:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:50 INFO - 'NO_EM_RESTART': '1', 15:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:50 INFO - 'SHELL': '/bin/bash', 15:46:50 INFO - 'SHLVL': '1', 15:46:50 INFO - 'TERM': 'linux', 15:46:50 INFO - 'TMOUT': '86400', 15:46:50 INFO - 'USER': 'cltbld', 15:46:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:50 INFO - '_': '/tools/buildbot/bin/python'} 15:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:46:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:46:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:46:52 INFO - Installing collected packages: mozsystemmonitor 15:46:52 INFO - Running setup.py install for mozsystemmonitor 15:46:52 INFO - Successfully installed mozsystemmonitor 15:46:52 INFO - Cleaning up... 15:46:52 INFO - Return code: 0 15:46:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:46:52 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')]} 15:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:52 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')]} 15:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:52 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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:46:52 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 15:46:52 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 15:46:52 INFO - Using env: {'DISPLAY': ':0', 15:46:52 INFO - 'HOME': '/home/cltbld', 15:46:52 INFO - 'LANG': 'en_US.UTF-8', 15:46:52 INFO - 'LANGUAGE': 'en_US:en', 15:46:52 INFO - 'LOGNAME': 'cltbld', 15:46:52 INFO - 'MAIL': '/var/mail/cltbld', 15:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:52 INFO - 'MOZ_NO_REMOTE': '1', 15:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:52 INFO - 'NO_EM_RESTART': '1', 15:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:52 INFO - 'SHELL': '/bin/bash', 15:46:52 INFO - 'SHLVL': '1', 15:46:52 INFO - 'TERM': 'linux', 15:46:52 INFO - 'TMOUT': '86400', 15:46:52 INFO - 'USER': 'cltbld', 15:46:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:52 INFO - '_': '/tools/buildbot/bin/python'} 15:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:54 INFO - Downloading blobuploader-1.2.4.tar.gz 15:46:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:46:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:46:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:46:54 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 15:46:54 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 15:46:54 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 15:46:54 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 15:46:54 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 15:46:54 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 15:46:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:46:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46: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 15:46:55 INFO - Downloading docopt-0.6.1.tar.gz 15:46:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:46:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:46:55 INFO - Running setup.py install for blobuploader 15:46:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:46:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:46:55 INFO - Running setup.py install for requests 15:46:55 INFO - Running setup.py install for docopt 15:46:56 INFO - Successfully installed blobuploader requests docopt 15:46:56 INFO - Cleaning up... 15:46:56 INFO - Return code: 0 15:46:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:46:56 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')]} 15:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:56 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')]} 15:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:56 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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:46:56 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 15:46:56 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 15:46:56 INFO - Using env: {'DISPLAY': ':0', 15:46:56 INFO - 'HOME': '/home/cltbld', 15:46:56 INFO - 'LANG': 'en_US.UTF-8', 15:46:56 INFO - 'LANGUAGE': 'en_US:en', 15:46:56 INFO - 'LOGNAME': 'cltbld', 15:46:56 INFO - 'MAIL': '/var/mail/cltbld', 15:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:56 INFO - 'MOZ_NO_REMOTE': '1', 15:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:56 INFO - 'NO_EM_RESTART': '1', 15:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:56 INFO - 'SHELL': '/bin/bash', 15:46:56 INFO - 'SHLVL': '1', 15:46:56 INFO - 'TERM': 'linux', 15:46:56 INFO - 'TMOUT': '86400', 15:46:56 INFO - 'USER': 'cltbld', 15:46:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:56 INFO - '_': '/tools/buildbot/bin/python'} 15:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:56 INFO - Running setup.py (path:/tmp/pip-LYFG3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:56 INFO - Running setup.py (path:/tmp/pip-i5Mnt6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:56 INFO - Running setup.py (path:/tmp/pip-6Vwijt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:56 INFO - Running setup.py (path:/tmp/pip-jUr_Qo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:56 INFO - Running setup.py (path:/tmp/pip-8ZHcUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:56 INFO - Running setup.py (path:/tmp/pip-oHW2EW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:46:56 INFO - Running setup.py (path:/tmp/pip-Ysyzr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:46:56 INFO - Running setup.py (path:/tmp/pip-KR3eO1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:46:56 INFO - Running setup.py (path:/tmp/pip-BdLWgD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:46:56 INFO - Running setup.py (path:/tmp/pip-77IVSK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:46:57 INFO - Running setup.py (path:/tmp/pip-qQP5fV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:46:57 INFO - Running setup.py (path:/tmp/pip-TmJQTY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:46:57 INFO - Running setup.py (path:/tmp/pip-JiqN0w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:46:57 INFO - Running setup.py (path:/tmp/pip-VOPI_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:46:57 INFO - Running setup.py (path:/tmp/pip-tq_m0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:46:57 INFO - Running setup.py (path:/tmp/pip-ASNdFC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:46:57 INFO - Running setup.py (path:/tmp/pip-jhsswA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:46:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:46:57 INFO - Running setup.py install for manifestparser 15:46:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:46:57 INFO - Running setup.py install for mozcrash 15:46:57 INFO - Running setup.py install for mozdebug 15:46:57 INFO - Running setup.py install for mozdevice 15:46:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:46:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:46:57 INFO - Running setup.py install for mozfile 15:46:58 INFO - Running setup.py install for mozhttpd 15:46:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Running setup.py install for mozinfo 15:46:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Running setup.py install for mozInstall 15:46:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Running setup.py install for mozleak 15:46:58 INFO - Running setup.py install for mozlog 15:46:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Running setup.py install for moznetwork 15:46:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Running setup.py install for mozprocess 15:46:58 INFO - Running setup.py install for mozprofile 15:46:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:46:58 INFO - Running setup.py install for mozrunner 15:46:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:46:59 INFO - Running setup.py install for mozscreenshot 15:46:59 INFO - Running setup.py install for moztest 15:46:59 INFO - Running setup.py install for mozversion 15:46:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:46:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:46:59 INFO - Cleaning up... 15:46:59 INFO - Return code: 0 15:46:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:59 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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:46:59 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 15:46:59 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 15:46:59 INFO - Using env: {'DISPLAY': ':0', 15:46:59 INFO - 'HOME': '/home/cltbld', 15:46:59 INFO - 'LANG': 'en_US.UTF-8', 15:46:59 INFO - 'LANGUAGE': 'en_US:en', 15:46:59 INFO - 'LOGNAME': 'cltbld', 15:46:59 INFO - 'MAIL': '/var/mail/cltbld', 15:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:59 INFO - 'MOZ_NO_REMOTE': '1', 15:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:59 INFO - 'NO_EM_RESTART': '1', 15:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:59 INFO - 'SHELL': '/bin/bash', 15:46:59 INFO - 'SHLVL': '1', 15:46:59 INFO - 'TERM': 'linux', 15:46:59 INFO - 'TMOUT': '86400', 15:46:59 INFO - 'USER': 'cltbld', 15:46:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:59 INFO - '_': '/tools/buildbot/bin/python'} 15:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:59 INFO - Running setup.py (path:/tmp/pip-eRDoRe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:59 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)) 15:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:59 INFO - Running setup.py (path:/tmp/pip-yJC0Tt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:59 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)) 15:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:59 INFO - Running setup.py (path:/tmp/pip-dQpVSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:59 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)) 15:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:59 INFO - Running setup.py (path:/tmp/pip-h_q3Gh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:59 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)) 15:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:59 INFO - Running setup.py (path:/tmp/pip-sfpAhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:59 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)) 15:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:59 INFO - Running setup.py (path:/tmp/pip-pyjMW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:59 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)) 15:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:46:59 INFO - Running setup.py (path:/tmp/pip-IZ9hAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:00 INFO - Running setup.py (path:/tmp/pip-85EasU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:00 INFO - Running setup.py (path:/tmp/pip-k31pi4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:00 INFO - Running setup.py (path:/tmp/pip-Uddpkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:00 INFO - Running setup.py (path:/tmp/pip-mG2TqA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:00 INFO - Running setup.py (path:/tmp/pip-jcYJAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:00 INFO - Running setup.py (path:/tmp/pip-wxVglM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:00 INFO - Running setup.py (path:/tmp/pip-1eGvg7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:00 INFO - Running setup.py (path:/tmp/pip-vIoUd_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:00 INFO - Running setup.py (path:/tmp/pip-p5afeL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:00 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)) 15:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:00 INFO - Running setup.py (path:/tmp/pip-wnY3PV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:00 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)) 15:47:00 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)) 15:47:00 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)) 15:47:00 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)) 15:47:00 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)) 15:47:00 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)) 15:47:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:00 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 15:47:00 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 15:47:00 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 15:47:00 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 15:47:00 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 15:47:00 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 15:47:02 INFO - Downloading blessings-1.5.1.tar.gz 15:47:02 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 15:47:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:47:02 INFO - Installing collected packages: blessings 15:47:02 INFO - Running setup.py install for blessings 15:47:02 INFO - Successfully installed blessings 15:47:02 INFO - Cleaning up... 15:47:02 INFO - Return code: 0 15:47:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:47:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:47:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:47:02 INFO - Reading from file tmpfile_stdout 15:47:02 INFO - Current package versions: 15:47:02 INFO - argparse == 1.2.1 15:47:02 INFO - blessings == 1.5.1 15:47:02 INFO - blobuploader == 1.2.4 15:47:02 INFO - docopt == 0.6.1 15:47:02 INFO - manifestparser == 1.1 15:47:02 INFO - mozInstall == 1.12 15:47:02 INFO - mozcrash == 0.16 15:47:02 INFO - mozdebug == 0.1 15:47:02 INFO - mozdevice == 0.48 15:47:02 INFO - mozfile == 1.2 15:47:02 INFO - mozhttpd == 0.7 15:47:02 INFO - mozinfo == 0.9 15:47:02 INFO - mozleak == 0.1 15:47:02 INFO - mozlog == 3.1 15:47:02 INFO - moznetwork == 0.27 15:47:02 INFO - mozprocess == 0.22 15:47:02 INFO - mozprofile == 0.28 15:47:02 INFO - mozrunner == 6.11 15:47:02 INFO - mozscreenshot == 0.1 15:47:02 INFO - mozsystemmonitor == 0.0 15:47:02 INFO - moztest == 0.7 15:47:02 INFO - mozversion == 1.4 15:47:02 INFO - psutil == 3.1.1 15:47:02 INFO - requests == 1.2.3 15:47:02 INFO - wsgiref == 0.1.2 15:47:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:47:02 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 15:47:02 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 15:47:02 INFO - Using env: {'DISPLAY': ':0', 15:47:02 INFO - 'HOME': '/home/cltbld', 15:47:02 INFO - 'LANG': 'en_US.UTF-8', 15:47:02 INFO - 'LANGUAGE': 'en_US:en', 15:47:02 INFO - 'LOGNAME': 'cltbld', 15:47:02 INFO - 'MAIL': '/var/mail/cltbld', 15:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:02 INFO - 'MOZ_NO_REMOTE': '1', 15:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:02 INFO - 'NO_EM_RESTART': '1', 15:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:02 INFO - 'SHELL': '/bin/bash', 15:47:02 INFO - 'SHLVL': '1', 15:47:02 INFO - 'TERM': 'linux', 15:47:02 INFO - 'TMOUT': '86400', 15:47:02 INFO - 'USER': 'cltbld', 15:47:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:02 INFO - '_': '/tools/buildbot/bin/python'} 15:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 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)) 15:47:03 INFO - Cleaning up... 15:47:03 INFO - Return code: 0 15:47:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:03 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 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:47:03 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 15:47:03 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 15:47:03 INFO - Using env: {'DISPLAY': ':0', 15:47:03 INFO - 'HOME': '/home/cltbld', 15:47:03 INFO - 'LANG': 'en_US.UTF-8', 15:47:03 INFO - 'LANGUAGE': 'en_US:en', 15:47:03 INFO - 'LOGNAME': 'cltbld', 15:47:03 INFO - 'MAIL': '/var/mail/cltbld', 15:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:03 INFO - 'MOZ_NO_REMOTE': '1', 15:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:03 INFO - 'NO_EM_RESTART': '1', 15:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:03 INFO - 'SHELL': '/bin/bash', 15:47:03 INFO - 'SHLVL': '1', 15:47:03 INFO - 'TERM': 'linux', 15:47:03 INFO - 'TMOUT': '86400', 15:47:03 INFO - 'USER': 'cltbld', 15:47:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:03 INFO - '_': '/tools/buildbot/bin/python'} 15:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:03 INFO - Downloading/unpacking jsonschema 15:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:05 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 15:47:05 INFO - Downloading/unpacking functools32 (from jsonschema) 15:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:47:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:05 INFO - warning: no files found matching '*.txt' 15:47:05 INFO - no previously-included directories found matching 'build' 15:47:05 INFO - no previously-included directories found matching 'dist' 15:47:05 INFO - no previously-included directories found matching '.git*' 15:47:05 INFO - Installing collected packages: jsonschema, functools32 15:47:05 INFO - Running setup.py install for functools32 15:47:05 INFO - warning: no files found matching '*.txt' 15:47:05 INFO - no previously-included directories found matching 'build' 15:47:05 INFO - no previously-included directories found matching 'dist' 15:47:05 INFO - no previously-included directories found matching '.git*' 15:47:05 INFO - Successfully installed jsonschema functools32 15:47:05 INFO - Cleaning up... 15:47:05 INFO - Return code: 0 15:47:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6b6c012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, '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-1453074078.937459-1582513433', '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 15:47:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:47:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:47:05 INFO - Using env: {'DISPLAY': ':0', 15:47:05 INFO - 'HOME': '/home/cltbld', 15:47:05 INFO - 'LANG': 'en_US.UTF-8', 15:47:05 INFO - 'LANGUAGE': 'en_US:en', 15:47:05 INFO - 'LOGNAME': 'cltbld', 15:47:05 INFO - 'MAIL': '/var/mail/cltbld', 15:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:05 INFO - 'MOZ_NO_REMOTE': '1', 15:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:05 INFO - 'NO_EM_RESTART': '1', 15:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:05 INFO - 'SHELL': '/bin/bash', 15:47:05 INFO - 'SHLVL': '1', 15:47:05 INFO - 'TERM': 'linux', 15:47:05 INFO - 'TMOUT': '86400', 15:47:05 INFO - 'USER': 'cltbld', 15:47:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:05 INFO - '_': '/tools/buildbot/bin/python'} 15:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:05 INFO - Downloading/unpacking flake8 15:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:47:07 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 15:47:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:47:07 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 15:47:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:07 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 15:47:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:47:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:47:08 INFO - no previously-included directories found matching 'docs/_build' 15:47:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:47:08 INFO - Running setup.py install for pep8 15:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:47:08 INFO - no previously-included directories found matching 'docs/_build' 15:47:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:47:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:47:08 INFO - Cleaning up... 15:47:08 INFO - Return code: 0 15:47:08 INFO - Running post-action listener: _resource_record_post_action 15:47:08 INFO - Running post-action listener: _start_resource_monitoring 15:47:08 INFO - Starting resource monitoring. 15:47:08 INFO - ##### 15:47:08 INFO - ##### Running install step. 15:47:08 INFO - ##### 15:47:08 INFO - Running pre-action listener: _resource_record_pre_action 15:47:08 INFO - Running main action method: install 15:47:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:47:08 INFO - Reading from file tmpfile_stdout 15:47:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:47:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:47:08 INFO - Reading from file tmpfile_stdout 15:47:08 INFO - Output received: 15:47:08 INFO - Usage: mozinstall [options] installer 15:47:08 INFO - Options: 15:47:08 INFO - -h, --help show this help message and exit 15:47:08 INFO - -d DEST, --destination=DEST 15:47:08 INFO - Directory to install application into. [default: 15:47:08 INFO - "/builds/slave/test-pgo"] 15:47:08 INFO - --app=APP Application being installed. [default: firefox] 15:47:08 INFO - mkdir: /builds/slave/test-pgo/build/application 15:47:08 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'] 15:47:08 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 15:47:24 INFO - Reading from file tmpfile_stdout 15:47:24 INFO - Output received: 15:47:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:47:24 INFO - Running post-action listener: _resource_record_post_action 15:47:24 INFO - ##### 15:47:24 INFO - ##### Running run-tests step. 15:47:24 INFO - ##### 15:47:24 INFO - Running pre-action listener: _resource_record_pre_action 15:47:24 INFO - Running main action method: run_tests 15:47:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:47:24 INFO - Python 2.7.3 15:47:24 INFO - Return code: 0 15:47:24 INFO - grabbing minidump binary from tooltool 15:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:24 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 0x1fe0840>, '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 0x1f4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:47:24 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 15:47:24 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 15:47:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:47:24 INFO - Return code: 0 15:47:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:47:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:47:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:47:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:47:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:47:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:47:25 INFO - Return code: 0 15:47:25 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/KiE8WmswTsql7qZOkANtmQ/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 15:47:25 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/KiE8WmswTsql7qZOkANtmQ/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 15:47:25 INFO - Using env: {'DISPLAY': ':0', 15:47:25 INFO - 'HOME': '/home/cltbld', 15:47:25 INFO - 'LANG': 'en_US.UTF-8', 15:47:25 INFO - 'LANGUAGE': 'en_US:en', 15:47:25 INFO - 'LOGNAME': 'cltbld', 15:47:25 INFO - 'MAIL': '/var/mail/cltbld', 15:47:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:47:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:25 INFO - 'MOZ_NO_REMOTE': '1', 15:47:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:25 INFO - 'NO_EM_RESTART': '1', 15:47:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:25 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:47:25 INFO - 'SHELL': '/bin/bash', 15:47:25 INFO - 'SHLVL': '1', 15:47:25 INFO - 'TERM': 'linux', 15:47:25 INFO - 'TMOUT': '86400', 15:47:25 INFO - 'USER': 'cltbld', 15:47:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1453074078.937459-1582513433', 15:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:25 INFO - '_': '/tools/buildbot/bin/python'} 15:47:25 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/KiE8WmswTsql7qZOkANtmQ/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 15:47:25 INFO - mozversion application_buildid: 20160117133002 15:47:25 INFO - mozversion application_changeset: 0a4331e7d7ba21c3a54d9f17fb6ed1f42b7c29ec 15:47:25 INFO - mozversion application_display_name: Nightly 15:47:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:47:25 INFO - mozversion application_name: Firefox 15:47:25 INFO - mozversion application_remotingname: firefox 15:47:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:47:25 INFO - mozversion application_vendor: Mozilla 15:47:25 INFO - mozversion application_version: 46.0a1 15:47:25 INFO - mozversion platform_buildid: 20160117133002 15:47:25 INFO - mozversion platform_changeset: 0a4331e7d7ba21c3a54d9f17fb6ed1f42b7c29ec 15:47:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:47:25 INFO - mozversion platform_version: 46.0a1 15:47:25 INFO - using testdate: 1453074445 15:47:25 INFO - actual date: 1453074445 15:47:25 INFO - starting webserver on 'localhost:49484' 15:47:25 INFO - SUITE-START | Running 3 tests 15:47:25 INFO - TEST-START | dromaeo_css 15:47:25 INFO - operating with platform_type : linux_ 15:47:25 INFO - Initialising browser for dromaeo_css test... 15:47:26 INFO - TEST-INFO | started process 30049 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprr0Bb_/profile http://localhost:49484/getInfo.html) 15:47:30 INFO - PROCESS | 30049 | __metrics Screen width/height:1600/1200 15:47:30 INFO - PROCESS | 30049 | colorDepth:24 15:47:30 INFO - PROCESS | 30049 | Browser inner width/height: 1024/697 15:47:30 INFO - PROCESS | 30049 | __metrics 15:47:30 INFO - PROCESS | 30049 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:47:30 INFO - PROCESS | 30049 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:47:31 INFO - TEST-INFO | 30049: exit 0 15:47:31 INFO - Browser initialized. 15:47:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:47:31 INFO - TEST-INFO | started process 30146 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprr0Bb_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:43 INFO - PROCESS | 30146 | RSS: Main: 150085632 15:47:43 INFO - PROCESS | 30146 | 15:48:34 INFO - PROCESS | 30146 | 1453074514341 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] 15:50:43 INFO - PROCESS | 30146 | Cycle 1(1): loaded http://localhost:49484/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49484/tests/dromaeo/cssquery-ext.html) 15:50:44 INFO - PROCESS | 30146 | RSS: Main: 280539136 15:50:44 INFO - PROCESS | 30146 | 15:53:47 INFO - PROCESS | 30146 | Cycle 1(1): loaded http://localhost:49484/tests/dromaeo/cssquery-ext.html (next: http://localhost:49484/tests/dromaeo/cssquery-jquery.html) 15:53:47 INFO - PROCESS | 30146 | RSS: Main: 238366720 15:53:47 INFO - PROCESS | 30146 | 15:56:49 INFO - PROCESS | 30146 | Cycle 1(1): loaded http://localhost:49484/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49484/tests/dromaeo/cssquery-mootools.html) 15:56:50 INFO - PROCESS | 30146 | RSS: Main: 241205248 15:56:50 INFO - PROCESS | 30146 | 15:59:52 INFO - PROCESS | 30146 | Cycle 1(1): loaded http://localhost:49484/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49484/tests/dromaeo/cssquery-prototype.html) 15:59:52 INFO - PROCESS | 30146 | RSS: Main: 214134784 15:59:52 INFO - PROCESS | 30146 | 16:02:55 INFO - PROCESS | 30146 | Cycle 1(1): loaded http://localhost:49484/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49484/tests/dromaeo/cssquery-yui.html) 16:02:56 INFO - PROCESS | 30146 | RSS: Main: 214343680 16:02:56 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | Cycle 1(1): loaded http://localhost:49484/tests/dromaeo/cssquery-yui.html (next: http://localhost:49484/tests/dromaeo/cssquery-dojo.html) 16:05:58 INFO - PROCESS | 30146 | RSS: Main: 289226752 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | __start_tp_report 16:05:58 INFO - PROCESS | 30146 | _x_x_mozilla_page_load 16:05:58 INFO - PROCESS | 30146 | _x_x_mozilla_page_load_details 16:05:58 INFO - PROCESS | 30146 | |i|pagename|runs| 16:05:58 INFO - PROCESS | 30146 | |0;dojo.html;3166.6833316668335;3204.967950320499;3258;3261.527078573607;3286.6384697683256;5230.293910322105;5246.842594722155;5248.71132087735;5290.338707661547;5332.253484512172;5309.230161626571;5315.973420132894;5327.2808170896915;5343.812966546172;5391.487808658171;4744.64415168862;4754.78603462845;4778.402699662543;4810.759462026902;4903.583195428393;4862.173430516803;4884.194107972198;4895.779689913945;4930.728809915453;4936.333594964688;4730.314104454852;4773.093112308685;4823.252395878644;4864.246041863516;4870.318155458239;4822.95177048232;4832.685875418087;4839.27410888366;4839.44346400165;4880.633952453581;4787.305840653121;4807.831725889577;4813.975930120362;4832.589229915461;4841.273808928654;5084.77118529667;5157.71632560209;5179.093658609729;5235.502627250406;5264.052470555337;5689;5692.345380281279;5695.5443564514735;5697.230873832021;5699.316082070137;5611.971940140314;5686.857828554278;5736.885262294731;5737.2254745609225;5739.713014349308;5264.973675131638;5304.443033481506;5317.388500322474;5346.144616861322;5346.465353464622;5804.88390232193;5826.300843898674;5840.678762668009;5854.736536855852;5858.150568167677;5505.642133261325;5636.549076073904;5642.379338272786;5648.181013752983;5649.435056494318;5548.140038294071;5679.375268720438;5728.05487094633;5728.1407788831175;5774.48029677331;5619.775208991677;5635.070213414822;5657.2928383952;5664.971675141598;5675.347335056439;5518.475744804237;5607;5615.410381909923;5697.857553561194;5707.200991861143;4406.184855801687;4446.399736035659;4446.688731788809;4476.977615111904;4478.171538265431;3942.329803933338;3944.8422063117728;3960.6435420812263;3966.4446977423186;3981.1042515434374;5215.322008138994;5281.445448227958;5285.233641122093;5314;5360.061989151883;5697.914531282034;5726.942730572641;5744.569157313218;5756.913646295309;5799.449052340021;5294.047071527085;5323;5329.200619907045;5332.440093790096;5333.439988801198;4819.204831202883;4878.609711223094;4880.243562247857;4908.067467181296;4929.285253638274;5991.310999235056;5991.730372133352;5998.550108741862;5998.790042348497;6012.518998480111;5743.4543718346695;5751.338596061507;5755.453231942959;5764.279465066867;5765.423457654201;5803.767849285981;5809.36097029318;5866.6186697864505;5917.911231331447;5961.105834124916;5570.275864137636;5574.386817449996;5575.9163612545035;5579.721013949367;5591.077472217039;5551.611387202857;5641.605087643826;5645.71771411436;5649.067903795828;5652.208690783212;5439.864003399946;5547.55619550443;5547.8890422190525;5548.445155484419;5553.972230138824;5554.50009499147;5555.944440555542;5557.36090349615;5559.221708960829;5574.358948720949;5452.0731475648445;5458.836234912959;5465.672059676433;5476.452354764491;5523.6409633373705;5408.242846001642;5443.401225865073;5495.230667706444;5580.5535557156145;5598.048331783688;5455.8363249102595;5502.174673798962;5505.504504594445;5508.641938274;5546.029444847055 16:05:58 INFO - PROCESS | 30146 | |1;ext.html;542.7530473634495;550.2846299810246;557.6793343827301;566.88095499945;578.020255666645;28675.85662071689;29231.707682923192;38643.22713545731;39572.20855582887;39634.80182599083;42630.14739705204;43003.13993720124;43118.353224701656;43122;43221.56778432215;8189.467684600511;8365.996080470351;8394.79013024673;8398.286145677625;8398.580070996457;8399.580020998956;8546.102659220785;8546.102659220785;8563.10087440819;8565.443246189008;8580.270676992463;8619.094995025525;8653.264472519844;8663.913360866374;8669.69656062038;8512.446690965067;8585.570721463964;8588.184122508352;8593.828123437528;8600.225979661798;8359.707410240613;8470.449420787629;8481.321494280504;8496.872546911802;8497.192766687154;39335.803320983214;39346.60653393458;39861.20277594461;39894.80052599718;39906;3345.9330813383594;3449.068751437123;3511.94732079019;4008.7594744315143;4042.858499952517;29238.853805730836;29609.555856662166;29859.568390987;30180.698193018008;30570.69429305723;3611.855525778966;3612.9277414451826;3666.1018050577777;3683.8710645127294;3739.1960728443514;264203;264672;266293;266770;266772;51857.2221416679;52421.7378913103;52458;58688;58840;50990.74504627453;63047.36952630415;63599.36400636027;63767;63776;14526.346314415876;14594.85405145935;14758.040727352687;14759.704805903822;14777.187254700879;10083.949580252198;12058;12109.091818113677;12139.210951288138;12162.513499459923;16397.180140992903;19677.606447870963;19996.400107996782;20295.39113826558;20321.390358289274;7356.668949897267;7554.660040298199;7642.121156067013;7658.73194438192;7660.5403675779635;984.6455276100598;989.678354534779;1000.4547521600745;1066.2962444786403;1117.932924024561;28608.856955715088;28998.565021524693;29066.27334316659;29191.416171676872;29651.258718532208;984.2273815055147;998.7752755629925;1050.8686414198226;1084.8264277715527;1103.5034234594464;13916;13937.303134843218;14050.734045740497;14117.78823317651;14254.3585538651;334540;346114;346166;346455;346902;51216.23175652368;51293;51486.74256628768;51509.227361589605;51590;1293.0625296660035;1325.4963114016805;1347.1916849889988;1348.339313736262;1355.4374934402113;24329.39176520601;26777.464450710486;27155.1853444397;27747.44505109846;28161.59192040431;41781.164376712906;42065;42330.1533969325;42377.36433953555;42453.15093698047;241246;245045;245179;245571;245867;25950.35124121912;26021.6096758545;28418.857905710338;31598.684013159575;32248;37683.62316376801;40657.59342406538;40796;41063.38404923988;41769.58230417657;33369.16577085592;34653.13367165841;34987.30025399529;35047.299054019284;35102.297954041285;34616.82691586526;35159.824200879855;35770.463443047855;35828.82085589555;35964.46053309255;34041.148971275914;34346.82826585851;34644.307113858085;34692.132696682784;35108.473372898916;30559.694403055684;31205.219869503446;31414.371712565164;31663;31667.20831979219;23677.526449471257;24158.87920560386;24207.394815129763;24554.754452455247;24564.50870982606 16:05:58 INFO - PROCESS | 30146 | |2;jquery.html;355.4135676134378;359.14165145302724;360.18058915966174;361.7919696174699;363.9017465284375;15853.286602102904;16312;16818.83181168188;17203.483895483125;17224.3110275589;16177;16439.342426302934;16456.094914779682;16498.34006639733;16742;5159.7678104485385;5224.608154388427;5388.407275199725;5397.2443857859935;5407.918881216785;5130.256112863633;5239.978204250173;5244.79020839166;5246.816361427351;5247.740542269866;3963.7621742695387;4116.115035267417;5133.768980395891;5202.375714914216;5309.460256525603;3996.9000774980714;5531.557475401958;5740.913886291709;5747.568932330092;5751.4536119068625;4965.875853103701;5062.4684408137355;5078.339815823956;5083.923741143886;5086.389633243997;14588.197649129293;15209.771853422208;17839.197236124404;18694.81305186958;18728.15723292455;2077.792220777925;2106.5892151030557;2145.2384403536676;2151.688005239247;2207.9006444710026;11995.760084798256;12048.397580121047;12128.878711212863;12297.877021229851;12335.321557314344;1768.5667011582116;1849.6485667723225;1861.9069046547618;1863.813618638139;1910.74204982327;49974;50734.238986414864;52818;53291.73354133243;54100.188497172574;9654.951725241328;10021;10089.697309080593;10096.69709908704;10184.643537476153;13323.40044697991;13333.599992000256;13360.799588006188;13367.598972030855;13379.260696109639;7148.249433809479;7175;7246.891296630555;7322.560646361236;7388.593627350548;6661.833454163588;6675.332466753286;6732.4950628703045;6758.560693554903;6763.695633696496;4407.449068866392;4453.1316393303;4453.844115455943;4465.821367145278;4475.664325175625;1763.3651885321274;1841.9171137298854;1847.1964695357563;1847.7136043913215;1853.0456814740419;872.289084396215;892.5626443042992;904.8099899021279;1015.7663737340453;1051.1853313681959;15883.28525216368;15910.68178636444;16244;16881.493555193363;16947.491575252763;783.7452827830978;857.3269983063266;858.6694122762781;862.4997501449144;926.8100039491889;6448.484121270287;9229.861552076723;9444.291678124031;9975.800483990279;10033.147182489423;486377;522663.1600525995;527363;554574;569964;46676.29985550219;47288.290675639895;47839.282410763866;60699.69650151809;69075;1086.809808283563;1118.4184224203532;1120.3418939968892;1126.6225814352283;1138.4421633399575;11443.771124577295;13780.448782048607;13986.930065349608;14526.85473145255;15653.452129175424;31161;31848.203794905312;32021.199470013435;33500.162495937795;34988.82505587456;41051.58948410597;41479.7926010368;42409.5759042418;43149.56850431456;46261;6943.201531823703;7037.120359955005;7084.964575177091;7245.529040612343;7338.559686418832;8257.628406721591;11330.490127944098;11519.366434846164;11591.188616796744;11850.881491185322;9428.151466367786;10082.243831712503;10294.794104118026;10294.845577316497;10473;8808.603612837309;9176.265898727952;9309.487978161265;9440.858387124335;9625.278104142357;6762.7294908205085;6964.965175174294;6978.720851165896;9746.122848943345;10299.176065914558;8916.73249802507;10123.341982771097;10143.695689129338;10148.746281343025;10250.231232657432;9625.278104142077;9683.951580242054;9805.705828825146;9830.5084745761;10030.749231268985 16:05:58 INFO - PROCESS | 30146 | |3;mootools.html;1307.2940612069483;1399.1605036977815;1451.0568130715035;1575.8739300855932;1765.0733364983382;7028.753993610225;7718.4982976106585;7847.960760196191;7851.842963140748;7857.80355491113;7679.424043196755;7822.178671239509;7838.608069596512;7844.333231675315;7848.60756962151;2024.4635171679517;2059.299838055061;2063.174730107954;2322.512272422793;2350.4711439925964;2036.2364113457454;2044.3458093410115;2372.3476044087843;2419.129113519132;2426.514697060586;2308.73449553301;2351.9764802352015;2353.0705371378294;2353.646952957053;2355.034435881289;2325.8953347099423;2327.208749025331;2330.0679728108894;2330.1378489958656;2331.860088394702;2327.6857624220684;2378.655095011231;2386.4869053153484;2390.270967354956;2391.4021494626345;7704.65329060188;7755.2632499912415;7767.53394796314;7769.805754856117;7787.3770098392;4740.1230772307235;4919.458859525449;4923.08922849274;4929.408470983505;4941.654084214107;3027.228056845512;3074.707902749235;3140.2463408781728;3144.9685503144906;3153.4796758534812;926.9953650231773;928.9489078100702;937.7186843946789;959.1465390463385;969.9030096990315;11252.718682033015;11395.943020284845;11444.370559619218;11466.598669046627;11485.655430337103;4563.885902852388;4580.519045500175;4610.930836037395;4618.792154353062;4646.79089440976;9761.707148785548;9762.36544624597;9776.266779991529;9783.804323913482;9801;5134.717590532482;5136.5377116059735;5139.665921715076;5143.27994080829;5144.897102058013;4640.605548528345;4646.651501137429;4648.302754586772;4650.255959046536;4651.441826980784;3522.0842580929143;3724.2923844469465;3812;3828.0429892526868;3836.175222327213;1157.6295585412756;1245.4520011195045;1255.554278231233;1264.3362234826789;1267.5816980396446;1284.113961366654;1307.0850404716737;1309.4173092973726;1311.7769979103575;1312.4356526693614;7200.891986620205;7222.458315626349;7256.709731610782;7256.854862902818;7262.96368518154;1119.7480566872553;1128.0862501373913;1129.8644162700527;1129.971750706239;1150.3787954504642;5503;5544.61187716856;5644.125160600113;5700.25896633435;5810.651360918274;9331.346805723535;9570.377925434825;9879.506024698736;9887.950560247153;10032.69901902944;9428.905710942803;9504.049595040578;9542.713718588453;9613.423194608346;9637.807243855084;7474.962625186839;7511.849763004819;7541.5098018629715;7549.131849837229;7619.504732192389;7390.519616225143;7511.248875112445;7515.2109028553405;7520.586367749826;7528.209537998431;8439.28266097364;8707.521086340312;8805.075467076122;8868.334874884538;8873.64505419776;9081.545922703706;9165.816683666422;9240.445573265626;9312.068793120634;9360.95319523398;6987.790366289019;7067.293270672892;7179.317964793337;7195.280471952763;7217.809061505003;6790.354916282945;6957.478189135936;7521.398288137046;7589.6205189741395;7604.581748003913;7080.468964827762;7106.78679639591;7198.964005179941;7288.489805713762;7305.415566754753;6916.55042422241;6992.650367481708;7032.824179395351;7150.284971502808;7151.499395042505;6964.512484126062;6980.860382792417;7038.049863268393;7050.541714788727;7083.150021997393;6344.936550634435;6377.936220637735;6449.677516124269;6452.161219041683;6507.186601674791;6641.402273795382;6702.162229721285;6707.195136583641;6798.490113241428;6802.93197068023 16:05:58 INFO - PROCESS | 30146 | |4;prototype.html;330.9635940046595;334.162921880689;338.8627605819644;341.84446077034954;346.5391029930191;5661.3206415230125;5797.681127537989;5820.126980952859;5844.327902291232;5891.145783861338;5617.522510586595;5698.6865722385255;5728.341240757314;5729.369769325382;5729.828105156842;4473.239549276631;4474.597286244238;4509.188346097718;4511.436070491189;4537.0925814837;4303.655707543389;4424.668149888771;4427.9557204427865;4508.233600287959;4531.116432295704;4457.353683715859;4469.553044695537;4499.75251361175;4503.819847206108;4508.391367165424;4494.97752511237;4498.392716983198;4500.617447516965;4504.729716217021;4505.189065968125;3942.073612701013;3955.782431966241;3960.8613698520703;3966.940495892564;3969.186316805048;5470.370907345627;5577.8605534861545;5598.748056337475;5614.382417934024;5659.717014149317;5106.183010718267;5112.539871411554;5113.539781419653;5122.846314610568;5130.461301563357;5885.087811389241;6193;6196.535259855484;6203.503719702413;6210.31686514483;4115.1975364803875;4171.353440216772;4246.5541118182455;4254.978805086788;4256.531781504032;6359;6443.259025212114;6459.644719540471;6462.450691691165;6468.902966455507;4366.345048242725;4369.60673539383;4372.934405983913;4399.20814253431;4417.955820441819;4297.978510107492;4425.247707889666;4426.911461770746;4432.312991486325;4438.1567502174485;5103.948960510347;5108.2848401223855;5147.819826306136;5149.588032957355;5154.433012368637;6232.8130156095385;6246.562740608114;6291.591046581958;6307.9369206308265;6314.747410103544;1542.5680809373168;1565.295616972367;1568.3569736408017;1569.082086979107;1569.8116226052719;1035.5909415780875;1038.5638032026568;1040.2354269611828;1040.9739756506149;1068.1401471815109;5918.378570250148;5919.940800591939;5930.169776231331;5932.317783454958;5935.851603709942;6356.459700925473;6359.872802543923;6366.936330636634;6376.426121649074;6384.840378990562;5795.246617939641;5824.88350232993;5834.299884013945;5838.8540286492325;5841.532677385799;3335;3454.2573346730574;3464.826758662057;3464.9826750866087;3465.3935561276676;6481.902771458432;6518.511111666644;6531.0856480092825;6537.313582073909;6544.770933017321;6506.512011599149;6514.05546195799;6523.902141467882;6528.08606795049;6535.379138981789;6508.9349106508325;6682.766103186365;6686.398224159849;6752.291009444036;6760.391564759097;6216.409441103088;6361.522885783677;6416.101745755504;6469.5794773339585;6484.416402523795;6189.81430557084;6274.968625156845;6342.23893132827;6348.079528468438;6383;6692.531522793358;6722.764703235363;6731.730730770911;6736.090627765189;6740.865182696417;4402.691811573159;4422.778861056999;4440.777961101868;4446.73319600825;4454.443194600675;6386.93613063882;6414.486841052798;6423.550351475352;6435.581687190318;6497.9025314619375;6267.435930766253;6322.905156422566;6324.525660575568;6324.936750632435;6326.4622507087415;6141.723622436912;6192.659403732658;6203.472704820141;6238.407351301619;6244.5316601256;6114.57197996136;6120.17377654011;6121.234845644294;6128.571000029955;6128.846778830565;6245.219347581552;6250.406211409909;6254.6247225166635;6261.812145635638;6264.467520260829;5927.762889484372;6072.301685306246;6096.786612468542;6097.146399504161;6109.327973922776 16:05:58 INFO - PROCESS | 30146 | |5;yui.html;703.5954326262397;789.2541548236918;807.1847434091569;816.7917181118814;820.5774026376417;13309.334533273333;13388.732225355487;13438;13441.7983730244;13457.394417251222;11550.711232219177;11844.34856082915;11845.46695398707;11870.406479676003;11904;658.9769358072468;787.9684812607503;802.0856223904754;802.1296892871212;802.3500964219002;661.894096944489;787.5078076202374;796.7251298302076;797.2466019611469;798.4610387988114;823.5799742131496;825.9215374539439;827.0488937721639;827.2182787266036;829.722043115557;684.8630273945231;688.3391943734022;825.1377310710292;825.781167990483;830.9542975136366;611.5596770325359;611.9816405507797;612.1338306296585;615.0190446238242;615.8552740106071;13552.728945421037;13629.182249065088;13629.591112266648;13641.386137623831;13666.726665466735;12211.938940305241;12352.776500229955;12441;12593.559225427067;12757.170783899017;9708.805823883482;10370.844437333446;10371.636992705295;10484.108850747696;10613.84079238812;3536.664016918389;3543.5924868639922;3558.62634423387;3564.500969864221;3691.151035261878;49579;49860.50139498595;49921.00157996856;49970.50029499695;50015.24977125346;9767.755806104904;9984.35101718386;10103.444310562843;10224.386536807666;10535.631252906265;17708.380206692706;17730;17759.55601109957;17766.555836104202;17771.111444427726;7686.039245094364;7700.537967721954;7752.224777522202;7845.137034926153;8011.278984891388;4185.727927684691;4322.438083049184;4360.193364227564;4477.485089214717;4512.4133862597655;3220.4847224443974;3256.234784825564;3277.1807048237943;3277.737780977516;3280.0323904448246;565.9943400566024;580.309431776185;586.6128355285491;587.9647221166744;612.6783438694721;520.3989392251955;523.4895976422957;572.9083346664513;596.627108057464;609.9935107073364;7486.475946683789;7599.202083781234;7775.727269119304;7863.84272314562;7923.12845586985;521.2832355511172;526.2159382520094;589.0898561722149;659.8383396067994;680.2619158213394;3781.640744129303;3882.6311500407414;3951.4863067801575;4118.814653340607;4405.118976204772;49979.75010124926;50564.49435505598;56209;57097.71451142718;57299;46517;46738.5326146741;46938.530614693416;48663.270050949264;52284.73857630764;45992.310115347624;46028;46476.76761616238;48081.75959120182;48100.51899481031;8585.012723536873;8614.913850861662;8746.73759787182;8907.153820387053;9018.278537717099;34365.65634343625;35849;36880.262394751415;36973.63026369702;37138.814305928296;44958;45034.54965450303;45141;45221.321680174166;45854;10919.181061420584;11057.557697692002;11105.500252488497;11197.832032519682;11233.101351891666;12312.26126432417;12463.06527010496;12574.30841303737;12827.42276597574;12838.55065072718;9964;10468.68593942183;10714.892851071701;10730.248882578144;10842.078423334106;11209.943950280523;11400.258983166068;11482.138839586898;11611.419429028683;11984;10954.11449771266;11253.549858005588;11533;11738.471768770254;11865.703357416134;8915.37592368528;9084.863727043967;9298.907010929805;9386.765330866783;9498.95250523743;8228.753137405887;8731.843880996184;9197.21823644971;9360.4383736976;9460.148586627236 16:05:58 INFO - PROCESS | 30146 | __end_tp_report 16:05:58 INFO - PROCESS | 30146 | __start_cc_report 16:05:58 INFO - PROCESS | 30146 | _x_x_mozilla_cycle_collect,1101 16:05:58 INFO - PROCESS | 30146 | __end_cc_report 16:05:58 INFO - PROCESS | 30146 | __startTimestamp1453075558935__endTimestamp 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | ------- Summary: start ------- 16:05:58 INFO - PROCESS | 30146 | Number of tests: 6 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | [#0] dojo.html Cycles:165 Average:5284.65 Median:5476.45 stddev:574.85 (10.5%) stddev-sans-first:552.08 16:05:58 INFO - PROCESS | 30146 | Values: 3166.7 3205.0 3258.0 3261.5 3286.6 5230.3 5246.8 5248.7 5290.3 5332.3 5309.2 5316.0 5327.3 5343.8 5391.5 4744.6 4754.8 4778.4 4810.8 4903.6 4862.2 4884.2 4895.8 4930.7 4936.3 4730.3 4773.1 4823.3 4864.2 4870.3 4823.0 4832.7 4839.3 4839.4 4880.6 4787.3 4807.8 4814.0 4832.6 4841.3 5084.8 5157.7 5179.1 5235.5 5264.1 5689.0 5692.3 5695.5 5697.2 5699.3 5612.0 5686.9 5736.9 5737.2 5739.7 5265.0 5304.4 5317.4 5346.1 5346.5 5804.9 5826.3 5840.7 5854.7 5858.2 5505.6 5636.5 5642.4 5648.2 5649.4 5548.1 5679.4 5728.1 5728.1 5774.5 5619.8 5635.1 5657.3 5665.0 5675.3 5518.5 5607.0 5615.4 5697.9 5707.2 4406.2 4446.4 4446.7 4477.0 4478.2 3942.3 3944.8 3960.6 3966.4 3981.1 5215.3 5281.4 5285.2 5314.0 5360.1 5697.9 5726.9 5744.6 5756.9 5799.4 5294.0 5323.0 5329.2 5332.4 5333.4 4819.2 4878.6 4880.2 4908.1 4929.3 5991.3 5991.7 5998.6 5998.8 6012.5 5743.5 5751.3 5755.5 5764.3 5765.4 5803.8 5809.4 5866.6 5917.9 5961.1 5570.3 5574.4 5575.9 5579.7 5591.1 5551.6 5641.6 5645.7 5649.1 5652.2 5439.9 5547.6 5547.9 5548.4 5554.0 5554.5 5555.9 5557.4 5559.2 5574.4 5452.1 5458.8 5465.7 5476.5 5523.6 5408.2 5443.4 5495.2 5580.6 5598.0 5455.8 5502.2 5505.5 5508.6 5546.0 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | [#1] ext.html Cycles:180 Average:44949.80 Median:19310.21 stddev:75395.23 (390.4%) stddev-sans-first:75533.01 16:05:58 INFO - PROCESS | 30146 | Values: 542.8 550.3 557.7 566.9 578.0 28675.9 29231.7 38643.2 39572.2 39634.8 42630.1 43003.1 43118.4 43122.0 43221.6 8189.5 8366.0 8394.8 8398.3 8398.6 8399.6 8546.1 8546.1 8563.1 8565.4 8580.3 8619.1 8653.3 8663.9 8669.7 8512.4 8585.6 8588.2 8593.8 8600.2 8359.7 8470.4 8481.3 8496.9 8497.2 39335.8 39346.6 39861.2 39894.8 39906.0 3345.9 3449.1 3511.9 4008.8 4042.9 29238.9 29609.6 29859.6 30180.7 30570.7 3611.9 3612.9 3666.1 3683.9 3739.2 264203.0 264672.0 266293.0 266770.0 266772.0 51857.2 52421.7 52458.0 58688.0 58840.0 50990.7 63047.4 63599.4 63767.0 63776.0 14526.3 14594.9 14758.0 14759.7 14777.2 10083.9 12058.0 12109.1 12139.2 12162.5 16397.2 19677.6 19996.4 20295.4 20321.4 7356.7 7554.7 7642.1 7658.7 7660.5 984.6 989.7 1000.5 1066.3 1117.9 28608.9 28998.6 29066.3 29191.4 29651.3 984.2 998.8 1050.9 1084.8 1103.5 13916.0 13937.3 14050.7 14117.8 14254.4 334540.0 346114.0 346166.0 346455.0 346902.0 51216.2 51293.0 51486.7 51509.2 51590.0 1293.1 1325.5 1347.2 1348.3 1355.4 24329.4 26777.5 27155.2 27747.4 28161.6 41781.2 42065.0 42330.2 42377.4 42453.2 241246.0 245045.0 245179.0 245571.0 245867.0 25950.4 26021.6 28418.9 31598.7 32248.0 37683.6 40657.6 40796.0 41063.4 41769.6 33369.2 34653.1 34987.3 35047.3 35102.3 34616.8 35159.8 35770.5 35828.8 35964.5 34041.1 34346.8 34644.3 34692.1 35108.5 30559.7 31205.2 31414.4 31663.0 31667.2 23677.5 24158.9 24207.4 24554.8 24564.5 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | [#2] jquery.html Cycles:180 Average:26603.59 Median:41944.68 stddev:86835.55 (207.0%) stddev-sans-first:87056.78 16:05:58 INFO - PROCESS | 30146 | Values: 355.4 359.1 360.2 361.8 363.9 15853.3 16312.0 16818.8 17203.5 17224.3 16177.0 16439.3 16456.1 16498.3 16742.0 5159.8 5224.6 5388.4 5397.2 5407.9 5130.3 5240.0 5244.8 5246.8 5247.7 3963.8 4116.1 5133.8 5202.4 5309.5 3996.9 5531.6 5740.9 5747.6 5751.5 4965.9 5062.5 5078.3 5083.9 5086.4 14588.2 15209.8 17839.2 18694.8 18728.2 2077.8 2106.6 2145.2 2151.7 2207.9 11995.8 12048.4 12128.9 12297.9 12335.3 1768.6 1849.6 1861.9 1863.8 1910.7 49974.0 50734.2 52818.0 53291.7 54100.2 9655.0 10021.0 10089.7 10096.7 10184.6 13323.4 13333.6 13360.8 13367.6 13379.3 7148.2 7175.0 7246.9 7322.6 7388.6 6661.8 6675.3 6732.5 6758.6 6763.7 4407.4 4453.1 4453.8 4465.8 4475.7 1763.4 1841.9 1847.2 1847.7 1853.0 872.3 892.6 904.8 1015.8 1051.2 15883.3 15910.7 16244.0 16881.5 16947.5 783.7 857.3 858.7 862.5 926.8 6448.5 9229.9 9444.3 9975.8 10033.1 486377.0 522663.2 527363.0 554574.0 569964.0 46676.3 47288.3 47839.3 60699.7 69075.0 1086.8 1118.4 1120.3 1126.6 1138.4 11443.8 13780.4 13986.9 14526.9 15653.5 31161.0 31848.2 32021.2 33500.2 34988.8 41051.6 41479.8 42409.6 43149.6 46261.0 6943.2 7037.1 7085.0 7245.5 7338.6 8257.6 11330.5 11519.4 11591.2 11850.9 9428.2 10082.2 10294.8 10294.8 10473.0 8808.6 9176.3 9309.5 9440.9 9625.3 6762.7 6965.0 6978.7 9746.1 10299.2 8916.7 10123.3 10143.7 10148.7 10250.2 9625.3 9684.0 9805.7 9830.5 10030.7 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | [#3] mootools.html Cycles:180 Average:5615.37 Median:6574.29 stddev:2932.82 (44.6%) stddev-sans-first:2923.17 16:05:58 INFO - PROCESS | 30146 | Values: 1307.3 1399.2 1451.1 1575.9 1765.1 7028.8 7718.5 7848.0 7851.8 7857.8 7679.4 7822.2 7838.6 7844.3 7848.6 2024.5 2059.3 2063.2 2322.5 2350.5 2036.2 2044.3 2372.3 2419.1 2426.5 2308.7 2352.0 2353.1 2353.6 2355.0 2325.9 2327.2 2330.1 2330.1 2331.9 2327.7 2378.7 2386.5 2390.3 2391.4 7704.7 7755.3 7767.5 7769.8 7787.4 4740.1 4919.5 4923.1 4929.4 4941.7 3027.2 3074.7 3140.2 3145.0 3153.5 927.0 928.9 937.7 959.1 969.9 11252.7 11395.9 11444.4 11466.6 11485.7 4563.9 4580.5 4610.9 4618.8 4646.8 9761.7 9762.4 9776.3 9783.8 9801.0 5134.7 5136.5 5139.7 5143.3 5144.9 4640.6 4646.7 4648.3 4650.3 4651.4 3522.1 3724.3 3812.0 3828.0 3836.2 1157.6 1245.5 1255.6 1264.3 1267.6 1284.1 1307.1 1309.4 1311.8 1312.4 7200.9 7222.5 7256.7 7256.9 7263.0 1119.7 1128.1 1129.9 1130.0 1150.4 5503.0 5544.6 5644.1 5700.3 5810.7 9331.3 9570.4 9879.5 9888.0 10032.7 9428.9 9504.0 9542.7 9613.4 9637.8 7475.0 7511.8 7541.5 7549.1 7619.5 7390.5 7511.2 7515.2 7520.6 7528.2 8439.3 8707.5 8805.1 8868.3 8873.6 9081.5 9165.8 9240.4 9312.1 9361.0 6987.8 7067.3 7179.3 7195.3 7217.8 6790.4 6957.5 7521.4 7589.6 7604.6 7080.5 7106.8 7199.0 7288.5 7305.4 6916.6 6992.7 7032.8 7150.3 7151.5 6964.5 6980.9 7038.0 7050.5 7083.2 6344.9 6377.9 6449.7 6452.2 6507.2 6641.4 6702.2 6707.2 6798.5 6802.9 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | [#4] prototype.html Cycles:180 Average:5181.97 Median:5836.58 stddev:1563.67 (26.8%) stddev-sans-first:1525.08 16:05:58 INFO - PROCESS | 30146 | Values: 331.0 334.2 338.9 341.8 346.5 5661.3 5797.7 5820.1 5844.3 5891.1 5617.5 5698.7 5728.3 5729.4 5729.8 4473.2 4474.6 4509.2 4511.4 4537.1 4303.7 4424.7 4428.0 4508.2 4531.1 4457.4 4469.6 4499.8 4503.8 4508.4 4495.0 4498.4 4500.6 4504.7 4505.2 3942.1 3955.8 3960.9 3966.9 3969.2 5470.4 5577.9 5598.7 5614.4 5659.7 5106.2 5112.5 5113.5 5122.8 5130.5 5885.1 6193.0 6196.5 6203.5 6210.3 4115.2 4171.4 4246.6 4255.0 4256.5 6359.0 6443.3 6459.6 6462.5 6468.9 4366.3 4369.6 4372.9 4399.2 4418.0 4298.0 4425.2 4426.9 4432.3 4438.2 5103.9 5108.3 5147.8 5149.6 5154.4 6232.8 6246.6 6291.6 6307.9 6314.7 1542.6 1565.3 1568.4 1569.1 1569.8 1035.6 1038.6 1040.2 1041.0 1068.1 5918.4 5919.9 5930.2 5932.3 5935.9 6356.5 6359.9 6366.9 6376.4 6384.8 5795.2 5824.9 5834.3 5838.9 5841.5 3335.0 3454.3 3464.8 3465.0 3465.4 6481.9 6518.5 6531.1 6537.3 6544.8 6506.5 6514.1 6523.9 6528.1 6535.4 6508.9 6682.8 6686.4 6752.3 6760.4 6216.4 6361.5 6416.1 6469.6 6484.4 6189.8 6275.0 6342.2 6348.1 6383.0 6692.5 6722.8 6731.7 6736.1 6740.9 4402.7 4422.8 4440.8 4446.7 4454.4 6386.9 6414.5 6423.6 6435.6 6497.9 6267.4 6322.9 6324.5 6324.9 6326.5 6141.7 6192.7 6203.5 6238.4 6244.5 6114.6 6120.2 6121.2 6128.6 6128.8 6245.2 6250.4 6254.6 6261.8 6264.5 5927.8 6072.3 6096.8 6097.1 6109.3 16:05:58 INFO - PROCESS | 30146 | 16:05:58 INFO - PROCESS | 30146 | [#5] yui.html Cycles:180 Average:13654.15 Median:46838.53 stddev:15760.69 (33.6%) stddev-sans-first:15774.89 16:05:58 INFO - PROCESS | 30146 | Values: 703.6 789.3 807.2 816.8 820.6 13309.3 13388.7 13438.0 13441.8 13457.4 11550.7 11844.3 11845.5 11870.4 11904.0 659.0 788.0 802.1 802.1 802.4 661.9 787.5 796.7 797.2 798.5 823.6 825.9 827.0 827.2 829.7 684.9 688.3 825.1 825.8 831.0 611.6 612.0 612.1 615.0 615.9 13552.7 13629.2 13629.6 13641.4 13666.7 12211.9 12352.8 12441.0 12593.6 12757.2 9708.8 10370.8 10371.6 10484.1 10613.8 3536.7 3543.6 3558.6 3564.5 3691.2 49579.0 49860.5 49921.0 49970.5 50015.2 9767.8 9984.4 10103.4 10224.4 10535.6 17708.4 17730.0 17759.6 17766.6 17771.1 7686.0 7700.5 7752.2 7845.1 8011.3 4185.7 4322.4 4360.2 4477.5 4512.4 3220.5 3256.2 3277.2 3277.7 3280.0 566.0 580.3 586.6 588.0 612.7 520.4 523.5 572.9 596.6 610.0 7486.5 7599.2 7775.7 7863.8 7923.1 521.3 526.2 589.1 659.8 680.3 3781.6 3882.6 3951.5 4118.8 4405.1 49979.8 50564.5 56209.0 57097.7 57299.0 46517.0 46738.5 46938.5 48663.3 52284.7 45992.3 46028.0 46476.8 48081.8 48100.5 8585.0 8614.9 8746.7 8907.2 9018.3 34365.7 35849.0 36880.3 36973.6 37138.8 44958.0 45034.5 45141.0 45221.3 45854.0 10919.2 11057.6 11105.5 11197.8 11233.1 12312.3 12463.1 12574.3 12827.4 12838.6 9964.0 10468.7 10714.9 10730.2 10842.1 11209.9 11400.3 11482.1 11611.4 11984.0 10954.1 11253.5 11533.0 11738.5 11865.7 8915.4 9084.9 9298.9 9386.8 9499.0 8228.8 8731.8 9197.2 9360.4 9460.1 16:05:58 INFO - PROCESS | 30146 | -------- Summary: end -------- 16:05:58 INFO - PROCESS | 30146 | 16:05:59 INFO - TEST-INFO | 30146: exit 0 16:05:59 INFO - TEST-OK | dromaeo_css | took 1113644ms 16:05:59 INFO - TEST-START | kraken 16:05:59 INFO - operating with platform_type : linux_ 16:05:59 INFO - Initialising browser for kraken test... 16:05:59 INFO - TEST-INFO | started process 30345 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeHX80D/profile http://localhost:49484/getInfo.html) 16:06:03 INFO - PROCESS | 30345 | __metrics Screen width/height:1600/1200 16:06:03 INFO - PROCESS | 30345 | colorDepth:24 16:06:03 INFO - PROCESS | 30345 | Browser inner width/height: 1024/697 16:06:03 INFO - PROCESS | 30345 | __metrics 16:06:03 INFO - PROCESS | 30345 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:06:03 INFO - PROCESS | 30345 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:04 INFO - TEST-INFO | 30345: exit 0 16:06:04 INFO - Browser initialized. 16:06:04 INFO - Running cycle 1/1 for kraken test... 16:06:04 INFO - TEST-INFO | started process 30427 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeHX80D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:16 INFO - PROCESS | 30427 | RSS: Main: 149819392 16:06:16 INFO - PROCESS | 30427 | 16:06:19 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49484/tests/kraken/driver.html?testName=audio-beat-detection) 16:06:19 INFO - PROCESS | 30427 | RSS: Main: 188469248 16:06:19 INFO - PROCESS | 30427 | 16:06:22 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49484/tests/kraken/driver.html?testName=audio-dft) 16:06:23 INFO - PROCESS | 30427 | RSS: Main: 180064256 16:06:23 INFO - PROCESS | 30427 | 16:06:25 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49484/tests/kraken/driver.html?testName=audio-fft) 16:06:26 INFO - PROCESS | 30427 | RSS: Main: 161570816 16:06:26 INFO - PROCESS | 30427 | 16:06:28 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49484/tests/kraken/driver.html?testName=audio-oscillator) 16:06:29 INFO - PROCESS | 30427 | RSS: Main: 164720640 16:06:29 INFO - PROCESS | 30427 | 16:06:31 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49484/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:06:31 INFO - PROCESS | 30427 | RSS: Main: 165007360 16:06:31 INFO - PROCESS | 30427 | 16:06:34 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49484/tests/kraken/driver.html?testName=imaging-darkroom) 16:06:35 INFO - PROCESS | 30427 | RSS: Main: 166191104 16:06:35 INFO - PROCESS | 30427 | 16:06:38 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49484/tests/kraken/driver.html?testName=imaging-desaturate) 16:06:39 INFO - PROCESS | 30427 | RSS: Main: 166785024 16:06:39 INFO - PROCESS | 30427 | 16:06:41 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49484/tests/kraken/driver.html?testName=json-parse-financial) 16:06:42 INFO - PROCESS | 30427 | RSS: Main: 167235584 16:06:42 INFO - PROCESS | 30427 | 16:06:44 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49484/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:06:44 INFO - PROCESS | 30427 | RSS: Main: 181874688 16:06:44 INFO - PROCESS | 30427 | 16:06:46 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:06:47 INFO - PROCESS | 30427 | RSS: Main: 179920896 16:06:47 INFO - PROCESS | 30427 | 16:06:49 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:06:49 INFO - PROCESS | 30427 | RSS: Main: 189657088 16:06:49 INFO - PROCESS | 30427 | 16:06:52 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:06:52 INFO - PROCESS | 30427 | RSS: Main: 196698112 16:06:52 INFO - PROCESS | 30427 | 16:06:55 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:06:55 INFO - PROCESS | 30427 | RSS: Main: 194035712 16:06:55 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | Cycle 1(1): loaded http://localhost:49484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49484/tests/kraken/driver.html?testName=ai-astar) 16:06:57 INFO - PROCESS | 30427 | RSS: Main: 253079552 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | __start_tp_report 16:06:57 INFO - PROCESS | 30427 | _x_x_mozilla_page_load 16:06:57 INFO - PROCESS | 30427 | _x_x_mozilla_page_load_details 16:06:57 INFO - PROCESS | 30427 | |i|pagename|runs| 16:06:57 INFO - PROCESS | 30427 | |0;ai-astar;111;112;107;110;110;110;111;111;103;109 16:06:57 INFO - PROCESS | 30427 | |1;audio-beat-detection;150;125;154;168;134;159;155;131;164;127 16:06:57 INFO - PROCESS | 30427 | |2;audio-dft;162;161;160;161;160;162;162;159;161;161 16:06:57 INFO - PROCESS | 30427 | |3;audio-fft;71;71;99;95;73;72;72;131;95;74 16:06:57 INFO - PROCESS | 30427 | |4;audio-oscillator;97;96;137;96;96;97;140;96;97;138 16:06:57 INFO - PROCESS | 30427 | |5;imaging-gaussian-blur;109;110;108;109;110;109;109;110;109;109 16:06:57 INFO - PROCESS | 30427 | |6;imaging-darkroom;146;145;145;146;146;146;145;146;146;146 16:06:57 INFO - PROCESS | 30427 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 16:06:57 INFO - PROCESS | 30427 | |8;json-parse-financial;56;56;55;55;55;56;58;55;60;53 16:06:57 INFO - PROCESS | 30427 | |9;json-stringify-tinderbox;67;69;68;73;68;69;68;68;69;70 16:06:57 INFO - PROCESS | 30427 | |10;stanford-crypto-aes;83;82;82;83;84;83;83;97;86;84 16:06:57 INFO - PROCESS | 30427 | |11;stanford-crypto-ccm;115;118;127;131;120;125;112;116;116;121 16:06:57 INFO - PROCESS | 30427 | |12;stanford-crypto-pbkdf2;132;132;142;142;143;131;141;142;143;142 16:06:57 INFO - PROCESS | 30427 | |13;stanford-crypto-sha256-iterative;66;70;71;69;68;67;65;67;68;66 16:06:57 INFO - PROCESS | 30427 | __end_tp_report 16:06:57 INFO - PROCESS | 30427 | __start_cc_report 16:06:57 INFO - PROCESS | 30427 | _x_x_mozilla_cycle_collect,936 16:06:57 INFO - PROCESS | 30427 | __end_cc_report 16:06:57 INFO - PROCESS | 30427 | __startTimestamp1453075617780__endTimestamp 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | ------- Summary: start ------- 16:06:57 INFO - PROCESS | 30427 | Number of tests: 14 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:2.63 (2.4%) stddev-sans-first:2.73 16:06:57 INFO - PROCESS | 30427 | Values: 111.0 112.0 107.0 110.0 110.0 110.0 111.0 111.0 103.0 109.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:154.50 stddev:16.00 (10.4%) stddev-sans-first:16.93 16:06:57 INFO - PROCESS | 30427 | Values: 150.0 125.0 154.0 168.0 134.0 159.0 155.0 131.0 164.0 127.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 16:06:57 INFO - PROCESS | 30427 | Values: 162.0 161.0 160.0 161.0 160.0 162.0 162.0 159.0 161.0 161.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#3] audio-fft Cycles:10 Average:85.30 Median:73.50 stddev:19.74 (26.9%) stddev-sans-first:20.25 16:06:57 INFO - PROCESS | 30427 | Values: 71.0 71.0 99.0 95.0 73.0 72.0 72.0 131.0 95.0 74.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:96.00 stddev:20.26 (21.1%) stddev-sans-first:21.02 16:06:57 INFO - PROCESS | 30427 | Values: 97.0 96.0 137.0 96.0 96.0 97.0 140.0 96.0 97.0 138.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:06:57 INFO - PROCESS | 30427 | Values: 109.0 110.0 108.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:06:57 INFO - PROCESS | 30427 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:06:57 INFO - PROCESS | 30427 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.91 (3.4%) stddev-sans-first:2.03 16:06:57 INFO - PROCESS | 30427 | Values: 56.0 56.0 55.0 55.0 55.0 56.0 58.0 55.0 60.0 53.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.62 16:06:57 INFO - PROCESS | 30427 | Values: 67.0 69.0 68.0 73.0 68.0 69.0 68.0 68.0 69.0 70.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.50 stddev:4.47 (5.4%) stddev-sans-first:4.70 16:06:57 INFO - PROCESS | 30427 | Values: 83.0 82.0 82.0 83.0 84.0 83.0 83.0 97.0 86.0 84.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:120.50 stddev:5.97 (5.0%) stddev-sans-first:6.04 16:06:57 INFO - PROCESS | 30427 | Values: 115.0 118.0 127.0 131.0 120.0 125.0 112.0 116.0 116.0 121.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:142.00 stddev:5.10 (3.6%) stddev-sans-first:4.74 16:06:57 INFO - PROCESS | 30427 | Values: 132.0 132.0 142.0 142.0 143.0 131.0 141.0 142.0 143.0 142.0 16:06:57 INFO - PROCESS | 30427 | 16:06:57 INFO - PROCESS | 30427 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:1.90 16:06:57 INFO - PROCESS | 30427 | Values: 66.0 70.0 71.0 69.0 68.0 67.0 65.0 67.0 68.0 66.0 16:06:57 INFO - PROCESS | 30427 | -------- Summary: end -------- 16:06:57 INFO - PROCESS | 30427 | 16:06:58 INFO - TEST-INFO | 30427: exit 0 16:06:58 INFO - TEST-OK | kraken | took 59062ms 16:06:58 INFO - TEST-START | v8_7 16:06:58 INFO - operating with platform_type : linux_ 16:06:58 INFO - Initialising browser for v8_7 test... 16:06:58 INFO - TEST-INFO | started process 30675 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGlngeW/profile http://localhost:49484/getInfo.html) 16:07:02 INFO - PROCESS | 30675 | __metrics Screen width/height:1600/1200 16:07:02 INFO - PROCESS | 30675 | colorDepth:24 16:07:02 INFO - PROCESS | 30675 | Browser inner width/height: 1024/697 16:07:02 INFO - PROCESS | 30675 | __metrics 16:07:02 INFO - PROCESS | 30675 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:07:02 INFO - PROCESS | 30675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:07:03 INFO - TEST-INFO | 30675: exit 0 16:07:03 INFO - Browser initialized. 16:07:03 INFO - Running cycle 1/1 for v8_7 test... 16:07:03 INFO - TEST-INFO | started process 30755 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGlngeW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:15 INFO - PROCESS | 30755 | RSS: Main: 149577728 16:07:15 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | Cycle 1(1): loaded http://localhost:49484/tests/v8_7/run.html (next: http://localhost:49484/tests/v8_7/run.html) 16:07:38 INFO - PROCESS | 30755 | RSS: Main: 553607168 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | __start_tp_report 16:07:38 INFO - PROCESS | 30755 | _x_x_mozilla_page_load 16:07:38 INFO - PROCESS | 30755 | _x_x_mozilla_page_load_details 16:07:38 INFO - PROCESS | 30755 | |i|pagename|runs| 16:07:38 INFO - PROCESS | 30755 | |0;Richards;166.16816218012627 16:07:38 INFO - PROCESS | 30755 | |1;DeltaBlue;189.7173211914248 16:07:38 INFO - PROCESS | 30755 | |2;Encrypt;279.72027972027973 16:07:38 INFO - PROCESS | 30755 | |3;Decrypt;5246.073298429319 16:07:38 INFO - PROCESS | 30755 | |4;RayTrace;1108.6474501108648 16:07:38 INFO - PROCESS | 30755 | |5;Earley;789.8894154818325 16:07:38 INFO - PROCESS | 30755 | |6;Boyer;12268.292682926829 16:07:38 INFO - PROCESS | 30755 | |7;RegExp;42666.666666666664 16:07:38 INFO - PROCESS | 30755 | |8;Splay;579.7101449275362 16:07:38 INFO - PROCESS | 30755 | |9;NavierStokes;4845.410628019324 16:07:38 INFO - PROCESS | 30755 | __end_tp_report 16:07:38 INFO - PROCESS | 30755 | __startTimestamp1453075658287__endTimestamp 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | ------- Summary: start ------- 16:07:38 INFO - PROCESS | 30755 | Number of tests: 10 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 166.2 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#1] DeltaBlue Cycles:1 Average:189.72 Median:189.72 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 189.7 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 279.7 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 5246.1 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 1108.6 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 789.9 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 12268.3 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#7] RegExp Cycles:1 Average:42666.67 Median:42666.67 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 42666.7 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#8] Splay Cycles:1 Average:579.71 Median:579.71 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 579.7 16:07:38 INFO - PROCESS | 30755 | 16:07:38 INFO - PROCESS | 30755 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 16:07:38 INFO - PROCESS | 30755 | Values: 4845.4 16:07:38 INFO - PROCESS | 30755 | -------- Summary: end -------- 16:07:38 INFO - PROCESS | 30755 | 16:07:39 INFO - TEST-INFO | 30755: exit 0 16:07:39 INFO - TEST-OK | v8_7 | took 40487ms 16:07:39 INFO - SUITE-END | took 1213s 16:07:39 INFO - Completed test suite (00:20:13) 16:07:39 INFO - Working with test: dromaeo_css 16:07:39 INFO - Generating results file: dromaeo_css 16:07:39 INFO - Working with test: kraken 16:07:39 INFO - Generating results file: kraken 16:07:39 INFO - javascript benchmark 16:07:39 INFO - Working with test: v8_7 16:07:39 INFO - Generating results file: v8_7 16:07:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:07:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 16:07:39 INFO - process_Request line: dromaeo_css 6821.94 graph.html#tests=[[72,1,35]] 16:07:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:07:39 INFO - process_Request line: kraken 1498.40 graph.html#tests=[[232,1,35]] 16:07:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:07:39 INFO - process_Request line: v8_7 20074.34 graph.html#tests=[[230,1,35]] 16:07:39 INFO - RETURN: dromaeo_css: 6821.94 16:07:39 INFO - RETURN: kraken: 1498.40 16:07:39 INFO - RETURN: v8_7: 20074.34 16:07:39 INFO - javascript benchmark 16:07:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.6833316668335, 3204.967950320499, 3258.0, 3261.527078573607, 3286.6384697683256, 5230.293910322105, 5246.842594722155, 5248.71132087735, 5290.338707661547, 5332.253484512172, 5309.230161626571, 5315.973420132894, 5327.2808170896915, 5343.812966546172, 5391.487808658171, 4744.64415168862, 4754.78603462845, 4778.402699662543, 4810.759462026902, 4903.583195428393, 4862.173430516803, 4884.194107972198, 4895.779689913945, 4930.728809915453, 4936.333594964688, 4730.314104454852, 4773.093112308685, 4823.252395878644, 4864.246041863516, 4870.318155458239, 4822.95177048232, 4832.685875418087, 4839.27410888366, 4839.44346400165, 4880.633952453581, 4787.305840653121, 4807.831725889577, 4813.975930120362, 4832.589229915461, 4841.273808928654, 5084.77118529667, 5157.71632560209, 5179.093658609729, 5235.502627250406, 5264.052470555337, 5689.0, 5692.345380281279, 5695.5443564514735, 5697.230873832021, 5699.316082070137, 5611.971940140314, 5686.857828554278, 5736.885262294731, 5737.2254745609225, 5739.713014349308, 5264.973675131638, 5304.443033481506, 5317.388500322474, 5346.144616861322, 5346.465353464622, 5804.88390232193, 5826.300843898674, 5840.678762668009, 5854.736536855852, 5858.150568167677, 5505.642133261325, 5636.549076073904, 5642.379338272786, 5648.181013752983, 5649.435056494318, 5548.140038294071, 5679.375268720438, 5728.05487094633, 5728.1407788831175, 5774.48029677331, 5619.775208991677, 5635.070213414822, 5657.2928383952, 5664.971675141598, 5675.347335056439, 5518.475744804237, 5607.0, 5615.410381909923, 5697.857553561194, 5707.200991861143, 4406.184855801687, 4446.399736035659, 4446.688731788809, 4476.977615111904, 4478.171538265431, 3942.329803933338, 3944.8422063117728, 3960.6435420812263, 3966.4446977423186, 3981.1042515434374, 5215.322008138994, 5281.445448227958, 5285.233641122093, 5314.0, 5360.061989151883, 5697.914531282034, 5726.942730572641, 5744.569157313218, 5756.913646295309, 5799.449052340021, 5294.047071527085, 5323.0, 5329.200619907045, 5332.440093790096, 5333.439988801198, 4819.204831202883, 4878.609711223094, 4880.243562247857, 4908.067467181296, 4929.285253638274, 5991.310999235056, 5991.730372133352, 5998.550108741862, 5998.790042348497, 6012.518998480111, 5743.4543718346695, 5751.338596061507, 5755.453231942959, 5764.279465066867, 5765.423457654201, 5803.767849285981, 5809.36097029318, 5866.6186697864505, 5917.911231331447, 5961.105834124916, 5570.275864137636, 5574.386817449996, 5575.9163612545035, 5579.721013949367, 5591.077472217039, 5551.611387202857, 5641.605087643826, 5645.71771411436, 5649.067903795828, 5652.208690783212, 5439.864003399946, 5547.55619550443, 5547.8890422190525, 5548.445155484419, 5553.972230138824, 5554.50009499147, 5555.944440555542, 5557.36090349615, 5559.221708960829, 5574.358948720949, 5452.0731475648445, 5458.836234912959, 5465.672059676433, 5476.452354764491, 5523.6409633373705, 5408.242846001642, 5443.401225865073, 5495.230667706444, 5580.5535557156145, 5598.048331783688, 5455.8363249102595, 5502.174673798962, 5505.504504594445, 5508.641938274, 5546.029444847055], "unit": "score", "name": "dojo.html", "value": 5248.412402272403}, {"lowerIsBetter": false, "replicates": [542.7530473634495, 550.2846299810246, 557.6793343827301, 566.88095499945, 578.020255666645, 28675.85662071689, 29231.707682923192, 38643.22713545731, 39572.20855582887, 39634.80182599083, 42630.14739705204, 43003.13993720124, 43118.353224701656, 43122.0, 43221.56778432215, 8189.467684600511, 8365.996080470351, 8394.79013024673, 8398.286145677625, 8398.580070996457, 8399.580020998956, 8546.102659220785, 8546.102659220785, 8563.10087440819, 8565.443246189008, 8580.270676992463, 8619.094995025525, 8653.264472519844, 8663.913360866374, 8669.69656062038, 8512.446690965067, 8585.570721463964, 8588.184122508352, 8593.828123437528, 8600.225979661798, 8359.707410240613, 8470.449420787629, 8481.321494280504, 8496.872546911802, 8497.192766687154, 39335.803320983214, 39346.60653393458, 39861.20277594461, 39894.80052599718, 39906.0, 3345.9330813383594, 3449.068751437123, 3511.94732079019, 4008.7594744315143, 4042.858499952517, 29238.853805730836, 29609.555856662166, 29859.568390987, 30180.698193018008, 30570.69429305723, 3611.855525778966, 3612.9277414451826, 3666.1018050577777, 3683.8710645127294, 3739.1960728443514, 264203.0, 264672.0, 266293.0, 266770.0, 266772.0, 51857.2221416679, 52421.7378913103, 52458.0, 58688.0, 58840.0, 50990.74504627453, 63047.36952630415, 63599.36400636027, 63767.0, 63776.0, 14526.346314415876, 14594.85405145935, 14758.040727352687, 14759.704805903822, 14777.187254700879, 10083.949580252198, 12058.0, 12109.091818113677, 12139.210951288138, 12162.513499459923, 16397.180140992903, 19677.606447870963, 19996.400107996782, 20295.39113826558, 20321.390358289274, 7356.668949897267, 7554.660040298199, 7642.121156067013, 7658.73194438192, 7660.5403675779635, 984.6455276100598, 989.678354534779, 1000.4547521600745, 1066.2962444786403, 1117.932924024561, 28608.856955715088, 28998.565021524693, 29066.27334316659, 29191.416171676872, 29651.258718532208, 984.2273815055147, 998.7752755629925, 1050.8686414198226, 1084.8264277715527, 1103.5034234594464, 13916.0, 13937.303134843218, 14050.734045740497, 14117.78823317651, 14254.3585538651, 334540.0, 346114.0, 346166.0, 346455.0, 346902.0, 51216.23175652368, 51293.0, 51486.74256628768, 51509.227361589605, 51590.0, 1293.0625296660035, 1325.4963114016805, 1347.1916849889988, 1348.339313736262, 1355.4374934402113, 24329.39176520601, 26777.464450710486, 27155.1853444397, 27747.44505109846, 28161.59192040431, 41781.164376712906, 42065.0, 42330.1533969325, 42377.36433953555, 42453.15093698047, 241246.0, 245045.0, 245179.0, 245571.0, 245867.0, 25950.35124121912, 26021.6096758545, 28418.857905710338, 31598.684013159575, 32248.0, 37683.62316376801, 40657.59342406538, 40796.0, 41063.38404923988, 41769.58230417657, 33369.16577085592, 34653.13367165841, 34987.30025399529, 35047.299054019284, 35102.297954041285, 34616.82691586526, 35159.824200879855, 35770.463443047855, 35828.82085589555, 35964.46053309255, 34041.148971275914, 34346.82826585851, 34644.307113858085, 34692.132696682784, 35108.473372898916, 30559.694403055684, 31205.219869503446, 31414.371712565164, 31663.0, 31667.20831979219, 23677.526449471257, 24158.87920560386, 24207.394815129763, 24554.754452455247, 24564.50870982606], "unit": "score", "name": "ext.html", "value": 17971.99046488989}, {"lowerIsBetter": false, "replicates": [355.4135676134378, 359.14165145302724, 360.18058915966174, 361.7919696174699, 363.9017465284375, 15853.286602102904, 16312.0, 16818.83181168188, 17203.483895483125, 17224.3110275589, 16177.0, 16439.342426302934, 16456.094914779682, 16498.34006639733, 16742.0, 5159.7678104485385, 5224.608154388427, 5388.407275199725, 5397.2443857859935, 5407.918881216785, 5130.256112863633, 5239.978204250173, 5244.79020839166, 5246.816361427351, 5247.740542269866, 3963.7621742695387, 4116.115035267417, 5133.768980395891, 5202.375714914216, 5309.460256525603, 3996.9000774980714, 5531.557475401958, 5740.913886291709, 5747.568932330092, 5751.4536119068625, 4965.875853103701, 5062.4684408137355, 5078.339815823956, 5083.923741143886, 5086.389633243997, 14588.197649129293, 15209.771853422208, 17839.197236124404, 18694.81305186958, 18728.15723292455, 2077.792220777925, 2106.5892151030557, 2145.2384403536676, 2151.688005239247, 2207.9006444710026, 11995.760084798256, 12048.397580121047, 12128.878711212863, 12297.877021229851, 12335.321557314344, 1768.5667011582116, 1849.6485667723225, 1861.9069046547618, 1863.813618638139, 1910.74204982327, 49974.0, 50734.238986414864, 52818.0, 53291.73354133243, 54100.188497172574, 9654.951725241328, 10021.0, 10089.697309080593, 10096.69709908704, 10184.643537476153, 13323.40044697991, 13333.599992000256, 13360.799588006188, 13367.598972030855, 13379.260696109639, 7148.249433809479, 7175.0, 7246.891296630555, 7322.560646361236, 7388.593627350548, 6661.833454163588, 6675.332466753286, 6732.4950628703045, 6758.560693554903, 6763.695633696496, 4407.449068866392, 4453.1316393303, 4453.844115455943, 4465.821367145278, 4475.664325175625, 1763.3651885321274, 1841.9171137298854, 1847.1964695357563, 1847.7136043913215, 1853.0456814740419, 872.289084396215, 892.5626443042992, 904.8099899021279, 1015.7663737340453, 1051.1853313681959, 15883.28525216368, 15910.68178636444, 16244.0, 16881.493555193363, 16947.491575252763, 783.7452827830978, 857.3269983063266, 858.6694122762781, 862.4997501449144, 926.8100039491889, 6448.484121270287, 9229.861552076723, 9444.291678124031, 9975.800483990279, 10033.147182489423, 486377.0, 522663.1600525995, 527363.0, 554574.0, 569964.0, 46676.29985550219, 47288.290675639895, 47839.282410763866, 60699.69650151809, 69075.0, 1086.809808283563, 1118.4184224203532, 1120.3418939968892, 1126.6225814352283, 1138.4421633399575, 11443.771124577295, 13780.448782048607, 13986.930065349608, 14526.85473145255, 15653.452129175424, 31161.0, 31848.203794905312, 32021.199470013435, 33500.162495937795, 34988.82505587456, 41051.58948410597, 41479.7926010368, 42409.5759042418, 43149.56850431456, 46261.0, 6943.201531823703, 7037.120359955005, 7084.964575177091, 7245.529040612343, 7338.559686418832, 8257.628406721591, 11330.490127944098, 11519.366434846164, 11591.188616796744, 11850.881491185322, 9428.151466367786, 10082.243831712503, 10294.794104118026, 10294.845577316497, 10473.0, 8808.603612837309, 9176.265898727952, 9309.487978161265, 9440.858387124335, 9625.278104142357, 6762.7294908205085, 6964.965175174294, 6978.720851165896, 9746.122848943345, 10299.176065914558, 8916.73249802507, 10123.341982771097, 10143.695689129338, 10148.746281343025, 10250.231232657432, 9625.278104142077, 9683.951580242054, 9805.705828825146, 9830.5084745761, 10030.749231268985], "unit": "score", "name": "jquery.html", "value": 8017.37651367777}, {"lowerIsBetter": false, "replicates": [1307.2940612069483, 1399.1605036977815, 1451.0568130715035, 1575.8739300855932, 1765.0733364983382, 7028.753993610225, 7718.4982976106585, 7847.960760196191, 7851.842963140748, 7857.80355491113, 7679.424043196755, 7822.178671239509, 7838.608069596512, 7844.333231675315, 7848.60756962151, 2024.4635171679517, 2059.299838055061, 2063.174730107954, 2322.512272422793, 2350.4711439925964, 2036.2364113457454, 2044.3458093410115, 2372.3476044087843, 2419.129113519132, 2426.514697060586, 2308.73449553301, 2351.9764802352015, 2353.0705371378294, 2353.646952957053, 2355.034435881289, 2325.8953347099423, 2327.208749025331, 2330.0679728108894, 2330.1378489958656, 2331.860088394702, 2327.6857624220684, 2378.655095011231, 2386.4869053153484, 2390.270967354956, 2391.4021494626345, 7704.65329060188, 7755.2632499912415, 7767.53394796314, 7769.805754856117, 7787.3770098392, 4740.1230772307235, 4919.458859525449, 4923.08922849274, 4929.408470983505, 4941.654084214107, 3027.228056845512, 3074.707902749235, 3140.2463408781728, 3144.9685503144906, 3153.4796758534812, 926.9953650231773, 928.9489078100702, 937.7186843946789, 959.1465390463385, 969.9030096990315, 11252.718682033015, 11395.943020284845, 11444.370559619218, 11466.598669046627, 11485.655430337103, 4563.885902852388, 4580.519045500175, 4610.930836037395, 4618.792154353062, 4646.79089440976, 9761.707148785548, 9762.36544624597, 9776.266779991529, 9783.804323913482, 9801.0, 5134.717590532482, 5136.5377116059735, 5139.665921715076, 5143.27994080829, 5144.897102058013, 4640.605548528345, 4646.651501137429, 4648.302754586772, 4650.255959046536, 4651.441826980784, 3522.0842580929143, 3724.2923844469465, 3812.0, 3828.0429892526868, 3836.175222327213, 1157.6295585412756, 1245.4520011195045, 1255.554278231233, 1264.3362234826789, 1267.5816980396446, 1284.113961366654, 1307.0850404716737, 1309.4173092973726, 1311.7769979103575, 1312.4356526693614, 7200.891986620205, 7222.458315626349, 7256.709731610782, 7256.854862902818, 7262.96368518154, 1119.7480566872553, 1128.0862501373913, 1129.8644162700527, 1129.971750706239, 1150.3787954504642, 5503.0, 5544.61187716856, 5644.125160600113, 5700.25896633435, 5810.651360918274, 9331.346805723535, 9570.377925434825, 9879.506024698736, 9887.950560247153, 10032.69901902944, 9428.905710942803, 9504.049595040578, 9542.713718588453, 9613.423194608346, 9637.807243855084, 7474.962625186839, 7511.849763004819, 7541.5098018629715, 7549.131849837229, 7619.504732192389, 7390.519616225143, 7511.248875112445, 7515.2109028553405, 7520.586367749826, 7528.209537998431, 8439.28266097364, 8707.521086340312, 8805.075467076122, 8868.334874884538, 8873.64505419776, 9081.545922703706, 9165.816683666422, 9240.445573265626, 9312.068793120634, 9360.95319523398, 6987.790366289019, 7067.293270672892, 7179.317964793337, 7195.280471952763, 7217.809061505003, 6790.354916282945, 6957.478189135936, 7521.398288137046, 7589.6205189741395, 7604.581748003913, 7080.468964827762, 7106.78679639591, 7198.964005179941, 7288.489805713762, 7305.415566754753, 6916.55042422241, 6992.650367481708, 7032.824179395351, 7150.284971502808, 7151.499395042505, 6964.512484126062, 6980.860382792417, 7038.049863268393, 7050.541714788727, 7083.150021997393, 6344.936550634435, 6377.936220637735, 6449.677516124269, 6452.161219041683, 6507.186601674791, 6641.402273795382, 6702.162229721285, 6707.195136583641, 6798.490113241428, 6802.93197068023], "unit": "score", "name": "mootools.html", "value": 4602.841611341123}, {"lowerIsBetter": false, "replicates": [330.9635940046595, 334.162921880689, 338.8627605819644, 341.84446077034954, 346.5391029930191, 5661.3206415230125, 5797.681127537989, 5820.126980952859, 5844.327902291232, 5891.145783861338, 5617.522510586595, 5698.6865722385255, 5728.341240757314, 5729.369769325382, 5729.828105156842, 4473.239549276631, 4474.597286244238, 4509.188346097718, 4511.436070491189, 4537.0925814837, 4303.655707543389, 4424.668149888771, 4427.9557204427865, 4508.233600287959, 4531.116432295704, 4457.353683715859, 4469.553044695537, 4499.75251361175, 4503.819847206108, 4508.391367165424, 4494.97752511237, 4498.392716983198, 4500.617447516965, 4504.729716217021, 4505.189065968125, 3942.073612701013, 3955.782431966241, 3960.8613698520703, 3966.940495892564, 3969.186316805048, 5470.370907345627, 5577.8605534861545, 5598.748056337475, 5614.382417934024, 5659.717014149317, 5106.183010718267, 5112.539871411554, 5113.539781419653, 5122.846314610568, 5130.461301563357, 5885.087811389241, 6193.0, 6196.535259855484, 6203.503719702413, 6210.31686514483, 4115.1975364803875, 4171.353440216772, 4246.5541118182455, 4254.978805086788, 4256.531781504032, 6359.0, 6443.259025212114, 6459.644719540471, 6462.450691691165, 6468.902966455507, 4366.345048242725, 4369.60673539383, 4372.934405983913, 4399.20814253431, 4417.955820441819, 4297.978510107492, 4425.247707889666, 4426.911461770746, 4432.312991486325, 4438.1567502174485, 5103.948960510347, 5108.2848401223855, 5147.819826306136, 5149.588032957355, 5154.433012368637, 6232.8130156095385, 6246.562740608114, 6291.591046581958, 6307.9369206308265, 6314.747410103544, 1542.5680809373168, 1565.295616972367, 1568.3569736408017, 1569.082086979107, 1569.8116226052719, 1035.5909415780875, 1038.5638032026568, 1040.2354269611828, 1040.9739756506149, 1068.1401471815109, 5918.378570250148, 5919.940800591939, 5930.169776231331, 5932.317783454958, 5935.851603709942, 6356.459700925473, 6359.872802543923, 6366.936330636634, 6376.426121649074, 6384.840378990562, 5795.246617939641, 5824.88350232993, 5834.299884013945, 5838.8540286492325, 5841.532677385799, 3335.0, 3454.2573346730574, 3464.826758662057, 3464.9826750866087, 3465.3935561276676, 6481.902771458432, 6518.511111666644, 6531.0856480092825, 6537.313582073909, 6544.770933017321, 6506.512011599149, 6514.05546195799, 6523.902141467882, 6528.08606795049, 6535.379138981789, 6508.9349106508325, 6682.766103186365, 6686.398224159849, 6752.291009444036, 6760.391564759097, 6216.409441103088, 6361.522885783677, 6416.101745755504, 6469.5794773339585, 6484.416402523795, 6189.81430557084, 6274.968625156845, 6342.23893132827, 6348.079528468438, 6383.0, 6692.531522793358, 6722.764703235363, 6731.730730770911, 6736.090627765189, 6740.865182696417, 4402.691811573159, 4422.778861056999, 4440.777961101868, 4446.73319600825, 4454.443194600675, 6386.93613063882, 6414.486841052798, 6423.550351475352, 6435.581687190318, 6497.9025314619375, 6267.435930766253, 6322.905156422566, 6324.525660575568, 6324.936750632435, 6326.4622507087415, 6141.723622436912, 6192.659403732658, 6203.472704820141, 6238.407351301619, 6244.5316601256, 6114.57197996136, 6120.17377654011, 6121.234845644294, 6128.571000029955, 6128.846778830565, 6245.219347581552, 6250.406211409909, 6254.6247225166635, 6261.812145635638, 6264.467520260829, 5927.762889484372, 6072.301685306246, 6096.786612468542, 6097.146399504161, 6109.327973922776], "unit": "score", "name": "prototype.html", "value": 4676.338829321691}, {"lowerIsBetter": false, "replicates": [703.5954326262397, 789.2541548236918, 807.1847434091569, 816.7917181118814, 820.5774026376417, 13309.334533273333, 13388.732225355487, 13438.0, 13441.7983730244, 13457.394417251222, 11550.711232219177, 11844.34856082915, 11845.46695398707, 11870.406479676003, 11904.0, 658.9769358072468, 787.9684812607503, 802.0856223904754, 802.1296892871212, 802.3500964219002, 661.894096944489, 787.5078076202374, 796.7251298302076, 797.2466019611469, 798.4610387988114, 823.5799742131496, 825.9215374539439, 827.0488937721639, 827.2182787266036, 829.722043115557, 684.8630273945231, 688.3391943734022, 825.1377310710292, 825.781167990483, 830.9542975136366, 611.5596770325359, 611.9816405507797, 612.1338306296585, 615.0190446238242, 615.8552740106071, 13552.728945421037, 13629.182249065088, 13629.591112266648, 13641.386137623831, 13666.726665466735, 12211.938940305241, 12352.776500229955, 12441.0, 12593.559225427067, 12757.170783899017, 9708.805823883482, 10370.844437333446, 10371.636992705295, 10484.108850747696, 10613.84079238812, 3536.664016918389, 3543.5924868639922, 3558.62634423387, 3564.500969864221, 3691.151035261878, 49579.0, 49860.50139498595, 49921.00157996856, 49970.50029499695, 50015.24977125346, 9767.755806104904, 9984.35101718386, 10103.444310562843, 10224.386536807666, 10535.631252906265, 17708.380206692706, 17730.0, 17759.55601109957, 17766.555836104202, 17771.111444427726, 7686.039245094364, 7700.537967721954, 7752.224777522202, 7845.137034926153, 8011.278984891388, 4185.727927684691, 4322.438083049184, 4360.193364227564, 4477.485089214717, 4512.4133862597655, 3220.4847224443974, 3256.234784825564, 3277.1807048237943, 3277.737780977516, 3280.0323904448246, 565.9943400566024, 580.309431776185, 586.6128355285491, 587.9647221166744, 612.6783438694721, 520.3989392251955, 523.4895976422957, 572.9083346664513, 596.627108057464, 609.9935107073364, 7486.475946683789, 7599.202083781234, 7775.727269119304, 7863.84272314562, 7923.12845586985, 521.2832355511172, 526.2159382520094, 589.0898561722149, 659.8383396067994, 680.2619158213394, 3781.640744129303, 3882.6311500407414, 3951.4863067801575, 4118.814653340607, 4405.118976204772, 49979.75010124926, 50564.49435505598, 56209.0, 57097.71451142718, 57299.0, 46517.0, 46738.5326146741, 46938.530614693416, 48663.270050949264, 52284.73857630764, 45992.310115347624, 46028.0, 46476.76761616238, 48081.75959120182, 48100.51899481031, 8585.012723536873, 8614.913850861662, 8746.73759787182, 8907.153820387053, 9018.278537717099, 34365.65634343625, 35849.0, 36880.262394751415, 36973.63026369702, 37138.814305928296, 44958.0, 45034.54965450303, 45141.0, 45221.321680174166, 45854.0, 10919.181061420584, 11057.557697692002, 11105.500252488497, 11197.832032519682, 11233.101351891666, 12312.26126432417, 12463.06527010496, 12574.30841303737, 12827.42276597574, 12838.55065072718, 9964.0, 10468.68593942183, 10714.892851071701, 10730.248882578144, 10842.078423334106, 11209.943950280523, 11400.258983166068, 11482.138839586898, 11611.419429028683, 11984.0, 10954.11449771266, 11253.549858005588, 11533.0, 11738.471768770254, 11865.703357416134, 8915.37592368528, 9084.863727043967, 9298.907010929805, 9386.765330866783, 9498.95250523743, 8228.753137405887, 8731.843880996184, 9197.21823644971, 9360.4383736976, 9460.148586627236], "unit": "score", "name": "yui.html", "value": 6191.8648901361}], "name": "dromaeo_css", "value": 6821.937328650874}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 110.0, 110.0, 110.0, 111.0, 111.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 154.0, 168.0, 134.0, 159.0, 155.0, 131.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 160.0, 162.0, 162.0, 159.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 99.0, 95.0, 73.0, 72.0, 72.0, 131.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 137.0, 96.0, 96.0, 97.0, 140.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 108.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 56.0, 58.0, 55.0, 60.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 73.0, 68.0, 69.0, 68.0, 68.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 83.0, 84.0, 83.0, 83.0, 97.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [115.0, 118.0, 127.0, 131.0, 120.0, 125.0, 112.0, 116.0, 116.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [132.0, 132.0, 142.0, 142.0, 143.0, 131.0, 141.0, 142.0, 143.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 71.0, 69.0, 68.0, 67.0, 65.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1498.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [189.7173211914248], "unit": "score", "name": "DeltaBlue", "value": 348.507978}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [42666.666666666664], "unit": "score", "name": "RegExp", "value": 21.351210937500017}, {"lowerIsBetter": false, "replicates": [579.7101449275362], "unit": "score", "name": "Splay", "value": 140.57197499999998}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20074.33992424924}]} 16:07:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20074.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1498.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6821.94"}}} 16:07:39 INFO - Return code: 0 16:07:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:07:39 INFO - # TBPL SUCCESS # 16:07:39 INFO - Running post-action listener: _resource_record_post_action 16:07:39 INFO - Running post-run listener: _resource_record_post_run 16:07:40 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 539758592; Read time: 0; Write time: 468364 16:07:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237662208; Read time: 0; Write time: 253180 16:07:40 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 302096384; Read time: 0; Write time: 215184 16:07:40 INFO - Running post-run listener: _upload_blobber_files 16:07:40 INFO - Blob upload gear active. 16:07:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:07:40 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 16:07:40 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'] 16:07:40 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 16:07:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:07:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:07:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:42 INFO - (blobuploader) - INFO - Done attempting. 16:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:42 INFO - (blobuploader) - INFO - Done attempting. 16:07:42 INFO - (blobuploader) - INFO - Iteration through files over. 16:07:42 INFO - Return code: 0 16:07:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:07:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:07:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6eaa06e616f02d50200287966cd395bc0c4f0abb43c034e6ec26c0585ff5a95e8c3bc0c0686420bd00cb212d10d0f359c2bc7b0db0a5f3647f29824bae28fcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f0ebe4d20dd3c3c7795b5bdccb8e0de6d1e5960a82de08802743cb1791c1facacdbddc8540a869f96c9d69d2147600ce088516a8660d0911da33b8eaf37dd1f"} 16:07:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:07:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:07:42 INFO - Contents: 16:07:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6eaa06e616f02d50200287966cd395bc0c4f0abb43c034e6ec26c0585ff5a95e8c3bc0c0686420bd00cb212d10d0f359c2bc7b0db0a5f3647f29824bae28fcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f0ebe4d20dd3c3c7795b5bdccb8e0de6d1e5960a82de08802743cb1791c1facacdbddc8540a869f96c9d69d2147600ce088516a8660d0911da33b8eaf37dd1f"} 16:07:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:07:42 INFO - Copying logs to upload dir... 16:07:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:07:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.703296 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-17 16:07:42.402373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 16:07:42.406004) ========= 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-1453074078.937459-1582513433 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/c6eaa06e616f02d50200287966cd395bc0c4f0abb43c034e6ec26c0585ff5a95e8c3bc0c0686420bd00cb212d10d0f359c2bc7b0db0a5f3647f29824bae28fcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f0ebe4d20dd3c3c7795b5bdccb8e0de6d1e5960a82de08802743cb1791c1facacdbddc8540a869f96c9d69d2147600ce088516a8660d0911da33b8eaf37dd1f"} build_url:https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/KiE8WmswTsql7qZOkANtmQ/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/c6eaa06e616f02d50200287966cd395bc0c4f0abb43c034e6ec26c0585ff5a95e8c3bc0c0686420bd00cb212d10d0f359c2bc7b0db0a5f3647f29824bae28fcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f0ebe4d20dd3c3c7795b5bdccb8e0de6d1e5960a82de08802743cb1791c1facacdbddc8540a869f96c9d69d2147600ce088516a8660d0911da33b8eaf37dd1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 16:07:42.431017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 16:07:42.431352) ========= 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-1453074078.937459-1582513433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 16:07:42.514576) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 16:07:42.514914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 16:07:42.515245) ========= ========= Total master_lag: 0.33 =========