builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1452635184.63 results: success (0) buildid: 20160112113017 builduid: b2734df4b3264bb3a99c2667696c6fb4 revision: bd7e3757ddd115826a660f444d07075b72cb6b39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.628515) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.628900) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.629190) ========= 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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004101 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.668374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.668659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.710999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.711274) ========= 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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021249 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.757723) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.758004) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.758360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.758624) ========= 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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 13:46:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-12 13:46:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187442 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.958035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:24.958355) ========= 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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.078873 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:25.049704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 13:46:25.050044) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev bd7e3757ddd115826a660f444d07075b72cb6b39 --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 bd7e3757ddd115826a660f444d07075b72cb6b39 --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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 13:46:25,235 truncating revision to first 12 chars 2016-01-12 13:46:25,235 Setting DEBUG logging. 2016-01-12 13:46:25,235 attempt 1/10 2016-01-12 13:46:25,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/bd7e3757ddd1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 13:46:26,574 unpacking tar archive at: b2g-inbound-bd7e3757ddd1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.653158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 13:46:26.716948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:26.717277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:26.725891) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:26.726161) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 13:46:26.726640) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-12 13:46:26.727032) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --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', '--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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:46:27 INFO - MultiFileLogger online at 20160112 13:46:27 in /builds/slave/test-pgo 13:46:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 13:46:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:46:27 INFO - {'append_to_log': False, 13:46:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:46:27 INFO - 'blob_upload_branch': 'B2G-Inbound', 13:46:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:46:27 INFO - 'branch': 'B2G-Inbound', 13:46:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:46:27 INFO - 'config_files': ('talos/linux_config.py',), 13:46:27 INFO - 'default_actions': ('clobber', 13:46:27 INFO - 'read-buildbot-config', 13:46:27 INFO - 'download-and-extract', 13:46:27 INFO - 'populate-webroot', 13:46:27 INFO - 'create-virtualenv', 13:46:27 INFO - 'install', 13:46:27 INFO - 'run-tests'), 13:46:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:46:27 INFO - 'download_minidump_stackwalk': True, 13:46:27 INFO - 'download_symbols': 'ondemand', 13:46:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:46:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:46:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:46:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:46:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:46:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:46:27 INFO - 'installer_path': 'installer.exe', 13:46:27 INFO - 'log_level': 'info', 13:46:27 INFO - 'log_name': 'talos', 13:46:27 INFO - 'log_to_console': True, 13:46:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:46:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:46:27 INFO - 'opt_config_files': (), 13:46:27 INFO - 'pip_index': False, 13:46:27 INFO - 'sps_profile': False, 13:46:27 INFO - 'sps_profile_interval': 0, 13:46:27 INFO - 'suite': 'dromaeojs', 13:46:27 INFO - 'system_bits': '32', 13:46:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:46:27 INFO - 'title': 'talos-linux64-ix-018', 13:46:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:46:27 INFO - 'use_talos_json': True, 13:46:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:46:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:46:27 INFO - 'work_dir': 'build'} 13:46:27 INFO - ##### 13:46:27 INFO - ##### Running clobber step. 13:46:27 INFO - ##### 13:46:27 INFO - Running pre-action listener: _resource_record_pre_action 13:46:27 INFO - Running main action method: clobber 13:46:27 INFO - rmtree: /builds/slave/test-pgo/build 13:46:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:46:31 INFO - Running post-action listener: _resource_record_post_action 13:46:31 INFO - ##### 13:46:31 INFO - ##### Running read-buildbot-config step. 13:46:31 INFO - ##### 13:46:31 INFO - Running pre-action listener: _resource_record_pre_action 13:46:31 INFO - Running main action method: read_buildbot_config 13:46:31 INFO - Using buildbot properties: 13:46:31 INFO - { 13:46:31 INFO - "project": "", 13:46:31 INFO - "product": "firefox", 13:46:31 INFO - "script_repo_revision": "production", 13:46:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 13:46:31 INFO - "repository": "", 13:46:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 13:46:31 INFO - "buildid": "20160112113017", 13:46:31 INFO - "pgo_build": "True", 13:46:31 INFO - "basedir": "/builds/slave/test-pgo", 13:46:31 INFO - "buildnumber": 1105, 13:46:31 INFO - "slavename": "talos-linux64-ix-018", 13:46:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:46:31 INFO - "platform": "ubuntu64_hw", 13:46:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 13:46:31 INFO - "branch": "b2g-inbound", 13:46:31 INFO - "repo_path": "integration/b2g-inbound", 13:46:31 INFO - "revision": "bd7e3757ddd115826a660f444d07075b72cb6b39", 13:46:31 INFO - "stage_platform": "linux64-pgo", 13:46:31 INFO - "builduid": "b2734df4b3264bb3a99c2667696c6fb4", 13:46:31 INFO - "slavebuilddir": "test" 13:46:31 INFO - } 13:46:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:46:31 INFO - Running post-action listener: _resource_record_post_action 13:46:31 INFO - ##### 13:46:31 INFO - ##### Running download-and-extract step. 13:46:31 INFO - ##### 13:46:31 INFO - Running pre-action listener: _resource_record_pre_action 13:46:31 INFO - Running main action method: download_and_extract 13:46:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:46:31 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')]} 13:46:31 INFO - https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/test_packages.json 13:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/test_packages.json 13:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:46:32 INFO - Downloaded 1302 bytes. 13:46:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:46:32 INFO - Using the following test package requirements: 13:46:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:46:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:46:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:46:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:46:32 INFO - u'jsshell-linux-x86_64.zip'], 13:46:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:46:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:46:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:46:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:46:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:46:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:46:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:46:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:46:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:46:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:46:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:46:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:46:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:46:32 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')]} 13:46:32 INFO - https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:46:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:46:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:46:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:35 INFO - Downloaded 24027046 bytes. 13:46: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 13:46:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:46: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 13:46:37 INFO - Return code: 0 13:46:37 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 13:46: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')]} 13:46:37 INFO - https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:40 INFO - Downloaded 24027046 bytes. 13:46:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:46:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:46:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:46:41 INFO - Return code: 0 13:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:41 INFO - https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:43 INFO - Downloaded 11132285 bytes. 13:46:43 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 13:46:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:46:43 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 13:46:44 INFO - Return code: 0 13:46:44 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')]} 13:46:44 INFO - https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:46:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:46:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:46:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuTjuzZTMGjM77CDz7zxg/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 13:46:48 INFO - Downloaded 55725555 bytes. 13:46:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:46:48 INFO - mkdir: /builds/slave/test-pgo/properties 13:46:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:46:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:46:48 INFO - Contents: 13:46:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:46:48 INFO - Running post-action listener: _resource_record_post_action 13:46:48 INFO - Running post-action listener: set_extra_try_arguments 13:46:48 INFO - ##### 13:46:48 INFO - ##### Running populate-webroot step. 13:46:48 INFO - ##### 13:46:48 INFO - Running pre-action listener: _resource_record_pre_action 13:46:48 INFO - Running main action method: populate_webroot 13:46:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:46:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:46:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:46:48 INFO - '--tppagecycles', 13:46:48 INFO - '7'], 13:46:48 INFO - 'tests': ['tsvgm']}}, 13:46:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:46:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:46:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:46:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:46:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:46:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:46:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'tests': ['damp', 'tps']}, 13:46:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['damp', 'tps']}, 13:46:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:46:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:46:48 INFO - 'other': {'tests': ['a11yr', 13:46:48 INFO - 'ts_paint', 13:46:48 INFO - 'tpaint', 13:46:48 INFO - 'sessionrestore', 13:46:48 INFO - 'sessionrestore_no_auto_restore']}, 13:46:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['a11yr', 13:46:48 INFO - 'ts_paint', 13:46:48 INFO - 'tpaint', 13:46:48 INFO - 'sessionrestore', 13:46:48 INFO - 'sessionrestore_no_auto_restore']}, 13:46:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['a11yr', 13:46:48 INFO - 'ts_paint', 13:46:48 INFO - 'tpaint', 13:46:48 INFO - 'sessionrestore', 13:46:48 INFO - 'sessionrestore_no_auto_restore']}, 13:46:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['a11yr', 13:46:48 INFO - 'ts_paint', 13:46:48 INFO - 'tpaint', 13:46:48 INFO - 'sessionrestore', 13:46:48 INFO - 'sessionrestore_no_auto_restore']}, 13:46:48 INFO - 'other_l64': {'tests': ['a11yr', 13:46:48 INFO - 'ts_paint', 13:46:48 INFO - 'tpaint', 13:46:48 INFO - 'sessionrestore', 13:46:48 INFO - 'sessionrestore_no_auto_restore']}, 13:46:48 INFO - 'other_nol64': {'tests': ['a11yr', 13:46:48 INFO - 'ts_paint', 13:46:48 INFO - 'tpaint', 13:46:48 INFO - 'sessionrestore', 13:46:48 INFO - 'sessionrestore_no_auto_restore']}, 13:46:48 INFO - 'svgr': {'tests': ['tsvgx', 13:46:48 INFO - 'tsvgr_opacity', 13:46:48 INFO - 'tart', 13:46:48 INFO - 'tscrollx', 13:46:48 INFO - 'cart']}, 13:46:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['tsvgx', 13:46:48 INFO - 'tsvgr_opacity', 13:46:48 INFO - 'tart', 13:46:48 INFO - 'tscrollx', 13:46:48 INFO - 'cart']}, 13:46:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'tests': ['tp5o']}, 13:46:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'talos_options': ['--e10s'], 13:46:48 INFO - 'tests': ['tp5o']}, 13:46:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'talos_options': ['--xperf_path', 13:46:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:46:48 INFO - 'tests': ['tp5n']}, 13:46:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:46:48 INFO - 'talos_options': ['--e10s', 13:46:48 INFO - '--xperf_path', 13:46:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:46:48 INFO - 'tests': ['tp5n']}}, 13:46:48 INFO - 'talos.zip': {'path': '', 13:46:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:46:48 INFO - Running post-action listener: _resource_record_post_action 13:46:48 INFO - ##### 13:46:48 INFO - ##### Running create-virtualenv step. 13:46:48 INFO - ##### 13:46:48 INFO - Running pre-action listener: _resource_record_pre_action 13:46:48 INFO - Running main action method: create_virtualenv 13:46:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:46:48 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 13:46:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:46:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:46:48 INFO - Using real prefix '/usr' 13:46:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:46:49 INFO - Installing distribute.............................................................................................................................................................................................done. 13:46:51 INFO - Installing pip.................done. 13:46:51 INFO - Return code: 0 13:46:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:46:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:46:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:46:51 INFO - Using env: {'DISPLAY': ':0', 13:46:51 INFO - 'HOME': '/home/cltbld', 13:46:51 INFO - 'LANG': 'en_US.UTF-8', 13:46:51 INFO - 'LANGUAGE': 'en_US:en', 13:46:51 INFO - 'LOGNAME': 'cltbld', 13:46:51 INFO - 'MAIL': '/var/mail/cltbld', 13:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:51 INFO - 'MOZ_NO_REMOTE': '1', 13:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:51 INFO - 'NO_EM_RESTART': '1', 13:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:51 INFO - 'SHELL': '/bin/bash', 13:46:51 INFO - 'SHLVL': '1', 13:46:51 INFO - 'TERM': 'linux', 13:46:51 INFO - 'TMOUT': '86400', 13:46:51 INFO - 'USER': 'cltbld', 13:46:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:51 INFO - '_': '/tools/buildbot/bin/python'} 13:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:52 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 13:46:52 INFO - Cleaning up... 13:46:52 INFO - Return code: 0 13:46:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:46:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:46:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:46:52 INFO - Using env: {'DISPLAY': ':0', 13:46:52 INFO - 'HOME': '/home/cltbld', 13:46:52 INFO - 'LANG': 'en_US.UTF-8', 13:46:52 INFO - 'LANGUAGE': 'en_US:en', 13:46:52 INFO - 'LOGNAME': 'cltbld', 13:46:52 INFO - 'MAIL': '/var/mail/cltbld', 13:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:52 INFO - 'MOZ_NO_REMOTE': '1', 13:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:52 INFO - 'NO_EM_RESTART': '1', 13:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:52 INFO - 'SHELL': '/bin/bash', 13:46:52 INFO - 'SHLVL': '1', 13:46:52 INFO - 'TERM': 'linux', 13:46:52 INFO - 'TMOUT': '86400', 13:46:52 INFO - 'USER': 'cltbld', 13:46:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:52 INFO - '_': '/tools/buildbot/bin/python'} 13:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:52 INFO - Downloading/unpacking psutil>=0.7.1 13:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:46:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:46:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:46:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:46:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:46:54 INFO - Installing collected packages: psutil 13:46:54 INFO - Running setup.py install for psutil 13:46:54 INFO - building 'psutil._psutil_linux' extension 13:46:54 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 13:46:55 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 13:46:55 INFO - building 'psutil._psutil_posix' extension 13:46:55 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 13:46:55 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 13:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:46:55 INFO - Successfully installed psutil 13:46:55 INFO - Cleaning up... 13:46:55 INFO - Return code: 0 13:46:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:46:55 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')]} 13:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:55 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')]} 13:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:55 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 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:46:55 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 13:46:55 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 13:46:55 INFO - Using env: {'DISPLAY': ':0', 13:46:55 INFO - 'HOME': '/home/cltbld', 13:46:55 INFO - 'LANG': 'en_US.UTF-8', 13:46:55 INFO - 'LANGUAGE': 'en_US:en', 13:46:55 INFO - 'LOGNAME': 'cltbld', 13:46:55 INFO - 'MAIL': '/var/mail/cltbld', 13:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:55 INFO - 'MOZ_NO_REMOTE': '1', 13:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:55 INFO - 'NO_EM_RESTART': '1', 13:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:55 INFO - 'SHELL': '/bin/bash', 13:46:55 INFO - 'SHLVL': '1', 13:46:55 INFO - 'TERM': 'linux', 13:46:55 INFO - 'TMOUT': '86400', 13:46:55 INFO - 'USER': 'cltbld', 13:46:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:55 INFO - '_': '/tools/buildbot/bin/python'} 13:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:46:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:46:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:46:58 INFO - Installing collected packages: mozsystemmonitor 13:46:58 INFO - Running setup.py install for mozsystemmonitor 13:46:58 INFO - Successfully installed mozsystemmonitor 13:46:58 INFO - Cleaning up... 13:46:58 INFO - Return code: 0 13:46:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:46:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:46:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:46:58 INFO - Using env: {'DISPLAY': ':0', 13:46:58 INFO - 'HOME': '/home/cltbld', 13:46:58 INFO - 'LANG': 'en_US.UTF-8', 13:46:58 INFO - 'LANGUAGE': 'en_US:en', 13:46:58 INFO - 'LOGNAME': 'cltbld', 13:46:58 INFO - 'MAIL': '/var/mail/cltbld', 13:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:58 INFO - 'MOZ_NO_REMOTE': '1', 13:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:58 INFO - 'NO_EM_RESTART': '1', 13:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:58 INFO - 'SHELL': '/bin/bash', 13:46:58 INFO - 'SHLVL': '1', 13:46:58 INFO - 'TERM': 'linux', 13:46:58 INFO - 'TMOUT': '86400', 13:46:58 INFO - 'USER': 'cltbld', 13:46:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:58 INFO - '_': '/tools/buildbot/bin/python'} 13:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:00 INFO - Downloading blobuploader-1.2.4.tar.gz 13:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:47:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:47:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:01 INFO - Downloading docopt-0.6.1.tar.gz 13:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:47:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:47:01 INFO - Running setup.py install for blobuploader 13:47:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:47:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:47:01 INFO - Running setup.py install for requests 13:47:01 INFO - Running setup.py install for docopt 13:47:01 INFO - Successfully installed blobuploader requests docopt 13:47:01 INFO - Cleaning up... 13:47:01 INFO - Return code: 0 13:47:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:47:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:47:01 INFO - Using env: {'DISPLAY': ':0', 13:47:01 INFO - 'HOME': '/home/cltbld', 13:47:01 INFO - 'LANG': 'en_US.UTF-8', 13:47:01 INFO - 'LANGUAGE': 'en_US:en', 13:47:01 INFO - 'LOGNAME': 'cltbld', 13:47:01 INFO - 'MAIL': '/var/mail/cltbld', 13:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:01 INFO - 'MOZ_NO_REMOTE': '1', 13:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:01 INFO - 'NO_EM_RESTART': '1', 13:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:01 INFO - 'SHELL': '/bin/bash', 13:47:01 INFO - 'SHLVL': '1', 13:47:01 INFO - 'TERM': 'linux', 13:47:01 INFO - 'TMOUT': '86400', 13:47:01 INFO - 'USER': 'cltbld', 13:47:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:01 INFO - '_': '/tools/buildbot/bin/python'} 13:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:47:02 INFO - Running setup.py (path:/tmp/pip-TIpyYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:47:02 INFO - Running setup.py (path:/tmp/pip-eAmyZK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:47:02 INFO - Running setup.py (path:/tmp/pip-4V7scK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:47:02 INFO - Running setup.py (path:/tmp/pip-PJ1GBX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:47:02 INFO - Running setup.py (path:/tmp/pip-Lrm6fm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:47:02 INFO - Running setup.py (path:/tmp/pip-Rx5pSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:47:02 INFO - Running setup.py (path:/tmp/pip-5DG5wj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:47:02 INFO - Running setup.py (path:/tmp/pip-VGQTkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:47:02 INFO - Running setup.py (path:/tmp/pip-kiLk6T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:47:02 INFO - Running setup.py (path:/tmp/pip-rYXXyY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:47:02 INFO - Running setup.py (path:/tmp/pip-oTL1tR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:47:02 INFO - Running setup.py (path:/tmp/pip-_a9PC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:47:03 INFO - Running setup.py (path:/tmp/pip-WfE1us-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:47:03 INFO - Running setup.py (path:/tmp/pip-ddYWr3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:47:03 INFO - Running setup.py (path:/tmp/pip-wtzAMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:47:03 INFO - Running setup.py (path:/tmp/pip-dhnCxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:47:03 INFO - Running setup.py (path:/tmp/pip-48PL1F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:47:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:47:03 INFO - Running setup.py install for manifestparser 13:47:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:47:03 INFO - Running setup.py install for mozcrash 13:47:03 INFO - Running setup.py install for mozdebug 13:47:03 INFO - Running setup.py install for mozdevice 13:47:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:47:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:47:03 INFO - Running setup.py install for mozfile 13:47:03 INFO - Running setup.py install for mozhttpd 13:47:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:47:03 INFO - Running setup.py install for mozinfo 13:47:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Running setup.py install for mozInstall 13:47:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Running setup.py install for mozleak 13:47:04 INFO - Running setup.py install for mozlog 13:47:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Running setup.py install for moznetwork 13:47:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Running setup.py install for mozprocess 13:47:04 INFO - Running setup.py install for mozprofile 13:47:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Running setup.py install for mozrunner 13:47:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:47:04 INFO - Running setup.py install for mozscreenshot 13:47:04 INFO - Running setup.py install for moztest 13:47:05 INFO - Running setup.py install for mozversion 13:47:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:47:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:47:05 INFO - Cleaning up... 13:47:05 INFO - Return code: 0 13:47:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:47:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 13:47:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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 13:47:05 INFO - Using env: {'DISPLAY': ':0', 13:47:05 INFO - 'HOME': '/home/cltbld', 13:47:05 INFO - 'LANG': 'en_US.UTF-8', 13:47:05 INFO - 'LANGUAGE': 'en_US:en', 13:47:05 INFO - 'LOGNAME': 'cltbld', 13:47:05 INFO - 'MAIL': '/var/mail/cltbld', 13:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:05 INFO - 'MOZ_NO_REMOTE': '1', 13:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:05 INFO - 'NO_EM_RESTART': '1', 13:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:05 INFO - 'SHELL': '/bin/bash', 13:47:05 INFO - 'SHLVL': '1', 13:47:05 INFO - 'TERM': 'linux', 13:47:05 INFO - 'TMOUT': '86400', 13:47:05 INFO - 'USER': 'cltbld', 13:47:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:05 INFO - '_': '/tools/buildbot/bin/python'} 13:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:47:05 INFO - Running setup.py (path:/tmp/pip-phuKWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:47:05 INFO - Running setup.py (path:/tmp/pip-T2mew8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:47:05 INFO - Running setup.py (path:/tmp/pip-kbwIDQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:47:05 INFO - Running setup.py (path:/tmp/pip-yZ3yXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:47:05 INFO - Running setup.py (path:/tmp/pip-9sIhMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:47:05 INFO - Running setup.py (path:/tmp/pip-SK_siP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:47:05 INFO - Running setup.py (path:/tmp/pip-GveGkI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:47:05 INFO - Running setup.py (path:/tmp/pip-N0rSMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:47:05 INFO - Running setup.py (path:/tmp/pip-rwEZGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:47:06 INFO - Running setup.py (path:/tmp/pip-X8fYd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:47:06 INFO - Running setup.py (path:/tmp/pip-GTnd0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:47:06 INFO - Running setup.py (path:/tmp/pip-iXgkeb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:47:06 INFO - Running setup.py (path:/tmp/pip-X2dOyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:47:06 INFO - Running setup.py (path:/tmp/pip-F1gg7j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:47:06 INFO - Running setup.py (path:/tmp/pip-tVQP1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:47:06 INFO - Running setup.py (path:/tmp/pip-QcVrj7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:47:06 INFO - Running setup.py (path:/tmp/pip-02j8Ke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:47:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:08 INFO - Downloading blessings-1.5.1.tar.gz 13:47:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:47:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:47:08 INFO - Installing collected packages: blessings 13:47:08 INFO - Running setup.py install for blessings 13:47:08 INFO - Successfully installed blessings 13:47:08 INFO - Cleaning up... 13:47:08 INFO - Return code: 0 13:47:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:47:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:47:08 INFO - Reading from file tmpfile_stdout 13:47:08 INFO - Current package versions: 13:47:08 INFO - argparse == 1.2.1 13:47:08 INFO - blessings == 1.5.1 13:47:08 INFO - blobuploader == 1.2.4 13:47:08 INFO - docopt == 0.6.1 13:47:08 INFO - manifestparser == 1.1 13:47:08 INFO - mozInstall == 1.12 13:47:08 INFO - mozcrash == 0.16 13:47:08 INFO - mozdebug == 0.1 13:47:08 INFO - mozdevice == 0.47 13:47:08 INFO - mozfile == 1.2 13:47:08 INFO - mozhttpd == 0.7 13:47:08 INFO - mozinfo == 0.9 13:47:08 INFO - mozleak == 0.1 13:47:08 INFO - mozlog == 3.1 13:47:08 INFO - moznetwork == 0.27 13:47:08 INFO - mozprocess == 0.22 13:47:08 INFO - mozprofile == 0.28 13:47:08 INFO - mozrunner == 6.11 13:47:08 INFO - mozscreenshot == 0.1 13:47:08 INFO - mozsystemmonitor == 0.0 13:47:08 INFO - moztest == 0.7 13:47:08 INFO - mozversion == 1.4 13:47:08 INFO - psutil == 3.1.1 13:47:08 INFO - requests == 1.2.3 13:47:08 INFO - wsgiref == 0.1.2 13:47:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:47:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:47:08 INFO - Using env: {'DISPLAY': ':0', 13:47:08 INFO - 'HOME': '/home/cltbld', 13:47:08 INFO - 'LANG': 'en_US.UTF-8', 13:47:08 INFO - 'LANGUAGE': 'en_US:en', 13:47:08 INFO - 'LOGNAME': 'cltbld', 13:47:08 INFO - 'MAIL': '/var/mail/cltbld', 13:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:08 INFO - 'MOZ_NO_REMOTE': '1', 13:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:08 INFO - 'NO_EM_RESTART': '1', 13:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:08 INFO - 'SHELL': '/bin/bash', 13:47:08 INFO - 'SHLVL': '1', 13:47:08 INFO - 'TERM': 'linux', 13:47:08 INFO - 'TMOUT': '86400', 13:47:08 INFO - 'USER': 'cltbld', 13:47:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:08 INFO - '_': '/tools/buildbot/bin/python'} 13:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:47:08 INFO - Cleaning up... 13:47:08 INFO - Return code: 0 13:47:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:47:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:47:08 INFO - Using env: {'DISPLAY': ':0', 13:47:08 INFO - 'HOME': '/home/cltbld', 13:47:08 INFO - 'LANG': 'en_US.UTF-8', 13:47:08 INFO - 'LANGUAGE': 'en_US:en', 13:47:08 INFO - 'LOGNAME': 'cltbld', 13:47:08 INFO - 'MAIL': '/var/mail/cltbld', 13:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:08 INFO - 'MOZ_NO_REMOTE': '1', 13:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:08 INFO - 'NO_EM_RESTART': '1', 13:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:08 INFO - 'SHELL': '/bin/bash', 13:47:08 INFO - 'SHLVL': '1', 13:47:08 INFO - 'TERM': 'linux', 13:47:08 INFO - 'TMOUT': '86400', 13:47:08 INFO - 'USER': 'cltbld', 13:47:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:08 INFO - '_': '/tools/buildbot/bin/python'} 13:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:09 INFO - Downloading/unpacking jsonschema 13:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:47:10 INFO - Downloading/unpacking functools32 (from jsonschema) 13:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:47:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:47:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:47:11 INFO - warning: no files found matching '*.txt' 13:47:11 INFO - no previously-included directories found matching 'build' 13:47:11 INFO - no previously-included directories found matching 'dist' 13:47:11 INFO - no previously-included directories found matching '.git*' 13:47:11 INFO - Installing collected packages: jsonschema, functools32 13:47:11 INFO - Running setup.py install for functools32 13:47:11 INFO - warning: no files found matching '*.txt' 13:47:11 INFO - no previously-included directories found matching 'build' 13:47:11 INFO - no previously-included directories found matching 'dist' 13:47:11 INFO - no previously-included directories found matching '.git*' 13:47:11 INFO - Successfully installed jsonschema functools32 13:47:11 INFO - Cleaning up... 13:47:11 INFO - Return code: 0 13:47:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd040364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1976630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', '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 13:47:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:47:11 INFO - Using env: {'DISPLAY': ':0', 13:47:11 INFO - 'HOME': '/home/cltbld', 13:47:11 INFO - 'LANG': 'en_US.UTF-8', 13:47:11 INFO - 'LANGUAGE': 'en_US:en', 13:47:11 INFO - 'LOGNAME': 'cltbld', 13:47:11 INFO - 'MAIL': '/var/mail/cltbld', 13:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:11 INFO - 'MOZ_NO_REMOTE': '1', 13:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:11 INFO - 'NO_EM_RESTART': '1', 13:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:11 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:11 INFO - 'SHELL': '/bin/bash', 13:47:11 INFO - 'SHLVL': '1', 13:47:11 INFO - 'TERM': 'linux', 13:47:11 INFO - 'TMOUT': '86400', 13:47:11 INFO - 'USER': 'cltbld', 13:47:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:11 INFO - '_': '/tools/buildbot/bin/python'} 13:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:11 INFO - Downloading/unpacking flake8 13:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:47:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:47:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:47:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:47:13 INFO - no previously-included directories found matching 'docs/_build' 13:47:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:47:14 INFO - Running setup.py install for pep8 13:47:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:47:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:47:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:47:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:47:14 INFO - no previously-included directories found matching 'docs/_build' 13:47:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:47:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:47:14 INFO - Cleaning up... 13:47:14 INFO - Return code: 0 13:47:14 INFO - Running post-action listener: _resource_record_post_action 13:47:14 INFO - Running post-action listener: _start_resource_monitoring 13:47:14 INFO - Starting resource monitoring. 13:47:14 INFO - ##### 13:47:14 INFO - ##### Running install step. 13:47:14 INFO - ##### 13:47:14 INFO - Running pre-action listener: _resource_record_pre_action 13:47:14 INFO - Running main action method: install 13:47:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:47:14 INFO - Reading from file tmpfile_stdout 13:47:14 INFO - Detecting whether we're running mozinstall >=1.0... 13:47:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:47:14 INFO - Reading from file tmpfile_stdout 13:47:14 INFO - Output received: 13:47:14 INFO - Usage: mozinstall [options] installer 13:47:14 INFO - Options: 13:47:14 INFO - -h, --help show this help message and exit 13:47:14 INFO - -d DEST, --destination=DEST 13:47:14 INFO - Directory to install application into. [default: 13:47:14 INFO - "/builds/slave/test-pgo"] 13:47:14 INFO - --app=APP Application being installed. [default: firefox] 13:47:14 INFO - mkdir: /builds/slave/test-pgo/build/application 13:47:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:47:30 INFO - Reading from file tmpfile_stdout 13:47:30 INFO - Output received: 13:47:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:47:30 INFO - Running post-action listener: _resource_record_post_action 13:47:30 INFO - ##### 13:47:30 INFO - ##### Running run-tests step. 13:47:30 INFO - ##### 13:47:30 INFO - Running pre-action listener: _resource_record_pre_action 13:47:30 INFO - Running main action method: run_tests 13:47:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:47:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:47:30 INFO - Python 2.7.3 13:47:30 INFO - Return code: 0 13:47:30 INFO - grabbing minidump binary from tooltool 13:47: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')]} 13:47:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a07840>, '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 0x19746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:47:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:47:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:47:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:47:30 INFO - Return code: 0 13:47:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:47:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:47:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:47:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:47:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:47:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:47:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:47:31 INFO - Return code: 0 13:47:31 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/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:47:31 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/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 13:47:31 INFO - Using env: {'DISPLAY': ':0', 13:47:31 INFO - 'HOME': '/home/cltbld', 13:47:31 INFO - 'LANG': 'en_US.UTF-8', 13:47:31 INFO - 'LANGUAGE': 'en_US:en', 13:47:31 INFO - 'LOGNAME': 'cltbld', 13:47:31 INFO - 'MAIL': '/var/mail/cltbld', 13:47:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:47:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:31 INFO - 'MOZ_NO_REMOTE': '1', 13:47:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:31 INFO - 'NO_EM_RESTART': '1', 13:47:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:31 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:47:31 INFO - 'SHELL': '/bin/bash', 13:47:31 INFO - 'SHLVL': '1', 13:47:31 INFO - 'TERM': 'linux', 13:47:31 INFO - 'TMOUT': '86400', 13:47:31 INFO - 'USER': 'cltbld', 13:47:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377', 13:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:31 INFO - '_': '/tools/buildbot/bin/python'} 13:47:31 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/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:47:31 INFO - mozversion application_buildid: 20160112113017 13:47:31 INFO - mozversion application_changeset: bd7e3757ddd115826a660f444d07075b72cb6b39 13:47:31 INFO - mozversion application_display_name: Nightly 13:47:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:47:31 INFO - mozversion application_name: Firefox 13:47:31 INFO - mozversion application_remotingname: firefox 13:47:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:47:31 INFO - mozversion application_vendor: Mozilla 13:47:31 INFO - mozversion application_version: 46.0a1 13:47:31 INFO - mozversion platform_buildid: 20160112113017 13:47:31 INFO - mozversion platform_changeset: bd7e3757ddd115826a660f444d07075b72cb6b39 13:47:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:47:31 INFO - mozversion platform_version: 46.0a1 13:47:31 INFO - using testdate: 1452635251 13:47:31 INFO - actual date: 1452635251 13:47:31 INFO - starting webserver on 'localhost:38851' 13:47:31 INFO - SUITE-START | Running 3 tests 13:47:31 INFO - TEST-START | dromaeo_css 13:47:31 INFO - operating with platform_type : linux_ 13:47:31 INFO - Initialising browser for dromaeo_css test... 13:47:31 INFO - TEST-INFO | started process 3299 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_vWIUy/profile http://localhost:38851/getInfo.html) 13:47:38 INFO - PROCESS | 3299 | __metrics Screen width/height:1600/1200 13:47:38 INFO - PROCESS | 3299 | colorDepth:24 13:47:38 INFO - PROCESS | 3299 | Browser inner width/height: 1024/697 13:47:38 INFO - PROCESS | 3299 | __metrics 13:47:38 INFO - PROCESS | 3299 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:47:38 INFO - PROCESS | 3299 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:47:39 INFO - TEST-INFO | 3299: exit 0 13:47:39 INFO - Browser initialized. 13:47:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:47:39 INFO - TEST-INFO | started process 3391 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_vWIUy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:47:51 INFO - PROCESS | 3391 | RSS: Main: 148303872 13:47:51 INFO - PROCESS | 3391 | 13:48:42 INFO - PROCESS | 3391 | 1452635322899 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] 13:50:51 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38851/tests/dromaeo/cssquery-ext.html) 13:50:52 INFO - PROCESS | 3391 | RSS: Main: 229113856 13:50:52 INFO - PROCESS | 3391 | 13:53:54 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-ext.html (next: http://localhost:38851/tests/dromaeo/cssquery-jquery.html) 13:53:55 INFO - PROCESS | 3391 | RSS: Main: 228913152 13:53:55 INFO - PROCESS | 3391 | 13:56:57 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38851/tests/dromaeo/cssquery-mootools.html) 13:56:57 INFO - PROCESS | 3391 | RSS: Main: 236261376 13:56:57 INFO - PROCESS | 3391 | 13:59:59 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38851/tests/dromaeo/cssquery-prototype.html) 14:00:00 INFO - PROCESS | 3391 | RSS: Main: 210927616 14:00:00 INFO - PROCESS | 3391 | 14:03:02 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38851/tests/dromaeo/cssquery-yui.html) 14:03:03 INFO - PROCESS | 3391 | RSS: Main: 215023616 14:03:03 INFO - PROCESS | 3391 | 14:06:05 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-yui.html (next: http://localhost:38851/tests/dromaeo/cssquery-dojo.html) 14:06:06 INFO - PROCESS | 3391 | RSS: Main: 229957632 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | __start_tp_report 14:06:06 INFO - PROCESS | 3391 | _x_x_mozilla_page_load 14:06:06 INFO - PROCESS | 3391 | _x_x_mozilla_page_load_details 14:06:06 INFO - PROCESS | 3391 | |i|pagename|runs| 14:06:06 INFO - PROCESS | 3391 | |0;dojo.html;3103.317270200556;3142.088794249668;3172.349668317995;3183.8089714617126;3212.389645967266;5089.770960306786;5203.687778733279;5208.296879921209;5216.061109000379;5255.500727430893;5190.9740451297785;5206.843794686166;5226.817061402851;5241.9213711794255;5272.499112584298;4698.506656801038;4731.66878318517;4736.242201247784;4881.658283920127;4885.389326334208;4826.276058591205;4832.951670483303;4892.3639926809465;4898.363212782333;4904.926426103593;4700.3889494365685;4757.714537127784;4767.427908650967;4825.613950883921;4846.903061938777;4771.475137734847;4791.736454495001;4793.616510679138;4797.544233297831;4811.374521312242;4751.64362672801;4783.067301876135;4790.209615413452;4799.0401919616215;4844.079624871263;5028.7737051832755;5066.746662666888;5093.898122037575;5118.07874582575;5157.871053223662;5521.641093328921;5550.611457197998;5552.250446189753;5563.970665426868;5564.1931919871795;5509.283793106911;5565.526930210896;5569.972150139264;5581.832545023656;5590.664560126364;5209.609279304067;5228.163493840967;5265.921011184835;5278.81524146653;5327.547158491533;5670.319561652628;5673.149027645886;5678.375378708339;5707.258056452634;5730.484256416942;5446.972765136149;5492.5605951523785;5496.80761173357;5496.835094947158;5522.061249587579;5591.4688104629995;5631.099024156116;5636.774529018875;5641.069223578145;5686.43135686428;5549.916751248735;5558.666480011212;5560.860978475571;5569.303837020372;5571.192177134374;5458.263134476795;5539.086050801573;5544.556435485151;5580.135079062752;5595.38450770415;4326.286162783105;4329.9134017319475;4333.133373325348;4355.15074560464;4365.410669559632;3888.8444462221196;3898.863539776094;3899.2201559688174;3918.1575961168487;3927.312720273998;5137.614678899023;5183.222516622537;5224.033553792485;5232.181801886144;5283.498067683564;5586.413426590231;5587.804426845041;5616.157576363496;5628.240187574625;5659.745311460994;5149.9742501287255;5151.6136289778415;5156.432792392834;5171.276021357013;5199.350081239845;4742.834000809955;4743.525647435298;4754.072955773591;4765.26138448541;4834.589059929875;5782.653040817564;5792.913106303493;5818.330891947396;5824.213731146326;5847.502962248256;5520.171974203901;5559.527440167631;5560.860978475571;5565.471280228372;5567.8864227155545;5644.576656750843;5679.517241034393;5686.687232202268;5766.8846623066465;5773.364929857628;5459.590530710133;5512.5314348280845;5514.420985796433;5515;5543.334799824047;5504.0643090675485;5538.861528461821;5544.61187716856;5552.222688823487;5578.135389014709;5328.626996110235;5385.380681221553;5420.241166236809;5430.375506816767;5484.862878428071;5375.193720941734;5380.865478362915;5386.8383948481605;5420.105682562491;5420.430854760351;5256.211568264791;5294.761735721825;5295.76169072385;5332.5467335276935;5344.25180474726;5432.348118225838;5454.372747134131;5511.255980442589;5517.586181036519;5584.525315348241;5371.194320851903;5376.865578360573;5384.569234461312;5395.190721391666;5420.13277875538 14:06:06 INFO - PROCESS | 3391 | |1;ext.html;532.7922110376953;535.5902734408178;558.8125233878011;560.6383882395858;573.23759399998;28394.85802570987;29038.419231615382;29066.709332906692;37186.4422033669;37845.62154378455;40299.798501007455;40639;40844.79577602108;40915.59084409155;41074;8354.164583541658;8550.10223926485;8551.914480855205;8552.444091134088;8553.529555874424;8403.159684031609;8561.357898157632;8564.78588035301;8581.52801595912;8584.484930904135;8604;8659.350548708871;8673.479591224515;8680.739577812676;8687.95656021719;8532.104129066453;8597.18326758957;8600.8709869352;8608.956955215215;8610.784730381727;8430.32557395407;8502.192291732275;8506.702265420681;8521.14788521149;8525.44584601999;39528;39867.8006609968;39942.20115597672;39970.800145999376;40143.799281003405;3047.9847600761855;3139.764517661162;3220.146661134801;3241.286916878283;3406.9488957665653;29492.262693432836;29845.552316715268;30073.398532029238;30162.396752064837;30175.03862248947;3823.1971286029966;3914.393269043303;4004.959950400517;4028.8589899353383;4073.327900896378;257642;257857;257979.99999999814;258767;259260;51917.22124168141;52709.47290527122;58754.118688219714;59069.704651476466;59119.40880591225;63095;64421.67789161024;64588.67705661536;64834;64854.351456485776;15406.383744650313;15590.922045389927;15607.297671604805;15641.608959776097;15660.530184094496;10888.618898338678;11013.063889569476;11097.611583594535;11116.722081947853;12193.207441516273;19684.70472942907;19933.103010364568;20009.299674511323;20106.497337566678;20182.293619723237;7226.205117437078;7496.7376141834775;7628.160902300742;7697.461177717506;7706.576138312446;924.2652091587204;942.3356533643764;970.9368891022061;1012.5291739341094;1024.1499555369026;28545.71454285472;28815.56776648352;28944.42111157765;29270.560941585893;29293.121206363845;1010.0202803280806;1010.5907107621425;1015.537930241753;1030.577463240083;1056.815057364958;13136.802947955788;15230.771538426932;15518;15541.611459713598;15767;331064;333875;334789;335163;335658;52078.21882671763;52813.47186528086;52814;52845.7357713209;52945;1303.882650561435;1308.2477575394187;1315.4146404849942;1318.967025824362;1319.2678063674562;28850.134495965154;29613.111606651833;29626.55560166556;29748.851255743582;30103.397932041673;41807.58192418037;43212.35181472218;46878.76560617175;47333.290000650704;49093.75453122712;208007;208286;208320;210352;210842;30299.030563013333;30684.232894177825;30750.38499229958;30865.537016944316;30869;33332.333353333284;42477.362839556816;42990.57009429991;42998.35502467403;43386.13227735491;31993;32134.35731285408;32221;32617;32976;35110.29779404448;35326.64673353233;35563.11092222715;35887.28225435529;35957.820210898775;31456.213594660316;31735.365292694478;31833.204169895937;31864.203394915312;31908.202294942814;30055.098347049625;30793.69206307998;32124.678753212167;33740.325193495504;33788.3242335147;23345.41636459102;23423.41441463977;23501;23674.763252367255;23690.407739806644 14:06:06 INFO - PROCESS | 3391 | |2;jquery.html;354.7853548603095;358.5518102372035;362.5051804287148;362.95281613390256;370.6016032764779;13457.798133028013;13560.32198390079;16371.427000054986;17076.743848842263;18287.908560457177;15709.921450392732;16273.918630406832;16704.66590668189;16714.164291785393;16813.495595132164;5163.870903227412;5326.280952071459;5350.759215835277;5352.625316227865;5357.223202635615;3895.1235971906235;4037.2329257440992;5219.269302297681;5306.283651707009;5638.830835074954;5764.769409223626;5777.59556831022;5819;5822.592418530705;5823.330317013534;5076.543111119999;5229.947700523003;5243.397009343898;5258.1849813279005;5284.920726189111;4930.235813448921;5074.06129865976;5081.872953176163;5102.260172275037;5113.309703190096;11920.165588408729;12047.578334758242;12049.638510844688;15053.849461505355;20115.899420502803;2110.1664842387327;2156.5147841735643;2167.3281282802222;2202.5815095131875;2274.8976296066717;9007.279417646638;9231.815363692689;9329.860052099224;9670.081342272473;12790.680232994157;1679.966400671992;1730.5414065272712;1750.7636469076767;1823.4620786867772;1829.2042961311872;56814.715926420104;56889.71555142239;56952.71523642397;57688.711556442366;58430;10261.9486902565;10273.537690803932;10298.691039268833;10311.587536498457;10384.740381490372;13136.40886160125;13450.394732237073;13476.304739052033;13482.460701572023;13536.59390218295;7781.338586220121;7809.45333826638;7858.764237072897;7860.528368297921;7931.682732690743;7690.538567685957;7719.459637825411;7720.691172353156;7760.650770715331;7799.103103143211;4456.68803183774;4478.57453541913;4496.820127194876;4499.605122412063;4530.161920044802;1741.6864964306294;1779.661864245789;1782.3850771483817;1881.3509339277928;1903.4004288649032;840.4999025579771;866.5060915278357;897.4749771383814;914.8307563100848;1044.3316277582353;14063.789043164361;16194.43319483836;16586.336546538245;17037.48887533376;17037.914810426115;910.0444533240204;911.3392790227165;929.4980710416299;932.1563984593953;985.2462865907586;9050.366474346733;9344.719658410258;9371.250299975985;9402.43585384879;9403.388779729295;528800;537105;538257;562179;565211;71639.28360716431;75322.62338688271;76326;76346;76428;1033.7570670892335;1057.9471026448646;1128.9096872250036;1161.8315344275034;1195.5456926367924;14395.568132956028;14428.639284017983;14597.416103356172;14767.409303628165;14926.10443373401;32938.69429139937;33104.33791324208;33451.49822752612;33881;34198;44030.779846100566;44204.11591768211;44222.33666495069;45166.32250516179;46117.53882461132;7025.262347453444;7218.953251778357;7350.338469537767;7391.741289054858;7429.702811887464;8832.381733278866;11011.504482298156;11051.889481105407;11087.889121108685;11325.71685707864;9333.25333973267;9624.470654114091;9806.362586431858;9869.228029913222;9898.455584942898;9291.396059256127;9564.234861211226;9929.751756206153;10015.39907605546;10074.14369778577;8670.739877803677;9534.856977145488;9664.9033509664;9967.700968970943;10056.849147262943;6890.2420733720255;7235.602041887747;7308.8538229234055;7390.852182956203;7427.517211381243;8399;9510.667126650535;9611.086946740048;9689.854652180364;9697.806043879224 14:06:06 INFO - PROCESS | 3391 | |3;mootools.html;1285.427984546877;1447.2980604406864;1473.933672984716;1614.2090375715902;1770.2299499717615;6976.197737260217;7398.778036658902;7445;7579.431542634297;7581.962090189541;7590.165081841007;7725.381969442446;7735.613219339039;7757.728479503218;7802.765917022484;2347.307544274435;2357.0807385119815;2357.174988753931;2359.7286312074075;2373.1100837186054;2242.6636004599277;2266.580682573721;2271.091563374655;2277.840551161419;2282.6461898405773;2211.4803021289986;2211.557688462306;2228.3426389215138;2272.0798076778847;2275.8748268845206;2290.5876942150408;2317.4206448387904;2319.9420014499606;2319.953600927972;2324.279473363246;2285.851419657717;2292.9541409171725;2294.66727324537;2296.219285442941;2296.2651951375565;7939.364850811979;7963.362930965567;7985.121636619967;7989.520628762293;7994;4755.2153894607345;4833.613310935117;4852.490488498692;4855.660103792736;4855.878603034917;3132.2326030122767;3144.9056528304186;3230;3250.6424293327714;3256.267339848539;1011.9241056920687;1019.3425240719769;1027.7430642339416;1029.469823041127;1035.6582327831798;10893;10903.29128606638;10930.344179349264;10932.726681832939;10942.343459392461;4431.933520997188;4455.465344158657;4495.887602809956;4504.662150338672;4534.0478499515475;9307.255419566418;9320.533973301443;9347.90652093484;9352.485613291334;9361.765955851159;4951.851444456672;4976.701397916137;4987.925181122286;4993.50064993505;5007.649464537448;3929.5088113985753;4046.858359957387;4376.059147283349;4488.663350248745;4568.543145685405;3850.403187505941;3851.8651847185215;3858.8456461741775;3901.902452438712;3906.2187562487616;1244.7074937389707;1249.7500499900057;1261.1865346851414;1263.9368031598383;1264.4562837979572;1298.3054066074606;1302.0560093932013;1308.3458270864567;1331.9067665263533;1345.6837643153851;7504.699812007459;7542.773716788505;7660.233976602295;7676;7679.424043196783;501.5661452843264;519.7998770473395;519.9220116982483;522.4853519283503;523.6936392210523;5671.149327600893;5685;5719.628224165499;5723.54211663066;5744.971275143681;9204.171624553823;9721.076497732704;9767.218622510181;9793.314467987173;9815.75460613476;9597.664081757104;9659.275554333453;9663.130318271249;9674.274429417681;9751.219902407933;7187.712491500281;7376.409887209011;7441.925580744231;7482.2517748224745;7569.091708994846;7002.3697867192195;7033.226345102137;7068.540544864567;7078.681459334445;7114.57312561248;8464.83070338602;8477.025142108736;8603.655853765778;8699.695510657097;8739.169778870997;8650.524221167896;9004.324675649483;9046.954765226132;9061.093890610886;9078.773030674285;5894.145348924468;6030.7889223876955;6299.559030867796;6533.67331633407;6793.592384456949;6894.620795856276;6908.3091690830515;6918.273581273894;6931;6933.895991560232;6542.509311801729;6706.6981985811735;6786.592804431552;6808.795736127924;6838.760643377458;6628.138342015507;6721.327867213239;6730.831729206613;6747.224069231905;6765.560238584476;6717.496187785838;6843;6860.794176174722;6870.484713646597;6940.583564986117;6334.018227174795;6443.194600674916;6443.935560644333;6450.41946224842;6451.096846441408;6434.195725534309;6494.383033611799;6504.9674751625935;6511.902321465276;6518.804435866931 14:06:06 INFO - PROCESS | 3391 | |4;prototype.html;339.29426792272073;341.6122700734667;345.0975698548297;349.3903139022406;351.6571342940633;5694.145878118285;5837.387074357195;5843.1527428522895;5852.151438041481;5861.384554621767;5660.377358490563;5796.449337312949;5827.417258274181;5828.417158284169;5837.387074357195;4503.1669141208895;4535.977320113395;4538.500764915857;4541.409616749835;4551.658625603093;4292.592203740655;4424.557544245582;4470.329450582422;4528.411306530146;4548.795304211319;4484.977575112136;4488.708233964782;4495.145922274757;4497.820087196525;4507.887302817439;4484.663650226246;4504.0991801639475;4512.819487220508;4528.388667529891;4539.931901021488;4014;4014.4781178446906;4016.0763024504527;4020.6783457323345;4022.4368588397647;5504.422035686235;5616.269884914935;5620.662760234358;5675.716214189315;5690.146478028288;5220.973895130538;5231.973840130813;5235;5235.65968212065;5237.633365664405;5889.263842019747;6210.565260431772;6213.37866213375;6226;6227.875442491125;4196.664266858675;4248.277792775205;4344.956550434486;4354.629856462205;4354.782260886975;6419.133416988693;6474.611523308617;6490.7079181436475;6494.415502604741;6497.870042599169;4453.732776033448;4454.064646424223;4456.17560751262;4458.152950939376;4458.308962110878;4437.134758722083;4498.865034048984;4510.8421205257655;4522.050369422458;4553.954460455419;5201.245819356172;5208.8437346879655;5210.53105220532;5212.582993360522;5214.739263036833;6237.625742455467;6240.719167637467;6242.43818056368;6244;6245.812625621239;1581.169885809936;1590.4115477273483;1594.2188327719334;1595.226315237109;1596.3135851583932;1048.6120135549895;1062.8405739139037;1077.7413420778958;1080.0549519170725;1083.0956151613334;5846.970765146147;5861.531077513789;5861.70691465425;5867.647941123546;5869.765209391577;6288.308286088527;6305.873882522324;6308.337624549356;6312.968435157794;6315.621062736251;5846;5854.502367298742;5857.853553661107;5861.9706901465215;5862.912056319158;3341.715954143925;3456.548249735117;3457.6023757267735;3458.0317511096932;3459.5329630500064;6623.4038936495945;6641.402273795382;6649.63427011519;6651.501137414713;6657.933420665829;6525;6544.116544266558;6544.803655890331;6548.050532672831;6552.115464412243;6524.641144737085;6647.933520664828;6726.3609957054005;6730.360615741497;6733.091032710619;6191.907121393093;6361.173047503795;6463.61218326883;6468.288488266381;6468.579542329733;6266.248050234001;6331.810045698637;6341.55609107358;6382.585131966407;6398.232212134573;6700.430463410665;6710.4631629470505;6713.395794378529;6713.496487763535;6715.0263211833035;4353.085851971122;4465.173942820588;4505.819767209406;4510.3234514821725;4515.9548404515535;6428.164338635947;6428.453581445629;6444.871102577828;6446.419822215836;6447.258565264867;6255.155554000152;6260.561760676709;6261.373862613702;6275.6862156892885;6285.465735412541;6150.865243459378;6192.81421557354;6260.248770147611;6269.310375858743;6269.529785266214;6086.178365920721;6089.939100608937;6091.543134265036;6092.817215483543;6097.420745029215;6298.149749783721;6351.2696039956;6352.968235158794;6353.36466353361;6362.968185159045;6029.8191054268445;6124.54065945047;6128.1726966858905;6130.080487926846;6131.356207598138 14:06:06 INFO - PROCESS | 3391 | |5;yui.html;761.6001599160442;810.9067457242417;847.7202523167356;856.5460306037799;860.5181098584789;13629.65925851853;13714.108582942114;13733.58799236022;13757.931210343946;13776.448942042307;12935.094543381967;12985.480580776757;12990.155639883402;13191.604251872435;13535.187888726683;673.1081317254633;817.5912043978026;829.6432534010373;829.9792505187359;830.2735106781566;683.9829004274908;813.5484805932705;820.6758330459465;829.875518672201;830.7217082277414;858.7295002074327;869.0787764969122;870.6256309786789;871.1158174452935;871.2333146830812;702.1784512120805;713.5682911838367;842.6418772021866;859.1494420523668;862.9741107766746;626.4049153304379;628.6605233174081;629.05013429721;629.5907660020977;629.6505439481086;12750.489980400773;12855.421506032157;12889.097763156582;12893.290869002201;12915.418806153746;11338.149638777042;11872.40637968098;12044.752433873762;12424.56514022014;12707.110502264844;9354.308336520635;9549.856752148724;9565.378250413702;9586.089321514444;9900;3505.772124811879;3566.5898421681577;3574.088607405121;3588.9641103588892;3623.6738693517445;45987;46150.53849461496;46167.307490387335;47588.762056189844;47613.76193119047;9501.572429240701;9548.331616786758;9756.90243097574;9798.040391921644;9826.80346393068;18068.728969065476;18079.909600452178;18168.1824317906;18240.543986400447;18285.908570457064;7374.151972523121;7485.363744081814;7517.849643007109;7615.619219039026;7756.108047574488;4303.849365272201;4463.575960283768;4496.460424748986;4539.614132798749;4621.399218101693;3041.680623534541;3120.719135277836;3122.7970181938103;3140.4661207594763;3150.291184483473;590.893639144958;591.5326891755551;596.7404179181983;597.2325561653341;602.8372339468407;585.1690599348934;593.4955288005248;614.7264467312093;638.1257676982564;641.3522342434175;7797.883031754528;7809.921900781033;7926.8810967835525;7949;8034.397420193392;514.920187370958;589.2987345059365;608.3308360803081;627.802242293676;671.0772687554612;3919.353306704362;4087.2642924273323;4127.195196936628;4291.206126866539;4367.912641747147;52402.737986309825;55319.72340138273;56109.71945140248;56506;56772;44312.3353149703;45672.71636418166;46176.07647847024;46285.305720414224;46404.30393544099;43558.34662480065;44907.32639010417;44989.77505112453;45471.99999999934;45486.31770523445;8571.914280857112;8596.484210947363;8889.822203556021;8900.866487002571;8908.376413650982;32519;32933.83533082319;33712.66287337095;34448.82775586106;34648.65351346555;42093.57906420896;42734.57265427306;43143.35284970665;43893.34159987539;43911.58486283285;10307.845382319121;10330.173586113244;10469.267151299337;10501.212409069503;10767.084797791962;11262.822289991775;11411.657650270174;11640.767184656428;11650.242734222249;11779.234349767237;10522.473876306307;10539.473026348498;10887.836682449928;10892.727681808019;11057.824266529506;10766.192535560021;10840.620578279722;10892.128629709763;10914.290571112851;11075.889241107809;7804.804879878048;9865.569492423701;10574.048335649828;10950.507227174638;10958.506867191156;8839.116088391109;9126.543672816466;9194.807521034043;9212.124848139416;9382.296327775308;9069.954650226706;9485.810283794424;9591.42451452915;9606.327557071218;9652.613895444385 14:06:06 INFO - PROCESS | 3391 | __end_tp_report 14:06:06 INFO - PROCESS | 3391 | __start_cc_report 14:06:06 INFO - PROCESS | 3391 | _x_x_mozilla_cycle_collect,873 14:06:06 INFO - PROCESS | 3391 | __end_cc_report 14:06:06 INFO - PROCESS | 3391 | __startTimestamp1452636366112__endTimestamp 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | ------- Summary: start ------- 14:06:06 INFO - PROCESS | 3391 | Number of tests: 6 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | [#0] dojo.html Cycles:165 Average:5186.24 Median:5375.19 stddev:551.51 (10.3%) stddev-sans-first:528.44 14:06:06 INFO - PROCESS | 3391 | Values: 3103.3 3142.1 3172.3 3183.8 3212.4 5089.8 5203.7 5208.3 5216.1 5255.5 5191.0 5206.8 5226.8 5241.9 5272.5 4698.5 4731.7 4736.2 4881.7 4885.4 4826.3 4833.0 4892.4 4898.4 4904.9 4700.4 4757.7 4767.4 4825.6 4846.9 4771.5 4791.7 4793.6 4797.5 4811.4 4751.6 4783.1 4790.2 4799.0 4844.1 5028.8 5066.7 5093.9 5118.1 5157.9 5521.6 5550.6 5552.3 5564.0 5564.2 5509.3 5565.5 5570.0 5581.8 5590.7 5209.6 5228.2 5265.9 5278.8 5327.5 5670.3 5673.1 5678.4 5707.3 5730.5 5447.0 5492.6 5496.8 5496.8 5522.1 5591.5 5631.1 5636.8 5641.1 5686.4 5549.9 5558.7 5560.9 5569.3 5571.2 5458.3 5539.1 5544.6 5580.1 5595.4 4326.3 4329.9 4333.1 4355.2 4365.4 3888.8 3898.9 3899.2 3918.2 3927.3 5137.6 5183.2 5224.0 5232.2 5283.5 5586.4 5587.8 5616.2 5628.2 5659.7 5150.0 5151.6 5156.4 5171.3 5199.4 4742.8 4743.5 4754.1 4765.3 4834.6 5782.7 5792.9 5818.3 5824.2 5847.5 5520.2 5559.5 5560.9 5565.5 5567.9 5644.6 5679.5 5686.7 5766.9 5773.4 5459.6 5512.5 5514.4 5515.0 5543.3 5504.1 5538.9 5544.6 5552.2 5578.1 5328.6 5385.4 5420.2 5430.4 5484.9 5375.2 5380.9 5386.8 5420.1 5420.4 5256.2 5294.8 5295.8 5332.5 5344.3 5432.3 5454.4 5511.3 5517.6 5584.5 5371.2 5376.9 5384.6 5395.2 5420.1 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | [#1] ext.html Cycles:180 Average:43678.03 Median:334976.00 stddev:71211.25 (21.3%) stddev-sans-first:71337.34 14:06:06 INFO - PROCESS | 3391 | Values: 532.8 535.6 558.8 560.6 573.2 28394.9 29038.4 29066.7 37186.4 37845.6 40299.8 40639.0 40844.8 40915.6 41074.0 8354.2 8550.1 8551.9 8552.4 8553.5 8403.2 8561.4 8564.8 8581.5 8584.5 8604.0 8659.4 8673.5 8680.7 8688.0 8532.1 8597.2 8600.9 8609.0 8610.8 8430.3 8502.2 8506.7 8521.1 8525.4 39528.0 39867.8 39942.2 39970.8 40143.8 3048.0 3139.8 3220.1 3241.3 3406.9 29492.3 29845.6 30073.4 30162.4 30175.0 3823.2 3914.4 4005.0 4028.9 4073.3 257642.0 257857.0 257980.0 258767.0 259260.0 51917.2 52709.5 58754.1 59069.7 59119.4 63095.0 64421.7 64588.7 64834.0 64854.4 15406.4 15590.9 15607.3 15641.6 15660.5 10888.6 11013.1 11097.6 11116.7 12193.2 19684.7 19933.1 20009.3 20106.5 20182.3 7226.2 7496.7 7628.2 7697.5 7706.6 924.3 942.3 970.9 1012.5 1024.1 28545.7 28815.6 28944.4 29270.6 29293.1 1010.0 1010.6 1015.5 1030.6 1056.8 13136.8 15230.8 15518.0 15541.6 15767.0 331064.0 333875.0 334789.0 335163.0 335658.0 52078.2 52813.5 52814.0 52845.7 52945.0 1303.9 1308.2 1315.4 1319.0 1319.3 28850.1 29613.1 29626.6 29748.9 30103.4 41807.6 43212.4 46878.8 47333.3 49093.8 208007.0 208286.0 208320.0 210352.0 210842.0 30299.0 30684.2 30750.4 30865.5 30869.0 33332.3 42477.4 42990.6 42998.4 43386.1 31993.0 32134.4 32221.0 32617.0 32976.0 35110.3 35326.6 35563.1 35887.3 35957.8 31456.2 31735.4 31833.2 31864.2 31908.2 30055.1 30793.7 32124.7 33740.3 33788.3 23345.4 23423.4 23501.0 23674.8 23690.4 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | [#2] jquery.html Cycles:180 Average:27678.76 Median:5107.78 stddev:89339.09 (1749.1%) stddev-sans-first:89566.15 14:06:06 INFO - PROCESS | 3391 | Values: 354.8 358.6 362.5 363.0 370.6 13457.8 13560.3 16371.4 17076.7 18287.9 15709.9 16273.9 16704.7 16714.2 16813.5 5163.9 5326.3 5350.8 5352.6 5357.2 3895.1 4037.2 5219.3 5306.3 5638.8 5764.8 5777.6 5819.0 5822.6 5823.3 5076.5 5229.9 5243.4 5258.2 5284.9 4930.2 5074.1 5081.9 5102.3 5113.3 11920.2 12047.6 12049.6 15053.8 20115.9 2110.2 2156.5 2167.3 2202.6 2274.9 9007.3 9231.8 9329.9 9670.1 12790.7 1680.0 1730.5 1750.8 1823.5 1829.2 56814.7 56889.7 56952.7 57688.7 58430.0 10261.9 10273.5 10298.7 10311.6 10384.7 13136.4 13450.4 13476.3 13482.5 13536.6 7781.3 7809.5 7858.8 7860.5 7931.7 7690.5 7719.5 7720.7 7760.7 7799.1 4456.7 4478.6 4496.8 4499.6 4530.2 1741.7 1779.7 1782.4 1881.4 1903.4 840.5 866.5 897.5 914.8 1044.3 14063.8 16194.4 16586.3 17037.5 17037.9 910.0 911.3 929.5 932.2 985.2 9050.4 9344.7 9371.3 9402.4 9403.4 528800.0 537105.0 538257.0 562179.0 565211.0 71639.3 75322.6 76326.0 76346.0 76428.0 1033.8 1057.9 1128.9 1161.8 1195.5 14395.6 14428.6 14597.4 14767.4 14926.1 32938.7 33104.3 33451.5 33881.0 34198.0 44030.8 44204.1 44222.3 45166.3 46117.5 7025.3 7219.0 7350.3 7391.7 7429.7 8832.4 11011.5 11051.9 11087.9 11325.7 9333.3 9624.5 9806.4 9869.2 9898.5 9291.4 9564.2 9929.8 10015.4 10074.1 8670.7 9534.9 9664.9 9967.7 10056.8 6890.2 7235.6 7308.9 7390.9 7427.5 8399.0 9510.7 9611.1 9689.9 9697.8 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | [#3] mootools.html Cycles:180 Average:5479.20 Median:5962.47 stddev:2866.28 (48.1%) stddev-sans-first:2856.98 14:06:06 INFO - PROCESS | 3391 | Values: 1285.4 1447.3 1473.9 1614.2 1770.2 6976.2 7398.8 7445.0 7579.4 7582.0 7590.2 7725.4 7735.6 7757.7 7802.8 2347.3 2357.1 2357.2 2359.7 2373.1 2242.7 2266.6 2271.1 2277.8 2282.6 2211.5 2211.6 2228.3 2272.1 2275.9 2290.6 2317.4 2319.9 2320.0 2324.3 2285.9 2293.0 2294.7 2296.2 2296.3 7939.4 7963.4 7985.1 7989.5 7994.0 4755.2 4833.6 4852.5 4855.7 4855.9 3132.2 3144.9 3230.0 3250.6 3256.3 1011.9 1019.3 1027.7 1029.5 1035.7 10893.0 10903.3 10930.3 10932.7 10942.3 4431.9 4455.5 4495.9 4504.7 4534.0 9307.3 9320.5 9347.9 9352.5 9361.8 4951.9 4976.7 4987.9 4993.5 5007.6 3929.5 4046.9 4376.1 4488.7 4568.5 3850.4 3851.9 3858.8 3901.9 3906.2 1244.7 1249.8 1261.2 1263.9 1264.5 1298.3 1302.1 1308.3 1331.9 1345.7 7504.7 7542.8 7660.2 7676.0 7679.4 501.6 519.8 519.9 522.5 523.7 5671.1 5685.0 5719.6 5723.5 5745.0 9204.2 9721.1 9767.2 9793.3 9815.8 9597.7 9659.3 9663.1 9674.3 9751.2 7187.7 7376.4 7441.9 7482.3 7569.1 7002.4 7033.2 7068.5 7078.7 7114.6 8464.8 8477.0 8603.7 8699.7 8739.2 8650.5 9004.3 9047.0 9061.1 9078.8 5894.1 6030.8 6299.6 6533.7 6793.6 6894.6 6908.3 6918.3 6931.0 6933.9 6542.5 6706.7 6786.6 6808.8 6838.8 6628.1 6721.3 6730.8 6747.2 6765.6 6717.5 6843.0 6860.8 6870.5 6940.6 6334.0 6443.2 6443.9 6450.4 6451.1 6434.2 6494.4 6505.0 6511.9 6518.8 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | [#4] prototype.html Cycles:180 Average:5209.36 Median:5853.33 stddev:1558.28 (26.6%) stddev-sans-first:1519.18 14:06:06 INFO - PROCESS | 3391 | Values: 339.3 341.6 345.1 349.4 351.7 5694.1 5837.4 5843.2 5852.2 5861.4 5660.4 5796.4 5827.4 5828.4 5837.4 4503.2 4536.0 4538.5 4541.4 4551.7 4292.6 4424.6 4470.3 4528.4 4548.8 4485.0 4488.7 4495.1 4497.8 4507.9 4484.7 4504.1 4512.8 4528.4 4539.9 4014.0 4014.5 4016.1 4020.7 4022.4 5504.4 5616.3 5620.7 5675.7 5690.1 5221.0 5232.0 5235.0 5235.7 5237.6 5889.3 6210.6 6213.4 6226.0 6227.9 4196.7 4248.3 4345.0 4354.6 4354.8 6419.1 6474.6 6490.7 6494.4 6497.9 4453.7 4454.1 4456.2 4458.2 4458.3 4437.1 4498.9 4510.8 4522.1 4554.0 5201.2 5208.8 5210.5 5212.6 5214.7 6237.6 6240.7 6242.4 6244.0 6245.8 1581.2 1590.4 1594.2 1595.2 1596.3 1048.6 1062.8 1077.7 1080.1 1083.1 5847.0 5861.5 5861.7 5867.6 5869.8 6288.3 6305.9 6308.3 6313.0 6315.6 5846.0 5854.5 5857.9 5862.0 5862.9 3341.7 3456.5 3457.6 3458.0 3459.5 6623.4 6641.4 6649.6 6651.5 6657.9 6525.0 6544.1 6544.8 6548.1 6552.1 6524.6 6647.9 6726.4 6730.4 6733.1 6191.9 6361.2 6463.6 6468.3 6468.6 6266.2 6331.8 6341.6 6382.6 6398.2 6700.4 6710.5 6713.4 6713.5 6715.0 4353.1 4465.2 4505.8 4510.3 4516.0 6428.2 6428.5 6444.9 6446.4 6447.3 6255.2 6260.6 6261.4 6275.7 6285.5 6150.9 6192.8 6260.2 6269.3 6269.5 6086.2 6089.9 6091.5 6092.8 6097.4 6298.1 6351.3 6353.0 6353.4 6363.0 6029.8 6124.5 6128.2 6130.1 6131.4 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - PROCESS | 3391 | [#5] yui.html Cycles:180 Average:13257.38 Median:46996.53 stddev:15169.63 (32.3%) stddev-sans-first:15183.16 14:06:06 INFO - PROCESS | 3391 | Values: 761.6 810.9 847.7 856.5 860.5 13629.7 13714.1 13733.6 13757.9 13776.4 12935.1 12985.5 12990.2 13191.6 13535.2 673.1 817.6 829.6 830.0 830.3 684.0 813.5 820.7 829.9 830.7 858.7 869.1 870.6 871.1 871.2 702.2 713.6 842.6 859.1 863.0 626.4 628.7 629.1 629.6 629.7 12750.5 12855.4 12889.1 12893.3 12915.4 11338.1 11872.4 12044.8 12424.6 12707.1 9354.3 9549.9 9565.4 9586.1 9900.0 3505.8 3566.6 3574.1 3589.0 3623.7 45987.0 46150.5 46167.3 47588.8 47613.8 9501.6 9548.3 9756.9 9798.0 9826.8 18068.7 18079.9 18168.2 18240.5 18285.9 7374.2 7485.4 7517.8 7615.6 7756.1 4303.8 4463.6 4496.5 4539.6 4621.4 3041.7 3120.7 3122.8 3140.5 3150.3 590.9 591.5 596.7 597.2 602.8 585.2 593.5 614.7 638.1 641.4 7797.9 7809.9 7926.9 7949.0 8034.4 514.9 589.3 608.3 627.8 671.1 3919.4 4087.3 4127.2 4291.2 4367.9 52402.7 55319.7 56109.7 56506.0 56772.0 44312.3 45672.7 46176.1 46285.3 46404.3 43558.3 44907.3 44989.8 45472.0 45486.3 8571.9 8596.5 8889.8 8900.9 8908.4 32519.0 32933.8 33712.7 34448.8 34648.7 42093.6 42734.6 43143.4 43893.3 43911.6 10307.8 10330.2 10469.3 10501.2 10767.1 11262.8 11411.7 11640.8 11650.2 11779.2 10522.5 10539.5 10887.8 10892.7 11057.8 10766.2 10840.6 10892.1 10914.3 11075.9 7804.8 9865.6 10574.0 10950.5 10958.5 8839.1 9126.5 9194.8 9212.1 9382.3 9070.0 9485.8 9591.4 9606.3 9652.6 14:06:06 INFO - PROCESS | 3391 | -------- Summary: end -------- 14:06:06 INFO - PROCESS | 3391 | 14:06:06 INFO - TEST-INFO | 3391: exit 0 14:06:06 INFO - TEST-OK | dromaeo_css | took 1114894ms 14:06:06 INFO - TEST-START | kraken 14:06:06 INFO - operating with platform_type : linux_ 14:06:06 INFO - Initialising browser for kraken test... 14:06:06 INFO - TEST-INFO | started process 3581 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0s43zC/profile http://localhost:38851/getInfo.html) 14:06:10 INFO - PROCESS | 3581 | __metrics Screen width/height:1600/1200 14:06:10 INFO - PROCESS | 3581 | colorDepth:24 14:06:10 INFO - PROCESS | 3581 | Browser inner width/height: 1024/697 14:06:10 INFO - PROCESS | 3581 | __metrics 14:06:10 INFO - PROCESS | 3581 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:06:10 INFO - PROCESS | 3581 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:11 INFO - TEST-INFO | 3581: exit 0 14:06:11 INFO - Browser initialized. 14:06:11 INFO - Running cycle 1/1 for kraken test... 14:06:11 INFO - TEST-INFO | started process 3664 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0s43zC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:23 INFO - PROCESS | 3664 | RSS: Main: 148742144 14:06:23 INFO - PROCESS | 3664 | 14:06:26 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-beat-detection) 14:06:26 INFO - PROCESS | 3664 | RSS: Main: 185237504 14:06:26 INFO - PROCESS | 3664 | 14:06:29 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-dft) 14:06:29 INFO - PROCESS | 3664 | RSS: Main: 175251456 14:06:29 INFO - PROCESS | 3664 | 14:06:32 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-fft) 14:06:33 INFO - PROCESS | 3664 | RSS: Main: 160669696 14:06:33 INFO - PROCESS | 3664 | 14:06:35 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-oscillator) 14:06:35 INFO - PROCESS | 3664 | RSS: Main: 162152448 14:06:35 INFO - PROCESS | 3664 | 14:06:38 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:06:38 INFO - PROCESS | 3664 | RSS: Main: 163680256 14:06:38 INFO - PROCESS | 3664 | 14:06:41 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38851/tests/kraken/driver.html?testName=imaging-darkroom) 14:06:42 INFO - PROCESS | 3664 | RSS: Main: 165662720 14:06:42 INFO - PROCESS | 3664 | 14:06:45 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38851/tests/kraken/driver.html?testName=imaging-desaturate) 14:06:46 INFO - PROCESS | 3664 | RSS: Main: 166346752 14:06:46 INFO - PROCESS | 3664 | 14:06:48 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38851/tests/kraken/driver.html?testName=json-parse-financial) 14:06:49 INFO - PROCESS | 3664 | RSS: Main: 164859904 14:06:49 INFO - PROCESS | 3664 | 14:06:51 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:06:51 INFO - PROCESS | 3664 | RSS: Main: 176680960 14:06:51 INFO - PROCESS | 3664 | 14:06:53 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:06:54 INFO - PROCESS | 3664 | RSS: Main: 174546944 14:06:54 INFO - PROCESS | 3664 | 14:06:56 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:06:56 INFO - PROCESS | 3664 | RSS: Main: 183758848 14:06:56 INFO - PROCESS | 3664 | 14:06:59 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:07:00 INFO - PROCESS | 3664 | RSS: Main: 192983040 14:07:00 INFO - PROCESS | 3664 | 14:07:02 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:07:03 INFO - PROCESS | 3664 | RSS: Main: 190685184 14:07:03 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38851/tests/kraken/driver.html?testName=ai-astar) 14:07:05 INFO - PROCESS | 3664 | RSS: Main: 249344000 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | __start_tp_report 14:07:05 INFO - PROCESS | 3664 | _x_x_mozilla_page_load 14:07:05 INFO - PROCESS | 3664 | _x_x_mozilla_page_load_details 14:07:05 INFO - PROCESS | 3664 | |i|pagename|runs| 14:07:05 INFO - PROCESS | 3664 | |0;ai-astar;107;109;103;109;110;109;99;110;109;101 14:07:05 INFO - PROCESS | 3664 | |1;audio-beat-detection;151;134;158;170;126;148;152;122;171;126 14:07:05 INFO - PROCESS | 3664 | |2;audio-dft;161;160;161;161;162;160;160;160;161;161 14:07:05 INFO - PROCESS | 3664 | |3;audio-fft;72;72;81;93;73;74;74;98;91;71 14:07:05 INFO - PROCESS | 3664 | |4;audio-oscillator;96;96;144;97;95;96;152;95;97;153 14:07:05 INFO - PROCESS | 3664 | |5;imaging-gaussian-blur;109;110;110;109;109;109;109;109;109;109 14:07:05 INFO - PROCESS | 3664 | |6;imaging-darkroom;146;146;145;145;145;146;147;146;146;145 14:07:05 INFO - PROCESS | 3664 | |7;imaging-desaturate;95;96;95;96;96;96;96;95;96;95 14:07:05 INFO - PROCESS | 3664 | |8;json-parse-financial;56;55;56;55;60;55;54;65;53;54 14:07:05 INFO - PROCESS | 3664 | |9;json-stringify-tinderbox;67;68;66;67;66;67;67;67;68;67 14:07:05 INFO - PROCESS | 3664 | |10;stanford-crypto-aes;86;83;92;86;85;87;87;85;85;89 14:07:05 INFO - PROCESS | 3664 | |11;stanford-crypto-ccm;118;121;115;116;120;135;124;119;125;122 14:07:05 INFO - PROCESS | 3664 | |12;stanford-crypto-pbkdf2;145;155;147;144;155;143;154;154;155;146 14:07:05 INFO - PROCESS | 3664 | |13;stanford-crypto-sha256-iterative;69;70;71;71;70;69;73;73;69;69 14:07:05 INFO - PROCESS | 3664 | __end_tp_report 14:07:05 INFO - PROCESS | 3664 | __start_cc_report 14:07:05 INFO - PROCESS | 3664 | _x_x_mozilla_cycle_collect,929 14:07:05 INFO - PROCESS | 3664 | __end_cc_report 14:07:05 INFO - PROCESS | 3664 | __startTimestamp1452636425387__endTimestamp 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | ------- Summary: start ------- 14:07:05 INFO - PROCESS | 3664 | Number of tests: 14 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:4.06 (3.7%) stddev-sans-first:4.30 14:07:05 INFO - PROCESS | 3664 | Values: 107.0 109.0 103.0 109.0 110.0 109.0 99.0 110.0 109.0 101.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:151.50 stddev:18.04 (11.9%) stddev-sans-first:19.04 14:07:05 INFO - PROCESS | 3664 | Values: 151.0 134.0 158.0 170.0 126.0 148.0 152.0 122.0 171.0 126.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 14:07:05 INFO - PROCESS | 3664 | Values: 161.0 160.0 161.0 161.0 162.0 160.0 160.0 160.0 161.0 161.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#3] audio-fft Cycles:10 Average:79.90 Median:77.50 stddev:10.25 (13.2%) stddev-sans-first:10.46 14:07:05 INFO - PROCESS | 3664 | Values: 72.0 72.0 81.0 93.0 73.0 74.0 74.0 98.0 91.0 71.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#4] audio-oscillator Cycles:10 Average:112.10 Median:96.00 stddev:26.04 (27.1%) stddev-sans-first:26.96 14:07:05 INFO - PROCESS | 3664 | Values: 96.0 96.0 144.0 97.0 95.0 96.0 152.0 95.0 97.0 153.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:07:05 INFO - PROCESS | 3664 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:07:05 INFO - PROCESS | 3664 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 147.0 146.0 146.0 145.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:07:05 INFO - PROCESS | 3664 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.50 stddev:3.59 (6.5%) stddev-sans-first:3.81 14:07:05 INFO - PROCESS | 3664 | Values: 56.0 55.0 56.0 55.0 60.0 55.0 54.0 65.0 53.0 54.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:07:05 INFO - PROCESS | 3664 | Values: 67.0 68.0 66.0 67.0 66.0 67.0 67.0 67.0 68.0 67.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:2.51 (2.9%) stddev-sans-first:2.65 14:07:05 INFO - PROCESS | 3664 | Values: 86.0 83.0 92.0 86.0 85.0 87.0 87.0 85.0 85.0 89.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.50 stddev:5.72 (4.7%) stddev-sans-first:5.93 14:07:05 INFO - PROCESS | 3664 | Values: 118.0 121.0 115.0 116.0 120.0 135.0 124.0 119.0 125.0 122.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:154.00 stddev:5.18 (3.4%) stddev-sans-first:5.20 14:07:05 INFO - PROCESS | 3664 | Values: 145.0 155.0 147.0 144.0 155.0 143.0 154.0 154.0 155.0 146.0 14:07:05 INFO - PROCESS | 3664 | 14:07:05 INFO - PROCESS | 3664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.58 (2.2%) stddev-sans-first:1.59 14:07:05 INFO - PROCESS | 3664 | Values: 69.0 70.0 71.0 71.0 70.0 69.0 73.0 73.0 69.0 69.0 14:07:05 INFO - PROCESS | 3664 | -------- Summary: end -------- 14:07:05 INFO - PROCESS | 3664 | 14:07:06 INFO - TEST-INFO | 3664: exit 0 14:07:06 INFO - TEST-OK | kraken | took 59443ms 14:07:06 INFO - TEST-START | v8_7 14:07:06 INFO - operating with platform_type : linux_ 14:07:06 INFO - Initialising browser for v8_7 test... 14:07:06 INFO - TEST-INFO | started process 3914 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaaa40E/profile http://localhost:38851/getInfo.html) 14:07:09 INFO - PROCESS | 3914 | __metrics Screen width/height:1600/1200 14:07:09 INFO - PROCESS | 3914 | colorDepth:24 14:07:09 INFO - PROCESS | 3914 | Browser inner width/height: 1024/697 14:07:09 INFO - PROCESS | 3914 | __metrics 14:07:10 INFO - PROCESS | 3914 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:07:10 INFO - PROCESS | 3914 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:07:11 INFO - TEST-INFO | 3914: exit 0 14:07:11 INFO - Browser initialized. 14:07:11 INFO - Running cycle 1/1 for v8_7 test... 14:07:11 INFO - TEST-INFO | started process 3996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaaa40E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:22 INFO - PROCESS | 3996 | RSS: Main: 148369408 14:07:22 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | Cycle 1(1): loaded http://localhost:38851/tests/v8_7/run.html (next: http://localhost:38851/tests/v8_7/run.html) 14:07:45 INFO - PROCESS | 3996 | RSS: Main: 563027968 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | __start_tp_report 14:07:45 INFO - PROCESS | 3996 | _x_x_mozilla_page_load 14:07:45 INFO - PROCESS | 3996 | _x_x_mozilla_page_load_details 14:07:45 INFO - PROCESS | 3996 | |i|pagename|runs| 14:07:45 INFO - PROCESS | 3996 | |0;Richards;166.11295681063123 14:07:45 INFO - PROCESS | 3996 | |1;DeltaBlue;190.36740909956217 14:07:45 INFO - PROCESS | 3996 | |2;Encrypt;279.6420581655481 14:07:45 INFO - PROCESS | 3996 | |3;Decrypt;5170.103092783505 14:07:45 INFO - PROCESS | 3996 | |4;RayTrace;1934.3629343629343 14:07:45 INFO - PROCESS | 3996 | |5;Earley;793.0214115781126 14:07:45 INFO - PROCESS | 3996 | |6;Boyer;12506.172839506173 14:07:45 INFO - PROCESS | 3996 | |7;RegExp;42250 14:07:45 INFO - PROCESS | 3996 | |8;Splay;572.6447219069239 14:07:45 INFO - PROCESS | 3996 | |9;NavierStokes;4826.923076923077 14:07:45 INFO - PROCESS | 3996 | __end_tp_report 14:07:45 INFO - PROCESS | 3996 | __startTimestamp1452636465668__endTimestamp 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | ------- Summary: start ------- 14:07:45 INFO - PROCESS | 3996 | Number of tests: 10 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 166.1 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#1] DeltaBlue Cycles:1 Average:190.37 Median:190.37 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 190.4 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 279.6 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 5170.1 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#4] RayTrace Cycles:1 Average:1934.36 Median:1934.36 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 1934.4 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 793.0 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 12506.2 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#7] RegExp Cycles:1 Average:42250.00 Median:42250.00 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 42250.0 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#8] Splay Cycles:1 Average:572.64 Median:572.64 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 572.6 14:07:45 INFO - PROCESS | 3996 | 14:07:45 INFO - PROCESS | 3996 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:07:45 INFO - PROCESS | 3996 | Values: 4826.9 14:07:45 INFO - PROCESS | 3996 | -------- Summary: end -------- 14:07:45 INFO - PROCESS | 3996 | 14:07:46 INFO - TEST-INFO | 3996: exit 0 14:07:46 INFO - TEST-OK | v8_7 | took 40238ms 14:07:46 INFO - SUITE-END | took 1214s 14:07:46 INFO - Completed test suite (00:20:14) 14:07:46 INFO - Working with test: dromaeo_css 14:07:46 INFO - Generating results file: dromaeo_css 14:07:46 INFO - Working with test: kraken 14:07:46 INFO - Generating results file: kraken 14:07:46 INFO - javascript benchmark 14:07:46 INFO - Working with test: v8_7 14:07:46 INFO - Generating results file: v8_7 14:07:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:07:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:07:46 INFO - process_Request line: dromaeo_css 6766.93 graph.html#tests=[[72,201,35]] 14:07:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:07:46 INFO - process_Request line: kraken 1507.10 graph.html#tests=[[232,201,35]] 14:07:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:07:46 INFO - process_Request line: v8_7 19011.03 graph.html#tests=[[230,201,35]] 14:07:46 INFO - RETURN: dromaeo_css: 6766.93 14:07:46 INFO - RETURN: kraken: 1507.10 14:07:46 INFO - RETURN: v8_7: 19011.03 14:07:46 INFO - javascript benchmark 14:07:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.317270200556, 3142.088794249668, 3172.349668317995, 3183.8089714617126, 3212.389645967266, 5089.770960306786, 5203.687778733279, 5208.296879921209, 5216.061109000379, 5255.500727430893, 5190.9740451297785, 5206.843794686166, 5226.817061402851, 5241.9213711794255, 5272.499112584298, 4698.506656801038, 4731.66878318517, 4736.242201247784, 4881.658283920127, 4885.389326334208, 4826.276058591205, 4832.951670483303, 4892.3639926809465, 4898.363212782333, 4904.926426103593, 4700.3889494365685, 4757.714537127784, 4767.427908650967, 4825.613950883921, 4846.903061938777, 4771.475137734847, 4791.736454495001, 4793.616510679138, 4797.544233297831, 4811.374521312242, 4751.64362672801, 4783.067301876135, 4790.209615413452, 4799.0401919616215, 4844.079624871263, 5028.7737051832755, 5066.746662666888, 5093.898122037575, 5118.07874582575, 5157.871053223662, 5521.641093328921, 5550.611457197998, 5552.250446189753, 5563.970665426868, 5564.1931919871795, 5509.283793106911, 5565.526930210896, 5569.972150139264, 5581.832545023656, 5590.664560126364, 5209.609279304067, 5228.163493840967, 5265.921011184835, 5278.81524146653, 5327.547158491533, 5670.319561652628, 5673.149027645886, 5678.375378708339, 5707.258056452634, 5730.484256416942, 5446.972765136149, 5492.5605951523785, 5496.80761173357, 5496.835094947158, 5522.061249587579, 5591.4688104629995, 5631.099024156116, 5636.774529018875, 5641.069223578145, 5686.43135686428, 5549.916751248735, 5558.666480011212, 5560.860978475571, 5569.303837020372, 5571.192177134374, 5458.263134476795, 5539.086050801573, 5544.556435485151, 5580.135079062752, 5595.38450770415, 4326.286162783105, 4329.9134017319475, 4333.133373325348, 4355.15074560464, 4365.410669559632, 3888.8444462221196, 3898.863539776094, 3899.2201559688174, 3918.1575961168487, 3927.312720273998, 5137.614678899023, 5183.222516622537, 5224.033553792485, 5232.181801886144, 5283.498067683564, 5586.413426590231, 5587.804426845041, 5616.157576363496, 5628.240187574625, 5659.745311460994, 5149.9742501287255, 5151.6136289778415, 5156.432792392834, 5171.276021357013, 5199.350081239845, 4742.834000809955, 4743.525647435298, 4754.072955773591, 4765.26138448541, 4834.589059929875, 5782.653040817564, 5792.913106303493, 5818.330891947396, 5824.213731146326, 5847.502962248256, 5520.171974203901, 5559.527440167631, 5560.860978475571, 5565.471280228372, 5567.8864227155545, 5644.576656750843, 5679.517241034393, 5686.687232202268, 5766.8846623066465, 5773.364929857628, 5459.590530710133, 5512.5314348280845, 5514.420985796433, 5515.0, 5543.334799824047, 5504.0643090675485, 5538.861528461821, 5544.61187716856, 5552.222688823487, 5578.135389014709, 5328.626996110235, 5385.380681221553, 5420.241166236809, 5430.375506816767, 5484.862878428071, 5375.193720941734, 5380.865478362915, 5386.8383948481605, 5420.105682562491, 5420.430854760351, 5256.211568264791, 5294.761735721825, 5295.76169072385, 5332.5467335276935, 5344.25180474726, 5432.348118225838, 5454.372747134131, 5511.255980442589, 5517.586181036519, 5584.525315348241, 5371.194320851903, 5376.865578360573, 5384.569234461312, 5395.190721391666, 5420.13277875538], "unit": "score", "name": "dojo.html", "value": 5151.912786755532}, {"lowerIsBetter": false, "replicates": [532.7922110376953, 535.5902734408178, 558.8125233878011, 560.6383882395858, 573.23759399998, 28394.85802570987, 29038.419231615382, 29066.709332906692, 37186.4422033669, 37845.62154378455, 40299.798501007455, 40639.0, 40844.79577602108, 40915.59084409155, 41074.0, 8354.164583541658, 8550.10223926485, 8551.914480855205, 8552.444091134088, 8553.529555874424, 8403.159684031609, 8561.357898157632, 8564.78588035301, 8581.52801595912, 8584.484930904135, 8604.0, 8659.350548708871, 8673.479591224515, 8680.739577812676, 8687.95656021719, 8532.104129066453, 8597.18326758957, 8600.8709869352, 8608.956955215215, 8610.784730381727, 8430.32557395407, 8502.192291732275, 8506.702265420681, 8521.14788521149, 8525.44584601999, 39528.0, 39867.8006609968, 39942.20115597672, 39970.800145999376, 40143.799281003405, 3047.9847600761855, 3139.764517661162, 3220.146661134801, 3241.286916878283, 3406.9488957665653, 29492.262693432836, 29845.552316715268, 30073.398532029238, 30162.396752064837, 30175.03862248947, 3823.1971286029966, 3914.393269043303, 4004.959950400517, 4028.8589899353383, 4073.327900896378, 257642.0, 257857.0, 257979.99999999814, 258767.0, 259260.0, 51917.22124168141, 52709.47290527122, 58754.118688219714, 59069.704651476466, 59119.40880591225, 63095.0, 64421.67789161024, 64588.67705661536, 64834.0, 64854.351456485776, 15406.383744650313, 15590.922045389927, 15607.297671604805, 15641.608959776097, 15660.530184094496, 10888.618898338678, 11013.063889569476, 11097.611583594535, 11116.722081947853, 12193.207441516273, 19684.70472942907, 19933.103010364568, 20009.299674511323, 20106.497337566678, 20182.293619723237, 7226.205117437078, 7496.7376141834775, 7628.160902300742, 7697.461177717506, 7706.576138312446, 924.2652091587204, 942.3356533643764, 970.9368891022061, 1012.5291739341094, 1024.1499555369026, 28545.71454285472, 28815.56776648352, 28944.42111157765, 29270.560941585893, 29293.121206363845, 1010.0202803280806, 1010.5907107621425, 1015.537930241753, 1030.577463240083, 1056.815057364958, 13136.802947955788, 15230.771538426932, 15518.0, 15541.611459713598, 15767.0, 331064.0, 333875.0, 334789.0, 335163.0, 335658.0, 52078.21882671763, 52813.47186528086, 52814.0, 52845.7357713209, 52945.0, 1303.882650561435, 1308.2477575394187, 1315.4146404849942, 1318.967025824362, 1319.2678063674562, 28850.134495965154, 29613.111606651833, 29626.55560166556, 29748.851255743582, 30103.397932041673, 41807.58192418037, 43212.35181472218, 46878.76560617175, 47333.290000650704, 49093.75453122712, 208007.0, 208286.0, 208320.0, 210352.0, 210842.0, 30299.030563013333, 30684.232894177825, 30750.38499229958, 30865.537016944316, 30869.0, 33332.333353333284, 42477.362839556816, 42990.57009429991, 42998.35502467403, 43386.13227735491, 31993.0, 32134.35731285408, 32221.0, 32617.0, 32976.0, 35110.29779404448, 35326.64673353233, 35563.11092222715, 35887.28225435529, 35957.820210898775, 31456.213594660316, 31735.365292694478, 31833.204169895937, 31864.203394915312, 31908.202294942814, 30055.098347049625, 30793.69206307998, 32124.678753212167, 33740.325193495504, 33788.3242335147, 23345.41636459102, 23423.41441463977, 23501.0, 23674.763252367255, 23690.407739806644], "unit": "score", "name": "ext.html", "value": 17894.958942684912}, {"lowerIsBetter": false, "replicates": [354.7853548603095, 358.5518102372035, 362.5051804287148, 362.95281613390256, 370.6016032764779, 13457.798133028013, 13560.32198390079, 16371.427000054986, 17076.743848842263, 18287.908560457177, 15709.921450392732, 16273.918630406832, 16704.66590668189, 16714.164291785393, 16813.495595132164, 5163.870903227412, 5326.280952071459, 5350.759215835277, 5352.625316227865, 5357.223202635615, 3895.1235971906235, 4037.2329257440992, 5219.269302297681, 5306.283651707009, 5638.830835074954, 5764.769409223626, 5777.59556831022, 5819.0, 5822.592418530705, 5823.330317013534, 5076.543111119999, 5229.947700523003, 5243.397009343898, 5258.1849813279005, 5284.920726189111, 4930.235813448921, 5074.06129865976, 5081.872953176163, 5102.260172275037, 5113.309703190096, 11920.165588408729, 12047.578334758242, 12049.638510844688, 15053.849461505355, 20115.899420502803, 2110.1664842387327, 2156.5147841735643, 2167.3281282802222, 2202.5815095131875, 2274.8976296066717, 9007.279417646638, 9231.815363692689, 9329.860052099224, 9670.081342272473, 12790.680232994157, 1679.966400671992, 1730.5414065272712, 1750.7636469076767, 1823.4620786867772, 1829.2042961311872, 56814.715926420104, 56889.71555142239, 56952.71523642397, 57688.711556442366, 58430.0, 10261.9486902565, 10273.537690803932, 10298.691039268833, 10311.587536498457, 10384.740381490372, 13136.40886160125, 13450.394732237073, 13476.304739052033, 13482.460701572023, 13536.59390218295, 7781.338586220121, 7809.45333826638, 7858.764237072897, 7860.528368297921, 7931.682732690743, 7690.538567685957, 7719.459637825411, 7720.691172353156, 7760.650770715331, 7799.103103143211, 4456.68803183774, 4478.57453541913, 4496.820127194876, 4499.605122412063, 4530.161920044802, 1741.6864964306294, 1779.661864245789, 1782.3850771483817, 1881.3509339277928, 1903.4004288649032, 840.4999025579771, 866.5060915278357, 897.4749771383814, 914.8307563100848, 1044.3316277582353, 14063.789043164361, 16194.43319483836, 16586.336546538245, 17037.48887533376, 17037.914810426115, 910.0444533240204, 911.3392790227165, 929.4980710416299, 932.1563984593953, 985.2462865907586, 9050.366474346733, 9344.719658410258, 9371.250299975985, 9402.43585384879, 9403.388779729295, 528800.0, 537105.0, 538257.0, 562179.0, 565211.0, 71639.28360716431, 75322.62338688271, 76326.0, 76346.0, 76428.0, 1033.7570670892335, 1057.9471026448646, 1128.9096872250036, 1161.8315344275034, 1195.5456926367924, 14395.568132956028, 14428.639284017983, 14597.416103356172, 14767.409303628165, 14926.10443373401, 32938.69429139937, 33104.33791324208, 33451.49822752612, 33881.0, 34198.0, 44030.779846100566, 44204.11591768211, 44222.33666495069, 45166.32250516179, 46117.53882461132, 7025.262347453444, 7218.953251778357, 7350.338469537767, 7391.741289054858, 7429.702811887464, 8832.381733278866, 11011.504482298156, 11051.889481105407, 11087.889121108685, 11325.71685707864, 9333.25333973267, 9624.470654114091, 9806.362586431858, 9869.228029913222, 9898.455584942898, 9291.396059256127, 9564.234861211226, 9929.751756206153, 10015.39907605546, 10074.14369778577, 8670.739877803677, 9534.856977145488, 9664.9033509664, 9967.700968970943, 10056.849147262943, 6890.2420733720255, 7235.602041887747, 7308.8538229234055, 7390.852182956203, 7427.517211381243, 8399.0, 9510.667126650535, 9611.086946740048, 9689.854652180364, 9697.806043879224], "unit": "score", "name": "jquery.html", "value": 8093.902271467268}, {"lowerIsBetter": false, "replicates": [1285.427984546877, 1447.2980604406864, 1473.933672984716, 1614.2090375715902, 1770.2299499717615, 6976.197737260217, 7398.778036658902, 7445.0, 7579.431542634297, 7581.962090189541, 7590.165081841007, 7725.381969442446, 7735.613219339039, 7757.728479503218, 7802.765917022484, 2347.307544274435, 2357.0807385119815, 2357.174988753931, 2359.7286312074075, 2373.1100837186054, 2242.6636004599277, 2266.580682573721, 2271.091563374655, 2277.840551161419, 2282.6461898405773, 2211.4803021289986, 2211.557688462306, 2228.3426389215138, 2272.0798076778847, 2275.8748268845206, 2290.5876942150408, 2317.4206448387904, 2319.9420014499606, 2319.953600927972, 2324.279473363246, 2285.851419657717, 2292.9541409171725, 2294.66727324537, 2296.219285442941, 2296.2651951375565, 7939.364850811979, 7963.362930965567, 7985.121636619967, 7989.520628762293, 7994.0, 4755.2153894607345, 4833.613310935117, 4852.490488498692, 4855.660103792736, 4855.878603034917, 3132.2326030122767, 3144.9056528304186, 3230.0, 3250.6424293327714, 3256.267339848539, 1011.9241056920687, 1019.3425240719769, 1027.7430642339416, 1029.469823041127, 1035.6582327831798, 10893.0, 10903.29128606638, 10930.344179349264, 10932.726681832939, 10942.343459392461, 4431.933520997188, 4455.465344158657, 4495.887602809956, 4504.662150338672, 4534.0478499515475, 9307.255419566418, 9320.533973301443, 9347.90652093484, 9352.485613291334, 9361.765955851159, 4951.851444456672, 4976.701397916137, 4987.925181122286, 4993.50064993505, 5007.649464537448, 3929.5088113985753, 4046.858359957387, 4376.059147283349, 4488.663350248745, 4568.543145685405, 3850.403187505941, 3851.8651847185215, 3858.8456461741775, 3901.902452438712, 3906.2187562487616, 1244.7074937389707, 1249.7500499900057, 1261.1865346851414, 1263.9368031598383, 1264.4562837979572, 1298.3054066074606, 1302.0560093932013, 1308.3458270864567, 1331.9067665263533, 1345.6837643153851, 7504.699812007459, 7542.773716788505, 7660.233976602295, 7676.0, 7679.424043196783, 501.5661452843264, 519.7998770473395, 519.9220116982483, 522.4853519283503, 523.6936392210523, 5671.149327600893, 5685.0, 5719.628224165499, 5723.54211663066, 5744.971275143681, 9204.171624553823, 9721.076497732704, 9767.218622510181, 9793.314467987173, 9815.75460613476, 9597.664081757104, 9659.275554333453, 9663.130318271249, 9674.274429417681, 9751.219902407933, 7187.712491500281, 7376.409887209011, 7441.925580744231, 7482.2517748224745, 7569.091708994846, 7002.3697867192195, 7033.226345102137, 7068.540544864567, 7078.681459334445, 7114.57312561248, 8464.83070338602, 8477.025142108736, 8603.655853765778, 8699.695510657097, 8739.169778870997, 8650.524221167896, 9004.324675649483, 9046.954765226132, 9061.093890610886, 9078.773030674285, 5894.145348924468, 6030.7889223876955, 6299.559030867796, 6533.67331633407, 6793.592384456949, 6894.620795856276, 6908.3091690830515, 6918.273581273894, 6931.0, 6933.895991560232, 6542.509311801729, 6706.6981985811735, 6786.592804431552, 6808.795736127924, 6838.760643377458, 6628.138342015507, 6721.327867213239, 6730.831729206613, 6747.224069231905, 6765.560238584476, 6717.496187785838, 6843.0, 6860.794176174722, 6870.484713646597, 6940.583564986117, 6334.018227174795, 6443.194600674916, 6443.935560644333, 6450.41946224842, 6451.096846441408, 6434.195725534309, 6494.383033611799, 6504.9674751625935, 6511.902321465276, 6518.804435866931], "unit": "score", "name": "mootools.html", "value": 4444.290966565622}, {"lowerIsBetter": false, "replicates": [339.29426792272073, 341.6122700734667, 345.0975698548297, 349.3903139022406, 351.6571342940633, 5694.145878118285, 5837.387074357195, 5843.1527428522895, 5852.151438041481, 5861.384554621767, 5660.377358490563, 5796.449337312949, 5827.417258274181, 5828.417158284169, 5837.387074357195, 4503.1669141208895, 4535.977320113395, 4538.500764915857, 4541.409616749835, 4551.658625603093, 4292.592203740655, 4424.557544245582, 4470.329450582422, 4528.411306530146, 4548.795304211319, 4484.977575112136, 4488.708233964782, 4495.145922274757, 4497.820087196525, 4507.887302817439, 4484.663650226246, 4504.0991801639475, 4512.819487220508, 4528.388667529891, 4539.931901021488, 4014.0, 4014.4781178446906, 4016.0763024504527, 4020.6783457323345, 4022.4368588397647, 5504.422035686235, 5616.269884914935, 5620.662760234358, 5675.716214189315, 5690.146478028288, 5220.973895130538, 5231.973840130813, 5235.0, 5235.65968212065, 5237.633365664405, 5889.263842019747, 6210.565260431772, 6213.37866213375, 6226.0, 6227.875442491125, 4196.664266858675, 4248.277792775205, 4344.956550434486, 4354.629856462205, 4354.782260886975, 6419.133416988693, 6474.611523308617, 6490.7079181436475, 6494.415502604741, 6497.870042599169, 4453.732776033448, 4454.064646424223, 4456.17560751262, 4458.152950939376, 4458.308962110878, 4437.134758722083, 4498.865034048984, 4510.8421205257655, 4522.050369422458, 4553.954460455419, 5201.245819356172, 5208.8437346879655, 5210.53105220532, 5212.582993360522, 5214.739263036833, 6237.625742455467, 6240.719167637467, 6242.43818056368, 6244.0, 6245.812625621239, 1581.169885809936, 1590.4115477273483, 1594.2188327719334, 1595.226315237109, 1596.3135851583932, 1048.6120135549895, 1062.8405739139037, 1077.7413420778958, 1080.0549519170725, 1083.0956151613334, 5846.970765146147, 5861.531077513789, 5861.70691465425, 5867.647941123546, 5869.765209391577, 6288.308286088527, 6305.873882522324, 6308.337624549356, 6312.968435157794, 6315.621062736251, 5846.0, 5854.502367298742, 5857.853553661107, 5861.9706901465215, 5862.912056319158, 3341.715954143925, 3456.548249735117, 3457.6023757267735, 3458.0317511096932, 3459.5329630500064, 6623.4038936495945, 6641.402273795382, 6649.63427011519, 6651.501137414713, 6657.933420665829, 6525.0, 6544.116544266558, 6544.803655890331, 6548.050532672831, 6552.115464412243, 6524.641144737085, 6647.933520664828, 6726.3609957054005, 6730.360615741497, 6733.091032710619, 6191.907121393093, 6361.173047503795, 6463.61218326883, 6468.288488266381, 6468.579542329733, 6266.248050234001, 6331.810045698637, 6341.55609107358, 6382.585131966407, 6398.232212134573, 6700.430463410665, 6710.4631629470505, 6713.395794378529, 6713.496487763535, 6715.0263211833035, 4353.085851971122, 4465.173942820588, 4505.819767209406, 4510.3234514821725, 4515.9548404515535, 6428.164338635947, 6428.453581445629, 6444.871102577828, 6446.419822215836, 6447.258565264867, 6255.155554000152, 6260.561760676709, 6261.373862613702, 6275.6862156892885, 6285.465735412541, 6150.865243459378, 6192.81421557354, 6260.248770147611, 6269.310375858743, 6269.529785266214, 6086.178365920721, 6089.939100608937, 6091.543134265036, 6092.817215483543, 6097.420745029215, 6298.149749783721, 6351.2696039956, 6352.968235158794, 6353.36466353361, 6362.968185159045, 6029.8191054268445, 6124.54065945047, 6128.1726966858905, 6130.080487926846, 6131.356207598138], "unit": "score", "name": "prototype.html", "value": 4708.589732057452}, {"lowerIsBetter": false, "replicates": [761.6001599160442, 810.9067457242417, 847.7202523167356, 856.5460306037799, 860.5181098584789, 13629.65925851853, 13714.108582942114, 13733.58799236022, 13757.931210343946, 13776.448942042307, 12935.094543381967, 12985.480580776757, 12990.155639883402, 13191.604251872435, 13535.187888726683, 673.1081317254633, 817.5912043978026, 829.6432534010373, 829.9792505187359, 830.2735106781566, 683.9829004274908, 813.5484805932705, 820.6758330459465, 829.875518672201, 830.7217082277414, 858.7295002074327, 869.0787764969122, 870.6256309786789, 871.1158174452935, 871.2333146830812, 702.1784512120805, 713.5682911838367, 842.6418772021866, 859.1494420523668, 862.9741107766746, 626.4049153304379, 628.6605233174081, 629.05013429721, 629.5907660020977, 629.6505439481086, 12750.489980400773, 12855.421506032157, 12889.097763156582, 12893.290869002201, 12915.418806153746, 11338.149638777042, 11872.40637968098, 12044.752433873762, 12424.56514022014, 12707.110502264844, 9354.308336520635, 9549.856752148724, 9565.378250413702, 9586.089321514444, 9900.0, 3505.772124811879, 3566.5898421681577, 3574.088607405121, 3588.9641103588892, 3623.6738693517445, 45987.0, 46150.53849461496, 46167.307490387335, 47588.762056189844, 47613.76193119047, 9501.572429240701, 9548.331616786758, 9756.90243097574, 9798.040391921644, 9826.80346393068, 18068.728969065476, 18079.909600452178, 18168.1824317906, 18240.543986400447, 18285.908570457064, 7374.151972523121, 7485.363744081814, 7517.849643007109, 7615.619219039026, 7756.108047574488, 4303.849365272201, 4463.575960283768, 4496.460424748986, 4539.614132798749, 4621.399218101693, 3041.680623534541, 3120.719135277836, 3122.7970181938103, 3140.4661207594763, 3150.291184483473, 590.893639144958, 591.5326891755551, 596.7404179181983, 597.2325561653341, 602.8372339468407, 585.1690599348934, 593.4955288005248, 614.7264467312093, 638.1257676982564, 641.3522342434175, 7797.883031754528, 7809.921900781033, 7926.8810967835525, 7949.0, 8034.397420193392, 514.920187370958, 589.2987345059365, 608.3308360803081, 627.802242293676, 671.0772687554612, 3919.353306704362, 4087.2642924273323, 4127.195196936628, 4291.206126866539, 4367.912641747147, 52402.737986309825, 55319.72340138273, 56109.71945140248, 56506.0, 56772.0, 44312.3353149703, 45672.71636418166, 46176.07647847024, 46285.305720414224, 46404.30393544099, 43558.34662480065, 44907.32639010417, 44989.77505112453, 45471.99999999934, 45486.31770523445, 8571.914280857112, 8596.484210947363, 8889.822203556021, 8900.866487002571, 8908.376413650982, 32519.0, 32933.83533082319, 33712.66287337095, 34448.82775586106, 34648.65351346555, 42093.57906420896, 42734.57265427306, 43143.35284970665, 43893.34159987539, 43911.58486283285, 10307.845382319121, 10330.173586113244, 10469.267151299337, 10501.212409069503, 10767.084797791962, 11262.822289991775, 11411.657650270174, 11640.767184656428, 11650.242734222249, 11779.234349767237, 10522.473876306307, 10539.473026348498, 10887.836682449928, 10892.727681808019, 11057.824266529506, 10766.192535560021, 10840.620578279722, 10892.128629709763, 10914.290571112851, 11075.889241107809, 7804.804879878048, 9865.569492423701, 10574.048335649828, 10950.507227174638, 10958.506867191156, 8839.116088391109, 9126.543672816466, 9194.807521034043, 9212.124848139416, 9382.296327775308, 9069.954650226706, 9485.810283794424, 9591.42451452915, 9606.327557071218, 9652.613895444385], "unit": "score", "name": "yui.html", "value": 6148.412845137129}], "name": "dromaeo_css", "value": 6766.932979655487}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 109.0, 110.0, 109.0, 99.0, 110.0, 109.0, 101.0], "unit": "score", "name": "ai-astar", "value": 106.6}, {"lowerIsBetter": true, "replicates": [151.0, 134.0, 158.0, 170.0, 126.0, 148.0, 152.0, 122.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 93.0, 73.0, 74.0, 74.0, 98.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 144.0, 97.0, 95.0, 96.0, 152.0, 95.0, 97.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 112.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 60.0, 55.0, 54.0, 65.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 92.0, 86.0, 85.0, 87.0, 87.0, 85.0, 85.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 115.0, 116.0, 120.0, 135.0, 124.0, 119.0, 125.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [145.0, 155.0, 147.0, 144.0, 155.0, 143.0, 154.0, 154.0, 155.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 71.0, 70.0, 69.0, 73.0, 73.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1507.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [190.36740909956217], "unit": "score", "name": "DeltaBlue", "value": 347.31785399999995}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1934.3629343629343], "unit": "score", "name": "RayTrace", "value": 382.5492035928143}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [42250.0], "unit": "score", "name": "RegExp", "value": 21.561775147929005}, {"lowerIsBetter": false, "replicates": [572.6447219069239], "unit": "score", "name": "Splay", "value": 142.30638453914761}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19011.026839254417}]} 14:07:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19011.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6766.93"}}} 14:07:46 INFO - Return code: 0 14:07:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:07:46 INFO - # TBPL SUCCESS # 14:07:46 INFO - Running post-action listener: _resource_record_post_action 14:07:46 INFO - Running post-run listener: _resource_record_post_run 14:07:48 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 10510336; Write bytes: 451317760; Read time: 1952; Write time: 509020 14:07:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98127872; Read time: 0; Write time: 128832 14:07:48 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 8749056; Write bytes: 353189888; Read time: 1888; Write time: 380188 14:07:48 INFO - Running post-run listener: _upload_blobber_files 14:07:48 INFO - Blob upload gear active. 14:07:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:07:48 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 14:07:48 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'] 14:07:48 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 14:07:48 INFO - (blobuploader) - INFO - Open directory for files ... 14:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:49 INFO - (blobuploader) - INFO - Done attempting. 14:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:50 INFO - (blobuploader) - INFO - Done attempting. 14:07:50 INFO - (blobuploader) - INFO - Iteration through files over. 14:07:50 INFO - Return code: 0 14:07:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:07:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:07:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ccae4ec3f286136a02ce03776c6dd7883fd6f644081d6a39c99440ac15861c104ba54891a613a8ccd8495e65ccdb08c32f4dc4522d91663a711ff161a2781fea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7bd8550ac3909df67f8bb5da37b51533a57f6d7200923ad1910d4de42b976ae34dc056eb32ea89016732eebdc58120b17b7fbe4608d7069beef4ac778615409f"} 14:07:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:07:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:07:50 INFO - Contents: 14:07:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ccae4ec3f286136a02ce03776c6dd7883fd6f644081d6a39c99440ac15861c104ba54891a613a8ccd8495e65ccdb08c32f4dc4522d91663a711ff161a2781fea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7bd8550ac3909df67f8bb5da37b51533a57f6d7200923ad1910d4de42b976ae34dc056eb32ea89016732eebdc58120b17b7fbe4608d7069beef4ac778615409f"} 14:07:50 INFO - Copying logs to upload dir... 14:07:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1283.409836 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-12 14:07:50.349957) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 14:07:50.353565) ========= 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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 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/ccae4ec3f286136a02ce03776c6dd7883fd6f644081d6a39c99440ac15861c104ba54891a613a8ccd8495e65ccdb08c32f4dc4522d91663a711ff161a2781fea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7bd8550ac3909df67f8bb5da37b51533a57f6d7200923ad1910d4de42b976ae34dc056eb32ea89016732eebdc58120b17b7fbe4608d7069beef4ac778615409f"} build_url:https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/OSuTjuzZTMGjM77CDz7zxg/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/ccae4ec3f286136a02ce03776c6dd7883fd6f644081d6a39c99440ac15861c104ba54891a613a8ccd8495e65ccdb08c32f4dc4522d91663a711ff161a2781fea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7bd8550ac3909df67f8bb5da37b51533a57f6d7200923ad1910d4de42b976ae34dc056eb32ea89016732eebdc58120b17b7fbe4608d7069beef4ac778615409f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 14:07:50.378123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:07:50.378453) ========= 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=62c568580acbfdaac3eec7be000001dc-1452635162.800434-2141700377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:07:50.461014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 14:07:50.461353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 14:07:50.461673) ========= ========= Total master_lag: 0.40 =========