builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1451454451.28 results: success (0) buildid: 20151229193155 builduid: e2d247078c9b437496b6d06df3af4960 revision: 3becd09c71b176713af62aae2646249cab9ff893 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.284058) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.284676) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.285153) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006340 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.315038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.315352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.336782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.337046) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.386531) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.386842) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.387205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.387503) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 21:47:31-- 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% 217M=0s 2015-12-29 21:47:31 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104172 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.504667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.505012) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021821 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:31.555378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-29 21:47:31.555730) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3becd09c71b176713af62aae2646249cab9ff893 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3becd09c71b176713af62aae2646249cab9ff893 --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=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 21:47:32,108 truncating revision to first 12 chars 2015-12-29 21:47:32,108 Setting DEBUG logging. 2015-12-29 21:47:32,108 attempt 1/10 2015-12-29 21:47:32,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3becd09c71b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 21:47:33,031 unpacking tar archive at: mozilla-inbound-3becd09c71b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.206711 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-29 21:47:32.776349) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:32.776737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:32.787773) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:32.788158) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 21:47:32.788638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-29 21:47:32.789112) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:47:33 INFO - MultiFileLogger online at 20151229 21:47:33 in /builds/slave/test-pgo 21:47:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:47:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:47:33 INFO - {'append_to_log': False, 21:47:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:47:33 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:47:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:47:33 INFO - 'branch': 'Mozilla-Inbound', 21:47:33 INFO - 'buildbot_json_path': 'buildprops.json', 21:47:33 INFO - 'config_files': ('talos/linux_config.py',), 21:47:33 INFO - 'default_actions': ('clobber', 21:47:33 INFO - 'read-buildbot-config', 21:47:33 INFO - 'download-and-extract', 21:47:33 INFO - 'populate-webroot', 21:47:33 INFO - 'create-virtualenv', 21:47:33 INFO - 'install', 21:47:33 INFO - 'run-tests'), 21:47:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:47:33 INFO - 'download_minidump_stackwalk': True, 21:47:33 INFO - 'download_symbols': 'ondemand', 21:47:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:47:33 INFO - 'tooltool.py': '/tools/tooltool.py', 21:47:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:47:33 INFO - '/tools/misc-python/virtualenv.py')}, 21:47:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:47:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:47:33 INFO - 'installer_path': 'installer.exe', 21:47:33 INFO - 'log_level': 'info', 21:47:33 INFO - 'log_name': 'talos', 21:47:33 INFO - 'log_to_console': True, 21:47:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:47:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:47:33 INFO - 'opt_config_files': (), 21:47:33 INFO - 'pip_index': False, 21:47:33 INFO - 'sps_profile': False, 21:47:33 INFO - 'sps_profile_interval': 0, 21:47:33 INFO - 'suite': 'dromaeojs', 21:47:33 INFO - 'system_bits': '32', 21:47:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:47:33 INFO - 'title': 'talos-linux64-ix-007', 21:47:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:47:33 INFO - 'use_talos_json': True, 21:47:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:47:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:47:33 INFO - 'work_dir': 'build'} 21:47:33 INFO - ##### 21:47:33 INFO - ##### Running clobber step. 21:47:33 INFO - ##### 21:47:33 INFO - Running pre-action listener: _resource_record_pre_action 21:47:33 INFO - Running main action method: clobber 21:47:33 INFO - rmtree: /builds/slave/test-pgo/build 21:47:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:47:34 INFO - Running post-action listener: _resource_record_post_action 21:47:34 INFO - ##### 21:47:34 INFO - ##### Running read-buildbot-config step. 21:47:34 INFO - ##### 21:47:34 INFO - Running pre-action listener: _resource_record_pre_action 21:47:34 INFO - Running main action method: read_buildbot_config 21:47:34 INFO - Using buildbot properties: 21:47:34 INFO - { 21:47:34 INFO - "project": "", 21:47:34 INFO - "product": "firefox", 21:47:34 INFO - "script_repo_revision": "production", 21:47:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:47:34 INFO - "repository": "", 21:47:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:47:34 INFO - "buildid": "20151229193155", 21:47:34 INFO - "pgo_build": "True", 21:47:34 INFO - "basedir": "/builds/slave/test-pgo", 21:47:34 INFO - "buildnumber": 584, 21:47:34 INFO - "slavename": "talos-linux64-ix-007", 21:47:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:47:34 INFO - "platform": "ubuntu64_hw", 21:47:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:47:34 INFO - "branch": "mozilla-inbound", 21:47:34 INFO - "repo_path": "integration/mozilla-inbound", 21:47:34 INFO - "revision": "3becd09c71b176713af62aae2646249cab9ff893", 21:47:34 INFO - "stage_platform": "linux64-pgo", 21:47:34 INFO - "builduid": "e2d247078c9b437496b6d06df3af4960", 21:47:34 INFO - "slavebuilddir": "test" 21:47:34 INFO - } 21:47:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:47:34 INFO - Running post-action listener: _resource_record_post_action 21:47:34 INFO - ##### 21:47:34 INFO - ##### Running download-and-extract step. 21:47:34 INFO - ##### 21:47:34 INFO - Running pre-action listener: _resource_record_pre_action 21:47:34 INFO - Running main action method: download_and_extract 21:47:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:47:34 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')]} 21:47:34 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json 21:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json 21:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:47:35 INFO - Downloaded 1302 bytes. 21:47:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:47:35 INFO - Using the following test package requirements: 21:47:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:47:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:35 INFO - u'jsshell-linux-x86_64.zip'], 21:47:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:47:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:47:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:47:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:47:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:47:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:35 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:37 INFO - Downloaded 23200035 bytes. 21:47:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:47:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:47:38 INFO - Return code: 0 21:47:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:38 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:47 INFO - Downloaded 23200035 bytes. 21:47:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:47:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:47:48 INFO - Return code: 0 21:47: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')]} 21:47:48 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:49 INFO - Downloaded 11132270 bytes. 21:47:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:47:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:47:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:47:49 INFO - Return code: 0 21:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:49 INFO - https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFgFp1scRW6V-SuGS8sJjg/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 21:47:51 INFO - Downloaded 54947110 bytes. 21:47:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:51 INFO - mkdir: /builds/slave/test-pgo/properties 21:47:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:47:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:47:51 INFO - Contents: 21:47:51 INFO - build_url:https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:47:51 INFO - Running post-action listener: _resource_record_post_action 21:47:51 INFO - Running post-action listener: set_extra_try_arguments 21:47:51 INFO - ##### 21:47:51 INFO - ##### Running populate-webroot step. 21:47:51 INFO - ##### 21:47:51 INFO - Running pre-action listener: _resource_record_pre_action 21:47:51 INFO - Running main action method: populate_webroot 21:47:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:51 INFO - '--tppagecycles', 21:47:51 INFO - '7'], 21:47:51 INFO - 'tests': ['tsvgm']}}, 21:47:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:47:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:47:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:47:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'tests': ['damp', 'tps']}, 21:47:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['damp', 'tps']}, 21:47:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:47:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:51 INFO - 'other': {'tests': ['a11yr', 21:47:51 INFO - 'ts_paint', 21:47:51 INFO - 'tpaint', 21:47:51 INFO - 'sessionrestore', 21:47:51 INFO - 'sessionrestore_no_auto_restore']}, 21:47:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['a11yr', 21:47:51 INFO - 'ts_paint', 21:47:51 INFO - 'tpaint', 21:47:51 INFO - 'sessionrestore', 21:47:51 INFO - 'sessionrestore_no_auto_restore']}, 21:47:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['a11yr', 21:47:51 INFO - 'ts_paint', 21:47:51 INFO - 'tpaint', 21:47:51 INFO - 'sessionrestore', 21:47:51 INFO - 'sessionrestore_no_auto_restore']}, 21:47:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['a11yr', 21:47:51 INFO - 'ts_paint', 21:47:51 INFO - 'tpaint', 21:47:51 INFO - 'sessionrestore', 21:47:51 INFO - 'sessionrestore_no_auto_restore']}, 21:47:51 INFO - 'other_l64': {'tests': ['a11yr', 21:47:51 INFO - 'ts_paint', 21:47:51 INFO - 'tpaint', 21:47:51 INFO - 'sessionrestore', 21:47:51 INFO - 'sessionrestore_no_auto_restore']}, 21:47:51 INFO - 'other_nol64': {'tests': ['a11yr', 21:47:51 INFO - 'ts_paint', 21:47:51 INFO - 'tpaint', 21:47:51 INFO - 'sessionrestore', 21:47:51 INFO - 'sessionrestore_no_auto_restore']}, 21:47:51 INFO - 'svgr': {'tests': ['tsvgx', 21:47:51 INFO - 'tsvgr_opacity', 21:47:51 INFO - 'tart', 21:47:51 INFO - 'tscrollx', 21:47:51 INFO - 'cart']}, 21:47:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['tsvgx', 21:47:51 INFO - 'tsvgr_opacity', 21:47:51 INFO - 'tart', 21:47:51 INFO - 'tscrollx', 21:47:51 INFO - 'cart']}, 21:47:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'tests': ['tp5o']}, 21:47:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'talos_options': ['--e10s'], 21:47:51 INFO - 'tests': ['tp5o']}, 21:47:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'talos_options': ['--xperf_path', 21:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:51 INFO - 'tests': ['tp5n']}, 21:47:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:51 INFO - 'talos_options': ['--e10s', 21:47:51 INFO - '--xperf_path', 21:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:51 INFO - 'tests': ['tp5n']}}, 21:47:51 INFO - 'talos.zip': {'path': '', 21:47:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:51 INFO - Running post-action listener: _resource_record_post_action 21:47:51 INFO - ##### 21:47:51 INFO - ##### Running create-virtualenv step. 21:47:51 INFO - ##### 21:47:51 INFO - Running pre-action listener: _resource_record_pre_action 21:47:51 INFO - Running main action method: create_virtualenv 21:47:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:47:51 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 21:47:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:47:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:51 INFO - Using real prefix '/usr' 21:47:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:47:51 INFO - Installing distribute.............................................................................................................................................................................................done. 21:47:53 INFO - Installing pip.................done. 21:47:53 INFO - Return code: 0 21:47:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:47:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:47:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:47:53 INFO - Using env: {'DISPLAY': ':0', 21:47:53 INFO - 'HOME': '/home/cltbld', 21:47:53 INFO - 'LANG': 'en_US.UTF-8', 21:47:53 INFO - 'LANGUAGE': 'en_US:en', 21:47:53 INFO - 'LOGNAME': 'cltbld', 21:47:53 INFO - 'MAIL': '/var/mail/cltbld', 21:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:53 INFO - 'MOZ_NO_REMOTE': '1', 21:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:53 INFO - 'NO_EM_RESTART': '1', 21:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:53 INFO - 'SHELL': '/bin/bash', 21:47:53 INFO - 'SHLVL': '1', 21:47:53 INFO - 'TERM': 'linux', 21:47:53 INFO - 'TMOUT': '86400', 21:47:53 INFO - 'USER': 'cltbld', 21:47:53 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:53 INFO - '_': '/tools/buildbot/bin/python'} 21:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:54 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 21:47:54 INFO - Cleaning up... 21:47:54 INFO - Return code: 0 21:47:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 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 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:47:54 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 21:47:54 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 21:47:54 INFO - Using env: {'DISPLAY': ':0', 21:47:54 INFO - 'HOME': '/home/cltbld', 21:47:54 INFO - 'LANG': 'en_US.UTF-8', 21:47:54 INFO - 'LANGUAGE': 'en_US:en', 21:47:54 INFO - 'LOGNAME': 'cltbld', 21:47:54 INFO - 'MAIL': '/var/mail/cltbld', 21:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:54 INFO - 'MOZ_NO_REMOTE': '1', 21:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:54 INFO - 'NO_EM_RESTART': '1', 21:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:54 INFO - 'SHELL': '/bin/bash', 21:47:54 INFO - 'SHLVL': '1', 21:47:54 INFO - 'TERM': 'linux', 21:47:54 INFO - 'TMOUT': '86400', 21:47:54 INFO - 'USER': 'cltbld', 21:47:54 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:54 INFO - '_': '/tools/buildbot/bin/python'} 21:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:54 INFO - Downloading/unpacking psutil>=0.7.1 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:47:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:56 INFO - Installing collected packages: psutil 21:47:56 INFO - Running setup.py install for psutil 21:47:56 INFO - building 'psutil._psutil_linux' extension 21:47:56 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 21:47:56 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 21:47:56 INFO - building 'psutil._psutil_posix' extension 21:47:56 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 21:47:56 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 21:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:56 INFO - Successfully installed psutil 21:47:56 INFO - Cleaning up... 21:47:56 INFO - Return code: 0 21:47:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:47: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')]} 21:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:56 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 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:47:56 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 21:47:56 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 21:47:56 INFO - Using env: {'DISPLAY': ':0', 21:47:56 INFO - 'HOME': '/home/cltbld', 21:47:56 INFO - 'LANG': 'en_US.UTF-8', 21:47:56 INFO - 'LANGUAGE': 'en_US:en', 21:47:56 INFO - 'LOGNAME': 'cltbld', 21:47:56 INFO - 'MAIL': '/var/mail/cltbld', 21:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:56 INFO - 'MOZ_NO_REMOTE': '1', 21:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:56 INFO - 'NO_EM_RESTART': '1', 21:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:56 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:56 INFO - 'SHELL': '/bin/bash', 21:47:56 INFO - 'SHLVL': '1', 21:47:56 INFO - 'TERM': 'linux', 21:47:56 INFO - 'TMOUT': '86400', 21:47:56 INFO - 'USER': 'cltbld', 21:47:56 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:56 INFO - '_': '/tools/buildbot/bin/python'} 21:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:56 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 21:47:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:47:58 INFO - Installing collected packages: mozsystemmonitor 21:47:58 INFO - Running setup.py install for mozsystemmonitor 21:47:58 INFO - Successfully installed mozsystemmonitor 21:47:58 INFO - Cleaning up... 21:47:58 INFO - Return code: 0 21:47:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:47:58 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')]} 21:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:58 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')]} 21:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:58 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 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:47:58 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 21:47:58 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 21:47:58 INFO - Using env: {'DISPLAY': ':0', 21:47:58 INFO - 'HOME': '/home/cltbld', 21:47:58 INFO - 'LANG': 'en_US.UTF-8', 21:47:58 INFO - 'LANGUAGE': 'en_US:en', 21:47:58 INFO - 'LOGNAME': 'cltbld', 21:47:58 INFO - 'MAIL': '/var/mail/cltbld', 21:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:58 INFO - 'MOZ_NO_REMOTE': '1', 21:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:58 INFO - 'NO_EM_RESTART': '1', 21:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:47:58 INFO - 'SHELL': '/bin/bash', 21:47:58 INFO - 'SHLVL': '1', 21:47:58 INFO - 'TERM': 'linux', 21:47:58 INFO - 'TMOUT': '86400', 21:47:58 INFO - 'USER': 'cltbld', 21:47:58 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:58 INFO - '_': '/tools/buildbot/bin/python'} 21:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:58 INFO - Downloading/unpacking blobuploader==1.2.4 21:47:58 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 21:47:58 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 21:47:58 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 21:47:58 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 21:47:58 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 21:47:58 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 21:48:00 INFO - Downloading blobuploader-1.2.4.tar.gz 21:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:48:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:48:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:48:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:48:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:01 INFO - Downloading docopt-0.6.1.tar.gz 21:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:48:01 INFO - Installing collected packages: blobuploader, requests, docopt 21:48:01 INFO - Running setup.py install for blobuploader 21:48:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:48:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:48:01 INFO - Running setup.py install for requests 21:48:01 INFO - Running setup.py install for docopt 21:48:01 INFO - Successfully installed blobuploader requests docopt 21:48:01 INFO - Cleaning up... 21:48:01 INFO - Return code: 0 21:48:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:01 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 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:48:01 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 21:48:01 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 21:48:01 INFO - Using env: {'DISPLAY': ':0', 21:48:01 INFO - 'HOME': '/home/cltbld', 21:48:01 INFO - 'LANG': 'en_US.UTF-8', 21:48:01 INFO - 'LANGUAGE': 'en_US:en', 21:48:01 INFO - 'LOGNAME': 'cltbld', 21:48:01 INFO - 'MAIL': '/var/mail/cltbld', 21:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:01 INFO - 'MOZ_NO_REMOTE': '1', 21:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:01 INFO - 'NO_EM_RESTART': '1', 21:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:01 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:01 INFO - 'SHELL': '/bin/bash', 21:48:01 INFO - 'SHLVL': '1', 21:48:01 INFO - 'TERM': 'linux', 21:48:01 INFO - 'TMOUT': '86400', 21:48:01 INFO - 'USER': 'cltbld', 21:48:01 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:01 INFO - '_': '/tools/buildbot/bin/python'} 21:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:48:02 INFO - Running setup.py (path:/tmp/pip-51itBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:48:02 INFO - Running setup.py (path:/tmp/pip-uoMYjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:48:02 INFO - Running setup.py (path:/tmp/pip-AlDmPN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:48:02 INFO - Running setup.py (path:/tmp/pip-dzAHIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:48:02 INFO - Running setup.py (path:/tmp/pip-sndEdJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:48:02 INFO - Running setup.py (path:/tmp/pip-l71TVo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:48:02 INFO - Running setup.py (path:/tmp/pip-rLzW2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:48:02 INFO - Running setup.py (path:/tmp/pip-npBJAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:48:02 INFO - Running setup.py (path:/tmp/pip-CI4MJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:48:02 INFO - Running setup.py (path:/tmp/pip-feLASl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:48:02 INFO - Running setup.py (path:/tmp/pip-SbfYwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:48:02 INFO - Running setup.py (path:/tmp/pip-kBs7XH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:48:02 INFO - Running setup.py (path:/tmp/pip-CtgLsp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:48:03 INFO - Running setup.py (path:/tmp/pip-mi9lbS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:48:03 INFO - Running setup.py (path:/tmp/pip-RLBdfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:48:03 INFO - Running setup.py (path:/tmp/pip-q1Gkco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:48:03 INFO - Running setup.py (path:/tmp/pip-RyBFXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:48:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:48:03 INFO - Running setup.py install for manifestparser 21:48:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:48:03 INFO - Running setup.py install for mozcrash 21:48:03 INFO - Running setup.py install for mozdebug 21:48:03 INFO - Running setup.py install for mozdevice 21:48:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:48:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:48:03 INFO - Running setup.py install for mozfile 21:48:03 INFO - Running setup.py install for mozhttpd 21:48:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:48:03 INFO - Running setup.py install for mozinfo 21:48:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Running setup.py install for mozInstall 21:48:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Running setup.py install for mozleak 21:48:04 INFO - Running setup.py install for mozlog 21:48:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Running setup.py install for moznetwork 21:48:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Running setup.py install for mozprocess 21:48:04 INFO - Running setup.py install for mozprofile 21:48:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Running setup.py install for mozrunner 21:48:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:48:04 INFO - Running setup.py install for mozscreenshot 21:48:04 INFO - Running setup.py install for moztest 21:48:04 INFO - Running setup.py install for mozversion 21:48:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:48:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:48:05 INFO - Cleaning up... 21:48:05 INFO - Return code: 0 21:48:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:48: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')]} 21:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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', '-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 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:48:05 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 21:48:05 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 21:48:05 INFO - Using env: {'DISPLAY': ':0', 21:48:05 INFO - 'HOME': '/home/cltbld', 21:48:05 INFO - 'LANG': 'en_US.UTF-8', 21:48:05 INFO - 'LANGUAGE': 'en_US:en', 21:48:05 INFO - 'LOGNAME': 'cltbld', 21:48:05 INFO - 'MAIL': '/var/mail/cltbld', 21:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:05 INFO - 'MOZ_NO_REMOTE': '1', 21:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:05 INFO - 'NO_EM_RESTART': '1', 21:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:05 INFO - 'SHELL': '/bin/bash', 21:48:05 INFO - 'SHLVL': '1', 21:48:05 INFO - 'TERM': 'linux', 21:48:05 INFO - 'TMOUT': '86400', 21:48:05 INFO - 'USER': 'cltbld', 21:48:05 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:05 INFO - '_': '/tools/buildbot/bin/python'} 21:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:48:05 INFO - Running setup.py (path:/tmp/pip-Rw1Eyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:48:05 INFO - Running setup.py (path:/tmp/pip-0qEuA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:48:05 INFO - Running setup.py (path:/tmp/pip-CE4DCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:48:05 INFO - Running setup.py (path:/tmp/pip-2auB_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:48:05 INFO - Running setup.py (path:/tmp/pip-FaYkVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:48:05 INFO - Running setup.py (path:/tmp/pip-uuAaDU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:48:05 INFO - Running setup.py (path:/tmp/pip-FyaMqs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:48:05 INFO - Running setup.py (path:/tmp/pip-vsTzJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:48:05 INFO - Running setup.py (path:/tmp/pip-6073ob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:48:05 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)) 21:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:48:05 INFO - Running setup.py (path:/tmp/pip-hzSkfH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:48:06 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)) 21:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:48:06 INFO - Running setup.py (path:/tmp/pip-a8zF4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:48:06 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)) 21:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:48:06 INFO - Running setup.py (path:/tmp/pip-V1u0Jr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:48:06 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)) 21:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:48:06 INFO - Running setup.py (path:/tmp/pip-nnLi2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:48:06 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)) 21:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:48:06 INFO - Running setup.py (path:/tmp/pip-izsLez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:48:06 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)) 21:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:48:06 INFO - Running setup.py (path:/tmp/pip-iXfnfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:48:06 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)) 21:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:48:06 INFO - Running setup.py (path:/tmp/pip-Eh9LNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:48:06 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)) 21:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:48:06 INFO - Running setup.py (path:/tmp/pip-XbcPiP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:48:06 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)) 21:48:06 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)) 21:48:06 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)) 21:48:06 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)) 21:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:48:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:08 INFO - Downloading blessings-1.5.1.tar.gz 21:48:08 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 21:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:48:08 INFO - Installing collected packages: blessings 21:48:08 INFO - Running setup.py install for blessings 21:48:08 INFO - Successfully installed blessings 21:48:08 INFO - Cleaning up... 21:48:08 INFO - Return code: 0 21:48:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:48:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:48:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:48:08 INFO - Reading from file tmpfile_stdout 21:48:08 INFO - Current package versions: 21:48:08 INFO - argparse == 1.2.1 21:48:08 INFO - blessings == 1.5.1 21:48:08 INFO - blobuploader == 1.2.4 21:48:08 INFO - docopt == 0.6.1 21:48:08 INFO - manifestparser == 1.1 21:48:08 INFO - mozInstall == 1.12 21:48:08 INFO - mozcrash == 0.16 21:48:08 INFO - mozdebug == 0.1 21:48:08 INFO - mozdevice == 0.47 21:48:08 INFO - mozfile == 1.2 21:48:08 INFO - mozhttpd == 0.7 21:48:08 INFO - mozinfo == 0.9 21:48:08 INFO - mozleak == 0.1 21:48:08 INFO - mozlog == 3.1 21:48:08 INFO - moznetwork == 0.27 21:48:08 INFO - mozprocess == 0.22 21:48:08 INFO - mozprofile == 0.28 21:48:08 INFO - mozrunner == 6.11 21:48:08 INFO - mozscreenshot == 0.1 21:48:08 INFO - mozsystemmonitor == 0.0 21:48:08 INFO - moztest == 0.7 21:48:08 INFO - mozversion == 1.4 21:48:08 INFO - psutil == 3.1.1 21:48:08 INFO - requests == 1.2.3 21:48:08 INFO - wsgiref == 0.1.2 21:48:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:48:08 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')]} 21:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:08 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')]} 21:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:08 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 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:48:08 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 21:48:08 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 21:48:08 INFO - Using env: {'DISPLAY': ':0', 21:48:08 INFO - 'HOME': '/home/cltbld', 21:48:08 INFO - 'LANG': 'en_US.UTF-8', 21:48:08 INFO - 'LANGUAGE': 'en_US:en', 21:48:08 INFO - 'LOGNAME': 'cltbld', 21:48:08 INFO - 'MAIL': '/var/mail/cltbld', 21:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:08 INFO - 'MOZ_NO_REMOTE': '1', 21:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:08 INFO - 'NO_EM_RESTART': '1', 21:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:08 INFO - 'SHELL': '/bin/bash', 21:48:08 INFO - 'SHLVL': '1', 21:48:08 INFO - 'TERM': 'linux', 21:48:08 INFO - 'TMOUT': '86400', 21:48:08 INFO - 'USER': 'cltbld', 21:48:08 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:08 INFO - '_': '/tools/buildbot/bin/python'} 21:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 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)) 21:48:08 INFO - Cleaning up... 21:48:08 INFO - Return code: 0 21:48:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:48:08 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')]} 21:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:08 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')]} 21:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:08 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 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:48:08 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 21:48:08 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 21:48:08 INFO - Using env: {'DISPLAY': ':0', 21:48:08 INFO - 'HOME': '/home/cltbld', 21:48:08 INFO - 'LANG': 'en_US.UTF-8', 21:48:08 INFO - 'LANGUAGE': 'en_US:en', 21:48:08 INFO - 'LOGNAME': 'cltbld', 21:48:08 INFO - 'MAIL': '/var/mail/cltbld', 21:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:08 INFO - 'MOZ_NO_REMOTE': '1', 21:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:08 INFO - 'NO_EM_RESTART': '1', 21:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:08 INFO - 'SHELL': '/bin/bash', 21:48:08 INFO - 'SHLVL': '1', 21:48:08 INFO - 'TERM': 'linux', 21:48:08 INFO - 'TMOUT': '86400', 21:48:08 INFO - 'USER': 'cltbld', 21:48:08 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:08 INFO - '_': '/tools/buildbot/bin/python'} 21:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:09 INFO - Downloading/unpacking jsonschema 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:48:10 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 21:48:10 INFO - Downloading/unpacking functools32 (from jsonschema) 21:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:11 INFO - Downloading functools32-3.2.3-2.tar.gz 21:48:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:48:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:48:11 INFO - warning: no files found matching '*.txt' 21:48:11 INFO - no previously-included directories found matching 'build' 21:48:11 INFO - no previously-included directories found matching 'dist' 21:48:11 INFO - no previously-included directories found matching '.git*' 21:48:11 INFO - Installing collected packages: jsonschema, functools32 21:48:11 INFO - Running setup.py install for functools32 21:48:11 INFO - warning: no files found matching '*.txt' 21:48:11 INFO - no previously-included directories found matching 'build' 21:48:11 INFO - no previously-included directories found matching 'dist' 21:48:11 INFO - no previously-included directories found matching '.git*' 21:48:11 INFO - Successfully installed jsonschema functools32 21:48:11 INFO - Cleaning up... 21:48:11 INFO - Return code: 0 21:48:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb21aedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a38230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, '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': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', '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 21:48:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:48:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:48:11 INFO - Using env: {'DISPLAY': ':0', 21:48:11 INFO - 'HOME': '/home/cltbld', 21:48:11 INFO - 'LANG': 'en_US.UTF-8', 21:48:11 INFO - 'LANGUAGE': 'en_US:en', 21:48:11 INFO - 'LOGNAME': 'cltbld', 21:48:11 INFO - 'MAIL': '/var/mail/cltbld', 21:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:11 INFO - 'MOZ_NO_REMOTE': '1', 21:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:11 INFO - 'NO_EM_RESTART': '1', 21:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:11 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:11 INFO - 'SHELL': '/bin/bash', 21:48:11 INFO - 'SHLVL': '1', 21:48:11 INFO - 'TERM': 'linux', 21:48:11 INFO - 'TMOUT': '86400', 21:48:11 INFO - 'USER': 'cltbld', 21:48:11 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:11 INFO - '_': '/tools/buildbot/bin/python'} 21:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:11 INFO - Downloading/unpacking flake8 21:48:11 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 21:48:11 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 21:48:11 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 21:48:11 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 21:48:11 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 21:48:11 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 21:48:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:48:13 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 21:48:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:48:13 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 21:48:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:13 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 21:48:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:48:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:48:13 INFO - no previously-included directories found matching 'docs/_build' 21:48:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:48:13 INFO - Running setup.py install for pep8 21:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:48:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:48:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:48:13 INFO - no previously-included directories found matching 'docs/_build' 21:48:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:48:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:48:14 INFO - Cleaning up... 21:48:14 INFO - Return code: 0 21:48:14 INFO - Running post-action listener: _resource_record_post_action 21:48:14 INFO - Running post-action listener: _start_resource_monitoring 21:48:14 INFO - Starting resource monitoring. 21:48:14 INFO - ##### 21:48:14 INFO - ##### Running install step. 21:48:14 INFO - ##### 21:48:14 INFO - Running pre-action listener: _resource_record_pre_action 21:48:14 INFO - Running main action method: install 21:48:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:48:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:48:14 INFO - Reading from file tmpfile_stdout 21:48:14 INFO - Detecting whether we're running mozinstall >=1.0... 21:48:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:48:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:48:14 INFO - Reading from file tmpfile_stdout 21:48:14 INFO - Output received: 21:48:14 INFO - Usage: mozinstall [options] installer 21:48:14 INFO - Options: 21:48:14 INFO - -h, --help show this help message and exit 21:48:14 INFO - -d DEST, --destination=DEST 21:48:14 INFO - Directory to install application into. [default: 21:48:14 INFO - "/builds/slave/test-pgo"] 21:48:14 INFO - --app=APP Application being installed. [default: firefox] 21:48:14 INFO - mkdir: /builds/slave/test-pgo/build/application 21:48:14 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'] 21:48:14 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 21:48:30 INFO - Reading from file tmpfile_stdout 21:48:30 INFO - Output received: 21:48:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:48:30 INFO - Running post-action listener: _resource_record_post_action 21:48:30 INFO - ##### 21:48:30 INFO - ##### Running run-tests step. 21:48:30 INFO - ##### 21:48:30 INFO - Running pre-action listener: _resource_record_pre_action 21:48:30 INFO - Running main action method: run_tests 21:48:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:48:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:48:30 INFO - Python 2.7.3 21:48:30 INFO - Return code: 0 21:48:30 INFO - grabbing minidump binary from tooltool 21:48: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')]} 21:48:30 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 0x2aca7f0>, '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 0x2a362d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:48:30 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 21:48:30 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 21:48:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:30 INFO - Return code: 0 21:48:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:48:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:48:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:48:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:48:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:48:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:48:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:48:31 INFO - Return code: 0 21:48:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 21:48:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 21:48:31 INFO - Using env: {'DISPLAY': ':0', 21:48:31 INFO - 'HOME': '/home/cltbld', 21:48:31 INFO - 'LANG': 'en_US.UTF-8', 21:48:31 INFO - 'LANGUAGE': 'en_US:en', 21:48:31 INFO - 'LOGNAME': 'cltbld', 21:48:31 INFO - 'MAIL': '/var/mail/cltbld', 21:48:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:48:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:31 INFO - 'MOZ_NO_REMOTE': '1', 21:48:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:31 INFO - 'NO_EM_RESTART': '1', 21:48:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:48:31 INFO - 'PWD': '/builds/slave/test-pgo', 21:48:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:48:31 INFO - 'SHELL': '/bin/bash', 21:48:31 INFO - 'SHLVL': '1', 21:48:31 INFO - 'TERM': 'linux', 21:48:31 INFO - 'TMOUT': '86400', 21:48:31 INFO - 'USER': 'cltbld', 21:48:31 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918', 21:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:31 INFO - '_': '/tools/buildbot/bin/python'} 21:48:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 21:48:31 INFO - mozversion application_buildid: 20151229193155 21:48:31 INFO - mozversion application_changeset: 3becd09c71b176713af62aae2646249cab9ff893 21:48:31 INFO - mozversion application_display_name: Nightly 21:48:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:31 INFO - mozversion application_name: Firefox 21:48:31 INFO - mozversion application_remotingname: firefox 21:48:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:48:31 INFO - mozversion application_vendor: Mozilla 21:48:31 INFO - mozversion application_version: 46.0a1 21:48:31 INFO - mozversion platform_buildid: 20151229193155 21:48:31 INFO - mozversion platform_changeset: 3becd09c71b176713af62aae2646249cab9ff893 21:48:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:48:31 INFO - mozversion platform_version: 46.0a1 21:48:31 INFO - using testdate: 1451454511 21:48:31 INFO - actual date: 1451454511 21:48:31 INFO - starting webserver on 'localhost:36166' 21:48:31 INFO - SUITE-START | Running 3 tests 21:48:31 INFO - TEST-START | dromaeo_css 21:48:31 INFO - operating with platform_type : linux_ 21:48:31 INFO - Initialising browser for dromaeo_css test... 21:48:31 INFO - TEST-INFO | started process 1853 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgSmgmY/profile http://localhost:36166/getInfo.html) 21:48:32 INFO - PROCESS | 1853 | Failed to load Oculus VR library! 21:48:35 INFO - PROCESS | 1853 | __metrics Screen width/height:1600/1200 21:48:35 INFO - PROCESS | 1853 | colorDepth:24 21:48:35 INFO - PROCESS | 1853 | Browser inner width/height: 1024/697 21:48:35 INFO - PROCESS | 1853 | __metrics 21:48:35 INFO - PROCESS | 1853 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:48:35 INFO - PROCESS | 1853 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:48:36 INFO - TEST-INFO | 1853: exit 0 21:48:36 INFO - Browser initialized. 21:48:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:48:36 INFO - TEST-INFO | started process 1952 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgSmgmY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:37 INFO - PROCESS | 1952 | Failed to load Oculus VR library! 21:48:48 INFO - PROCESS | 1952 | RSS: Main: 148480000 21:48:48 INFO - PROCESS | 1952 | 21:49:40 INFO - PROCESS | 1952 | 1451454580273 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] 21:51:48 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:36166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36166/tests/dromaeo/cssquery-ext.html) 21:51:50 INFO - PROCESS | 1952 | RSS: Main: 233193472 21:51:50 INFO - PROCESS | 1952 | 21:54:52 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:36166/tests/dromaeo/cssquery-ext.html (next: http://localhost:36166/tests/dromaeo/cssquery-jquery.html) 21:54:53 INFO - PROCESS | 1952 | RSS: Main: 239067136 21:54:53 INFO - PROCESS | 1952 | 21:57:55 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:36166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36166/tests/dromaeo/cssquery-mootools.html) 21:57:55 INFO - PROCESS | 1952 | RSS: Main: 226287616 21:57:55 INFO - PROCESS | 1952 | 22:00:57 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:36166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36166/tests/dromaeo/cssquery-prototype.html) 22:00:58 INFO - PROCESS | 1952 | RSS: Main: 216055808 22:00:58 INFO - PROCESS | 1952 | 22:04:00 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:36166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36166/tests/dromaeo/cssquery-yui.html) 22:04:01 INFO - PROCESS | 1952 | RSS: Main: 218411008 22:04:01 INFO - PROCESS | 1952 | 22:07:03 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:36166/tests/dromaeo/cssquery-yui.html (next: http://localhost:36166/tests/dromaeo/cssquery-dojo.html) 22:07:04 INFO - PROCESS | 1952 | RSS: Main: 313229312 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | __start_tp_report 22:07:04 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 22:07:04 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 22:07:04 INFO - PROCESS | 1952 | |i|pagename|runs| 22:07:04 INFO - PROCESS | 1952 | |0;dojo.html;3148.0870547541213;3249.2851572654035;3284.178955261185;3300.306935543536;3319.30294638126;5174.741262936847;5264;5365.973170134149;5408.188771684245;5417.151495261105;5230.581553475722;5253.86865328367;5346.224797404374;5357.062514060033;5373.408925018254;4862.124817532843;4866.46468888422;4886.535779100997;4917.139500587401;5010.448850626428;4959.404871415435;4971.527704868032;5022.221555658879;5034;5036.320096786942;4748;4766.666333356667;4869.196582563873;4878.585320247783;4889;4923.163062279421;4934.383202099738;4935.406283319702;4940.752962351868;4979;4885.43817460993;4897.33885925399;4916.459189489154;4928;4932.482089380599;5086.338775959139;5160.200168973815;5189;5191.766370513336;5192.376914770214;5764.682942438206;5765.279340082489;5773.8556536086935;5774.5091667208335;5776.104703770922;5824.417558244184;5851.8537036574;5879.706014699291;5897.085951677497;5897.941020589782;5447.972760136214;5453.318335208099;5453.318335208099;5455.809046683386;5499.587530935196;5808.07070868659;5850.414958504116;5917.5857689961285;5919.1713160157615;5921.496672782776;5661.886762264814;5687.289088863892;5725.541956643458;5764.654120752768;5803.593748437569;5756.309242890796;5759.2512973313205;5759.94240057594;5779.768809247583;5786.971065144731;5729.28383952006;5737.885242295214;5739.225204597409;5744.798932037359;5747.798827041033;5671.631343962629;5776;5786.450287222707;5787.623804452697;5897.52819774417;4449.265871131227;4455.420795296591;4458.175237581057;4458.264386376211;4490.281554951257;3986.421968814506;3991.8802435926386;3992.461017762565;4034.1326614777963;4035.9798201009394;5196.324477817935;5317.7872885084935;5357.035733567917;5432.13085906261;5470.64440811346;5844.1818145459665;5870.354261031283;5872.500837428781;5881.852953676107;5888.234529511136;5187.636865419385;5423.891522169534;5427.3215848019;5430.70131142791;5432.185172224198;4925.852224433273;5011.448740638527;5104.285400043997;5106.4893510648635;5126.846194614168;5938.8812223755285;5939.16851640762;5939.4357536034;5941.376155503696;5941.673207973517;5712.200291959046;5767;5769.163471296554;5777.277840269966;5779.537636988946;5795.710214489343;5855.795047173328;5868.119782032729;5895.970520147372;5901.439363260483;5669.34802497718;5695.031844586348;5708.343540492897;5743.0811070228565;5743.59794814359;5791.710414479344;5793.797217097382;5794.5364370851075;5798.072308430631;5798.59409841307;5583.525400340854;5590.8043218487155;5690.032694442038;5708.600397972102;5722.713864306851;5427.104527753035;5605.299337582802;5614.29821272341;5634.126710359901;5639.802606908738;5516.117421212587;5517.641353312022;5520.1443776214755;5521.861953451035;5523.061079616395;5549.944500554942;5646.576506762091;5666.744996475086;5674.120511320752;5813.215215945793;5599.8880022400135;5614.157876318585;5632.127020311858;5639.548836093185;5641.5204707600315 22:07:04 INFO - PROCESS | 1952 | |1;ext.html;529.8489930369846;531.3225637312427;536.0030343560976;547.9999001821676;551.6056019945738;27956.860215698944;29111;29180.270493237655;35824.10439739008;36502;39008.953612190155;39137;39333.60666393335;39450.21099578014;39469.40795888064;8419.4106412551;8577.356698247657;8588.527630980294;8590.484570925733;8593.656253749843;7463.402927765793;7608.467407281492;10071;10240.436775977318;10255.230857685667;9938.801223975515;10019.549120289605;10021.599136034587;10026.498675066254;10038.598456061749;7401.9629901850685;7532.661030253597;9939;10037.34383826675;10047.397156170653;10023;10283.94858025705;10297.3821570706;10302.536385862579;10303.484825758682;35954.10114747126;36279.27441451183;36299;36301.455478167845;36427.63572364269;3170.0014495434093;3175.4760464523324;3287.3425314936867;3541.628129046439;3631.654992775682;25826.096086637066;26387.20838374852;26839.194824155307;27870.5819412709;28083.85958070217;3707.5180226570374;3776.3013842439236;3853.614638536124;3995.820188091543;4095.692823038284;280799;282269.18442747905;283778;284309;285162;53884.461155387944;54060.459395405545;60251.698741506014;60589.394106058375;60799.69600151971;65049.34950650528;65649.67175164094;65879;65907.03418346186;65918;15265.618359540878;15515.534533963999;15523.301451434712;15565.377384904477;15579.221038948008;12027.15809893299;12096.395180240952;12113.576024839089;12119.091068169922;12128.211666241667;19335.226590936207;19686.11412486413;19798;20533.38399848007;20568.177272909215;7695.884561731578;7790.805229869298;7916.366690664733;7934.166912474223;7955.681772729026;876.2332958661171;934.7289286106953;953.8998405167496;961.8220629183623;977.7799995001068;26653.20040398791;26967.86516067407;27176.45647087047;27279.454410911672;27385.589216161774;1014.573878970834;1029.2126523209752;1112.065864673678;1115.938623375706;1140.122105978392;14318.778120292509;14326.426942922166;14461.987660863639;14568.344424500923;14618.488352907598;337689;343512;344350;344470;344806;51635.22547161795;52168.21747673788;52210.73894630503;52248.738756305975;52263.47736522662;1309.5874799438336;1313.2514466753858;1319.7228581997888;1337.993310033463;1340.1289162044554;26857.328566785985;27508.862455688395;27902.720972790823;27949.441011179257;28003.439931200854;42181;42463;46315.3052704203;47167;47235;193058;193433;195948;196545;196956;27350.31624209331;31937.6806231944;32395;32410.35179296448;32522;31201;38371.42442863415;38963.80518097391;39225.6077439222;39280.41079383869;31997.36005279928;33484;33927.66072339344;35682.10794730153;37068.629313706515;35818;36240;36948.63051369559;37143.44284835784;37148;35287.11782205466;36137.63862361343;36193.45709814408;36214.27571448503;36299.27401452009;31504.684953150176;33061.33877322392;33081.33837323288;33309.83345083259;33343.66656333405;29878.25304367408;30107.54838677378;30523.542146868258;30653.693463065974;30904.536431953988 22:07:04 INFO - PROCESS | 1952 | |2;jquery.html;342.4144712541554;343.52936477026475;347.8625942752613;351.4552443712247;359.78592737321287;13744.656383590414;13962.860371396284;16579.83420165798;16818.41135560254;17558.56103597409;14793.704125917475;16336.509904702849;16476.917615411938;16892.915535422337;16934.49196524106;5454.400015998247;5622.32532096149;5627;5628.127640215773;5633.577481688869;4051.4530538377385;4125.814338354766;5498.505134537891;5530.2810634617645;5922.763089476416;6046.939530604682;6066.636001839904;6086.969565152191;6091.543134264925;6098.57309988301;5896.528277737771;6040.546958978094;6052.697365131769;6053.424924632175;6057.878842423127;5250.369955605313;5274.894502109936;5289.365276166846;5299.311089558371;5307.814226502092;21221.787782122137;22151.113955441764;22900.19849305283;23427.648585271236;23991.7600823993;2197.8681279123302;2262.1290803040947;2293.6788849561076;2293.7820907013806;2346.577616029114;13924.721505569833;14273.92945529079;14474.059186152972;14584;14745.262736863115;1884.7644044494439;1925.3357591630865;1944.8735832171005;1945.289969161246;1977.5155087003632;68943.3105668947;72503.14289705252;74117.25882741157;74274.62862685705;74492;15660.13869237203;15680.529584112495;15693.529194124194;15703.450379236672;15893.443729469413;24288.63567046496;24341.513169736507;24518;24721.87639061793;24745.62881556778;8836.116388361112;8846;8866.822663546822;8938.284937205008;9124.635014599342;7581.772546823604;7666.118396384487;7679.1936846631415;7687.154413014676;7740.729074482366;7598.582077985764;7622.8094297643;7634.31291183785;7739.148693643695;7739.61301934901;1800.8919464832152;1825.8174182581636;1851.9629607407776;2148.8933199402322;2979.925501862471;875.0724232313768;881.6253092435818;936.0031566381782;943.7640589852537;986.2504496582649;14133.434662613587;15308.311125999357;16394.1802909854;16767.91616041912;16790.328386864632;928.7492377058292;936.7939053408239;938.7653086728318;940.9294302927308;945.229637845154;9414.19979301767;9474.194693450996;9489.905100948901;9553.761155971017;9709.36889102206;455737;456262;460859;468968;633953;75895;78950.6052469734;80362;82221.58889205636;82930.17069829225;1102.162356608967;1123.8876112388696;1139.9943000285111;1144.1133121830649;1145.5818626201376;14978.850211497745;15166.772498412312;15268.160251185847;15380.384784608937;15793.289301981209;34699.1936327365;34748;34954.300913982086;36011.0997225061;36684;46674.53325466838;47136.52863471321;47618;48822.26766598433;49972.75013624909;9468.668596599086;9571.712848614552;9695.418274903528;9696.660616878375;9701.223902087957;11430.828537571777;16964;16971;17211.483655490356;17652.646947061243;2783.2067860660422;12177.590274723092;13104.541341053018;13768.793468098187;13789;14439.639009024859;14512.709745804814;14578.635534111732;14608.634784130056;14957.252137392868;15019.249037548298;15109.244537773287;15131.167785771888;15525;15687;9802.9019709802;9804.803903921738;10028.849567256642;10147.64483243083;10153.898461015295;11464.369459679798;14297.499587514387;14739.115653060851;14774.926125369304;15115.168665723491 22:07:04 INFO - PROCESS | 1952 | |3;mootools.html;1345.5021641992464;1415.8513356097608;1424.2024466298874;1578.2661062605887;1798.6132981408994;6338.429541341278;7012.088428504294;7207.603581802999;7209.927900720998;7211;7086.610236437007;7294.598797066159;7300.0509933708545;7302.1967583565765;7306.086739157606;1936.1480948382737;1970.0839109813933;1970.655135351315;2215.8559693619945;2258.977410225901;1990.64168449679;2002.8698134621277;2206.6138425775425;2245.41619179013;2253.481699209183;2192.2875065603744;2212.4579478027904;2213.900374483152;2217.5121473275935;2276.46503071778;2241.8991145398413;2265.796078352948;2272.8295377846725;2276.612975794119;2276.715410573678;2217.800397964191;2266.195500597281;2267.399139228106;2269.319204238722;2270.943226419336;7122.394596459307;7161.140663120407;7191.712331506734;7195.532290401159;7203.027591275216;4474.731516109044;4545.886352841172;4553.271476563734;4555.544445555451;4555.635549156093;3044.2389402649337;3134.0284511801415;3145.653978062411;3148.055583324993;3159.447096758081;930.3208657679932;950;956.9712908612753;1018.974525636865;1066.9733256668567;9840.458774767385;9859.260555458297;9861.013898610154;9874.456904870229;9917.355371900876;4145.461090058334;4158.542560318362;4188.623023927861;4205.852795152155;4221.873343799691;8579.785505362415;8608;8640.956795216109;8644.524551149747;8652.307815374756;4629.189891768927;4645.628349732014;4645.976770116128;4647.488776234612;4651.3023046543285;4251.192273468031;4256.659467242614;4257.020885196423;4258.574142585717;4264.509581398179;3245.0913744151676;3509.894703158909;3548.183917698944;3556.466530020466;3600.891973240807;1055.9260851740305;1135.8125909224884;1136.5851464215502;1154.6766905266538;1161.4773351991637;1034;1034.1984961654778;1091.8034753744403;1188.518649946773;1343.6103529976197;6620.503462240351;6662;6693.397594216543;6714.261431242559;6757.695903684247;1059.1103473082649;1062.0972173652488;1066.9359838409564;1073.9463026848625;1081.2485322700647;5496.230527726121;5586.16207568868;5593.161025846156;5595.468430499096;5596.720163991784;8528.360372972053;8586.398952073296;8753.168448997336;8768.947726272889;8775.605097770487;8533;8576.742697719079;8630.309575234092;8635.438696484709;8648.308135349156;6655.267920528738;6686.5653732507235;6788;6793.286704896013;6985.336393042754;6713.6643167842385;6758.4931130166415;6760.526763126534;6761.188657361148;6777.762778302736;7623.085229772463;7843.137254902071;7938.960305198668;7945.523268603903;7951.681932722627;7835.725749598737;8051.2351326623875;8145.022597288126;8165.183481651788;8171.182881711781;6269.12232287471;6307.400796924285;6340.651264180515;6373.107764913008;6386.16979792624;6331.90502142459;6497.4477169441125;7062.788116356312;7125.786226413215;7136.714531418893;6377.521685873486;6380.3619638035825;6432.163818703539;6438.420542151041;6668.199816022108;6453.128827608401;6501.4798816095545;6593.109930159367;6601.735930562723;6619.966900165468;6360.650164241011;6432.195975503062;6460.806175814733;6464.644444555406;6466.256380516113;6074.119252708421;6112.541559383153;6113.113598528277;6120.846978825565;6126.172966649446;6076.210092687922;6119.785807496716;6141.416565426277;6173.166622505904;6177.84555386101 22:07:04 INFO - PROCESS | 1952 | |4;prototype.html;321.55143574713276;332.6573629161963;341.53210102160034;343.26369936486225;347.93737127317087;5997.040473524237;6050.576459647827;6073.817785466432;6099.054646529784;6136.294326152494;5973.193618861453;5990.460858522732;5997.430244126812;6005.579609427342;6023.789167379143;4652.7906244219;4653.139169253682;4659;4661.673682842203;4667.76661166942;4467.329900514933;4610.2854057621125;4627.976860115711;4652.162610730084;4653.813277614204;4598.908021839561;4601.33280674302;4602.171609110359;4606.378138951232;4615.215413379734;4392.472903251614;4477.910441791146;4483.036147228329;4600.746958917258;4623.491415944261;4001.7398869073418;4033.3949907513816;4043.0903046814524;4047.1096358801015;4053.6959728020515;5688.715564221772;5758.827235182951;5760;5780.1907732917425;5785.132230165466;5092.388913330387;5179.715115668637;5214.843554693365;5322.20166974953;5345.144776835727;6277.7175027123885;6316.557840951089;6342.365763423667;6351.237851457809;6403.679816009181;4473.507914129443;4476.1271552047365;4477.283634618478;4478.104379124188;4478.596926276651;6447.580907241061;6551.901721474182;6611.603303801788;6669.666516674147;6683.331666833278;4560.726356418625;4584.862454126382;4591.977040114845;4592.196365636067;4594.563516465931;4650.697704649187;4652.534746525321;4655.674102812771;4657.510961349078;4659.487456379796;5363.570914326844;5368.973155134199;5372;5372.838814835562;5378.784848606012;6296.937030629635;6361.681915904186;6386.190076366477;6391.169148010729;6415.358464153547;1610.428297954233;1630;1634.3380930723076;1634.599523116844;1635.2314412226235;1042.4579218806177;1084.208527774729;1085.159001773616;1088.1838621034224;1109.7447587055024;6076.635401875901;6078.1186727924205;6086.087086936995;6092.51259899207;6102.084687296941;6629.900551491635;6631.469482441393;6634.336566343327;6634.502412319095;6635.071090047397;5943.851403714942;6048.848778780478;6077.209962704908;6079;6081.695915204311;3546.184377593168;3549.07723991764;3557.8932632021083;3559.60844307126;3570.946435803465;6805.217399999064;6807.5575087619145;6808.9659551701925;6824.7952561423235;6836.897446538306;6392.904106438407;6467.191601049869;6615.801525954229;6746.22418421878;6748.055272261888;6760.966195169091;6884.242733299333;6890.2420733719255;6895.103636527319;6900.3444672756;6648.634325112165;6651.06885036105;6653.73385064592;6656;6659.267480577036;6408.29508754046;6570.211574611078;6575.980722987944;6580.243272023778;6581.6709164542535;6849;6856.382925536725;6863.519553631198;6865.794026179223;6871.003704462725;4586.931196032129;4592.931106033346;4597.08058388317;4598.540145985375;4599;6663.566868153554;6667.733290668319;6669.533132680665;6676.9666151668935;6679.799606011828;6293.779717709858;6465.515086368447;6471.708773105127;6473.546851720334;6477.4494167996245;6444.935550644621;6452.257990330984;6453.870922581428;6455.419012288917;6467.320931302145;6165.136880836597;6290.402411770874;6318.747250109944;6329.177206963065;6337.809865704036;6488.091667166695;6552.541322107598;6553.705083271169;6559.409653131241;6563.540552161303;6361.522885783492;6368.617882927039;6388.0737293091315;6390.009548519987;6398.424141827258 22:07:04 INFO - PROCESS | 1952 | |5;yui.html;740.4520654715509;748.1097493982162;759.6505607420586;771.8687823070078;777.5451360953844;11896.702582435444;11945.701357466067;12059.4573244204;12067.215630984001;12142;11274.605388811373;13777.448902043907;14001.439942402318;14013.229272390014;14027.158370497751;664.5281849886586;788.0071110400879;788.0189164490189;792.627465091409;792.8969233999572;661.4377778887955;783.9921600784005;792.2513225002375;795.3716563914501;798.0144521515923;840.3823189955408;848.4569875279826;848.762346542969;848.9660413583449;849.3120572336396;682.6518475577467;691.0774116554406;827.9710210142616;844.6832437835811;846.547097302943;609.8079105081885;610.0239616613427;610.1823556434399;613.1232337757006;614.6926536731634;12362.814557781641;12525.185862918881;12595.3072581008;12608.873911260953;12629.93685031569;11104.111671066295;11297.152713546435;11501.654950351503;11522.423878806027;12075.698107547381;10016.298859079867;10045.54795034218;10175.084242418217;10321.071103600638;10544.683659490227;3412.488126781003;3500.089976606075;3508.298340331944;3526.612072672004;3533.628968958248;44986.325205121946;45131.548684513065;45395;46421.53578464206;46537.534624654;9039.90367561461;9061.048589898097;9075.636974520945;9101.908980910239;9329.346945713734;15146.545603631908;15186.848131518764;15208.543743687707;15210.771838422432;15252.618684532976;6852.177738671391;6866;7007.684654190573;7201;7319.194888562254;4049.9595004049584;4096.91806163875;4115;4163.146554956287;4244.72409293395;2831.957520637192;2853.2581528802248;2856.3287627407544;2859.3995260995007;2871.1099559136733;545.8580769000089;547.4498129379948;554.2130175151295;561.8426840484589;569.564283323258;470.47096934961377;503.2024241577141;528.6770228072298;586.6919867069737;618.9381061893774;7915.44591878563;7980.880286795703;8102.311303539147;8175.591220438954;8182.67269309221;561.6854561445604;606.8422210225373;614.0788816774838;653.7679123910943;680.4590350671228;3740.1958578905665;3787.6401741834484;3804.2391521695217;3826.081740382288;3959.208158368338;50817.745911270205;50994;51065.234021489705;51100.48899511032;51330.48669513257;49376.50623493719;49972.75013624909;50321.748391258545;50522.242166367534;50704.49295507072;19311.806881931283;19317.80682193188;19351.612967740846;19378.418647440598;22070.668939966235;7739.34215591681;7893.763187104396;8007.799805004922;8043.718469853527;8145.470544414594;34015;34102.317953641286;34205.48691769576;34703.82648086845;34997;39860.80069599633;40312.79843600763;43516.78241608899;43671.78164109159;43905.34141987937;9387.530623468663;9406.717798466058;9575.701831560236;9810.950945245228;9824.80350392974;11727.472263748323;11924.165308428674;12010;12120.27278363301;12268.386580670753;10298.3820970742;10652.680419587425;10799.40603266828;10920.672379828618;10996.945015274872;10550.366977981346;10785.946070269913;10843.186760993114;11020.173486988348;11122.499487522919;8091.3121672394955;9891.604335826487;10163.542640581043;10294.786620876548;10305.175585953255;8626.353023523387;8963.282937365126;9313.44119352841;9327.766805829908;9701.126898579161;7455.552666840007;8545.786355340917;8677.652893884175;8732.607032683418;9121.543922803701 22:07:04 INFO - PROCESS | 1952 | __end_tp_report 22:07:04 INFO - PROCESS | 1952 | __start_cc_report 22:07:04 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,962 22:07:04 INFO - PROCESS | 1952 | __end_cc_report 22:07:04 INFO - PROCESS | 1952 | __startTimestamp1451455624109__endTimestamp 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | ------- Summary: start ------- 22:07:04 INFO - PROCESS | 1952 | Number of tests: 6 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5361.51 Median:5583.53 stddev:585.47 (10.5%) stddev-sans-first:560.93 22:07:04 INFO - PROCESS | 1952 | Values: 3148.1 3249.3 3284.2 3300.3 3319.3 5174.7 5264.0 5366.0 5408.2 5417.2 5230.6 5253.9 5346.2 5357.1 5373.4 4862.1 4866.5 4886.5 4917.1 5010.4 4959.4 4971.5 5022.2 5034.0 5036.3 4748.0 4766.7 4869.2 4878.6 4889.0 4923.2 4934.4 4935.4 4940.8 4979.0 4885.4 4897.3 4916.5 4928.0 4932.5 5086.3 5160.2 5189.0 5191.8 5192.4 5764.7 5765.3 5773.9 5774.5 5776.1 5824.4 5851.9 5879.7 5897.1 5897.9 5448.0 5453.3 5453.3 5455.8 5499.6 5808.1 5850.4 5917.6 5919.2 5921.5 5661.9 5687.3 5725.5 5764.7 5803.6 5756.3 5759.3 5759.9 5779.8 5787.0 5729.3 5737.9 5739.2 5744.8 5747.8 5671.6 5776.0 5786.5 5787.6 5897.5 4449.3 4455.4 4458.2 4458.3 4490.3 3986.4 3991.9 3992.5 4034.1 4036.0 5196.3 5317.8 5357.0 5432.1 5470.6 5844.2 5870.4 5872.5 5881.9 5888.2 5187.6 5423.9 5427.3 5430.7 5432.2 4925.9 5011.4 5104.3 5106.5 5126.8 5938.9 5939.2 5939.4 5941.4 5941.7 5712.2 5767.0 5769.2 5777.3 5779.5 5795.7 5855.8 5868.1 5896.0 5901.4 5669.3 5695.0 5708.3 5743.1 5743.6 5791.7 5793.8 5794.5 5798.1 5798.6 5583.5 5590.8 5690.0 5708.6 5722.7 5427.1 5605.3 5614.3 5634.1 5639.8 5516.1 5517.6 5520.1 5521.9 5523.1 5549.9 5646.6 5666.7 5674.1 5813.2 5599.9 5614.2 5632.1 5639.5 5641.5 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:44395.75 Median:33326.75 stddev:73484.20 (220.5%) stddev-sans-first:73616.53 22:07:04 INFO - PROCESS | 1952 | Values: 529.8 531.3 536.0 548.0 551.6 27956.9 29111.0 29180.3 35824.1 36502.0 39009.0 39137.0 39333.6 39450.2 39469.4 8419.4 8577.4 8588.5 8590.5 8593.7 7463.4 7608.5 10071.0 10240.4 10255.2 9938.8 10019.5 10021.6 10026.5 10038.6 7402.0 7532.7 9939.0 10037.3 10047.4 10023.0 10283.9 10297.4 10302.5 10303.5 35954.1 36279.3 36299.0 36301.5 36427.6 3170.0 3175.5 3287.3 3541.6 3631.7 25826.1 26387.2 26839.2 27870.6 28083.9 3707.5 3776.3 3853.6 3995.8 4095.7 280799.0 282269.2 283778.0 284309.0 285162.0 53884.5 54060.5 60251.7 60589.4 60799.7 65049.3 65649.7 65879.0 65907.0 65918.0 15265.6 15515.5 15523.3 15565.4 15579.2 12027.2 12096.4 12113.6 12119.1 12128.2 19335.2 19686.1 19798.0 20533.4 20568.2 7695.9 7790.8 7916.4 7934.2 7955.7 876.2 934.7 953.9 961.8 977.8 26653.2 26967.9 27176.5 27279.5 27385.6 1014.6 1029.2 1112.1 1115.9 1140.1 14318.8 14326.4 14462.0 14568.3 14618.5 337689.0 343512.0 344350.0 344470.0 344806.0 51635.2 52168.2 52210.7 52248.7 52263.5 1309.6 1313.3 1319.7 1338.0 1340.1 26857.3 27508.9 27902.7 27949.4 28003.4 42181.0 42463.0 46315.3 47167.0 47235.0 193058.0 193433.0 195948.0 196545.0 196956.0 27350.3 31937.7 32395.0 32410.4 32522.0 31201.0 38371.4 38963.8 39225.6 39280.4 31997.4 33484.0 33927.7 35682.1 37068.6 35818.0 36240.0 36948.6 37143.4 37148.0 35287.1 36137.6 36193.5 36214.3 36299.3 31504.7 33061.3 33081.3 33309.8 33343.7 29878.3 30107.5 30523.5 30653.7 30904.5 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:28733.55 Median:17523.53 stddev:81856.57 (467.1%) stddev-sans-first:82058.44 22:07:04 INFO - PROCESS | 1952 | Values: 342.4 343.5 347.9 351.5 359.8 13744.7 13962.9 16579.8 16818.4 17558.6 14793.7 16336.5 16476.9 16892.9 16934.5 5454.4 5622.3 5627.0 5628.1 5633.6 4051.5 4125.8 5498.5 5530.3 5922.8 6046.9 6066.6 6087.0 6091.5 6098.6 5896.5 6040.5 6052.7 6053.4 6057.9 5250.4 5274.9 5289.4 5299.3 5307.8 21221.8 22151.1 22900.2 23427.6 23991.8 2197.9 2262.1 2293.7 2293.8 2346.6 13924.7 14273.9 14474.1 14584.0 14745.3 1884.8 1925.3 1944.9 1945.3 1977.5 68943.3 72503.1 74117.3 74274.6 74492.0 15660.1 15680.5 15693.5 15703.5 15893.4 24288.6 24341.5 24518.0 24721.9 24745.6 8836.1 8846.0 8866.8 8938.3 9124.6 7581.8 7666.1 7679.2 7687.2 7740.7 7598.6 7622.8 7634.3 7739.1 7739.6 1800.9 1825.8 1852.0 2148.9 2979.9 875.1 881.6 936.0 943.8 986.3 14133.4 15308.3 16394.2 16767.9 16790.3 928.7 936.8 938.8 940.9 945.2 9414.2 9474.2 9489.9 9553.8 9709.4 455737.0 456262.0 460859.0 468968.0 633953.0 75895.0 78950.6 80362.0 82221.6 82930.2 1102.2 1123.9 1140.0 1144.1 1145.6 14978.9 15166.8 15268.2 15380.4 15793.3 34699.2 34748.0 34954.3 36011.1 36684.0 46674.5 47136.5 47618.0 48822.3 49972.8 9468.7 9571.7 9695.4 9696.7 9701.2 11430.8 16964.0 16971.0 17211.5 17652.6 2783.2 12177.6 13104.5 13768.8 13789.0 14439.6 14512.7 14578.6 14608.6 14957.3 15019.2 15109.2 15131.2 15525.0 15687.0 9802.9 9804.8 10028.8 10147.6 10153.9 11464.4 14297.5 14739.1 14774.9 15115.2 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:5134.44 Median:6175.51 stddev:2582.62 (41.8%) stddev-sans-first:2574.16 22:07:04 INFO - PROCESS | 1952 | Values: 1345.5 1415.9 1424.2 1578.3 1798.6 6338.4 7012.1 7207.6 7209.9 7211.0 7086.6 7294.6 7300.1 7302.2 7306.1 1936.1 1970.1 1970.7 2215.9 2259.0 1990.6 2002.9 2206.6 2245.4 2253.5 2192.3 2212.5 2213.9 2217.5 2276.5 2241.9 2265.8 2272.8 2276.6 2276.7 2217.8 2266.2 2267.4 2269.3 2270.9 7122.4 7161.1 7191.7 7195.5 7203.0 4474.7 4545.9 4553.3 4555.5 4555.6 3044.2 3134.0 3145.7 3148.1 3159.4 930.3 950.0 957.0 1019.0 1067.0 9840.5 9859.3 9861.0 9874.5 9917.4 4145.5 4158.5 4188.6 4205.9 4221.9 8579.8 8608.0 8641.0 8644.5 8652.3 4629.2 4645.6 4646.0 4647.5 4651.3 4251.2 4256.7 4257.0 4258.6 4264.5 3245.1 3509.9 3548.2 3556.5 3600.9 1055.9 1135.8 1136.6 1154.7 1161.5 1034.0 1034.2 1091.8 1188.5 1343.6 6620.5 6662.0 6693.4 6714.3 6757.7 1059.1 1062.1 1066.9 1073.9 1081.2 5496.2 5586.2 5593.2 5595.5 5596.7 8528.4 8586.4 8753.2 8768.9 8775.6 8533.0 8576.7 8630.3 8635.4 8648.3 6655.3 6686.6 6788.0 6793.3 6985.3 6713.7 6758.5 6760.5 6761.2 6777.8 7623.1 7843.1 7939.0 7945.5 7951.7 7835.7 8051.2 8145.0 8165.2 8171.2 6269.1 6307.4 6340.7 6373.1 6386.2 6331.9 6497.4 7062.8 7125.8 7136.7 6377.5 6380.4 6432.2 6438.4 6668.2 6453.1 6501.5 6593.1 6601.7 6620.0 6360.7 6432.2 6460.8 6464.6 6466.3 6074.1 6112.5 6113.1 6120.8 6126.2 6076.2 6119.8 6141.4 6173.2 6177.8 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:5359.40 Median:6076.92 stddev:1613.24 (26.5%) stddev-sans-first:1572.83 22:07:04 INFO - PROCESS | 1952 | Values: 321.6 332.7 341.5 343.3 347.9 5997.0 6050.6 6073.8 6099.1 6136.3 5973.2 5990.5 5997.4 6005.6 6023.8 4652.8 4653.1 4659.0 4661.7 4667.8 4467.3 4610.3 4628.0 4652.2 4653.8 4598.9 4601.3 4602.2 4606.4 4615.2 4392.5 4477.9 4483.0 4600.7 4623.5 4001.7 4033.4 4043.1 4047.1 4053.7 5688.7 5758.8 5760.0 5780.2 5785.1 5092.4 5179.7 5214.8 5322.2 5345.1 6277.7 6316.6 6342.4 6351.2 6403.7 4473.5 4476.1 4477.3 4478.1 4478.6 6447.6 6551.9 6611.6 6669.7 6683.3 4560.7 4584.9 4592.0 4592.2 4594.6 4650.7 4652.5 4655.7 4657.5 4659.5 5363.6 5369.0 5372.0 5372.8 5378.8 6296.9 6361.7 6386.2 6391.2 6415.4 1610.4 1630.0 1634.3 1634.6 1635.2 1042.5 1084.2 1085.2 1088.2 1109.7 6076.6 6078.1 6086.1 6092.5 6102.1 6629.9 6631.5 6634.3 6634.5 6635.1 5943.9 6048.8 6077.2 6079.0 6081.7 3546.2 3549.1 3557.9 3559.6 3570.9 6805.2 6807.6 6809.0 6824.8 6836.9 6392.9 6467.2 6615.8 6746.2 6748.1 6761.0 6884.2 6890.2 6895.1 6900.3 6648.6 6651.1 6653.7 6656.0 6659.3 6408.3 6570.2 6576.0 6580.2 6581.7 6849.0 6856.4 6863.5 6865.8 6871.0 4586.9 4592.9 4597.1 4598.5 4599.0 6663.6 6667.7 6669.5 6677.0 6679.8 6293.8 6465.5 6471.7 6473.5 6477.4 6444.9 6452.3 6453.9 6455.4 6467.3 6165.1 6290.4 6318.7 6329.2 6337.8 6488.1 6552.5 6553.7 6559.4 6563.5 6361.5 6368.6 6388.1 6390.0 6398.4 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:12272.33 Median:25237.98 stddev:14135.17 (56.0%) stddev-sans-first:14148.30 22:07:04 INFO - PROCESS | 1952 | Values: 740.5 748.1 759.7 771.9 777.5 11896.7 11945.7 12059.5 12067.2 12142.0 11274.6 13777.4 14001.4 14013.2 14027.2 664.5 788.0 788.0 792.6 792.9 661.4 784.0 792.3 795.4 798.0 840.4 848.5 848.8 849.0 849.3 682.7 691.1 828.0 844.7 846.5 609.8 610.0 610.2 613.1 614.7 12362.8 12525.2 12595.3 12608.9 12629.9 11104.1 11297.2 11501.7 11522.4 12075.7 10016.3 10045.5 10175.1 10321.1 10544.7 3412.5 3500.1 3508.3 3526.6 3533.6 44986.3 45131.5 45395.0 46421.5 46537.5 9039.9 9061.0 9075.6 9101.9 9329.3 15146.5 15186.8 15208.5 15210.8 15252.6 6852.2 6866.0 7007.7 7201.0 7319.2 4050.0 4096.9 4115.0 4163.1 4244.7 2832.0 2853.3 2856.3 2859.4 2871.1 545.9 547.4 554.2 561.8 569.6 470.5 503.2 528.7 586.7 618.9 7915.4 7980.9 8102.3 8175.6 8182.7 561.7 606.8 614.1 653.8 680.5 3740.2 3787.6 3804.2 3826.1 3959.2 50817.7 50994.0 51065.2 51100.5 51330.5 49376.5 49972.8 50321.7 50522.2 50704.5 19311.8 19317.8 19351.6 19378.4 22070.7 7739.3 7893.8 8007.8 8043.7 8145.5 34015.0 34102.3 34205.5 34703.8 34997.0 39860.8 40312.8 43516.8 43671.8 43905.3 9387.5 9406.7 9575.7 9811.0 9824.8 11727.5 11924.2 12010.0 12120.3 12268.4 10298.4 10652.7 10799.4 10920.7 10996.9 10550.4 10785.9 10843.2 11020.2 11122.5 8091.3 9891.6 10163.5 10294.8 10305.2 8626.4 8963.3 9313.4 9327.8 9701.1 7455.6 8545.8 8677.7 8732.6 9121.5 22:07:04 INFO - PROCESS | 1952 | -------- Summary: end -------- 22:07:04 INFO - PROCESS | 1952 | 22:07:04 INFO - TEST-INFO | 1952: exit 0 22:07:04 INFO - TEST-OK | dromaeo_css | took 1113312ms 22:07:04 INFO - TEST-START | kraken 22:07:04 INFO - operating with platform_type : linux_ 22:07:04 INFO - Initialising browser for kraken test... 22:07:04 INFO - TEST-INFO | started process 2154 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvBtWad/profile http://localhost:36166/getInfo.html) 22:07:05 INFO - PROCESS | 2154 | Failed to load Oculus VR library! 22:07:08 INFO - PROCESS | 2154 | __metrics Screen width/height:1600/1200 22:07:08 INFO - PROCESS | 2154 | colorDepth:24 22:07:08 INFO - PROCESS | 2154 | Browser inner width/height: 1024/697 22:07:08 INFO - PROCESS | 2154 | __metrics 22:07:08 INFO - PROCESS | 2154 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:07:08 INFO - PROCESS | 2154 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:07:10 INFO - TEST-INFO | 2154: exit 0 22:07:10 INFO - Browser initialized. 22:07:10 INFO - Running cycle 1/1 for kraken test... 22:07:10 INFO - TEST-INFO | started process 2235 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvBtWad/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:10 INFO - PROCESS | 2235 | Failed to load Oculus VR library! 22:07:21 INFO - PROCESS | 2235 | RSS: Main: 148930560 22:07:21 INFO - PROCESS | 2235 | 22:07:24 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36166/tests/kraken/driver.html?testName=audio-beat-detection) 22:07:24 INFO - PROCESS | 2235 | RSS: Main: 183910400 22:07:24 INFO - PROCESS | 2235 | 22:07:27 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36166/tests/kraken/driver.html?testName=audio-dft) 22:07:28 INFO - PROCESS | 2235 | RSS: Main: 176451584 22:07:28 INFO - PROCESS | 2235 | 22:07:30 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36166/tests/kraken/driver.html?testName=audio-fft) 22:07:31 INFO - PROCESS | 2235 | RSS: Main: 159485952 22:07:31 INFO - PROCESS | 2235 | 22:07:33 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36166/tests/kraken/driver.html?testName=audio-oscillator) 22:07:33 INFO - PROCESS | 2235 | RSS: Main: 162185216 22:07:33 INFO - PROCESS | 2235 | 22:07:36 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:07:36 INFO - PROCESS | 2235 | RSS: Main: 163651584 22:07:36 INFO - PROCESS | 2235 | 22:07:39 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36166/tests/kraken/driver.html?testName=imaging-darkroom) 22:07:40 INFO - PROCESS | 2235 | RSS: Main: 164880384 22:07:40 INFO - PROCESS | 2235 | 22:07:43 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36166/tests/kraken/driver.html?testName=imaging-desaturate) 22:07:44 INFO - PROCESS | 2235 | RSS: Main: 164564992 22:07:44 INFO - PROCESS | 2235 | 22:07:46 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36166/tests/kraken/driver.html?testName=json-parse-financial) 22:07:47 INFO - PROCESS | 2235 | RSS: Main: 164777984 22:07:47 INFO - PROCESS | 2235 | 22:07:48 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:07:49 INFO - PROCESS | 2235 | RSS: Main: 178020352 22:07:49 INFO - PROCESS | 2235 | 22:07:51 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:07:51 INFO - PROCESS | 2235 | RSS: Main: 175341568 22:07:51 INFO - PROCESS | 2235 | 22:07:54 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:07:54 INFO - PROCESS | 2235 | RSS: Main: 187023360 22:07:54 INFO - PROCESS | 2235 | 22:07:57 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:07:57 INFO - PROCESS | 2235 | RSS: Main: 193765376 22:07:57 INFO - PROCESS | 2235 | 22:08:00 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:08:00 INFO - PROCESS | 2235 | RSS: Main: 192200704 22:08:00 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:36166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36166/tests/kraken/driver.html?testName=ai-astar) 22:08:02 INFO - PROCESS | 2235 | RSS: Main: 251006976 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | __start_tp_report 22:08:02 INFO - PROCESS | 2235 | _x_x_mozilla_page_load 22:08:02 INFO - PROCESS | 2235 | _x_x_mozilla_page_load_details 22:08:02 INFO - PROCESS | 2235 | |i|pagename|runs| 22:08:02 INFO - PROCESS | 2235 | |0;ai-astar;111;113;106;110;110;110;101;112;111;102 22:08:02 INFO - PROCESS | 2235 | |1;audio-beat-detection;150;125;149;161;126;154;154;125;170;124 22:08:02 INFO - PROCESS | 2235 | |2;audio-dft;160;161;160;159;163;161;161;160;160;161 22:08:02 INFO - PROCESS | 2235 | |3;audio-fft;77;73;84;106;73;71;73;106;92;71 22:08:02 INFO - PROCESS | 2235 | |4;audio-oscillator;97;103;158;95;97;96;147;96;97;137 22:08:02 INFO - PROCESS | 2235 | |5;imaging-gaussian-blur;110;109;110;110;109;109;110;110;109;109 22:08:02 INFO - PROCESS | 2235 | |6;imaging-darkroom;146;146;146;147;145;147;145;145;145;145 22:08:02 INFO - PROCESS | 2235 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;96;96 22:08:02 INFO - PROCESS | 2235 | |8;json-parse-financial;58;56;57;56;56;58;56;65;55;54 22:08:02 INFO - PROCESS | 2235 | |9;json-stringify-tinderbox;68;67;68;68;68;69;69;68;68;68 22:08:02 INFO - PROCESS | 2235 | |10;stanford-crypto-aes;85;95;86;94;87;87;88;89;88;88 22:08:02 INFO - PROCESS | 2235 | |11;stanford-crypto-ccm;118;118;115;118;130;133;117;132;122;122 22:08:02 INFO - PROCESS | 2235 | |12;stanford-crypto-pbkdf2;144;160;168;155;148;144;154;154;152;142 22:08:02 INFO - PROCESS | 2235 | |13;stanford-crypto-sha256-iterative;70;69;69;72;69;67;69;70;68;68 22:08:02 INFO - PROCESS | 2235 | __end_tp_report 22:08:02 INFO - PROCESS | 2235 | __start_cc_report 22:08:02 INFO - PROCESS | 2235 | _x_x_mozilla_cycle_collect,913 22:08:02 INFO - PROCESS | 2235 | __end_cc_report 22:08:02 INFO - PROCESS | 2235 | __startTimestamp1451455682804__endTimestamp 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | ------- Summary: start ------- 22:08:02 INFO - PROCESS | 2235 | Number of tests: 14 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:4.17 (3.8%) stddev-sans-first:4.33 22:08:02 INFO - PROCESS | 2235 | Values: 111.0 113.0 106.0 110.0 110.0 110.0 101.0 112.0 111.0 102.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:152.00 stddev:17.23 (11.3%) stddev-sans-first:18.13 22:08:02 INFO - PROCESS | 2235 | Values: 150.0 125.0 149.0 161.0 126.0 154.0 154.0 125.0 170.0 124.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 22:08:02 INFO - PROCESS | 2235 | Values: 160.0 161.0 160.0 159.0 163.0 161.0 161.0 160.0 160.0 161.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#3] audio-fft Cycles:10 Average:82.60 Median:73.00 stddev:13.99 (19.2%) stddev-sans-first:14.70 22:08:02 INFO - PROCESS | 2235 | Values: 77.0 73.0 84.0 106.0 73.0 71.0 73.0 106.0 92.0 71.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#4] audio-oscillator Cycles:10 Average:112.30 Median:96.00 stddev:24.77 (25.8%) stddev-sans-first:25.65 22:08:02 INFO - PROCESS | 2235 | Values: 97.0 103.0 158.0 95.0 97.0 96.0 147.0 96.0 97.0 137.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:08:02 INFO - PROCESS | 2235 | Values: 110.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 22:08:02 INFO - PROCESS | 2235 | Values: 146.0 146.0 146.0 147.0 145.0 147.0 145.0 145.0 145.0 145.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:08:02 INFO - PROCESS | 2235 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:3.03 (5.4%) stddev-sans-first:3.20 22:08:02 INFO - PROCESS | 2235 | Values: 58.0 56.0 57.0 56.0 56.0 58.0 56.0 65.0 55.0 54.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 22:08:02 INFO - PROCESS | 2235 | Values: 68.0 67.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.00 stddev:3.27 (3.7%) stddev-sans-first:3.18 22:08:02 INFO - PROCESS | 2235 | Values: 85.0 95.0 86.0 94.0 87.0 87.0 88.0 89.0 88.0 88.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:122.00 stddev:6.70 (5.5%) stddev-sans-first:6.91 22:08:02 INFO - PROCESS | 2235 | Values: 118.0 118.0 115.0 118.0 130.0 133.0 117.0 132.0 122.0 122.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:154.00 stddev:8.03 (5.2%) stddev-sans-first:7.97 22:08:02 INFO - PROCESS | 2235 | Values: 144.0 160.0 168.0 155.0 148.0 144.0 154.0 154.0 152.0 142.0 22:08:02 INFO - PROCESS | 2235 | 22:08:02 INFO - PROCESS | 2235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 22:08:02 INFO - PROCESS | 2235 | Values: 70.0 69.0 69.0 72.0 69.0 67.0 69.0 70.0 68.0 68.0 22:08:02 INFO - PROCESS | 2235 | -------- Summary: end -------- 22:08:02 INFO - PROCESS | 2235 | 22:08:03 INFO - TEST-INFO | 2235: exit 0 22:08:03 INFO - TEST-OK | kraken | took 58983ms 22:08:03 INFO - TEST-START | v8_7 22:08:03 INFO - operating with platform_type : linux_ 22:08:03 INFO - Initialising browser for v8_7 test... 22:08:03 INFO - TEST-INFO | started process 2574 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzYNYbU/profile http://localhost:36166/getInfo.html) 22:08:04 INFO - PROCESS | 2574 | Failed to load Oculus VR library! 22:08:07 INFO - PROCESS | 2574 | __metrics Screen width/height:1600/1200 22:08:07 INFO - PROCESS | 2574 | colorDepth:24 22:08:07 INFO - PROCESS | 2574 | Browser inner width/height: 1024/697 22:08:07 INFO - PROCESS | 2574 | __metrics 22:08:07 INFO - PROCESS | 2574 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:08:07 INFO - PROCESS | 2574 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:08:08 INFO - TEST-INFO | 2574: exit 0 22:08:08 INFO - Browser initialized. 22:08:08 INFO - Running cycle 1/1 for v8_7 test... 22:08:08 INFO - TEST-INFO | started process 2657 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzYNYbU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:09 INFO - PROCESS | 2657 | Failed to load Oculus VR library! 22:08:20 INFO - PROCESS | 2657 | RSS: Main: 148508672 22:08:20 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | Cycle 1(1): loaded http://localhost:36166/tests/v8_7/run.html (next: http://localhost:36166/tests/v8_7/run.html) 22:08:42 INFO - PROCESS | 2657 | RSS: Main: 615522304 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | __start_tp_report 22:08:42 INFO - PROCESS | 2657 | _x_x_mozilla_page_load 22:08:42 INFO - PROCESS | 2657 | _x_x_mozilla_page_load_details 22:08:42 INFO - PROCESS | 2657 | |i|pagename|runs| 22:08:42 INFO - PROCESS | 2657 | |0;Richards;167.897918065816 22:08:42 INFO - PROCESS | 2657 | |1;DeltaBlue;192.30769230769232 22:08:42 INFO - PROCESS | 2657 | |2;Encrypt;283.04557033682426 22:08:42 INFO - PROCESS | 2657 | |3;Decrypt;5153.846153846154 22:08:42 INFO - PROCESS | 2657 | |4;RayTrace;1117.1875 22:08:42 INFO - PROCESS | 2657 | |5;Earley;791.7656373713381 22:08:42 INFO - PROCESS | 2657 | |6;Boyer;12207.317073170732 22:08:42 INFO - PROCESS | 2657 | |7;RegExp;26256.410256410258 22:08:42 INFO - PROCESS | 2657 | |8;Splay;625.3908692933084 22:08:42 INFO - PROCESS | 2657 | |9;NavierStokes;4835.748792270531 22:08:42 INFO - PROCESS | 2657 | __end_tp_report 22:08:42 INFO - PROCESS | 2657 | __startTimestamp1451455722376__endTimestamp 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | ------- Summary: start ------- 22:08:42 INFO - PROCESS | 2657 | Number of tests: 10 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 167.9 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#1] DeltaBlue Cycles:1 Average:192.31 Median:192.31 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 192.3 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#2] Encrypt Cycles:1 Average:283.05 Median:283.05 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 283.0 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#3] Decrypt Cycles:1 Average:5153.85 Median:5153.85 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 5153.8 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#4] RayTrace Cycles:1 Average:1117.19 Median:1117.19 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 1117.2 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 791.8 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 12207.3 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 26256.4 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#8] Splay Cycles:1 Average:625.39 Median:625.39 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 625.4 22:08:42 INFO - PROCESS | 2657 | 22:08:42 INFO - PROCESS | 2657 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:08:42 INFO - PROCESS | 2657 | Values: 4835.7 22:08:42 INFO - PROCESS | 2657 | -------- Summary: end -------- 22:08:42 INFO - PROCESS | 2657 | 22:08:43 INFO - TEST-INFO | 2657: exit 0 22:08:43 INFO - TEST-OK | v8_7 | took 39441ms 22:08:43 INFO - SUITE-END | took 1211s 22:08:43 INFO - Completed test suite (00:20:11) 22:08:43 INFO - Working with test: dromaeo_css 22:08:43 INFO - Generating results file: dromaeo_css 22:08:43 INFO - Working with test: kraken 22:08:43 INFO - Generating results file: kraken 22:08:43 INFO - javascript benchmark 22:08:43 INFO - Working with test: v8_7 22:08:43 INFO - Generating results file: v8_7 22:08:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:08:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:08:43 INFO - process_Request line: dromaeo_css 6925.84 graph.html#tests=[[72,63,35]] 22:08:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:08:43 INFO - process_Request line: kraken 1516.10 graph.html#tests=[[232,63,35]] 22:08:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:08:43 INFO - process_Request line: v8_7 20837.85 graph.html#tests=[[230,63,35]] 22:08:43 INFO - RETURN: dromaeo_css: 6925.84 22:08:43 INFO - RETURN: kraken: 1516.10 22:08:43 INFO - RETURN: v8_7: 20837.85 22:08:43 INFO - javascript benchmark 22:08:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3148.0870547541213, 3249.2851572654035, 3284.178955261185, 3300.306935543536, 3319.30294638126, 5174.741262936847, 5264.0, 5365.973170134149, 5408.188771684245, 5417.151495261105, 5230.581553475722, 5253.86865328367, 5346.224797404374, 5357.062514060033, 5373.408925018254, 4862.124817532843, 4866.46468888422, 4886.535779100997, 4917.139500587401, 5010.448850626428, 4959.404871415435, 4971.527704868032, 5022.221555658879, 5034.0, 5036.320096786942, 4748.0, 4766.666333356667, 4869.196582563873, 4878.585320247783, 4889.0, 4923.163062279421, 4934.383202099738, 4935.406283319702, 4940.752962351868, 4979.0, 4885.43817460993, 4897.33885925399, 4916.459189489154, 4928.0, 4932.482089380599, 5086.338775959139, 5160.200168973815, 5189.0, 5191.766370513336, 5192.376914770214, 5764.682942438206, 5765.279340082489, 5773.8556536086935, 5774.5091667208335, 5776.104703770922, 5824.417558244184, 5851.8537036574, 5879.706014699291, 5897.085951677497, 5897.941020589782, 5447.972760136214, 5453.318335208099, 5453.318335208099, 5455.809046683386, 5499.587530935196, 5808.07070868659, 5850.414958504116, 5917.5857689961285, 5919.1713160157615, 5921.496672782776, 5661.886762264814, 5687.289088863892, 5725.541956643458, 5764.654120752768, 5803.593748437569, 5756.309242890796, 5759.2512973313205, 5759.94240057594, 5779.768809247583, 5786.971065144731, 5729.28383952006, 5737.885242295214, 5739.225204597409, 5744.798932037359, 5747.798827041033, 5671.631343962629, 5776.0, 5786.450287222707, 5787.623804452697, 5897.52819774417, 4449.265871131227, 4455.420795296591, 4458.175237581057, 4458.264386376211, 4490.281554951257, 3986.421968814506, 3991.8802435926386, 3992.461017762565, 4034.1326614777963, 4035.9798201009394, 5196.324477817935, 5317.7872885084935, 5357.035733567917, 5432.13085906261, 5470.64440811346, 5844.1818145459665, 5870.354261031283, 5872.500837428781, 5881.852953676107, 5888.234529511136, 5187.636865419385, 5423.891522169534, 5427.3215848019, 5430.70131142791, 5432.185172224198, 4925.852224433273, 5011.448740638527, 5104.285400043997, 5106.4893510648635, 5126.846194614168, 5938.8812223755285, 5939.16851640762, 5939.4357536034, 5941.376155503696, 5941.673207973517, 5712.200291959046, 5767.0, 5769.163471296554, 5777.277840269966, 5779.537636988946, 5795.710214489343, 5855.795047173328, 5868.119782032729, 5895.970520147372, 5901.439363260483, 5669.34802497718, 5695.031844586348, 5708.343540492897, 5743.0811070228565, 5743.59794814359, 5791.710414479344, 5793.797217097382, 5794.5364370851075, 5798.072308430631, 5798.59409841307, 5583.525400340854, 5590.8043218487155, 5690.032694442038, 5708.600397972102, 5722.713864306851, 5427.104527753035, 5605.299337582802, 5614.29821272341, 5634.126710359901, 5639.802606908738, 5516.117421212587, 5517.641353312022, 5520.1443776214755, 5521.861953451035, 5523.061079616395, 5549.944500554942, 5646.576506762091, 5666.744996475086, 5674.120511320752, 5813.215215945793, 5599.8880022400135, 5614.157876318585, 5632.127020311858, 5639.548836093185, 5641.5204707600315], "unit": "score", "name": "dojo.html", "value": 5324.324067267316}, {"lowerIsBetter": false, "replicates": [529.8489930369846, 531.3225637312427, 536.0030343560976, 547.9999001821676, 551.6056019945738, 27956.860215698944, 29111.0, 29180.270493237655, 35824.10439739008, 36502.0, 39008.953612190155, 39137.0, 39333.60666393335, 39450.21099578014, 39469.40795888064, 8419.4106412551, 8577.356698247657, 8588.527630980294, 8590.484570925733, 8593.656253749843, 7463.402927765793, 7608.467407281492, 10071.0, 10240.436775977318, 10255.230857685667, 9938.801223975515, 10019.549120289605, 10021.599136034587, 10026.498675066254, 10038.598456061749, 7401.9629901850685, 7532.661030253597, 9939.0, 10037.34383826675, 10047.397156170653, 10023.0, 10283.94858025705, 10297.3821570706, 10302.536385862579, 10303.484825758682, 35954.10114747126, 36279.27441451183, 36299.0, 36301.455478167845, 36427.63572364269, 3170.0014495434093, 3175.4760464523324, 3287.3425314936867, 3541.628129046439, 3631.654992775682, 25826.096086637066, 26387.20838374852, 26839.194824155307, 27870.5819412709, 28083.85958070217, 3707.5180226570374, 3776.3013842439236, 3853.614638536124, 3995.820188091543, 4095.692823038284, 280799.0, 282269.18442747905, 283778.0, 284309.0, 285162.0, 53884.461155387944, 54060.459395405545, 60251.698741506014, 60589.394106058375, 60799.69600151971, 65049.34950650528, 65649.67175164094, 65879.0, 65907.03418346186, 65918.0, 15265.618359540878, 15515.534533963999, 15523.301451434712, 15565.377384904477, 15579.221038948008, 12027.15809893299, 12096.395180240952, 12113.576024839089, 12119.091068169922, 12128.211666241667, 19335.226590936207, 19686.11412486413, 19798.0, 20533.38399848007, 20568.177272909215, 7695.884561731578, 7790.805229869298, 7916.366690664733, 7934.166912474223, 7955.681772729026, 876.2332958661171, 934.7289286106953, 953.8998405167496, 961.8220629183623, 977.7799995001068, 26653.20040398791, 26967.86516067407, 27176.45647087047, 27279.454410911672, 27385.589216161774, 1014.573878970834, 1029.2126523209752, 1112.065864673678, 1115.938623375706, 1140.122105978392, 14318.778120292509, 14326.426942922166, 14461.987660863639, 14568.344424500923, 14618.488352907598, 337689.0, 343512.0, 344350.0, 344470.0, 344806.0, 51635.22547161795, 52168.21747673788, 52210.73894630503, 52248.738756305975, 52263.47736522662, 1309.5874799438336, 1313.2514466753858, 1319.7228581997888, 1337.993310033463, 1340.1289162044554, 26857.328566785985, 27508.862455688395, 27902.720972790823, 27949.441011179257, 28003.439931200854, 42181.0, 42463.0, 46315.3052704203, 47167.0, 47235.0, 193058.0, 193433.0, 195948.0, 196545.0, 196956.0, 27350.31624209331, 31937.6806231944, 32395.0, 32410.35179296448, 32522.0, 31201.0, 38371.42442863415, 38963.80518097391, 39225.6077439222, 39280.41079383869, 31997.36005279928, 33484.0, 33927.66072339344, 35682.10794730153, 37068.629313706515, 35818.0, 36240.0, 36948.63051369559, 37143.44284835784, 37148.0, 35287.11782205466, 36137.63862361343, 36193.45709814408, 36214.27571448503, 36299.27401452009, 31504.684953150176, 33061.33877322392, 33081.33837323288, 33309.83345083259, 33343.66656333405, 29878.25304367408, 30107.54838677378, 30523.542146868258, 30653.693463065974, 30904.536431953988], "unit": "score", "name": "ext.html", "value": 18222.17110518872}, {"lowerIsBetter": false, "replicates": [342.4144712541554, 343.52936477026475, 347.8625942752613, 351.4552443712247, 359.78592737321287, 13744.656383590414, 13962.860371396284, 16579.83420165798, 16818.41135560254, 17558.56103597409, 14793.704125917475, 16336.509904702849, 16476.917615411938, 16892.915535422337, 16934.49196524106, 5454.400015998247, 5622.32532096149, 5627.0, 5628.127640215773, 5633.577481688869, 4051.4530538377385, 4125.814338354766, 5498.505134537891, 5530.2810634617645, 5922.763089476416, 6046.939530604682, 6066.636001839904, 6086.969565152191, 6091.543134264925, 6098.57309988301, 5896.528277737771, 6040.546958978094, 6052.697365131769, 6053.424924632175, 6057.878842423127, 5250.369955605313, 5274.894502109936, 5289.365276166846, 5299.311089558371, 5307.814226502092, 21221.787782122137, 22151.113955441764, 22900.19849305283, 23427.648585271236, 23991.7600823993, 2197.8681279123302, 2262.1290803040947, 2293.6788849561076, 2293.7820907013806, 2346.577616029114, 13924.721505569833, 14273.92945529079, 14474.059186152972, 14584.0, 14745.262736863115, 1884.7644044494439, 1925.3357591630865, 1944.8735832171005, 1945.289969161246, 1977.5155087003632, 68943.3105668947, 72503.14289705252, 74117.25882741157, 74274.62862685705, 74492.0, 15660.13869237203, 15680.529584112495, 15693.529194124194, 15703.450379236672, 15893.443729469413, 24288.63567046496, 24341.513169736507, 24518.0, 24721.87639061793, 24745.62881556778, 8836.116388361112, 8846.0, 8866.822663546822, 8938.284937205008, 9124.635014599342, 7581.772546823604, 7666.118396384487, 7679.1936846631415, 7687.154413014676, 7740.729074482366, 7598.582077985764, 7622.8094297643, 7634.31291183785, 7739.148693643695, 7739.61301934901, 1800.8919464832152, 1825.8174182581636, 1851.9629607407776, 2148.8933199402322, 2979.925501862471, 875.0724232313768, 881.6253092435818, 936.0031566381782, 943.7640589852537, 986.2504496582649, 14133.434662613587, 15308.311125999357, 16394.1802909854, 16767.91616041912, 16790.328386864632, 928.7492377058292, 936.7939053408239, 938.7653086728318, 940.9294302927308, 945.229637845154, 9414.19979301767, 9474.194693450996, 9489.905100948901, 9553.761155971017, 9709.36889102206, 455737.0, 456262.0, 460859.0, 468968.0, 633953.0, 75895.0, 78950.6052469734, 80362.0, 82221.58889205636, 82930.17069829225, 1102.162356608967, 1123.8876112388696, 1139.9943000285111, 1144.1133121830649, 1145.5818626201376, 14978.850211497745, 15166.772498412312, 15268.160251185847, 15380.384784608937, 15793.289301981209, 34699.1936327365, 34748.0, 34954.300913982086, 36011.0997225061, 36684.0, 46674.53325466838, 47136.52863471321, 47618.0, 48822.26766598433, 49972.75013624909, 9468.668596599086, 9571.712848614552, 9695.418274903528, 9696.660616878375, 9701.223902087957, 11430.828537571777, 16964.0, 16971.0, 17211.483655490356, 17652.646947061243, 2783.2067860660422, 12177.590274723092, 13104.541341053018, 13768.793468098187, 13789.0, 14439.639009024859, 14512.709745804814, 14578.635534111732, 14608.634784130056, 14957.252137392868, 15019.249037548298, 15109.244537773287, 15131.167785771888, 15525.0, 15687.0, 9802.9019709802, 9804.803903921738, 10028.849567256642, 10147.64483243083, 10153.898461015295, 11464.369459679798, 14297.499587514387, 14739.115653060851, 14774.926125369304, 15115.168665723491], "unit": "score", "name": "jquery.html", "value": 9539.377194197477}, {"lowerIsBetter": false, "replicates": [1345.5021641992464, 1415.8513356097608, 1424.2024466298874, 1578.2661062605887, 1798.6132981408994, 6338.429541341278, 7012.088428504294, 7207.603581802999, 7209.927900720998, 7211.0, 7086.610236437007, 7294.598797066159, 7300.0509933708545, 7302.1967583565765, 7306.086739157606, 1936.1480948382737, 1970.0839109813933, 1970.655135351315, 2215.8559693619945, 2258.977410225901, 1990.64168449679, 2002.8698134621277, 2206.6138425775425, 2245.41619179013, 2253.481699209183, 2192.2875065603744, 2212.4579478027904, 2213.900374483152, 2217.5121473275935, 2276.46503071778, 2241.8991145398413, 2265.796078352948, 2272.8295377846725, 2276.612975794119, 2276.715410573678, 2217.800397964191, 2266.195500597281, 2267.399139228106, 2269.319204238722, 2270.943226419336, 7122.394596459307, 7161.140663120407, 7191.712331506734, 7195.532290401159, 7203.027591275216, 4474.731516109044, 4545.886352841172, 4553.271476563734, 4555.544445555451, 4555.635549156093, 3044.2389402649337, 3134.0284511801415, 3145.653978062411, 3148.055583324993, 3159.447096758081, 930.3208657679932, 950.0, 956.9712908612753, 1018.974525636865, 1066.9733256668567, 9840.458774767385, 9859.260555458297, 9861.013898610154, 9874.456904870229, 9917.355371900876, 4145.461090058334, 4158.542560318362, 4188.623023927861, 4205.852795152155, 4221.873343799691, 8579.785505362415, 8608.0, 8640.956795216109, 8644.524551149747, 8652.307815374756, 4629.189891768927, 4645.628349732014, 4645.976770116128, 4647.488776234612, 4651.3023046543285, 4251.192273468031, 4256.659467242614, 4257.020885196423, 4258.574142585717, 4264.509581398179, 3245.0913744151676, 3509.894703158909, 3548.183917698944, 3556.466530020466, 3600.891973240807, 1055.9260851740305, 1135.8125909224884, 1136.5851464215502, 1154.6766905266538, 1161.4773351991637, 1034.0, 1034.1984961654778, 1091.8034753744403, 1188.518649946773, 1343.6103529976197, 6620.503462240351, 6662.0, 6693.397594216543, 6714.261431242559, 6757.695903684247, 1059.1103473082649, 1062.0972173652488, 1066.9359838409564, 1073.9463026848625, 1081.2485322700647, 5496.230527726121, 5586.16207568868, 5593.161025846156, 5595.468430499096, 5596.720163991784, 8528.360372972053, 8586.398952073296, 8753.168448997336, 8768.947726272889, 8775.605097770487, 8533.0, 8576.742697719079, 8630.309575234092, 8635.438696484709, 8648.308135349156, 6655.267920528738, 6686.5653732507235, 6788.0, 6793.286704896013, 6985.336393042754, 6713.6643167842385, 6758.4931130166415, 6760.526763126534, 6761.188657361148, 6777.762778302736, 7623.085229772463, 7843.137254902071, 7938.960305198668, 7945.523268603903, 7951.681932722627, 7835.725749598737, 8051.2351326623875, 8145.022597288126, 8165.183481651788, 8171.182881711781, 6269.12232287471, 6307.400796924285, 6340.651264180515, 6373.107764913008, 6386.16979792624, 6331.90502142459, 6497.4477169441125, 7062.788116356312, 7125.786226413215, 7136.714531418893, 6377.521685873486, 6380.3619638035825, 6432.163818703539, 6438.420542151041, 6668.199816022108, 6453.128827608401, 6501.4798816095545, 6593.109930159367, 6601.735930562723, 6619.966900165468, 6360.650164241011, 6432.195975503062, 6460.806175814733, 6464.644444555406, 6466.256380516113, 6074.119252708421, 6112.541559383153, 6113.113598528277, 6120.846978825565, 6126.172966649446, 6076.210092687922, 6119.785807496716, 6141.416565426277, 6173.166622505904, 6177.84555386101], "unit": "score", "name": "mootools.html", "value": 4263.72404540864}, {"lowerIsBetter": false, "replicates": [321.55143574713276, 332.6573629161963, 341.53210102160034, 343.26369936486225, 347.93737127317087, 5997.040473524237, 6050.576459647827, 6073.817785466432, 6099.054646529784, 6136.294326152494, 5973.193618861453, 5990.460858522732, 5997.430244126812, 6005.579609427342, 6023.789167379143, 4652.7906244219, 4653.139169253682, 4659.0, 4661.673682842203, 4667.76661166942, 4467.329900514933, 4610.2854057621125, 4627.976860115711, 4652.162610730084, 4653.813277614204, 4598.908021839561, 4601.33280674302, 4602.171609110359, 4606.378138951232, 4615.215413379734, 4392.472903251614, 4477.910441791146, 4483.036147228329, 4600.746958917258, 4623.491415944261, 4001.7398869073418, 4033.3949907513816, 4043.0903046814524, 4047.1096358801015, 4053.6959728020515, 5688.715564221772, 5758.827235182951, 5760.0, 5780.1907732917425, 5785.132230165466, 5092.388913330387, 5179.715115668637, 5214.843554693365, 5322.20166974953, 5345.144776835727, 6277.7175027123885, 6316.557840951089, 6342.365763423667, 6351.237851457809, 6403.679816009181, 4473.507914129443, 4476.1271552047365, 4477.283634618478, 4478.104379124188, 4478.596926276651, 6447.580907241061, 6551.901721474182, 6611.603303801788, 6669.666516674147, 6683.331666833278, 4560.726356418625, 4584.862454126382, 4591.977040114845, 4592.196365636067, 4594.563516465931, 4650.697704649187, 4652.534746525321, 4655.674102812771, 4657.510961349078, 4659.487456379796, 5363.570914326844, 5368.973155134199, 5372.0, 5372.838814835562, 5378.784848606012, 6296.937030629635, 6361.681915904186, 6386.190076366477, 6391.169148010729, 6415.358464153547, 1610.428297954233, 1630.0, 1634.3380930723076, 1634.599523116844, 1635.2314412226235, 1042.4579218806177, 1084.208527774729, 1085.159001773616, 1088.1838621034224, 1109.7447587055024, 6076.635401875901, 6078.1186727924205, 6086.087086936995, 6092.51259899207, 6102.084687296941, 6629.900551491635, 6631.469482441393, 6634.336566343327, 6634.502412319095, 6635.071090047397, 5943.851403714942, 6048.848778780478, 6077.209962704908, 6079.0, 6081.695915204311, 3546.184377593168, 3549.07723991764, 3557.8932632021083, 3559.60844307126, 3570.946435803465, 6805.217399999064, 6807.5575087619145, 6808.9659551701925, 6824.7952561423235, 6836.897446538306, 6392.904106438407, 6467.191601049869, 6615.801525954229, 6746.22418421878, 6748.055272261888, 6760.966195169091, 6884.242733299333, 6890.2420733719255, 6895.103636527319, 6900.3444672756, 6648.634325112165, 6651.06885036105, 6653.73385064592, 6656.0, 6659.267480577036, 6408.29508754046, 6570.211574611078, 6575.980722987944, 6580.243272023778, 6581.6709164542535, 6849.0, 6856.382925536725, 6863.519553631198, 6865.794026179223, 6871.003704462725, 4586.931196032129, 4592.931106033346, 4597.08058388317, 4598.540145985375, 4599.0, 6663.566868153554, 6667.733290668319, 6669.533132680665, 6676.9666151668935, 6679.799606011828, 6293.779717709858, 6465.515086368447, 6471.708773105127, 6473.546851720334, 6477.4494167996245, 6444.935550644621, 6452.257990330984, 6453.870922581428, 6455.419012288917, 6467.320931302145, 6165.136880836597, 6290.402411770874, 6318.747250109944, 6329.177206963065, 6337.809865704036, 6488.091667166695, 6552.541322107598, 6553.705083271169, 6559.409653131241, 6563.540552161303, 6361.522885783492, 6368.617882927039, 6388.0737293091315, 6390.009548519987, 6398.424141827258], "unit": "score", "name": "prototype.html", "value": 4833.568287783723}, {"lowerIsBetter": false, "replicates": [740.4520654715509, 748.1097493982162, 759.6505607420586, 771.8687823070078, 777.5451360953844, 11896.702582435444, 11945.701357466067, 12059.4573244204, 12067.215630984001, 12142.0, 11274.605388811373, 13777.448902043907, 14001.439942402318, 14013.229272390014, 14027.158370497751, 664.5281849886586, 788.0071110400879, 788.0189164490189, 792.627465091409, 792.8969233999572, 661.4377778887955, 783.9921600784005, 792.2513225002375, 795.3716563914501, 798.0144521515923, 840.3823189955408, 848.4569875279826, 848.762346542969, 848.9660413583449, 849.3120572336396, 682.6518475577467, 691.0774116554406, 827.9710210142616, 844.6832437835811, 846.547097302943, 609.8079105081885, 610.0239616613427, 610.1823556434399, 613.1232337757006, 614.6926536731634, 12362.814557781641, 12525.185862918881, 12595.3072581008, 12608.873911260953, 12629.93685031569, 11104.111671066295, 11297.152713546435, 11501.654950351503, 11522.423878806027, 12075.698107547381, 10016.298859079867, 10045.54795034218, 10175.084242418217, 10321.071103600638, 10544.683659490227, 3412.488126781003, 3500.089976606075, 3508.298340331944, 3526.612072672004, 3533.628968958248, 44986.325205121946, 45131.548684513065, 45395.0, 46421.53578464206, 46537.534624654, 9039.90367561461, 9061.048589898097, 9075.636974520945, 9101.908980910239, 9329.346945713734, 15146.545603631908, 15186.848131518764, 15208.543743687707, 15210.771838422432, 15252.618684532976, 6852.177738671391, 6866.0, 7007.684654190573, 7201.0, 7319.194888562254, 4049.9595004049584, 4096.91806163875, 4115.0, 4163.146554956287, 4244.72409293395, 2831.957520637192, 2853.2581528802248, 2856.3287627407544, 2859.3995260995007, 2871.1099559136733, 545.8580769000089, 547.4498129379948, 554.2130175151295, 561.8426840484589, 569.564283323258, 470.47096934961377, 503.2024241577141, 528.6770228072298, 586.6919867069737, 618.9381061893774, 7915.44591878563, 7980.880286795703, 8102.311303539147, 8175.591220438954, 8182.67269309221, 561.6854561445604, 606.8422210225373, 614.0788816774838, 653.7679123910943, 680.4590350671228, 3740.1958578905665, 3787.6401741834484, 3804.2391521695217, 3826.081740382288, 3959.208158368338, 50817.745911270205, 50994.0, 51065.234021489705, 51100.48899511032, 51330.48669513257, 49376.50623493719, 49972.75013624909, 50321.748391258545, 50522.242166367534, 50704.49295507072, 19311.806881931283, 19317.80682193188, 19351.612967740846, 19378.418647440598, 22070.668939966235, 7739.34215591681, 7893.763187104396, 8007.799805004922, 8043.718469853527, 8145.470544414594, 34015.0, 34102.317953641286, 34205.48691769576, 34703.82648086845, 34997.0, 39860.80069599633, 40312.79843600763, 43516.78241608899, 43671.78164109159, 43905.34141987937, 9387.530623468663, 9406.717798466058, 9575.701831560236, 9810.950945245228, 9824.80350392974, 11727.472263748323, 11924.165308428674, 12010.0, 12120.27278363301, 12268.386580670753, 10298.3820970742, 10652.680419587425, 10799.40603266828, 10920.672379828618, 10996.945015274872, 10550.366977981346, 10785.946070269913, 10843.186760993114, 11020.173486988348, 11122.499487522919, 8091.3121672394955, 9891.604335826487, 10163.542640581043, 10294.786620876548, 10305.175585953255, 8626.353023523387, 8963.282937365126, 9313.44119352841, 9327.766805829908, 9701.126898579161, 7455.552666840007, 8545.786355340917, 8677.652893884175, 8732.607032683418, 9121.543922803701], "unit": "score", "name": "yui.html", "value": 5785.634742366426}], "name": "dromaeo_css", "value": 6925.838157581672}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 110.0, 110.0, 110.0, 101.0, 112.0, 111.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 149.0, 161.0, 126.0, 154.0, 154.0, 125.0, 170.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 159.0, 163.0, 161.0, 161.0, 160.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 84.0, 106.0, 73.0, 71.0, 73.0, 106.0, 92.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [97.0, 103.0, 158.0, 95.0, 97.0, 96.0, 147.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 112.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 57.0, 56.0, 56.0, 58.0, 56.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 95.0, 86.0, 94.0, 87.0, 87.0, 88.0, 89.0, 88.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.7}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 115.0, 118.0, 130.0, 133.0, 117.0, 132.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [144.0, 160.0, 168.0, 155.0, 148.0, 144.0, 154.0, 154.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 72.0, 69.0, 67.0, 69.0, 70.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1516.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [192.30769230769232], "unit": "score", "name": "DeltaBlue", "value": 343.8135999999999}, {"lowerIsBetter": false, "replicates": [283.04557033682426], "unit": "score", "name": "Encrypt", "value": 940.4174729999997}, {"lowerIsBetter": false, "replicates": [5153.846153846154], "unit": "score", "name": "Decrypt", "value": 51.647059701492495}, {"lowerIsBetter": false, "replicates": [1117.1875], "unit": "score", "name": "RayTrace", "value": 662.3677762237762}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [625.3908692933084], "unit": "score", "name": "Splay", "value": 130.30410899999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20837.85037147388}]} 22:08:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20837.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1516.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6925.84"}}} 22:08:43 INFO - Return code: 0 22:08:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:08:43 INFO - # TBPL SUCCESS # 22:08:43 INFO - Running post-action listener: _resource_record_post_action 22:08:43 INFO - Running post-run listener: _resource_record_post_run 22:08:44 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543596544; Read time: 12; Write time: 450688 22:08:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235450368; Read time: 0; Write time: 292108 22:08:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308146176; Read time: 12; Write time: 158580 22:08:44 INFO - Running post-run listener: _upload_blobber_files 22:08:44 INFO - Blob upload gear active. 22:08:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:08:44 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 22:08:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:08:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:08:45 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:08:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:08:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:45 INFO - (blobuploader) - INFO - Done attempting. 22:08:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:08:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:08:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:46 INFO - (blobuploader) - INFO - Done attempting. 22:08:46 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:46 INFO - Return code: 0 22:08:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:08:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1da47e5ee46482eeaae206ae8b41ac55fcfd7284da82ee185420391b3f8d4828b37af8bf087347866c31086a5ba9b8e47c91dcb22e52556795a0eb7f994c69e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a627488d4793e3a1451218b770d36aea5073f8448fa9f66608c5ff8ad45cfabc810d70741ff61cdaa927d25b06e19f3f082a1d3ce4e98b0701e87e4eb00e329f"} 22:08:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:08:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:08:46 INFO - Contents: 22:08:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1da47e5ee46482eeaae206ae8b41ac55fcfd7284da82ee185420391b3f8d4828b37af8bf087347866c31086a5ba9b8e47c91dcb22e52556795a0eb7f994c69e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a627488d4793e3a1451218b770d36aea5073f8448fa9f66608c5ff8ad45cfabc810d70741ff61cdaa927d25b06e19f3f082a1d3ce4e98b0701e87e4eb00e329f"} 22:08:46 INFO - Copying logs to upload dir... 22:08:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.544033 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-29 22:08:46.424847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:46.429795) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1da47e5ee46482eeaae206ae8b41ac55fcfd7284da82ee185420391b3f8d4828b37af8bf087347866c31086a5ba9b8e47c91dcb22e52556795a0eb7f994c69e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a627488d4793e3a1451218b770d36aea5073f8448fa9f66608c5ff8ad45cfabc810d70741ff61cdaa927d25b06e19f3f082a1d3ce4e98b0701e87e4eb00e329f"} build_url:https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/NFgFp1scRW6V-SuGS8sJjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1da47e5ee46482eeaae206ae8b41ac55fcfd7284da82ee185420391b3f8d4828b37af8bf087347866c31086a5ba9b8e47c91dcb22e52556795a0eb7f994c69e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a627488d4793e3a1451218b770d36aea5073f8448fa9f66608c5ff8ad45cfabc810d70741ff61cdaa927d25b06e19f3f082a1d3ce4e98b0701e87e4eb00e329f"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:46.570954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:46.571272) ========= 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=6ef107882637bc5fc02d78b7000001c2-1451451266.145898-1706190918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004672 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:08:46.631913) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:08:46.632217) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:08:46.632522) ========= ========= Total master_lag: 0.40 =========