builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1450853607.83 results: success (0) buildid: 20151222203111 builduid: 4b23cefc970043068821d985a3cb7617 revision: 356660b81c20de47d1b538fef7755ed21597cb5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:27.834482) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:27.834922) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:27.835222) ========= 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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006473 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:27.873187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:27.873478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.383958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.384375) ========= 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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.435962) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.439355) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.439775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.440095) ========= 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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 22:53:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-22 22:53:29 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.620138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.620485) ========= 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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018143 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.677923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:28.681282) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 356660b81c20de47d1b538fef7755ed21597cb5c --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/b2g-inbound --rev 356660b81c20de47d1b538fef7755ed21597cb5c --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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 22:53:29,134 truncating revision to first 12 chars 2015-12-22 22:53:29,135 Setting DEBUG logging. 2015-12-22 22:53:29,135 attempt 1/10 2015-12-22 22:53:29,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/356660b81c20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 22:53:29,412 unpacking tar archive at: b2g-inbound-356660b81c20/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:29.248916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:29.249272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:29.263280) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:29.263674) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 22:53:29.264190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 22:53:29.264514) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:29 INFO - MultiFileLogger online at 20151222 22:53:29 in /builds/slave/test-pgo 22:53:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:53:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:29 INFO - {'append_to_log': False, 22:53:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:29 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:53:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:29 INFO - 'branch': 'B2G-Inbound', 22:53:29 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:29 INFO - 'config_files': ('talos/linux_config.py',), 22:53:29 INFO - 'default_actions': ('clobber', 22:53:29 INFO - 'read-buildbot-config', 22:53:29 INFO - 'download-and-extract', 22:53:29 INFO - 'populate-webroot', 22:53:29 INFO - 'create-virtualenv', 22:53:29 INFO - 'install', 22:53:29 INFO - 'run-tests'), 22:53:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:29 INFO - 'download_minidump_stackwalk': True, 22:53:29 INFO - 'download_symbols': 'ondemand', 22:53:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:29 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:29 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:29 INFO - 'installer_path': 'installer.exe', 22:53:29 INFO - 'log_level': 'info', 22:53:29 INFO - 'log_name': 'talos', 22:53:29 INFO - 'log_to_console': True, 22:53:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:29 INFO - 'opt_config_files': (), 22:53:29 INFO - 'pip_index': False, 22:53:29 INFO - 'sps_profile': False, 22:53:29 INFO - 'sps_profile_interval': 0, 22:53:29 INFO - 'suite': 'dromaeojs', 22:53:29 INFO - 'system_bits': '64', 22:53:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:29 INFO - 'title': 'talos-linux64-ix-025', 22:53:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:29 INFO - 'use_talos_json': True, 22:53:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:29 INFO - 'work_dir': 'build'} 22:53:29 INFO - ##### 22:53:29 INFO - ##### Running clobber step. 22:53:29 INFO - ##### 22:53:29 INFO - Running pre-action listener: _resource_record_pre_action 22:53:29 INFO - Running main action method: clobber 22:53:29 INFO - rmtree: /builds/slave/test-pgo/build 22:53:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:30 INFO - Running post-action listener: _resource_record_post_action 22:53:30 INFO - ##### 22:53:30 INFO - ##### Running read-buildbot-config step. 22:53:30 INFO - ##### 22:53:30 INFO - Running pre-action listener: _resource_record_pre_action 22:53:30 INFO - Running main action method: read_buildbot_config 22:53:30 INFO - Using buildbot properties: 22:53:30 INFO - { 22:53:30 INFO - "project": "", 22:53:30 INFO - "product": "firefox", 22:53:30 INFO - "script_repo_revision": "production", 22:53:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:53:30 INFO - "repository": "", 22:53:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:53:30 INFO - "buildid": "20151222203111", 22:53:30 INFO - "pgo_build": "True", 22:53:30 INFO - "basedir": "/builds/slave/test-pgo", 22:53:30 INFO - "buildnumber": 1074, 22:53:30 INFO - "slavename": "talos-linux64-ix-025", 22:53:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:53:30 INFO - "platform": "ubuntu64_hw", 22:53:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:53:30 INFO - "branch": "b2g-inbound", 22:53:30 INFO - "repo_path": "integration/b2g-inbound", 22:53:30 INFO - "revision": "356660b81c20de47d1b538fef7755ed21597cb5c", 22:53:30 INFO - "stage_platform": "linux64-pgo", 22:53:30 INFO - "builduid": "4b23cefc970043068821d985a3cb7617", 22:53:30 INFO - "slavebuilddir": "test" 22:53:30 INFO - } 22:53:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:53:30 INFO - Running post-action listener: _resource_record_post_action 22:53:30 INFO - ##### 22:53:30 INFO - ##### Running download-and-extract step. 22:53:30 INFO - ##### 22:53:30 INFO - Running pre-action listener: _resource_record_pre_action 22:53:30 INFO - Running main action method: download_and_extract 22:53:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53: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')]} 22:53:30 INFO - https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/test_packages.json 22:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/test_packages.json 22:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:53:30 INFO - Downloaded 1302 bytes. 22:53:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:53:30 INFO - Using the following test package requirements: 22:53:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:30 INFO - u'jsshell-linux-x86_64.zip'], 22:53:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53: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')]} 22:53:30 INFO - https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:33 INFO - Downloaded 23175517 bytes. 22:53:33 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 22:53:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:33 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 22:53:34 INFO - Return code: 0 22:53:34 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 22:53: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')]} 22:53:34 INFO - https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:35 INFO - Downloaded 23175517 bytes. 22:53:35 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 22:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:35 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 22:53:37 INFO - Return code: 0 22:53:37 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')]} 22:53:37 INFO - https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:38 INFO - Downloaded 11132277 bytes. 22:53:38 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 22:53:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:38 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 22:53:38 INFO - Return code: 0 22:53: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')]} 22:53:38 INFO - https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K3896e9cRX-6046Fw_cfeg/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 22:53:39 INFO - Downloaded 54900321 bytes. 22:53:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:39 INFO - mkdir: /builds/slave/test-pgo/properties 22:53:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:53:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:53:39 INFO - Contents: 22:53:39 INFO - build_url:https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:39 INFO - Running post-action listener: _resource_record_post_action 22:53:39 INFO - Running post-action listener: set_extra_try_arguments 22:53:39 INFO - ##### 22:53:39 INFO - ##### Running populate-webroot step. 22:53:39 INFO - ##### 22:53:39 INFO - Running pre-action listener: _resource_record_pre_action 22:53:39 INFO - Running main action method: populate_webroot 22:53:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:39 INFO - '--tppagecycles', 22:53:39 INFO - '7'], 22:53:39 INFO - 'tests': ['tsvgm']}}, 22:53:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:53:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'tests': ['damp', 'tps']}, 22:53:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['damp', 'tps']}, 22:53:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:53:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:39 INFO - 'other': {'tests': ['a11yr', 22:53:39 INFO - 'ts_paint', 22:53:39 INFO - 'tpaint', 22:53:39 INFO - 'sessionrestore', 22:53:39 INFO - 'sessionrestore_no_auto_restore']}, 22:53:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['a11yr', 22:53:39 INFO - 'ts_paint', 22:53:39 INFO - 'tpaint', 22:53:39 INFO - 'sessionrestore', 22:53:39 INFO - 'sessionrestore_no_auto_restore']}, 22:53:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['a11yr', 22:53:39 INFO - 'ts_paint', 22:53:39 INFO - 'tpaint', 22:53:39 INFO - 'sessionrestore', 22:53:39 INFO - 'sessionrestore_no_auto_restore']}, 22:53:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['a11yr', 22:53:39 INFO - 'ts_paint', 22:53:39 INFO - 'tpaint', 22:53:39 INFO - 'sessionrestore', 22:53:39 INFO - 'sessionrestore_no_auto_restore']}, 22:53:39 INFO - 'other_l64': {'tests': ['a11yr', 22:53:39 INFO - 'ts_paint', 22:53:39 INFO - 'tpaint', 22:53:39 INFO - 'sessionrestore', 22:53:39 INFO - 'sessionrestore_no_auto_restore']}, 22:53:39 INFO - 'other_nol64': {'tests': ['a11yr', 22:53:39 INFO - 'ts_paint', 22:53:39 INFO - 'tpaint', 22:53:39 INFO - 'sessionrestore', 22:53:39 INFO - 'sessionrestore_no_auto_restore']}, 22:53:39 INFO - 'svgr': {'tests': ['tsvgx', 22:53:39 INFO - 'tsvgr_opacity', 22:53:39 INFO - 'tart', 22:53:39 INFO - 'tscrollx', 22:53:39 INFO - 'cart']}, 22:53:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['tsvgx', 22:53:39 INFO - 'tsvgr_opacity', 22:53:39 INFO - 'tart', 22:53:39 INFO - 'tscrollx', 22:53:39 INFO - 'cart']}, 22:53:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'tests': ['tp5o']}, 22:53:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'talos_options': ['--e10s'], 22:53:39 INFO - 'tests': ['tp5o']}, 22:53:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'talos_options': ['--xperf_path', 22:53:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:39 INFO - 'tests': ['tp5n']}, 22:53:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:39 INFO - 'talos_options': ['--e10s', 22:53:39 INFO - '--xperf_path', 22:53:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:39 INFO - 'tests': ['tp5n']}}, 22:53:39 INFO - 'talos.zip': {'path': '', 22:53:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:39 INFO - Running post-action listener: _resource_record_post_action 22:53:39 INFO - ##### 22:53:39 INFO - ##### Running create-virtualenv step. 22:53:39 INFO - ##### 22:53:39 INFO - Running pre-action listener: _resource_record_pre_action 22:53:39 INFO - Running main action method: create_virtualenv 22:53:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:53:39 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 22:53:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:53:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:40 INFO - Using real prefix '/usr' 22:53:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:53:40 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:42 INFO - Installing pip.................done. 22:53:42 INFO - Return code: 0 22:53:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:42 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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:42 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 22:53:42 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 22:53:42 INFO - Using env: {'DISPLAY': ':0', 22:53:42 INFO - 'HOME': '/home/cltbld', 22:53:42 INFO - 'LANG': 'en_US.UTF-8', 22:53:42 INFO - 'LANGUAGE': 'en_US:en', 22:53:42 INFO - 'LOGNAME': 'cltbld', 22:53:42 INFO - 'MAIL': '/var/mail/cltbld', 22:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:42 INFO - 'MOZ_NO_REMOTE': '1', 22:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:42 INFO - 'NO_EM_RESTART': '1', 22:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:42 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:42 INFO - 'SHELL': '/bin/bash', 22:53:42 INFO - 'SHLVL': '1', 22:53:42 INFO - 'TERM': 'linux', 22:53:42 INFO - 'TMOUT': '86400', 22:53:42 INFO - 'USER': 'cltbld', 22:53:42 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:42 INFO - '_': '/tools/buildbot/bin/python'} 22:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:42 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 22:53:42 INFO - Cleaning up... 22:53:42 INFO - Return code: 0 22:53:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:42 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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:42 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 22:53:42 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 22:53:42 INFO - Using env: {'DISPLAY': ':0', 22:53:42 INFO - 'HOME': '/home/cltbld', 22:53:42 INFO - 'LANG': 'en_US.UTF-8', 22:53:42 INFO - 'LANGUAGE': 'en_US:en', 22:53:42 INFO - 'LOGNAME': 'cltbld', 22:53:42 INFO - 'MAIL': '/var/mail/cltbld', 22:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:42 INFO - 'MOZ_NO_REMOTE': '1', 22:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:42 INFO - 'NO_EM_RESTART': '1', 22:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:42 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:42 INFO - 'SHELL': '/bin/bash', 22:53:42 INFO - 'SHLVL': '1', 22:53:42 INFO - 'TERM': 'linux', 22:53:42 INFO - 'TMOUT': '86400', 22:53:42 INFO - 'USER': 'cltbld', 22:53:42 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:42 INFO - '_': '/tools/buildbot/bin/python'} 22:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:42 INFO - Downloading/unpacking psutil>=0.7.1 22:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:53:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:53:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:44 INFO - Installing collected packages: psutil 22:53:44 INFO - Running setup.py install for psutil 22:53:44 INFO - building 'psutil._psutil_linux' extension 22:53:44 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 22:53:44 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 22:53:44 INFO - building 'psutil._psutil_posix' extension 22:53:44 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 22:53:45 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 22:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:45 INFO - Successfully installed psutil 22:53:45 INFO - Cleaning up... 22:53:45 INFO - Return code: 0 22:53:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:53:45 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')]} 22:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:45 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')]} 22:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:45 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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:45 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 22:53:45 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 22:53:45 INFO - Using env: {'DISPLAY': ':0', 22:53:45 INFO - 'HOME': '/home/cltbld', 22:53:45 INFO - 'LANG': 'en_US.UTF-8', 22:53:45 INFO - 'LANGUAGE': 'en_US:en', 22:53:45 INFO - 'LOGNAME': 'cltbld', 22:53:45 INFO - 'MAIL': '/var/mail/cltbld', 22:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:45 INFO - 'MOZ_NO_REMOTE': '1', 22:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:45 INFO - 'NO_EM_RESTART': '1', 22:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:45 INFO - 'SHELL': '/bin/bash', 22:53:45 INFO - 'SHLVL': '1', 22:53:45 INFO - 'TERM': 'linux', 22:53:45 INFO - 'TMOUT': '86400', 22:53:45 INFO - 'USER': 'cltbld', 22:53:45 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:45 INFO - '_': '/tools/buildbot/bin/python'} 22:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:45 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 22:53:45 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 22:53:45 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 22:53:45 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 22:53:45 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 22:53:45 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 22:53:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:53:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:47 INFO - Installing collected packages: mozsystemmonitor 22:53:47 INFO - Running setup.py install for mozsystemmonitor 22:53:47 INFO - Successfully installed mozsystemmonitor 22:53:47 INFO - Cleaning up... 22:53:47 INFO - Return code: 0 22:53:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:53:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:53:47 INFO - Using env: {'DISPLAY': ':0', 22:53:47 INFO - 'HOME': '/home/cltbld', 22:53:47 INFO - 'LANG': 'en_US.UTF-8', 22:53:47 INFO - 'LANGUAGE': 'en_US:en', 22:53:47 INFO - 'LOGNAME': 'cltbld', 22:53:47 INFO - 'MAIL': '/var/mail/cltbld', 22:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:47 INFO - 'MOZ_NO_REMOTE': '1', 22:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:47 INFO - 'NO_EM_RESTART': '1', 22:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:47 INFO - 'SHELL': '/bin/bash', 22:53:47 INFO - 'SHLVL': '1', 22:53:47 INFO - 'TERM': 'linux', 22:53:47 INFO - 'TMOUT': '86400', 22:53:47 INFO - 'USER': 'cltbld', 22:53:47 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:47 INFO - '_': '/tools/buildbot/bin/python'} 22:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:47 INFO - Downloading/unpacking blobuploader==1.2.4 22:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:49 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:53:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:53:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:53:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:49 INFO - Downloading docopt-0.6.1.tar.gz 22:53:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:53:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:50 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:50 INFO - Running setup.py install for blobuploader 22:53:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:53:50 INFO - Running setup.py install for requests 22:53:50 INFO - Running setup.py install for docopt 22:53:50 INFO - Successfully installed blobuploader requests docopt 22:53:50 INFO - Cleaning up... 22:53:50 INFO - Return code: 0 22:53:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:50 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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:50 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 22:53:50 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 22:53:50 INFO - Using env: {'DISPLAY': ':0', 22:53:50 INFO - 'HOME': '/home/cltbld', 22:53:50 INFO - 'LANG': 'en_US.UTF-8', 22:53:50 INFO - 'LANGUAGE': 'en_US:en', 22:53:50 INFO - 'LOGNAME': 'cltbld', 22:53:50 INFO - 'MAIL': '/var/mail/cltbld', 22:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:50 INFO - 'MOZ_NO_REMOTE': '1', 22:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:50 INFO - 'NO_EM_RESTART': '1', 22:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:50 INFO - 'SHELL': '/bin/bash', 22:53:50 INFO - 'SHLVL': '1', 22:53:50 INFO - 'TERM': 'linux', 22:53:50 INFO - 'TMOUT': '86400', 22:53:50 INFO - 'USER': 'cltbld', 22:53:50 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:50 INFO - '_': '/tools/buildbot/bin/python'} 22:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:50 INFO - Running setup.py (path:/tmp/pip-vAErEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:50 INFO - Running setup.py (path:/tmp/pip-kQ93EA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:50 INFO - Running setup.py (path:/tmp/pip-Ub0yPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:51 INFO - Running setup.py (path:/tmp/pip-Ub_RWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:51 INFO - Running setup.py (path:/tmp/pip-KxSvhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:51 INFO - Running setup.py (path:/tmp/pip-WsORd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:51 INFO - Running setup.py (path:/tmp/pip-GSMCC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:51 INFO - Running setup.py (path:/tmp/pip-NAD5H0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:51 INFO - Running setup.py (path:/tmp/pip-li3i5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:51 INFO - Running setup.py (path:/tmp/pip-RVAiPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:51 INFO - Running setup.py (path:/tmp/pip-3YJbcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:51 INFO - Running setup.py (path:/tmp/pip-AudORh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:51 INFO - Running setup.py (path:/tmp/pip-5UyjGQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:51 INFO - Running setup.py (path:/tmp/pip-_Xragv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:51 INFO - Running setup.py (path:/tmp/pip-EXbZ9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:51 INFO - Running setup.py (path:/tmp/pip-3f9Mp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:51 INFO - Running setup.py (path:/tmp/pip-mgPG3b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:53:52 INFO - Running setup.py install for manifestparser 22:53:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Running setup.py install for mozcrash 22:53:52 INFO - Running setup.py install for mozdebug 22:53:52 INFO - Running setup.py install for mozdevice 22:53:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Running setup.py install for mozfile 22:53:52 INFO - Running setup.py install for mozhttpd 22:53:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Running setup.py install for mozinfo 22:53:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Running setup.py install for mozInstall 22:53:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:53:52 INFO - Running setup.py install for mozleak 22:53:52 INFO - Running setup.py install for mozlog 22:53:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for moznetwork 22:53:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozprocess 22:53:53 INFO - Running setup.py install for mozprofile 22:53:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozrunner 22:53:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Running setup.py install for mozscreenshot 22:53:53 INFO - Running setup.py install for moztest 22:53:53 INFO - Running setup.py install for mozversion 22:53:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:53:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:53:53 INFO - Cleaning up... 22:53:53 INFO - Return code: 0 22:53:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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', '-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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:53 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 22:53:53 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 22:53:53 INFO - Using env: {'DISPLAY': ':0', 22:53:53 INFO - 'HOME': '/home/cltbld', 22:53:53 INFO - 'LANG': 'en_US.UTF-8', 22:53:53 INFO - 'LANGUAGE': 'en_US:en', 22:53:53 INFO - 'LOGNAME': 'cltbld', 22:53:53 INFO - 'MAIL': '/var/mail/cltbld', 22:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:53 INFO - 'MOZ_NO_REMOTE': '1', 22:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:53 INFO - 'NO_EM_RESTART': '1', 22:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:53 INFO - 'SHELL': '/bin/bash', 22:53:53 INFO - 'SHLVL': '1', 22:53:53 INFO - 'TERM': 'linux', 22:53:53 INFO - 'TMOUT': '86400', 22:53:53 INFO - 'USER': 'cltbld', 22:53:53 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:53 INFO - '_': '/tools/buildbot/bin/python'} 22:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:54 INFO - Running setup.py (path:/tmp/pip-HF38Jp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:54 INFO - Running setup.py (path:/tmp/pip-WiNUP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:54 INFO - Running setup.py (path:/tmp/pip-7vKPVE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:54 INFO - Running setup.py (path:/tmp/pip-mWKeu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:54 INFO - Running setup.py (path:/tmp/pip-68taFo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:54 INFO - Running setup.py (path:/tmp/pip-pQAxwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:54 INFO - Running setup.py (path:/tmp/pip-h0O3SS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:54 INFO - Running setup.py (path:/tmp/pip-2fCLKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:54 INFO - Running setup.py (path:/tmp/pip-DZkbtW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:54 INFO - Running setup.py (path:/tmp/pip-f5ZIPs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:54 INFO - Running setup.py (path:/tmp/pip-GpV_gZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:54 INFO - Running setup.py (path:/tmp/pip-bIOqNf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:54 INFO - Running setup.py (path:/tmp/pip-C318wK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:54 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)) 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:55 INFO - Running setup.py (path:/tmp/pip-0k5LBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:55 INFO - Running setup.py (path:/tmp/pip-ncjoAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:55 INFO - Running setup.py (path:/tmp/pip-rzIK2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:55 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)) 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:55 INFO - Running setup.py (path:/tmp/pip-yucvGb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:55 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)) 22:53:55 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)) 22:53:55 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)) 22:53:55 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)) 22:53:55 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)) 22:53:55 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)) 22:53:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:56 INFO - Downloading blessings-1.5.1.tar.gz 22:53:56 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 22:53:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:53:57 INFO - Installing collected packages: blessings 22:53:57 INFO - Running setup.py install for blessings 22:53:57 INFO - Successfully installed blessings 22:53:57 INFO - Cleaning up... 22:53:57 INFO - Return code: 0 22:53:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:53:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:53:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:53:57 INFO - Reading from file tmpfile_stdout 22:53:57 INFO - Current package versions: 22:53:57 INFO - argparse == 1.2.1 22:53:57 INFO - blessings == 1.5.1 22:53:57 INFO - blobuploader == 1.2.4 22:53:57 INFO - docopt == 0.6.1 22:53:57 INFO - manifestparser == 1.1 22:53:57 INFO - mozInstall == 1.12 22:53:57 INFO - mozcrash == 0.16 22:53:57 INFO - mozdebug == 0.1 22:53:57 INFO - mozdevice == 0.47 22:53:57 INFO - mozfile == 1.2 22:53:57 INFO - mozhttpd == 0.7 22:53:57 INFO - mozinfo == 0.9 22:53:57 INFO - mozleak == 0.1 22:53:57 INFO - mozlog == 3.1 22:53:57 INFO - moznetwork == 0.27 22:53:57 INFO - mozprocess == 0.22 22:53:57 INFO - mozprofile == 0.28 22:53:57 INFO - mozrunner == 6.11 22:53:57 INFO - mozscreenshot == 0.1 22:53:57 INFO - mozsystemmonitor == 0.0 22:53:57 INFO - moztest == 0.7 22:53:57 INFO - mozversion == 1.4 22:53:57 INFO - psutil == 3.1.1 22:53:57 INFO - requests == 1.2.3 22:53:57 INFO - wsgiref == 0.1.2 22:53:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 22:53:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 22:53:57 INFO - Using env: {'DISPLAY': ':0', 22:53:57 INFO - 'HOME': '/home/cltbld', 22:53:57 INFO - 'LANG': 'en_US.UTF-8', 22:53:57 INFO - 'LANGUAGE': 'en_US:en', 22:53:57 INFO - 'LOGNAME': 'cltbld', 22:53:57 INFO - 'MAIL': '/var/mail/cltbld', 22:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:57 INFO - 'MOZ_NO_REMOTE': '1', 22:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:57 INFO - 'NO_EM_RESTART': '1', 22:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:57 INFO - 'SHELL': '/bin/bash', 22:53:57 INFO - 'SHLVL': '1', 22:53:57 INFO - 'TERM': 'linux', 22:53:57 INFO - 'TMOUT': '86400', 22:53:57 INFO - 'USER': 'cltbld', 22:53:57 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:57 INFO - '_': '/tools/buildbot/bin/python'} 22:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 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)) 22:53:57 INFO - Cleaning up... 22:53:57 INFO - Return code: 0 22:53:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:57 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 22:53:57 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 22:53:57 INFO - Using env: {'DISPLAY': ':0', 22:53:57 INFO - 'HOME': '/home/cltbld', 22:53:57 INFO - 'LANG': 'en_US.UTF-8', 22:53:57 INFO - 'LANGUAGE': 'en_US:en', 22:53:57 INFO - 'LOGNAME': 'cltbld', 22:53:57 INFO - 'MAIL': '/var/mail/cltbld', 22:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:57 INFO - 'MOZ_NO_REMOTE': '1', 22:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:57 INFO - 'NO_EM_RESTART': '1', 22:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:57 INFO - 'SHELL': '/bin/bash', 22:53:57 INFO - 'SHLVL': '1', 22:53:57 INFO - 'TERM': 'linux', 22:53:57 INFO - 'TMOUT': '86400', 22:53:57 INFO - 'USER': 'cltbld', 22:53:57 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:57 INFO - '_': '/tools/buildbot/bin/python'} 22:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:57 INFO - Downloading/unpacking jsonschema 22:53:57 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 22:53:57 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 22:53:57 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 22:53:57 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 22:53:57 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 22:53:57 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 22:53:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:53:59 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 22:53:59 INFO - Downloading/unpacking functools32 (from jsonschema) 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:59 INFO - Downloading functools32-3.2.3-2.tar.gz 22:53:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:53:59 INFO - warning: no files found matching '*.txt' 22:53:59 INFO - no previously-included directories found matching 'build' 22:53:59 INFO - no previously-included directories found matching 'dist' 22:53:59 INFO - no previously-included directories found matching '.git*' 22:53:59 INFO - Installing collected packages: jsonschema, functools32 22:53:59 INFO - Running setup.py install for functools32 22:53:59 INFO - warning: no files found matching '*.txt' 22:53:59 INFO - no previously-included directories found matching 'build' 22:53:59 INFO - no previously-included directories found matching 'dist' 22:53:59 INFO - no previously-included directories found matching '.git*' 22:53:59 INFO - Successfully installed jsonschema functools32 22:53:59 INFO - Cleaning up... 22:53:59 INFO - Return code: 0 22:53:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f10f3261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d92630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, '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': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', '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 22:53:59 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 22:53:59 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 22:53:59 INFO - Using env: {'DISPLAY': ':0', 22:53:59 INFO - 'HOME': '/home/cltbld', 22:53:59 INFO - 'LANG': 'en_US.UTF-8', 22:53:59 INFO - 'LANGUAGE': 'en_US:en', 22:53:59 INFO - 'LOGNAME': 'cltbld', 22:53:59 INFO - 'MAIL': '/var/mail/cltbld', 22:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:59 INFO - 'MOZ_NO_REMOTE': '1', 22:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:59 INFO - 'NO_EM_RESTART': '1', 22:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:59 INFO - 'SHELL': '/bin/bash', 22:53:59 INFO - 'SHLVL': '1', 22:53:59 INFO - 'TERM': 'linux', 22:53:59 INFO - 'TMOUT': '86400', 22:53:59 INFO - 'USER': 'cltbld', 22:53:59 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:59 INFO - '_': '/tools/buildbot/bin/python'} 22:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:00 INFO - Downloading/unpacking flake8 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:01 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 22:54:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:02 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 22:54:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:54:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:02 INFO - no previously-included directories found matching 'docs/_build' 22:54:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:02 INFO - Running setup.py install for pep8 22:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:02 INFO - no previously-included directories found matching 'docs/_build' 22:54:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:02 INFO - Cleaning up... 22:54:02 INFO - Return code: 0 22:54:02 INFO - Running post-action listener: _resource_record_post_action 22:54:02 INFO - Running post-action listener: _start_resource_monitoring 22:54:02 INFO - Starting resource monitoring. 22:54:02 INFO - ##### 22:54:02 INFO - ##### Running install step. 22:54:02 INFO - ##### 22:54:02 INFO - Running pre-action listener: _resource_record_pre_action 22:54:02 INFO - Running main action method: install 22:54:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:02 INFO - Reading from file tmpfile_stdout 22:54:02 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:54:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:54:03 INFO - Reading from file tmpfile_stdout 22:54:03 INFO - Output received: 22:54:03 INFO - Usage: mozinstall [options] installer 22:54:03 INFO - Options: 22:54:03 INFO - -h, --help show this help message and exit 22:54:03 INFO - -d DEST, --destination=DEST 22:54:03 INFO - Directory to install application into. [default: 22:54:03 INFO - "/builds/slave/test-pgo"] 22:54:03 INFO - --app=APP Application being installed. [default: firefox] 22:54:03 INFO - mkdir: /builds/slave/test-pgo/build/application 22:54:03 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'] 22:54:03 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 22:54:19 INFO - Reading from file tmpfile_stdout 22:54:19 INFO - Output received: 22:54:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:54:19 INFO - Running post-action listener: _resource_record_post_action 22:54:19 INFO - ##### 22:54:19 INFO - ##### Running run-tests step. 22:54:19 INFO - ##### 22:54:19 INFO - Running pre-action listener: _resource_record_pre_action 22:54:19 INFO - Running main action method: run_tests 22:54:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:54:19 INFO - Python 2.7.3 22:54:19 INFO - Return code: 0 22:54:19 INFO - grabbing minidump binary from tooltool 22:54:19 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')]} 22:54:19 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 0x1e23840>, '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 0x1d906b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d90b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:54:19 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 22:54:19 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 22:54:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:19 INFO - Return code: 0 22:54:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:54:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:54:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:54:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:54:20 INFO - Return code: 0 22:54:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 22:54:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 22:54:20 INFO - Using env: {'DISPLAY': ':0', 22:54:20 INFO - 'HOME': '/home/cltbld', 22:54:20 INFO - 'LANG': 'en_US.UTF-8', 22:54:20 INFO - 'LANGUAGE': 'en_US:en', 22:54:20 INFO - 'LOGNAME': 'cltbld', 22:54:20 INFO - 'MAIL': '/var/mail/cltbld', 22:54:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:20 INFO - 'MOZ_NO_REMOTE': '1', 22:54:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:20 INFO - 'NO_EM_RESTART': '1', 22:54:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:20 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:54:20 INFO - 'SHELL': '/bin/bash', 22:54:20 INFO - 'SHLVL': '1', 22:54:20 INFO - 'TERM': 'linux', 22:54:20 INFO - 'TMOUT': '86400', 22:54:20 INFO - 'USER': 'cltbld', 22:54:20 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450851102.610636-2084109839', 22:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:20 INFO - '_': '/tools/buildbot/bin/python'} 22:54:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 22:54:20 INFO - mozversion application_buildid: 20151222203111 22:54:20 INFO - mozversion application_changeset: 356660b81c20de47d1b538fef7755ed21597cb5c 22:54:20 INFO - mozversion application_display_name: Nightly 22:54:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:20 INFO - mozversion application_name: Firefox 22:54:20 INFO - mozversion application_remotingname: firefox 22:54:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:20 INFO - mozversion application_vendor: Mozilla 22:54:20 INFO - mozversion application_version: 46.0a1 22:54:20 INFO - mozversion platform_buildid: 20151222203111 22:54:20 INFO - mozversion platform_changeset: 356660b81c20de47d1b538fef7755ed21597cb5c 22:54:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:20 INFO - mozversion platform_version: 46.0a1 22:54:20 INFO - using testdate: 1450853660 22:54:20 INFO - actual date: 1450853660 22:54:20 INFO - starting webserver on 'localhost:60797' 22:54:20 INFO - SUITE-START | Running 3 tests 22:54:20 INFO - TEST-START | dromaeo_css 22:54:20 INFO - operating with platform_type : linux_ 22:54:20 INFO - Initialising browser for dromaeo_css test... 22:54:20 INFO - TEST-INFO | started process 15195 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoMV480/profile http://localhost:60797/getInfo.html) 22:54:24 INFO - PROCESS | 15195 | __metrics Screen width/height:1600/1200 22:54:24 INFO - PROCESS | 15195 | colorDepth:24 22:54:24 INFO - PROCESS | 15195 | Browser inner width/height: 1024/697 22:54:24 INFO - PROCESS | 15195 | __metrics 22:54:24 INFO - PROCESS | 15195 | 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:54:25 INFO - PROCESS | 15195 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:54:26 INFO - TEST-INFO | 15195: exit 0 22:54:26 INFO - Browser initialized. 22:54:26 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:26 INFO - TEST-INFO | started process 15288 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoMV480/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:38 INFO - PROCESS | 15288 | RSS: Main: 150159360 22:54:38 INFO - PROCESS | 15288 | 22:55:29 INFO - PROCESS | 15288 | 1450853729693 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] 22:57:38 INFO - PROCESS | 15288 | Cycle 1(1): loaded http://localhost:60797/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60797/tests/dromaeo/cssquery-ext.html) 22:57:39 INFO - PROCESS | 15288 | RSS: Main: 312598528 22:57:39 INFO - PROCESS | 15288 | 23:00:42 INFO - PROCESS | 15288 | Cycle 1(1): loaded http://localhost:60797/tests/dromaeo/cssquery-ext.html (next: http://localhost:60797/tests/dromaeo/cssquery-jquery.html) 23:00:42 INFO - PROCESS | 15288 | RSS: Main: 236597248 23:00:42 INFO - PROCESS | 15288 | 23:03:44 INFO - PROCESS | 15288 | Cycle 1(1): loaded http://localhost:60797/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60797/tests/dromaeo/cssquery-mootools.html) 23:03:45 INFO - PROCESS | 15288 | RSS: Main: 222072832 23:03:45 INFO - PROCESS | 15288 | 23:06:46 INFO - PROCESS | 15288 | Cycle 1(1): loaded http://localhost:60797/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60797/tests/dromaeo/cssquery-prototype.html) 23:06:47 INFO - PROCESS | 15288 | RSS: Main: 212107264 23:06:47 INFO - PROCESS | 15288 | 23:09:49 INFO - PROCESS | 15288 | Cycle 1(1): loaded http://localhost:60797/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60797/tests/dromaeo/cssquery-yui.html) 23:09:50 INFO - PROCESS | 15288 | RSS: Main: 219504640 23:09:50 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | Cycle 1(1): loaded http://localhost:60797/tests/dromaeo/cssquery-yui.html (next: http://localhost:60797/tests/dromaeo/cssquery-dojo.html) 23:12:53 INFO - PROCESS | 15288 | RSS: Main: 260575232 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | __start_tp_report 23:12:53 INFO - PROCESS | 15288 | _x_x_mozilla_page_load 23:12:53 INFO - PROCESS | 15288 | _x_x_mozilla_page_load_details 23:12:53 INFO - PROCESS | 15288 | |i|pagename|runs| 23:12:53 INFO - PROCESS | 15288 | |0;dojo.html;3151.1964449065485;3198.0885447647424;3239.433099207638;3241.1086951088464;3261.9836900815494;5204.635675502707;5314.548263397606;5406.702631355279;5417.431169727181;5476.999999999995;5285.7885684572575;5347.973260133694;5467.917981230285;5549.223108764776;5583.972080139603;4939.753012349377;4971.676841005323;4973.801047958077;4990.750462476862;5016.498350164972;4997.025580011899;5016.097102521545;5045.84862454127;5056.646034777567;5067;4839.4918533554;4887.413510378778;4933.753312334405;4962.05720913029;4965.230389289666;4924.409070911478;4926.5812405945535;4926.655134140611;4931.876703082416;4968.478309777457;4769.141554520185;4895.11887860185;4919.655624106314;4927.704337739711;4973.90052198954;5026.195808670632;5218.478152184789;5220.947790522084;5231.319928409321;5248.816291429782;5808.912866307009;5812.5640576956475;5814.418558144194;5819.67991760453;5824.359320474744;5607.383187849333;5769.076947688392;5868.090445980837;5872.17789509469;5874.23634927461;5410.215518749759;5422.783088676449;5507.394186639466;5517.917231241535;5530.972345138249;5899.616524925866;5928.347881733006;5931.881362372728;5935.139404786368;5938.257717785277;5730.971345143331;5733.483986441157;5739.081746920556;5743.798967036218;5790.971045144747;5593.944060559343;5740;5740.741666625012;5810.593258471951;5913.674747888821;5723.284589426322;5774;5781.88436231273;5786.681732504752;5787.88424231513;5783.768649254067;5786.363500014995;5787.218725472091;5787.276590426197;5790.392008839011;4358.455193100863;4396.846110386121;4460.50934397216;4474.574915383034;4517.909641807146;3978.980105099456;3995.780232087263;3996.3406038003404;4033.153037862023;4034.4755181826176;5333.493318134771;5508.779648814003;5514.724263786795;5514.889702206014;5519.613627046068;5757.740901659436;5833.095870140135;5835.533157347402;5842.444967728059;5844.47399734026;5547.084731019337;5550.417206193372;5553.750081246354;5576.693281869536;5606.915896261559;5122;5128.640995130305;5132.615053870974;5136.357955255593;5188.247704082887;5739.081746920473;5864.706764661835;6003.939960600425;6008.489278411384;6008.879822403527;5745.97127014379;5798.304203495608;5873.911891321548;5921.644701317935;5926.170336152856;5809.390014048633;5921.792737254175;5927.051671732502;5928.67392293428;5938.821835344774;5752.597318187687;5761.769529218952;5763.394843541368;5773.422657734193;5774.335951365647;5743.712814359182;5864.589478736448;5869.119632055226;5870.412958704266;5871.4715675587695;5565.777368905198;5667.291588551431;5667.319921609268;5719.256496655408;5724.885502290014;5716.085426331767;5729.828105156852;5730.684812335361;5733.397993210653;5752.741126649395;5467.753951072291;5559.027170245272;5574.665520068809;5633.436656334334;5635.9436405635415;5669.518090962314;5670.092785154356;5765.827025189251;5812.505936995402;5837.883242335214;5674.971625141848;5684.602077854511;5685.573581981285;5691;5749.13762935563 23:12:53 INFO - PROCESS | 15288 | |1;ext.html;557.6458948567658;616.365143901781;616.7502161624543;617.2161355079049;621.2700077409044;29604;37147;38169.42745858814;38207.617923820755;38217.80891095548;42498.150036999315;42940.3558946616;42957.57042429575;42968.35547466791;43000.35499467511;7534.660940257701;7674.693012279502;8625.568721563912;8777.253933415635;8785.868211976825;10332.79334413315;10601.469926503683;10607.257491975564;10614.522346494427;10615.681529554126;10324.845127323097;10394;10415.843762343571;10416.322939008978;10434.582616695323;7800;7938.047434307862;10309.432981186032;10419.06228439444;10458;10167.491625418774;10346.32748871321;10366.688999330032;10368.844467332996;10373.79252414955;39427.21145577101;39774.40338394926;39839.80080099581;39876.60123398758;39930.20139597221;3169.112648458435;3226.754759662574;3257.837108144607;3358.177246574605;3359.328134373135;29735;29974.400511989857;30087.713637559365;30420.69579304223;31126;3828.942565861514;3855.652991230803;3885.805709714531;3950.4074388841905;3972.960270397288;268144;268815;269666.6516667424;269987;270143;52172;54977.72511137499;55485.45145485419;55592.88478267387;55618.16572751412;47886.28170577444;59442.70278648579;60830.39169608247;60892.695536522035;60917.080779498385;14214.21821799811;14573.271336433349;14609.488667896572;14650.706985860435;14670.339834707464;10822.404767737693;10827.24209305341;10831.83752243717;10849;10882.619108331328;18692.85032221285;18717;18931;18938.715919261223;18941.526461838563;7509.662065207079;7693.076830780342;7699;7745.922540774633;7755.224477552312;921.5852866210232;944.9433034017981;956.9951550871557;968.3995922527937;1064.9616623791742;27727;27834.443311133666;27846.5823012655;28427.857860710563;28510;1034.8706411698538;1040.079529616295;1051.7896420715736;1128.4075860173475;1186.5253898440692;14652.853471465362;14850.331735071948;15401.152936588594;15469.5359139226;15540.378384864705;311407;316490;316858;318951;320077;51134.74432627887;51197.744011279705;51258.48741512612;51575.484245157815;51576.74211628918;1313.90802643814;1338.3843432021185;1358.3344161360862;1363.7817949128091;1364.6793003644136;27348.316292092855;28027.859860700566;28171.27049832852;28434.85782571074;28552.143435696962;43169.568304317814;43320.78339608282;43437.565624343355;43537.346939795294;43545;293299;293801;295092;295589;295659;27111.322216944733;29815.22956326977;30338;30626.693733063275;30641.08076757701;35184.29631407409;36510.8174459126;36622.450663240605;41593.79203103965;42769.78615106905;32094.19764505906;32501.674983249864;32690.24225307299;32878.01365959025;35093.82453087718;30164.396712065198;33510.66489335075;34481;36342.63657363393;36804.81597592102;31699.366012679155;32133.678663214003;32230.19424514406;32530.83734581312;32537;29856;31363.529547057267;31738.682613173572;31949.36101278008;31983.68016319807;24256.456274820273;24506.007347830262;24517.162312050063;24639.876800615883;24673.383165421008 23:12:53 INFO - PROCESS | 15288 | |2;jquery.html;344.7552237911082;347.24301023768186;361.887814777419;363.8035460851141;364.9744517883749;16374.345026198953;16547.751783723255;16817.243224054917;17202.139893005362;17230.396936107238;15120.924395378008;15379.461718839842;16145.43490977813;16341.182940852968;16390.098544580043;5233.712145831978;5289.867753306169;5407.107827208506;5410.08028635131;5413.296271484721;5339.359276886779;5373.220882971967;5380.569554435636;5382.434844341346;5383.515483606475;3907.98046009771;4030.979845100785;5340.546053585431;5340.866478338034;5597.832065038056;5798.681072541009;5824.941750582482;5833.32916714579;5853.619514731528;5862.443067908542;5090.770915308783;5158;5197.818076367309;5201.791928322863;5205.765740541685;15716.29276682552;16197.838021619751;18238;19699;20745;2086.238522939116;2129.6379615465407;2169.1323470611724;2171.6742488626674;2234.7988681018624;13294.20234785916;13418.664533386744;13437.865621343759;13575.389107490088;13586.524471643444;1721.5523963769385;1841.5764374194011;1851.4538211227587;1856.8793028453108;1889.5181728659104;55517;56879;58593.70703146457;58792.70603646997;59228.11157832593;9715.514224288898;9868.901310986797;9985;9989.750256243651;10036.548355323883;13127.606171814861;13128.277944713132;13136.146150500377;13145.868541314656;13149.53976610814;7163.606001669854;7207.279272072751;7399.223081576464;7492.587907665022;7651.961740191264;6832.214295356098;6918.446524278046;7292.270772922665;7333.816654583678;7345.522541034816;5861.9413805861395;5933.614315069507;5938.406159384113;5954.10688396744;6038.094285857069;1774.3434929076325;1790.9641807163785;1791.8297761712618;1825.6896327624336;1837.4303965770655;446.9910601787946;456.0787209836112;904.9457032578066;906.6464079009191;912.7307444303947;9236.399634023766;10123.341982771097;10640.627578034731;10719.142468602493;10971.451427428598;459.0955817040425;463.0807846424844;468.5288195067491;903.9231665308522;922.4004397141912;8984.371094023356;9162.67930622425;9205;9212.12484813955;9406.764830879283;342463;351177;542884;544764;555676;76564;81110;81314.59342703367;81989;83324.16675833285;1154.9364784936909;1181.9231749936228;1182;1199.5201919232202;1200.5017917564287;15285.847141528442;15445.304961276544;15572.454964076203;15749.212539372757;15881.444149454714;31322;31456.685433145376;31666.683333166373;32537.186570335933;33629.66370336363;43580.34629480497;44085.33871991987;45117.774411127735;45569.31646025379;46944;9252.583633736363;9456.905430945602;9460.101290377403;9527.428354298765;9585.568649410932;13377;17044.48866534006;17245.827541724924;17547;17575.121243938007;14235.786463202852;14344.713105738036;14424.206668633326;14786.112833230041;14944;13477.528286509925;13734.587962361145;14038.929805350908;14643.85356146425;14707.044042137228;13753.656158596115;13845.376958037114;14301;14598.124112553282;14687.41250349974;9412.57643406062;9511.096445837635;9551.52242387864;9575.569099390405;9622.759431014281;10994.505247264053;14548.85451145475;14610.123392596479;14625.34185961613;14676.633084172981 23:12:53 INFO - PROCESS | 15288 | |3;mootools.html;1302.2446980751165;1668.0908904646967;1707.9658406831863;1734.470986349163;1743.7733094697687;6651.401373876351;7387.187409384964;7553.924460755391;7574.469787114904;7584.734534291301;7515.436342274337;7592.77221683349;7599.544027358363;7608.809779755495;7627.8855817162785;2215.6898034275214;2241.764614715456;2253.6281513550243;2254.199759085526;2257.81937445004;2243.3270018994317;2267;2320.7331156916916;2322.9767702323015;2323.2217207235594;2267.784560466753;2271.1256166375897;2274.8862556872173;2292.1748170658634;2299.482616411311;2243.248511748566;2255.0979608156786;2285.0973865323103;2285.131649973008;2287.3938406322336;2265.082641530183;2272.091163534583;2272.909083636669;2275.192306731103;2296.127471560796;7527.774166775005;7580.54516728998;7610.961945190294;7627.733029343946;7699.422543309274;4462.107578484283;4553.795079221443;4559.680822342438;4560.247559152735;4572.885677858047;2982.4482470742764;3014.3820516794003;3132.9530057049164;3137.905862824119;3154.7318477929402;1026.653110858599;1051.374432212832;1062.787442511493;1091.781643671269;1829.7529833472445;10309.175265978703;10311.123554497877;10334.379937203792;10337.74155646115;10382.221333400024;4033.858814941463;4083.9795801020805;4130.855420060284;4175.206710724952;4183.874483765431;8417.368697347723;8418.200270974248;8476.618552165168;8508.064112947572;8552.957235213784;4470.664700147502;4530.093981203707;4531.003179300548;4531.796069176895;4545.340925565774;3693.649103335179;3767.4913886625504;4076.9592304076577;4155.750654960712;4220.860367700704;3519.489673997256;3533.434650455915;3552.3605750965075;3569.6787289144104;3579.49887015818;1068.8076146293743;1094.7099018760034;1099.7580532282884;1101.1136035491506;1104.4036220440871;1295.371744703818;1308.064733715398;1325.7017171136417;1349.7705390083709;1350.4665657065405;7166.749163779347;7166.928330716731;7204.351608355273;7275.963620181865;7277.8544429111125;489.6694731056523;497.65164384930694;500.08734060340026;502.74360076360585;510.178612433981;5575.080111781592;5681.0910254359105;5704.771809127588;5720.313562372542;5728.742206600713;8532.464156451773;8705.260052895448;9018.368714189945;9066.95466522663;9123.361364704408;8954.2836573074;8999.37004409698;9020.819583608421;9032.412893162054;9060.139286767746;6948.791536253921;7020.613866237304;7112.110986126734;7155.89266161008;7177.4258059355125;6872.244053154249;6913.446924246149;6914.239433662193;6915.51591388598;6922.238553759184;7851.2148785121035;8054.959725201571;8072.717454889051;8092.5549094798;8112.148224436349;7960.965074540272;7992.200779921961;8024.959875200587;8029.237222463857;8074.59627018635;6535;6541.476681865534;6624.900626490703;6650.068990341259;6677.399034086956;7304.452166087671;7449.962750186214;7450.590217538087;7460;7460.813479663052;6705;6907.758228461979;6998.790036298919;7015.193252775792;7085.078939737801;6792.184937807495;6868.347506986828;6961.060256865461;6971.337722916315;7043.647817608997;6804.727810887509;6936.132983377078;6944.444444444332;6969.895451568129;7006.439484841098;6206.286277078194;6280.152179455715;6281.52888533371;6292.811215663537;6309.053641953744;6462.1599192106605;6473.482121430368;6480.805575832733;6498.837529061811;6513.772017979348 23:12:53 INFO - PROCESS | 15288 | |4;prototype.html;332.61250643000903;338.51423207696956;341.3258813842661;344.3663658867686;350.5040367879449;5955.940440595593;5965.582409231356;6044.516438684911;6056.273247210341;6085.78699745509;5720.1991721159075;5787.13193021047;5871.882562348761;5918.378570250126;5935.050391937291;4497.617702495292;4512.0975804839;4526.8868278292975;4533.682642215046;4541.750203738793;4378;4528.071745292224;4534.34252033455;4539.296409056601;4540.069285796404;4378.759168245745;4409.713368631044;4426.18115648606;4455.420795296607;4506.549345065484;4442.644588432918;4459.799309031101;4460.821567137311;4482.148391805546;4496.617787488068;3861.6331448512346;3888.8833334999995;3904.063024874038;3904.609539046101;3909.6872250219913;5563.972180139073;5613.129964855454;5639.125935480007;5653.660780353192;5656.43435656431;5310.097283461821;5317.8936421271355;5318.016167009116;5320.201969704536;5326.440723723992;6313.40022697843;6316.6841657917375;6318.399752023551;6318.589291696071;6324.209473815773;4456.442944631921;4457.33140028995;4462.486814016397;4466.39703640011;4475.664325175592;6400.743970241185;6528.836779080513;6545.443637290836;6555.6066636002;6564.179477565257;4547.47704014036;4552.044070745181;4552.135094332132;4552.362669226311;4554.248548989446;4599.218132917412;4605.562471565196;4612.7001744886475;4616.6537509686905;4617.053504031665;5298.576113910878;5300.734963251822;5306.09796334624;5310.867228319323;5313.8937221255355;6226.346233645402;6363.045543168561;6403.423691867754;6412.487001039905;6428.582142160744;1584.7464405695264;1604.8635865951526;1606.2852030846161;1609.903405795656;1612.1375064340757;1060.671191930504;1068.636663534402;1069.1660504806264;1078.730317420645;1092.0771947704177;6002.039673652194;6003.369646187175;6013.639181649115;6017.277926648742;6029;6501.057346684799;6503.544751867324;6510.348965103546;6513;6518.902216466757;5955.851103722442;6080.908786368208;6086.087086936995;6089.634621922699;6093.4515893568905;3500.9299814003575;3567.3222087803233;3568.839402226854;3589.2821435712963;3613;6750.5274630775375;6750.898736518956;6753.29090445506;6765.763198288037;6766.830829229309;6587.176602924635;6624.105745724266;6646.401823835878;6727.764528241488;6851.280615535297;6742.561733487308;6755.054292399166;6769.424598908951;6774.491913106537;6786.93213067863;6659.467242620675;6668.866622667617;6669.266380698216;6680.665966701743;6684.899726504009;6424.13274207976;6576.44100251484;6578.901316480353;6580.177477815273;6589.308122647053;6748.460123190035;6756.425703815231;6761.628110453972;6765.25582185969;6772.0857684212;4477.1493416250805;4486.237339652333;4489.932651010172;4494.977525112354;4498.640108791224;6501.05734668461;6600.504962127764;6644.867102658017;6651.966740166268;6654.5341826073645;6414.583052101599;6450.225972883284;6457.160569125984;6460.967695161494;6474.70863811139;6444.581102228341;6451.709673064817;6452.419282264619;6454.806355809334;6455.419012288917;6190.969045154746;6315.621062736067;6336.366363363811;6337.429631333018;6339.080833279241;6478.546501744832;6478.805635830932;6494.740210391531;6496.693673745752;6498.122753428227;6295.401936815995;6303.180586523723;6317.6209427434505;6331.620102793847;6342.080398342122 23:12:53 INFO - PROCESS | 15288 | |5;yui.html;775.5191781095725;788.4297684173039;803.5660743198665;839.8362319347726;862.0474375814723;12947;13217.801732974001;13261;13293.534726284583;13298.468061277561;12535.623931282076;12594;14812;14866.331015104319;14935.327910244037;795.8448102620006;815.4414226255034;815.9673613055471;817.3052905030736;817.3338728935898;681.366329313738;690.1855810144028;808.1595141053298;811.5820352518458;821.5604651511443;843.0431460292551;851.7402192331336;852.4288726553193;854.2824027816632;855.5850412549939;708.9184743754482;719.241200533437;842.7134774176748;844.1094645149365;846.5174850335311;607;618.1469571990624;619.0281258424276;619.7830759234276;619.9318075011745;12747.235165889984;12908;12946.546870859474;12974.80537791934;13052.347382630925;12296.323702196376;12848.678783030498;12923.87076129236;13106.60680179596;13321.733565328735;9738.464384458852;10059.446730429823;10100.141487973531;10358.223133265035;10668.253222274443;3648.854045838163;3688.944665830015;3759.342115129841;3776;3830.253100645375;43678.344824827655;44105.55894441046;44413.77793111046;44505.32420137005;44575;9988.950055249677;10159.593616255266;10298.17614590831;10410.635627752992;10544.314619549705;17402.912985435247;17435;17443;17475.21361538734;17486.47540573785;7216.458765592602;7439.4420418468835;7471.402287816962;7694.615269236516;7860.253275938891;4133.359329303963;4144.854930077493;4147.688923330762;4263.126059157865;4347.282698354736;3148.622165340174;3166.1293144385477;3200.5519227308196;3200.871965121369;3201.5037669161316;570.3469527391114;583.7081459270365;583.8190161050088;587.814838325926;589.5254320272136;630.9873802524015;660.3957378998259;671.5366397186024;706.0926709178681;707.779602807225;8580.22777949975;9003.414778039407;9018.413803102909;9021.684241051531;9065.229455496225;527.7915223486701;558.8742532930058;584.3484514766005;589.3428826858022;709.6026225313841;4083.3670781028986;4105.240743400179;4150;4177.268977928911;4269.5090064642345;51739.48260517346;52187.73906130445;63996.68001659962;64315.356846430936;64342;48618.75690621524;49261.50738492641;49402.50597494051;50087;50637.49362506402;44290.77854610771;46203.306950395774;46594.76702616465;46858.29712554246;48238.27642585364;8512.276456501268;8658.398196333446;8799.428037177562;9174;9302.581383837609;34160;34917.30165396627;35277.82361088178;35368;36622.633773661924;43312;43359;43543.56456435522;43749;44047;11090.611828586283;11294;11318.547258109584;11325.207623827435;11396.886031139582;12445.253284802578;12446.56437024736;12461.252324860538;13117.278549679859;13120.934395327962;11479.713007174887;11672.124590655905;11812.232204906653;12162.391880406121;12273.447694853932;11683;12006.579769708018;12092.153549251469;12361.690957726129;12417.379131043592;11381.943090284496;11611.796267920241;11710.648680539598;11712.824307635221;11728.648140555797;9453.43279403238;9549.47477888695;9849.606015759577;9878.308518403643;9954.352967057119;9187.494687792236;9549.665761698307;9649.758756031155;9724.367916085432;9763.170130538983 23:12:53 INFO - PROCESS | 15288 | __end_tp_report 23:12:53 INFO - PROCESS | 15288 | __start_cc_report 23:12:53 INFO - PROCESS | 15288 | _x_x_mozilla_cycle_collect,1328 23:12:53 INFO - PROCESS | 15288 | __end_cc_report 23:12:53 INFO - PROCESS | 15288 | __startTimestamp1450854773421__endTimestamp 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | ------- Summary: start ------- 23:12:53 INFO - PROCESS | 15288 | Number of tests: 6 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | [#0] dojo.html Cycles:165 Average:5401.30 Median:5635.94 stddev:597.47 (10.6%) stddev-sans-first:572.64 23:12:53 INFO - PROCESS | 15288 | Values: 3151.2 3198.1 3239.4 3241.1 3262.0 5204.6 5314.5 5406.7 5417.4 5477.0 5285.8 5348.0 5467.9 5549.2 5584.0 4939.8 4971.7 4973.8 4990.8 5016.5 4997.0 5016.1 5045.8 5056.6 5067.0 4839.5 4887.4 4933.8 4962.1 4965.2 4924.4 4926.6 4926.7 4931.9 4968.5 4769.1 4895.1 4919.7 4927.7 4973.9 5026.2 5218.5 5220.9 5231.3 5248.8 5808.9 5812.6 5814.4 5819.7 5824.4 5607.4 5769.1 5868.1 5872.2 5874.2 5410.2 5422.8 5507.4 5517.9 5531.0 5899.6 5928.3 5931.9 5935.1 5938.3 5731.0 5733.5 5739.1 5743.8 5791.0 5593.9 5740.0 5740.7 5810.6 5913.7 5723.3 5774.0 5781.9 5786.7 5787.9 5783.8 5786.4 5787.2 5787.3 5790.4 4358.5 4396.8 4460.5 4474.6 4517.9 3979.0 3995.8 3996.3 4033.2 4034.5 5333.5 5508.8 5514.7 5514.9 5519.6 5757.7 5833.1 5835.5 5842.4 5844.5 5547.1 5550.4 5553.8 5576.7 5606.9 5122.0 5128.6 5132.6 5136.4 5188.2 5739.1 5864.7 6003.9 6008.5 6008.9 5746.0 5798.3 5873.9 5921.6 5926.2 5809.4 5921.8 5927.1 5928.7 5938.8 5752.6 5761.8 5763.4 5773.4 5774.3 5743.7 5864.6 5869.1 5870.4 5871.5 5565.8 5667.3 5667.3 5719.3 5724.9 5716.1 5729.8 5730.7 5733.4 5752.7 5467.8 5559.0 5574.7 5633.4 5635.9 5669.5 5670.1 5765.8 5812.5 5837.9 5675.0 5684.6 5685.6 5691.0 5749.1 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | [#1] ext.html Cycles:180 Average:45682.36 Median:160013.56 stddev:76867.07 (48.0%) stddev-sans-first:77008.03 23:12:53 INFO - PROCESS | 15288 | Values: 557.6 616.4 616.8 617.2 621.3 29604.0 37147.0 38169.4 38207.6 38217.8 42498.2 42940.4 42957.6 42968.4 43000.4 7534.7 7674.7 8625.6 8777.3 8785.9 10332.8 10601.5 10607.3 10614.5 10615.7 10324.8 10394.0 10415.8 10416.3 10434.6 7800.0 7938.0 10309.4 10419.1 10458.0 10167.5 10346.3 10366.7 10368.8 10373.8 39427.2 39774.4 39839.8 39876.6 39930.2 3169.1 3226.8 3257.8 3358.2 3359.3 29735.0 29974.4 30087.7 30420.7 31126.0 3828.9 3855.7 3885.8 3950.4 3973.0 268144.0 268815.0 269666.7 269987.0 270143.0 52172.0 54977.7 55485.5 55592.9 55618.2 47886.3 59442.7 60830.4 60892.7 60917.1 14214.2 14573.3 14609.5 14650.7 14670.3 10822.4 10827.2 10831.8 10849.0 10882.6 18692.9 18717.0 18931.0 18938.7 18941.5 7509.7 7693.1 7699.0 7745.9 7755.2 921.6 944.9 957.0 968.4 1065.0 27727.0 27834.4 27846.6 28427.9 28510.0 1034.9 1040.1 1051.8 1128.4 1186.5 14652.9 14850.3 15401.2 15469.5 15540.4 311407.0 316490.0 316858.0 318951.0 320077.0 51134.7 51197.7 51258.5 51575.5 51576.7 1313.9 1338.4 1358.3 1363.8 1364.7 27348.3 28027.9 28171.3 28434.9 28552.1 43169.6 43320.8 43437.6 43537.3 43545.0 293299.0 293801.0 295092.0 295589.0 295659.0 27111.3 29815.2 30338.0 30626.7 30641.1 35184.3 36510.8 36622.5 41593.8 42769.8 32094.2 32501.7 32690.2 32878.0 35093.8 30164.4 33510.7 34481.0 36342.6 36804.8 31699.4 32133.7 32230.2 32530.8 32537.0 29856.0 31363.5 31738.7 31949.4 31983.7 24256.5 24506.0 24517.2 24639.9 24673.4 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | [#2] jquery.html Cycles:180 Average:26494.37 Median:364.39 stddev:78244.29 (21472.7%) stddev-sans-first:78439.14 23:12:53 INFO - PROCESS | 15288 | Values: 344.8 347.2 361.9 363.8 365.0 16374.3 16547.8 16817.2 17202.1 17230.4 15120.9 15379.5 16145.4 16341.2 16390.1 5233.7 5289.9 5407.1 5410.1 5413.3 5339.4 5373.2 5380.6 5382.4 5383.5 3908.0 4031.0 5340.5 5340.9 5597.8 5798.7 5824.9 5833.3 5853.6 5862.4 5090.8 5158.0 5197.8 5201.8 5205.8 15716.3 16197.8 18238.0 19699.0 20745.0 2086.2 2129.6 2169.1 2171.7 2234.8 13294.2 13418.7 13437.9 13575.4 13586.5 1721.6 1841.6 1851.5 1856.9 1889.5 55517.0 56879.0 58593.7 58792.7 59228.1 9715.5 9868.9 9985.0 9989.8 10036.5 13127.6 13128.3 13136.1 13145.9 13149.5 7163.6 7207.3 7399.2 7492.6 7652.0 6832.2 6918.4 7292.3 7333.8 7345.5 5861.9 5933.6 5938.4 5954.1 6038.1 1774.3 1791.0 1791.8 1825.7 1837.4 447.0 456.1 904.9 906.6 912.7 9236.4 10123.3 10640.6 10719.1 10971.5 459.1 463.1 468.5 903.9 922.4 8984.4 9162.7 9205.0 9212.1 9406.8 342463.0 351177.0 542884.0 544764.0 555676.0 76564.0 81110.0 81314.6 81989.0 83324.2 1154.9 1181.9 1182.0 1199.5 1200.5 15285.8 15445.3 15572.5 15749.2 15881.4 31322.0 31456.7 31666.7 32537.2 33629.7 43580.3 44085.3 45117.8 45569.3 46944.0 9252.6 9456.9 9460.1 9527.4 9585.6 13377.0 17044.5 17245.8 17547.0 17575.1 14235.8 14344.7 14424.2 14786.1 14944.0 13477.5 13734.6 14038.9 14643.9 14707.0 13753.7 13845.4 14301.0 14598.1 14687.4 9412.6 9511.1 9551.5 9575.6 9622.8 10994.5 14548.9 14610.1 14625.3 14676.6 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | [#3] mootools.html Cycles:180 Average:5298.14 Median:6243.22 stddev:2710.99 (43.4%) stddev-sans-first:2701.96 23:12:53 INFO - PROCESS | 15288 | Values: 1302.2 1668.1 1708.0 1734.5 1743.8 6651.4 7387.2 7553.9 7574.5 7584.7 7515.4 7592.8 7599.5 7608.8 7627.9 2215.7 2241.8 2253.6 2254.2 2257.8 2243.3 2267.0 2320.7 2323.0 2323.2 2267.8 2271.1 2274.9 2292.2 2299.5 2243.2 2255.1 2285.1 2285.1 2287.4 2265.1 2272.1 2272.9 2275.2 2296.1 7527.8 7580.5 7611.0 7627.7 7699.4 4462.1 4553.8 4559.7 4560.2 4572.9 2982.4 3014.4 3133.0 3137.9 3154.7 1026.7 1051.4 1062.8 1091.8 1829.8 10309.2 10311.1 10334.4 10337.7 10382.2 4033.9 4084.0 4130.9 4175.2 4183.9 8417.4 8418.2 8476.6 8508.1 8553.0 4470.7 4530.1 4531.0 4531.8 4545.3 3693.6 3767.5 4077.0 4155.8 4220.9 3519.5 3533.4 3552.4 3569.7 3579.5 1068.8 1094.7 1099.8 1101.1 1104.4 1295.4 1308.1 1325.7 1349.8 1350.5 7166.7 7166.9 7204.4 7276.0 7277.9 489.7 497.7 500.1 502.7 510.2 5575.1 5681.1 5704.8 5720.3 5728.7 8532.5 8705.3 9018.4 9067.0 9123.4 8954.3 8999.4 9020.8 9032.4 9060.1 6948.8 7020.6 7112.1 7155.9 7177.4 6872.2 6913.4 6914.2 6915.5 6922.2 7851.2 8055.0 8072.7 8092.6 8112.1 7961.0 7992.2 8025.0 8029.2 8074.6 6535.0 6541.5 6624.9 6650.1 6677.4 7304.5 7450.0 7450.6 7460.0 7460.8 6705.0 6907.8 6998.8 7015.2 7085.1 6792.2 6868.3 6961.1 6971.3 7043.6 6804.7 6936.1 6944.4 6969.9 7006.4 6206.3 6280.2 6281.5 6292.8 6309.1 6462.2 6473.5 6480.8 6498.8 6513.8 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | [#4] prototype.html Cycles:180 Average:5312.50 Median:6015.46 stddev:1611.30 (26.8%) stddev-sans-first:1571.87 23:12:53 INFO - PROCESS | 15288 | Values: 332.6 338.5 341.3 344.4 350.5 5955.9 5965.6 6044.5 6056.3 6085.8 5720.2 5787.1 5871.9 5918.4 5935.1 4497.6 4512.1 4526.9 4533.7 4541.8 4378.0 4528.1 4534.3 4539.3 4540.1 4378.8 4409.7 4426.2 4455.4 4506.5 4442.6 4459.8 4460.8 4482.1 4496.6 3861.6 3888.9 3904.1 3904.6 3909.7 5564.0 5613.1 5639.1 5653.7 5656.4 5310.1 5317.9 5318.0 5320.2 5326.4 6313.4 6316.7 6318.4 6318.6 6324.2 4456.4 4457.3 4462.5 4466.4 4475.7 6400.7 6528.8 6545.4 6555.6 6564.2 4547.5 4552.0 4552.1 4552.4 4554.2 4599.2 4605.6 4612.7 4616.7 4617.1 5298.6 5300.7 5306.1 5310.9 5313.9 6226.3 6363.0 6403.4 6412.5 6428.6 1584.7 1604.9 1606.3 1609.9 1612.1 1060.7 1068.6 1069.2 1078.7 1092.1 6002.0 6003.4 6013.6 6017.3 6029.0 6501.1 6503.5 6510.3 6513.0 6518.9 5955.9 6080.9 6086.1 6089.6 6093.5 3500.9 3567.3 3568.8 3589.3 3613.0 6750.5 6750.9 6753.3 6765.8 6766.8 6587.2 6624.1 6646.4 6727.8 6851.3 6742.6 6755.1 6769.4 6774.5 6786.9 6659.5 6668.9 6669.3 6680.7 6684.9 6424.1 6576.4 6578.9 6580.2 6589.3 6748.5 6756.4 6761.6 6765.3 6772.1 4477.1 4486.2 4489.9 4495.0 4498.6 6501.1 6600.5 6644.9 6652.0 6654.5 6414.6 6450.2 6457.2 6461.0 6474.7 6444.6 6451.7 6452.4 6454.8 6455.4 6191.0 6315.6 6336.4 6337.4 6339.1 6478.5 6478.8 6494.7 6496.7 6498.1 6295.4 6303.2 6317.6 6331.6 6342.1 23:12:53 INFO - PROCESS | 15288 | 23:12:53 INFO - PROCESS | 15288 | [#5] yui.html Cycles:180 Average:13762.87 Median:44352.28 stddev:15727.60 (35.5%) stddev-sans-first:15741.48 23:12:53 INFO - PROCESS | 15288 | Values: 775.5 788.4 803.6 839.8 862.0 12947.0 13217.8 13261.0 13293.5 13298.5 12535.6 12594.0 14812.0 14866.3 14935.3 795.8 815.4 816.0 817.3 817.3 681.4 690.2 808.2 811.6 821.6 843.0 851.7 852.4 854.3 855.6 708.9 719.2 842.7 844.1 846.5 607.0 618.1 619.0 619.8 619.9 12747.2 12908.0 12946.5 12974.8 13052.3 12296.3 12848.7 12923.9 13106.6 13321.7 9738.5 10059.4 10100.1 10358.2 10668.3 3648.9 3688.9 3759.3 3776.0 3830.3 43678.3 44105.6 44413.8 44505.3 44575.0 9989.0 10159.6 10298.2 10410.6 10544.3 17402.9 17435.0 17443.0 17475.2 17486.5 7216.5 7439.4 7471.4 7694.6 7860.3 4133.4 4144.9 4147.7 4263.1 4347.3 3148.6 3166.1 3200.6 3200.9 3201.5 570.3 583.7 583.8 587.8 589.5 631.0 660.4 671.5 706.1 707.8 8580.2 9003.4 9018.4 9021.7 9065.2 527.8 558.9 584.3 589.3 709.6 4083.4 4105.2 4150.0 4177.3 4269.5 51739.5 52187.7 63996.7 64315.4 64342.0 48618.8 49261.5 49402.5 50087.0 50637.5 44290.8 46203.3 46594.8 46858.3 48238.3 8512.3 8658.4 8799.4 9174.0 9302.6 34160.0 34917.3 35277.8 35368.0 36622.6 43312.0 43359.0 43543.6 43749.0 44047.0 11090.6 11294.0 11318.5 11325.2 11396.9 12445.3 12446.6 12461.3 13117.3 13120.9 11479.7 11672.1 11812.2 12162.4 12273.4 11683.0 12006.6 12092.2 12361.7 12417.4 11381.9 11611.8 11710.6 11712.8 11728.6 9453.4 9549.5 9849.6 9878.3 9954.4 9187.5 9549.7 9649.8 9724.4 9763.2 23:12:53 INFO - PROCESS | 15288 | -------- Summary: end -------- 23:12:53 INFO - PROCESS | 15288 | 23:12:54 INFO - TEST-INFO | 15288: exit 0 23:12:54 INFO - TEST-OK | dromaeo_css | took 1113415ms 23:12:54 INFO - TEST-START | kraken 23:12:54 INFO - operating with platform_type : linux_ 23:12:54 INFO - Initialising browser for kraken test... 23:12:54 INFO - TEST-INFO | started process 15485 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi3WBy5/profile http://localhost:60797/getInfo.html) 23:12:58 INFO - PROCESS | 15485 | __metrics Screen width/height:1600/1200 23:12:58 INFO - PROCESS | 15485 | colorDepth:24 23:12:58 INFO - PROCESS | 15485 | Browser inner width/height: 1024/697 23:12:58 INFO - PROCESS | 15485 | __metrics 23:12:58 INFO - PROCESS | 15485 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:12:58 INFO - PROCESS | 15485 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:12:59 INFO - TEST-INFO | 15485: exit 0 23:12:59 INFO - Browser initialized. 23:12:59 INFO - Running cycle 1/1 for kraken test... 23:12:59 INFO - TEST-INFO | started process 15567 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi3WBy5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:11 INFO - PROCESS | 15567 | RSS: Main: 150413312 23:13:11 INFO - PROCESS | 15567 | 23:13:13 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60797/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:14 INFO - PROCESS | 15567 | RSS: Main: 185200640 23:13:14 INFO - PROCESS | 15567 | 23:13:16 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60797/tests/kraken/driver.html?testName=audio-dft) 23:13:17 INFO - PROCESS | 15567 | RSS: Main: 176340992 23:13:17 INFO - PROCESS | 15567 | 23:13:20 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60797/tests/kraken/driver.html?testName=audio-fft) 23:13:20 INFO - PROCESS | 15567 | RSS: Main: 160837632 23:13:20 INFO - PROCESS | 15567 | 23:13:22 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60797/tests/kraken/driver.html?testName=audio-oscillator) 23:13:23 INFO - PROCESS | 15567 | RSS: Main: 163438592 23:13:23 INFO - PROCESS | 15567 | 23:13:25 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60797/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:26 INFO - PROCESS | 15567 | RSS: Main: 164237312 23:13:26 INFO - PROCESS | 15567 | 23:13:28 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60797/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:29 INFO - PROCESS | 15567 | RSS: Main: 165785600 23:13:29 INFO - PROCESS | 15567 | 23:13:32 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60797/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:33 INFO - PROCESS | 15567 | RSS: Main: 164651008 23:13:33 INFO - PROCESS | 15567 | 23:13:36 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60797/tests/kraken/driver.html?testName=json-parse-financial) 23:13:36 INFO - PROCESS | 15567 | RSS: Main: 166219776 23:13:36 INFO - PROCESS | 15567 | 23:13:38 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60797/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:38 INFO - PROCESS | 15567 | RSS: Main: 177205248 23:13:38 INFO - PROCESS | 15567 | 23:13:40 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:41 INFO - PROCESS | 15567 | RSS: Main: 175169536 23:13:41 INFO - PROCESS | 15567 | 23:13:43 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:43 INFO - PROCESS | 15567 | RSS: Main: 184274944 23:13:43 INFO - PROCESS | 15567 | 23:13:46 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:46 INFO - PROCESS | 15567 | RSS: Main: 191868928 23:13:46 INFO - PROCESS | 15567 | 23:13:49 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:50 INFO - PROCESS | 15567 | RSS: Main: 188088320 23:13:50 INFO - PROCESS | 15567 | 23:13:51 INFO - PROCESS | 15567 | Cycle 1(1): loaded http://localhost:60797/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60797/tests/kraken/driver.html?testName=ai-astar) 23:13:52 INFO - PROCESS | 15567 | RSS: Main: 247205888 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | __start_tp_report 23:13:52 INFO - PROCESS | 15567 | _x_x_mozilla_page_load 23:13:52 INFO - PROCESS | 15567 | _x_x_mozilla_page_load_details 23:13:52 INFO - PROCESS | 15567 | |i|pagename|runs| 23:13:52 INFO - PROCESS | 15567 | |0;ai-astar;110;112;104;109;111;111;100;109;110;118 23:13:52 INFO - PROCESS | 15567 | |1;audio-beat-detection;154;123;146;162;125;144;156;124;165;130 23:13:52 INFO - PROCESS | 15567 | |2;audio-dft;160;161;159;160;159;162;160;162;161;161 23:13:52 INFO - PROCESS | 15567 | |3;audio-fft;71;70;82;90;70;97;71;101;93;73 23:13:52 INFO - PROCESS | 15567 | |4;audio-oscillator;94;93;136;93;93;93;140;92;94;141 23:13:52 INFO - PROCESS | 15567 | |5;imaging-gaussian-blur;110;110;110;110;109;109;110;110;109;109 23:13:52 INFO - PROCESS | 15567 | |6;imaging-darkroom;144;146;146;146;146;146;145;145;145;145 23:13:52 INFO - PROCESS | 15567 | |7;imaging-desaturate;96;95;95;95;96;95;96;95;96;95 23:13:52 INFO - PROCESS | 15567 | |8;json-parse-financial;60;59;58;57;60;58;59;65;57;56 23:13:52 INFO - PROCESS | 15567 | |9;json-stringify-tinderbox;66;66;67;66;66;67;66;67;67;67 23:13:52 INFO - PROCESS | 15567 | |10;stanford-crypto-aes;84;84;85;86;84;85;86;87;93;84 23:13:52 INFO - PROCESS | 15567 | |11;stanford-crypto-ccm;123;126;123;115;116;122;116;125;124;121 23:13:52 INFO - PROCESS | 15567 | |12;stanford-crypto-pbkdf2;153;154;160;150;157;139;151;151;147;140 23:13:52 INFO - PROCESS | 15567 | |13;stanford-crypto-sha256-iterative;66;68;66;67;67;66;71;67;68;66 23:13:52 INFO - PROCESS | 15567 | __end_tp_report 23:13:52 INFO - PROCESS | 15567 | __start_cc_report 23:13:52 INFO - PROCESS | 15567 | _x_x_mozilla_cycle_collect,936 23:13:52 INFO - PROCESS | 15567 | __end_cc_report 23:13:52 INFO - PROCESS | 15567 | __startTimestamp1450854832019__endTimestamp 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | ------- Summary: start ------- 23:13:52 INFO - PROCESS | 15567 | Number of tests: 14 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:4.77 (4.3%) stddev-sans-first:5.05 23:13:52 INFO - PROCESS | 15567 | Values: 110.0 112.0 104.0 109.0 111.0 111.0 100.0 109.0 110.0 118.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:150.00 stddev:16.33 (10.9%) stddev-sans-first:16.82 23:13:52 INFO - PROCESS | 15567 | Values: 154.0 123.0 146.0 162.0 125.0 144.0 156.0 124.0 165.0 130.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 23:13:52 INFO - PROCESS | 15567 | Values: 160.0 161.0 159.0 160.0 159.0 162.0 160.0 162.0 161.0 161.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.50 stddev:12.39 (16.0%) stddev-sans-first:12.51 23:13:52 INFO - PROCESS | 15567 | Values: 71.0 70.0 82.0 90.0 70.0 97.0 71.0 101.0 93.0 73.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.00 stddev:22.19 (23.9%) stddev-sans-first:23.04 23:13:52 INFO - PROCESS | 15567 | Values: 94.0 93.0 136.0 93.0 93.0 93.0 140.0 92.0 94.0 141.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:13:52 INFO - PROCESS | 15567 | Values: 110.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 23:13:52 INFO - PROCESS | 15567 | Values: 144.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:13:52 INFO - PROCESS | 15567 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:2.51 (4.3%) stddev-sans-first:2.64 23:13:52 INFO - PROCESS | 15567 | Values: 60.0 59.0 58.0 57.0 60.0 58.0 59.0 65.0 57.0 56.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 23:13:52 INFO - PROCESS | 15567 | Values: 66.0 66.0 67.0 66.0 66.0 67.0 66.0 67.0 67.0 67.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.74 (3.2%) stddev-sans-first:2.83 23:13:52 INFO - PROCESS | 15567 | Values: 84.0 84.0 85.0 86.0 84.0 85.0 86.0 87.0 93.0 84.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:123.00 stddev:4.01 (3.3%) stddev-sans-first:4.20 23:13:52 INFO - PROCESS | 15567 | Values: 123.0 126.0 123.0 115.0 116.0 122.0 116.0 125.0 124.0 121.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:152.00 stddev:6.71 (4.4%) stddev-sans-first:7.04 23:13:52 INFO - PROCESS | 15567 | Values: 153.0 154.0 160.0 150.0 157.0 139.0 151.0 151.0 147.0 140.0 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - PROCESS | 15567 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.58 23:13:52 INFO - PROCESS | 15567 | Values: 66.0 68.0 66.0 67.0 67.0 66.0 71.0 67.0 68.0 66.0 23:13:52 INFO - PROCESS | 15567 | -------- Summary: end -------- 23:13:52 INFO - PROCESS | 15567 | 23:13:52 INFO - TEST-INFO | 15567: exit 0 23:13:52 INFO - TEST-OK | kraken | took 58786ms 23:13:52 INFO - TEST-START | v8_7 23:13:52 INFO - operating with platform_type : linux_ 23:13:52 INFO - Initialising browser for v8_7 test... 23:13:52 INFO - TEST-INFO | started process 15815 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvI7xpj/profile http://localhost:60797/getInfo.html) 23:13:56 INFO - PROCESS | 15815 | __metrics Screen width/height:1600/1200 23:13:56 INFO - PROCESS | 15815 | colorDepth:24 23:13:56 INFO - PROCESS | 15815 | Browser inner width/height: 1024/697 23:13:56 INFO - PROCESS | 15815 | __metrics 23:13:56 INFO - PROCESS | 15815 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:57 INFO - PROCESS | 15815 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:58 INFO - TEST-INFO | 15815: exit 0 23:13:58 INFO - Browser initialized. 23:13:58 INFO - Running cycle 1/1 for v8_7 test... 23:13:58 INFO - TEST-INFO | started process 15900 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvI7xpj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:09 INFO - PROCESS | 15900 | RSS: Main: 149446656 23:14:09 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | Cycle 1(1): loaded http://localhost:60797/tests/v8_7/run.html (next: http://localhost:60797/tests/v8_7/run.html) 23:14:31 INFO - PROCESS | 15900 | RSS: Main: 541966336 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | __start_tp_report 23:14:31 INFO - PROCESS | 15900 | _x_x_mozilla_page_load 23:14:31 INFO - PROCESS | 15900 | _x_x_mozilla_page_load_details 23:14:31 INFO - PROCESS | 15900 | |i|pagename|runs| 23:14:31 INFO - PROCESS | 15900 | |0;Richards;166.47244880972198 23:14:31 INFO - PROCESS | 15900 | |1;DeltaBlue;188.85741265344666 23:14:31 INFO - PROCESS | 15900 | |2;Encrypt;280.50490883590464 23:14:31 INFO - PROCESS | 15900 | |3;Decrypt;5138.461538461538 23:14:31 INFO - PROCESS | 15900 | |4;RayTrace;1982.1782178217823 23:14:31 INFO - PROCESS | 15900 | |5;Earley;789.8894154818325 23:14:31 INFO - PROCESS | 15900 | |6;Boyer;12469.135802469136 23:14:31 INFO - PROCESS | 15900 | |7;RegExp;26315.78947368421 23:14:31 INFO - PROCESS | 15900 | |8;Splay;580.3830528148578 23:14:31 INFO - PROCESS | 15900 | |9;NavierStokes;4854.368932038835 23:14:31 INFO - PROCESS | 15900 | __end_tp_report 23:14:31 INFO - PROCESS | 15900 | __startTimestamp1450854871575__endTimestamp 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | ------- Summary: start ------- 23:14:31 INFO - PROCESS | 15900 | Number of tests: 10 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#0] Richards Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 166.5 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#1] DeltaBlue Cycles:1 Average:188.86 Median:188.86 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 188.9 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 280.5 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 5138.5 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 1982.2 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 789.9 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#6] Boyer Cycles:1 Average:12469.14 Median:12469.14 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 12469.1 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#7] RegExp Cycles:1 Average:26315.79 Median:26315.79 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 26315.8 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#8] Splay Cycles:1 Average:580.38 Median:580.38 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 580.4 23:14:31 INFO - PROCESS | 15900 | 23:14:31 INFO - PROCESS | 15900 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 23:14:31 INFO - PROCESS | 15900 | Values: 4854.4 23:14:31 INFO - PROCESS | 15900 | -------- Summary: end -------- 23:14:31 INFO - PROCESS | 15900 | 23:14:32 INFO - TEST-INFO | 15900: exit 0 23:14:32 INFO - TEST-OK | v8_7 | took 39490ms 23:14:32 INFO - SUITE-END | took 1211s 23:14:32 INFO - Completed test suite (00:20:11) 23:14:32 INFO - Working with test: dromaeo_css 23:14:32 INFO - Generating results file: dromaeo_css 23:14:32 INFO - Working with test: kraken 23:14:32 INFO - Generating results file: kraken 23:14:32 INFO - javascript benchmark 23:14:32 INFO - Working with test: v8_7 23:14:32 INFO - Generating results file: v8_7 23:14:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:14:32 INFO - process_Request line: dromaeo_css 6932.69 graph.html#tests=[[72,201,35]] 23:14:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:32 INFO - process_Request line: kraken 1501.60 graph.html#tests=[[232,201,35]] 23:14:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:32 INFO - process_Request line: v8_7 19848.41 graph.html#tests=[[230,201,35]] 23:14:32 INFO - RETURN: dromaeo_css: 6932.69 23:14:32 INFO - RETURN: kraken: 1501.60 23:14:32 INFO - RETURN: v8_7: 19848.41 23:14:32 INFO - javascript benchmark 23:14:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3151.1964449065485, 3198.0885447647424, 3239.433099207638, 3241.1086951088464, 3261.9836900815494, 5204.635675502707, 5314.548263397606, 5406.702631355279, 5417.431169727181, 5476.999999999995, 5285.7885684572575, 5347.973260133694, 5467.917981230285, 5549.223108764776, 5583.972080139603, 4939.753012349377, 4971.676841005323, 4973.801047958077, 4990.750462476862, 5016.498350164972, 4997.025580011899, 5016.097102521545, 5045.84862454127, 5056.646034777567, 5067.0, 4839.4918533554, 4887.413510378778, 4933.753312334405, 4962.05720913029, 4965.230389289666, 4924.409070911478, 4926.5812405945535, 4926.655134140611, 4931.876703082416, 4968.478309777457, 4769.141554520185, 4895.11887860185, 4919.655624106314, 4927.704337739711, 4973.90052198954, 5026.195808670632, 5218.478152184789, 5220.947790522084, 5231.319928409321, 5248.816291429782, 5808.912866307009, 5812.5640576956475, 5814.418558144194, 5819.67991760453, 5824.359320474744, 5607.383187849333, 5769.076947688392, 5868.090445980837, 5872.17789509469, 5874.23634927461, 5410.215518749759, 5422.783088676449, 5507.394186639466, 5517.917231241535, 5530.972345138249, 5899.616524925866, 5928.347881733006, 5931.881362372728, 5935.139404786368, 5938.257717785277, 5730.971345143331, 5733.483986441157, 5739.081746920556, 5743.798967036218, 5790.971045144747, 5593.944060559343, 5740.0, 5740.741666625012, 5810.593258471951, 5913.674747888821, 5723.284589426322, 5774.0, 5781.88436231273, 5786.681732504752, 5787.88424231513, 5783.768649254067, 5786.363500014995, 5787.218725472091, 5787.276590426197, 5790.392008839011, 4358.455193100863, 4396.846110386121, 4460.50934397216, 4474.574915383034, 4517.909641807146, 3978.980105099456, 3995.780232087263, 3996.3406038003404, 4033.153037862023, 4034.4755181826176, 5333.493318134771, 5508.779648814003, 5514.724263786795, 5514.889702206014, 5519.613627046068, 5757.740901659436, 5833.095870140135, 5835.533157347402, 5842.444967728059, 5844.47399734026, 5547.084731019337, 5550.417206193372, 5553.750081246354, 5576.693281869536, 5606.915896261559, 5122.0, 5128.640995130305, 5132.615053870974, 5136.357955255593, 5188.247704082887, 5739.081746920473, 5864.706764661835, 6003.939960600425, 6008.489278411384, 6008.879822403527, 5745.97127014379, 5798.304203495608, 5873.911891321548, 5921.644701317935, 5926.170336152856, 5809.390014048633, 5921.792737254175, 5927.051671732502, 5928.67392293428, 5938.821835344774, 5752.597318187687, 5761.769529218952, 5763.394843541368, 5773.422657734193, 5774.335951365647, 5743.712814359182, 5864.589478736448, 5869.119632055226, 5870.412958704266, 5871.4715675587695, 5565.777368905198, 5667.291588551431, 5667.319921609268, 5719.256496655408, 5724.885502290014, 5716.085426331767, 5729.828105156852, 5730.684812335361, 5733.397993210653, 5752.741126649395, 5467.753951072291, 5559.027170245272, 5574.665520068809, 5633.436656334334, 5635.9436405635415, 5669.518090962314, 5670.092785154356, 5765.827025189251, 5812.505936995402, 5837.883242335214, 5674.971625141848, 5684.602077854511, 5685.573581981285, 5691.0, 5749.13762935563], "unit": "score", "name": "dojo.html", "value": 5362.367157602477}, {"lowerIsBetter": false, "replicates": [557.6458948567658, 616.365143901781, 616.7502161624543, 617.2161355079049, 621.2700077409044, 29604.0, 37147.0, 38169.42745858814, 38207.617923820755, 38217.80891095548, 42498.150036999315, 42940.3558946616, 42957.57042429575, 42968.35547466791, 43000.35499467511, 7534.660940257701, 7674.693012279502, 8625.568721563912, 8777.253933415635, 8785.868211976825, 10332.79334413315, 10601.469926503683, 10607.257491975564, 10614.522346494427, 10615.681529554126, 10324.845127323097, 10394.0, 10415.843762343571, 10416.322939008978, 10434.582616695323, 7800.0, 7938.047434307862, 10309.432981186032, 10419.06228439444, 10458.0, 10167.491625418774, 10346.32748871321, 10366.688999330032, 10368.844467332996, 10373.79252414955, 39427.21145577101, 39774.40338394926, 39839.80080099581, 39876.60123398758, 39930.20139597221, 3169.112648458435, 3226.754759662574, 3257.837108144607, 3358.177246574605, 3359.328134373135, 29735.0, 29974.400511989857, 30087.713637559365, 30420.69579304223, 31126.0, 3828.942565861514, 3855.652991230803, 3885.805709714531, 3950.4074388841905, 3972.960270397288, 268144.0, 268815.0, 269666.6516667424, 269987.0, 270143.0, 52172.0, 54977.72511137499, 55485.45145485419, 55592.88478267387, 55618.16572751412, 47886.28170577444, 59442.70278648579, 60830.39169608247, 60892.695536522035, 60917.080779498385, 14214.21821799811, 14573.271336433349, 14609.488667896572, 14650.706985860435, 14670.339834707464, 10822.404767737693, 10827.24209305341, 10831.83752243717, 10849.0, 10882.619108331328, 18692.85032221285, 18717.0, 18931.0, 18938.715919261223, 18941.526461838563, 7509.662065207079, 7693.076830780342, 7699.0, 7745.922540774633, 7755.224477552312, 921.5852866210232, 944.9433034017981, 956.9951550871557, 968.3995922527937, 1064.9616623791742, 27727.0, 27834.443311133666, 27846.5823012655, 28427.857860710563, 28510.0, 1034.8706411698538, 1040.079529616295, 1051.7896420715736, 1128.4075860173475, 1186.5253898440692, 14652.853471465362, 14850.331735071948, 15401.152936588594, 15469.5359139226, 15540.378384864705, 311407.0, 316490.0, 316858.0, 318951.0, 320077.0, 51134.74432627887, 51197.744011279705, 51258.48741512612, 51575.484245157815, 51576.74211628918, 1313.90802643814, 1338.3843432021185, 1358.3344161360862, 1363.7817949128091, 1364.6793003644136, 27348.316292092855, 28027.859860700566, 28171.27049832852, 28434.85782571074, 28552.143435696962, 43169.568304317814, 43320.78339608282, 43437.565624343355, 43537.346939795294, 43545.0, 293299.0, 293801.0, 295092.0, 295589.0, 295659.0, 27111.322216944733, 29815.22956326977, 30338.0, 30626.693733063275, 30641.08076757701, 35184.29631407409, 36510.8174459126, 36622.450663240605, 41593.79203103965, 42769.78615106905, 32094.19764505906, 32501.674983249864, 32690.24225307299, 32878.01365959025, 35093.82453087718, 30164.396712065198, 33510.66489335075, 34481.0, 36342.63657363393, 36804.81597592102, 31699.366012679155, 32133.678663214003, 32230.19424514406, 32530.83734581312, 32537.0, 29856.0, 31363.529547057267, 31738.682613173572, 31949.36101278008, 31983.68016319807, 24256.456274820273, 24506.007347830262, 24517.162312050063, 24639.876800615883, 24673.383165421008], "unit": "score", "name": "ext.html", "value": 18308.124589257142}, {"lowerIsBetter": false, "replicates": [344.7552237911082, 347.24301023768186, 361.887814777419, 363.8035460851141, 364.9744517883749, 16374.345026198953, 16547.751783723255, 16817.243224054917, 17202.139893005362, 17230.396936107238, 15120.924395378008, 15379.461718839842, 16145.43490977813, 16341.182940852968, 16390.098544580043, 5233.712145831978, 5289.867753306169, 5407.107827208506, 5410.08028635131, 5413.296271484721, 5339.359276886779, 5373.220882971967, 5380.569554435636, 5382.434844341346, 5383.515483606475, 3907.98046009771, 4030.979845100785, 5340.546053585431, 5340.866478338034, 5597.832065038056, 5798.681072541009, 5824.941750582482, 5833.32916714579, 5853.619514731528, 5862.443067908542, 5090.770915308783, 5158.0, 5197.818076367309, 5201.791928322863, 5205.765740541685, 15716.29276682552, 16197.838021619751, 18238.0, 19699.0, 20745.0, 2086.238522939116, 2129.6379615465407, 2169.1323470611724, 2171.6742488626674, 2234.7988681018624, 13294.20234785916, 13418.664533386744, 13437.865621343759, 13575.389107490088, 13586.524471643444, 1721.5523963769385, 1841.5764374194011, 1851.4538211227587, 1856.8793028453108, 1889.5181728659104, 55517.0, 56879.0, 58593.70703146457, 58792.70603646997, 59228.11157832593, 9715.514224288898, 9868.901310986797, 9985.0, 9989.750256243651, 10036.548355323883, 13127.606171814861, 13128.277944713132, 13136.146150500377, 13145.868541314656, 13149.53976610814, 7163.606001669854, 7207.279272072751, 7399.223081576464, 7492.587907665022, 7651.961740191264, 6832.214295356098, 6918.446524278046, 7292.270772922665, 7333.816654583678, 7345.522541034816, 5861.9413805861395, 5933.614315069507, 5938.406159384113, 5954.10688396744, 6038.094285857069, 1774.3434929076325, 1790.9641807163785, 1791.8297761712618, 1825.6896327624336, 1837.4303965770655, 446.9910601787946, 456.0787209836112, 904.9457032578066, 906.6464079009191, 912.7307444303947, 9236.399634023766, 10123.341982771097, 10640.627578034731, 10719.142468602493, 10971.451427428598, 459.0955817040425, 463.0807846424844, 468.5288195067491, 903.9231665308522, 922.4004397141912, 8984.371094023356, 9162.67930622425, 9205.0, 9212.12484813955, 9406.764830879283, 342463.0, 351177.0, 542884.0, 544764.0, 555676.0, 76564.0, 81110.0, 81314.59342703367, 81989.0, 83324.16675833285, 1154.9364784936909, 1181.9231749936228, 1182.0, 1199.5201919232202, 1200.5017917564287, 15285.847141528442, 15445.304961276544, 15572.454964076203, 15749.212539372757, 15881.444149454714, 31322.0, 31456.685433145376, 31666.683333166373, 32537.186570335933, 33629.66370336363, 43580.34629480497, 44085.33871991987, 45117.774411127735, 45569.31646025379, 46944.0, 9252.583633736363, 9456.905430945602, 9460.101290377403, 9527.428354298765, 9585.568649410932, 13377.0, 17044.48866534006, 17245.827541724924, 17547.0, 17575.121243938007, 14235.786463202852, 14344.713105738036, 14424.206668633326, 14786.112833230041, 14944.0, 13477.528286509925, 13734.587962361145, 14038.929805350908, 14643.85356146425, 14707.044042137228, 13753.656158596115, 13845.376958037114, 14301.0, 14598.124112553282, 14687.41250349974, 9412.57643406062, 9511.096445837635, 9551.52242387864, 9575.569099390405, 9622.759431014281, 10994.505247264053, 14548.85451145475, 14610.123392596479, 14625.34185961613, 14676.633084172981], "unit": "score", "name": "jquery.html", "value": 8606.100115745066}, {"lowerIsBetter": false, "replicates": [1302.2446980751165, 1668.0908904646967, 1707.9658406831863, 1734.470986349163, 1743.7733094697687, 6651.401373876351, 7387.187409384964, 7553.924460755391, 7574.469787114904, 7584.734534291301, 7515.436342274337, 7592.77221683349, 7599.544027358363, 7608.809779755495, 7627.8855817162785, 2215.6898034275214, 2241.764614715456, 2253.6281513550243, 2254.199759085526, 2257.81937445004, 2243.3270018994317, 2267.0, 2320.7331156916916, 2322.9767702323015, 2323.2217207235594, 2267.784560466753, 2271.1256166375897, 2274.8862556872173, 2292.1748170658634, 2299.482616411311, 2243.248511748566, 2255.0979608156786, 2285.0973865323103, 2285.131649973008, 2287.3938406322336, 2265.082641530183, 2272.091163534583, 2272.909083636669, 2275.192306731103, 2296.127471560796, 7527.774166775005, 7580.54516728998, 7610.961945190294, 7627.733029343946, 7699.422543309274, 4462.107578484283, 4553.795079221443, 4559.680822342438, 4560.247559152735, 4572.885677858047, 2982.4482470742764, 3014.3820516794003, 3132.9530057049164, 3137.905862824119, 3154.7318477929402, 1026.653110858599, 1051.374432212832, 1062.787442511493, 1091.781643671269, 1829.7529833472445, 10309.175265978703, 10311.123554497877, 10334.379937203792, 10337.74155646115, 10382.221333400024, 4033.858814941463, 4083.9795801020805, 4130.855420060284, 4175.206710724952, 4183.874483765431, 8417.368697347723, 8418.200270974248, 8476.618552165168, 8508.064112947572, 8552.957235213784, 4470.664700147502, 4530.093981203707, 4531.003179300548, 4531.796069176895, 4545.340925565774, 3693.649103335179, 3767.4913886625504, 4076.9592304076577, 4155.750654960712, 4220.860367700704, 3519.489673997256, 3533.434650455915, 3552.3605750965075, 3569.6787289144104, 3579.49887015818, 1068.8076146293743, 1094.7099018760034, 1099.7580532282884, 1101.1136035491506, 1104.4036220440871, 1295.371744703818, 1308.064733715398, 1325.7017171136417, 1349.7705390083709, 1350.4665657065405, 7166.749163779347, 7166.928330716731, 7204.351608355273, 7275.963620181865, 7277.8544429111125, 489.6694731056523, 497.65164384930694, 500.08734060340026, 502.74360076360585, 510.178612433981, 5575.080111781592, 5681.0910254359105, 5704.771809127588, 5720.313562372542, 5728.742206600713, 8532.464156451773, 8705.260052895448, 9018.368714189945, 9066.95466522663, 9123.361364704408, 8954.2836573074, 8999.37004409698, 9020.819583608421, 9032.412893162054, 9060.139286767746, 6948.791536253921, 7020.613866237304, 7112.110986126734, 7155.89266161008, 7177.4258059355125, 6872.244053154249, 6913.446924246149, 6914.239433662193, 6915.51591388598, 6922.238553759184, 7851.2148785121035, 8054.959725201571, 8072.717454889051, 8092.5549094798, 8112.148224436349, 7960.965074540272, 7992.200779921961, 8024.959875200587, 8029.237222463857, 8074.59627018635, 6535.0, 6541.476681865534, 6624.900626490703, 6650.068990341259, 6677.399034086956, 7304.452166087671, 7449.962750186214, 7450.590217538087, 7460.0, 7460.813479663052, 6705.0, 6907.758228461979, 6998.790036298919, 7015.193252775792, 7085.078939737801, 6792.184937807495, 6868.347506986828, 6961.060256865461, 6971.337722916315, 7043.647817608997, 6804.727810887509, 6936.132983377078, 6944.444444444332, 6969.895451568129, 7006.439484841098, 6206.286277078194, 6280.152179455715, 6281.52888533371, 6292.811215663537, 6309.053641953744, 6462.1599192106605, 6473.482121430368, 6480.805575832733, 6498.837529061811, 6513.772017979348], "unit": "score", "name": "mootools.html", "value": 4331.134252921878}, {"lowerIsBetter": false, "replicates": [332.61250643000903, 338.51423207696956, 341.3258813842661, 344.3663658867686, 350.5040367879449, 5955.940440595593, 5965.582409231356, 6044.516438684911, 6056.273247210341, 6085.78699745509, 5720.1991721159075, 5787.13193021047, 5871.882562348761, 5918.378570250126, 5935.050391937291, 4497.617702495292, 4512.0975804839, 4526.8868278292975, 4533.682642215046, 4541.750203738793, 4378.0, 4528.071745292224, 4534.34252033455, 4539.296409056601, 4540.069285796404, 4378.759168245745, 4409.713368631044, 4426.18115648606, 4455.420795296607, 4506.549345065484, 4442.644588432918, 4459.799309031101, 4460.821567137311, 4482.148391805546, 4496.617787488068, 3861.6331448512346, 3888.8833334999995, 3904.063024874038, 3904.609539046101, 3909.6872250219913, 5563.972180139073, 5613.129964855454, 5639.125935480007, 5653.660780353192, 5656.43435656431, 5310.097283461821, 5317.8936421271355, 5318.016167009116, 5320.201969704536, 5326.440723723992, 6313.40022697843, 6316.6841657917375, 6318.399752023551, 6318.589291696071, 6324.209473815773, 4456.442944631921, 4457.33140028995, 4462.486814016397, 4466.39703640011, 4475.664325175592, 6400.743970241185, 6528.836779080513, 6545.443637290836, 6555.6066636002, 6564.179477565257, 4547.47704014036, 4552.044070745181, 4552.135094332132, 4552.362669226311, 4554.248548989446, 4599.218132917412, 4605.562471565196, 4612.7001744886475, 4616.6537509686905, 4617.053504031665, 5298.576113910878, 5300.734963251822, 5306.09796334624, 5310.867228319323, 5313.8937221255355, 6226.346233645402, 6363.045543168561, 6403.423691867754, 6412.487001039905, 6428.582142160744, 1584.7464405695264, 1604.8635865951526, 1606.2852030846161, 1609.903405795656, 1612.1375064340757, 1060.671191930504, 1068.636663534402, 1069.1660504806264, 1078.730317420645, 1092.0771947704177, 6002.039673652194, 6003.369646187175, 6013.639181649115, 6017.277926648742, 6029.0, 6501.057346684799, 6503.544751867324, 6510.348965103546, 6513.0, 6518.902216466757, 5955.851103722442, 6080.908786368208, 6086.087086936995, 6089.634621922699, 6093.4515893568905, 3500.9299814003575, 3567.3222087803233, 3568.839402226854, 3589.2821435712963, 3613.0, 6750.5274630775375, 6750.898736518956, 6753.29090445506, 6765.763198288037, 6766.830829229309, 6587.176602924635, 6624.105745724266, 6646.401823835878, 6727.764528241488, 6851.280615535297, 6742.561733487308, 6755.054292399166, 6769.424598908951, 6774.491913106537, 6786.93213067863, 6659.467242620675, 6668.866622667617, 6669.266380698216, 6680.665966701743, 6684.899726504009, 6424.13274207976, 6576.44100251484, 6578.901316480353, 6580.177477815273, 6589.308122647053, 6748.460123190035, 6756.425703815231, 6761.628110453972, 6765.25582185969, 6772.0857684212, 4477.1493416250805, 4486.237339652333, 4489.932651010172, 4494.977525112354, 4498.640108791224, 6501.05734668461, 6600.504962127764, 6644.867102658017, 6651.966740166268, 6654.5341826073645, 6414.583052101599, 6450.225972883284, 6457.160569125984, 6460.967695161494, 6474.70863811139, 6444.581102228341, 6451.709673064817, 6452.419282264619, 6454.806355809334, 6455.419012288917, 6190.969045154746, 6315.621062736067, 6336.366363363811, 6337.429631333018, 6339.080833279241, 6478.546501744832, 6478.805635830932, 6494.740210391531, 6496.693673745752, 6498.122753428227, 6295.401936815995, 6303.180586523723, 6317.6209427434505, 6331.620102793847, 6342.080398342122], "unit": "score", "name": "prototype.html", "value": 4790.06985116337}, {"lowerIsBetter": false, "replicates": [775.5191781095725, 788.4297684173039, 803.5660743198665, 839.8362319347726, 862.0474375814723, 12947.0, 13217.801732974001, 13261.0, 13293.534726284583, 13298.468061277561, 12535.623931282076, 12594.0, 14812.0, 14866.331015104319, 14935.327910244037, 795.8448102620006, 815.4414226255034, 815.9673613055471, 817.3052905030736, 817.3338728935898, 681.366329313738, 690.1855810144028, 808.1595141053298, 811.5820352518458, 821.5604651511443, 843.0431460292551, 851.7402192331336, 852.4288726553193, 854.2824027816632, 855.5850412549939, 708.9184743754482, 719.241200533437, 842.7134774176748, 844.1094645149365, 846.5174850335311, 607.0, 618.1469571990624, 619.0281258424276, 619.7830759234276, 619.9318075011745, 12747.235165889984, 12908.0, 12946.546870859474, 12974.80537791934, 13052.347382630925, 12296.323702196376, 12848.678783030498, 12923.87076129236, 13106.60680179596, 13321.733565328735, 9738.464384458852, 10059.446730429823, 10100.141487973531, 10358.223133265035, 10668.253222274443, 3648.854045838163, 3688.944665830015, 3759.342115129841, 3776.0, 3830.253100645375, 43678.344824827655, 44105.55894441046, 44413.77793111046, 44505.32420137005, 44575.0, 9988.950055249677, 10159.593616255266, 10298.17614590831, 10410.635627752992, 10544.314619549705, 17402.912985435247, 17435.0, 17443.0, 17475.21361538734, 17486.47540573785, 7216.458765592602, 7439.4420418468835, 7471.402287816962, 7694.615269236516, 7860.253275938891, 4133.359329303963, 4144.854930077493, 4147.688923330762, 4263.126059157865, 4347.282698354736, 3148.622165340174, 3166.1293144385477, 3200.5519227308196, 3200.871965121369, 3201.5037669161316, 570.3469527391114, 583.7081459270365, 583.8190161050088, 587.814838325926, 589.5254320272136, 630.9873802524015, 660.3957378998259, 671.5366397186024, 706.0926709178681, 707.779602807225, 8580.22777949975, 9003.414778039407, 9018.413803102909, 9021.684241051531, 9065.229455496225, 527.7915223486701, 558.8742532930058, 584.3484514766005, 589.3428826858022, 709.6026225313841, 4083.3670781028986, 4105.240743400179, 4150.0, 4177.268977928911, 4269.5090064642345, 51739.48260517346, 52187.73906130445, 63996.68001659962, 64315.356846430936, 64342.0, 48618.75690621524, 49261.50738492641, 49402.50597494051, 50087.0, 50637.49362506402, 44290.77854610771, 46203.306950395774, 46594.76702616465, 46858.29712554246, 48238.27642585364, 8512.276456501268, 8658.398196333446, 8799.428037177562, 9174.0, 9302.581383837609, 34160.0, 34917.30165396627, 35277.82361088178, 35368.0, 36622.633773661924, 43312.0, 43359.0, 43543.56456435522, 43749.0, 44047.0, 11090.611828586283, 11294.0, 11318.547258109584, 11325.207623827435, 11396.886031139582, 12445.253284802578, 12446.56437024736, 12461.252324860538, 13117.278549679859, 13120.934395327962, 11479.713007174887, 11672.124590655905, 11812.232204906653, 12162.391880406121, 12273.447694853932, 11683.0, 12006.579769708018, 12092.153549251469, 12361.690957726129, 12417.379131043592, 11381.943090284496, 11611.796267920241, 11710.648680539598, 11712.824307635221, 11728.648140555797, 9453.43279403238, 9549.47477888695, 9849.606015759577, 9878.308518403643, 9954.352967057119, 9187.494687792236, 9549.665761698307, 9649.758756031155, 9724.367916085432, 9763.170130538983], "unit": "score", "name": "yui.html", "value": 6333.176292709876}], "name": "dromaeo_css", "value": 6932.689984803166}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 109.0, 111.0, 111.0, 100.0, 109.0, 110.0, 118.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [154.0, 123.0, 146.0, 162.0, 125.0, 144.0, 156.0, 124.0, 165.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 160.0, 159.0, 162.0, 160.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 82.0, 90.0, 70.0, 97.0, 71.0, 101.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 136.0, 93.0, 93.0, 93.0, 140.0, 92.0, 94.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.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.6}, {"lowerIsBetter": true, "replicates": [144.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 58.0, 57.0, 60.0, 58.0, 59.0, 65.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 86.0, 84.0, 85.0, 86.0, 87.0, 93.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 123.0, 115.0, 116.0, 122.0, 116.0, 125.0, 124.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [153.0, 154.0, 160.0, 150.0, 157.0, 139.0, 151.0, 151.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 67.0, 67.0, 66.0, 71.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1501.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "Richards", "value": 212.05911400000002}, {"lowerIsBetter": false, "replicates": [188.85741265344666], "unit": "score", "name": "DeltaBlue", "value": 350.09481000000017}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12469.135802469136], "unit": "score", "name": "Boyer", "value": 53.449012871287174}, {"lowerIsBetter": false, "replicates": [26315.78947368421], "unit": "score", "name": "RegExp", "value": 34.61742999999998}, {"lowerIsBetter": false, "replicates": [580.3830528148578], "unit": "score", "name": "Splay", "value": 140.40899300000004}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19848.414964511976}]} 23:14:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19848.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1501.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6932.69"}}} 23:14:32 INFO - Return code: 0 23:14:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:32 INFO - # TBPL SUCCESS # 23:14:32 INFO - Running post-action listener: _resource_record_post_action 23:14:32 INFO - Running post-run listener: _resource_record_post_run 23:14:33 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 16384; Write bytes: 558039040; Read time: 304; Write time: 690220 23:14:33 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 242421760; Read time: 104; Write time: 429660 23:14:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 12288; Write bytes: 311607296; Read time: 200; Write time: 259636 23:14:33 INFO - Running post-run listener: _upload_blobber_files 23:14:33 INFO - Blob upload gear active. 23:14:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:14:34 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 23:14:34 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:14:34 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:14:34 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:14:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:14:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:35 INFO - (blobuploader) - INFO - Done attempting. 23:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:14:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:35 INFO - (blobuploader) - INFO - Done attempting. 23:14:35 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:35 INFO - Return code: 0 23:14:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:14:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/57c0ce4c2d88ea95e1d997c9a878da4484f65867f9cf270ac76023af4f35b9bfe398a7b18a3e1f311bf34f561a3ba98bc8a995d946b419b046215c7817463833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dcc6d70ac61d6bc77895f6f2fef20ab7458129463f9fafa4113d62266239abae195b181c7013a7253373f22123aa12ed36e523855e9c5fe967b6bf5ab8e84e16"} 23:14:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:14:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:14:36 INFO - Contents: 23:14:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/57c0ce4c2d88ea95e1d997c9a878da4484f65867f9cf270ac76023af4f35b9bfe398a7b18a3e1f311bf34f561a3ba98bc8a995d946b419b046215c7817463833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dcc6d70ac61d6bc77895f6f2fef20ab7458129463f9fafa4113d62266239abae195b181c7013a7253373f22123aa12ed36e523855e9c5fe967b6bf5ab8e84e16"} 23:14:36 INFO - Copying logs to upload dir... 23:14:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.353940 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 23:14:35.624817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 23:14:35.628470) ========= 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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/57c0ce4c2d88ea95e1d997c9a878da4484f65867f9cf270ac76023af4f35b9bfe398a7b18a3e1f311bf34f561a3ba98bc8a995d946b419b046215c7817463833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dcc6d70ac61d6bc77895f6f2fef20ab7458129463f9fafa4113d62266239abae195b181c7013a7253373f22123aa12ed36e523855e9c5fe967b6bf5ab8e84e16"} build_url:https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/K3896e9cRX-6046Fw_cfeg/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/B2G-Inbound/sha512/57c0ce4c2d88ea95e1d997c9a878da4484f65867f9cf270ac76023af4f35b9bfe398a7b18a3e1f311bf34f561a3ba98bc8a995d946b419b046215c7817463833", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dcc6d70ac61d6bc77895f6f2fef20ab7458129463f9fafa4113d62266239abae195b181c7013a7253373f22123aa12ed36e523855e9c5fe967b6bf5ab8e84e16"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 23:14:35.653946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 23:14:35.654288) ========= 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=3cd289541638898829117e0a000001bd-1450851102.610636-2084109839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 23:14:35.738112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 23:14:35.738818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 23:14:35.739559) ========= ========= Total master_lag: 0.25 =========