builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1450950744.5 results: success (0) buildid: 20151223233008 builduid: 75beb91862964e328b2f246f942834fc revision: b49e416249d3083d86f7f0487d31449cf57d5dd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.503589) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.504556) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.504925) ========= 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=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006563 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.554604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.555014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.620919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.621264) ========= 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=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004658 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.681390) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.681682) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.682076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.682375) ========= 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=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 01:52: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-24 01:52:24 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100705 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.795685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.796050) ========= 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=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.848782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:24.849161) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b49e416249d3083d86f7f0487d31449cf57d5dd7 --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 b49e416249d3083d86f7f0487d31449cf57d5dd7 --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=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 01:52:25,068 truncating revision to first 12 chars 2015-12-24 01:52:25,068 Setting DEBUG logging. 2015-12-24 01:52:25,068 attempt 1/10 2015-12-24 01:52:25,068 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b49e416249d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 01:52:25,637 unpacking tar archive at: b2g-inbound-b49e416249d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.869109 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:25.731334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:25.731633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:25.751263) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:25.751534) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 01:52:25.752009) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-24 01:52:25.752311) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:52:26 INFO - MultiFileLogger online at 20151224 01:52:26 in /builds/slave/test-pgo 01:52:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 01:52:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:52:26 INFO - {'append_to_log': False, 01:52:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:52:26 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:52:26 INFO - 'branch': 'B2G-Inbound', 01:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 01:52:26 INFO - 'config_files': ('talos/linux_config.py',), 01:52:26 INFO - 'default_actions': ('clobber', 01:52:26 INFO - 'read-buildbot-config', 01:52:26 INFO - 'download-and-extract', 01:52:26 INFO - 'populate-webroot', 01:52:26 INFO - 'create-virtualenv', 01:52:26 INFO - 'install', 01:52:26 INFO - 'run-tests'), 01:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:52:26 INFO - 'download_minidump_stackwalk': True, 01:52:26 INFO - 'download_symbols': 'ondemand', 01:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 01:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 01:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:52:26 INFO - 'installer_path': 'installer.exe', 01:52:26 INFO - 'log_level': 'info', 01:52:26 INFO - 'log_name': 'talos', 01:52:26 INFO - 'log_to_console': True, 01:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:52:26 INFO - 'opt_config_files': (), 01:52:26 INFO - 'pip_index': False, 01:52:26 INFO - 'sps_profile': False, 01:52:26 INFO - 'sps_profile_interval': 0, 01:52:26 INFO - 'suite': 'dromaeojs', 01:52:26 INFO - 'system_bits': '64', 01:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:52:26 INFO - 'title': 'talos-linux64-ix-002', 01:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:52:26 INFO - 'use_talos_json': True, 01:52:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:52:26 INFO - 'work_dir': 'build'} 01:52:26 INFO - ##### 01:52:26 INFO - ##### Running clobber step. 01:52:26 INFO - ##### 01:52:26 INFO - Running pre-action listener: _resource_record_pre_action 01:52:26 INFO - Running main action method: clobber 01:52:26 INFO - rmtree: /builds/slave/test-pgo/build 01:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:52:27 INFO - Running post-action listener: _resource_record_post_action 01:52:27 INFO - ##### 01:52:27 INFO - ##### Running read-buildbot-config step. 01:52:27 INFO - ##### 01:52:27 INFO - Running pre-action listener: _resource_record_pre_action 01:52:27 INFO - Running main action method: read_buildbot_config 01:52:27 INFO - Using buildbot properties: 01:52:27 INFO - { 01:52:27 INFO - "project": "", 01:52:27 INFO - "product": "firefox", 01:52:27 INFO - "script_repo_revision": "production", 01:52:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:52:27 INFO - "repository": "", 01:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:52:27 INFO - "buildid": "20151223233008", 01:52:27 INFO - "pgo_build": "True", 01:52:27 INFO - "basedir": "/builds/slave/test-pgo", 01:52:27 INFO - "buildnumber": 1076, 01:52:27 INFO - "slavename": "talos-linux64-ix-002", 01:52:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:52:27 INFO - "platform": "ubuntu64_hw", 01:52:27 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:52:27 INFO - "branch": "b2g-inbound", 01:52:27 INFO - "repo_path": "integration/b2g-inbound", 01:52:27 INFO - "revision": "b49e416249d3083d86f7f0487d31449cf57d5dd7", 01:52:27 INFO - "stage_platform": "linux64-pgo", 01:52:27 INFO - "builduid": "75beb91862964e328b2f246f942834fc", 01:52:27 INFO - "slavebuilddir": "test" 01:52:27 INFO - } 01:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:52:27 INFO - Running post-action listener: _resource_record_post_action 01:52:27 INFO - ##### 01:52:27 INFO - ##### Running download-and-extract step. 01:52:27 INFO - ##### 01:52:27 INFO - Running pre-action listener: _resource_record_pre_action 01:52:27 INFO - Running main action method: download_and_extract 01:52:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:27 INFO - https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/test_packages.json 01:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/test_packages.json 01:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:52:30 INFO - Downloaded 1302 bytes. 01:52:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:52:30 INFO - Using the following test package requirements: 01:52:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:52:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:30 INFO - u'jsshell-linux-x86_64.zip'], 01:52:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:52:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:52:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:52:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:52:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:52:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:52: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')]} 01:52:30 INFO - https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:31 INFO - Downloaded 23180404 bytes. 01:52:31 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 01:52:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:31 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 01:52:32 INFO - Return code: 0 01:52:32 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 01:52: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')]} 01:52:32 INFO - https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:38 INFO - Downloaded 23180404 bytes. 01:52:38 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 01:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:38 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 01:52:39 INFO - Return code: 0 01:52:39 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')]} 01:52:40 INFO - https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:40 INFO - Downloaded 11132277 bytes. 01:52:40 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 01:52:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:40 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 01:52:41 INFO - Return code: 0 01:52: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')]} 01:52:41 INFO - https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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 01:52:42 INFO - Downloaded 54836164 bytes. 01:52:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:42 INFO - mkdir: /builds/slave/test-pgo/properties 01:52:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:52:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:52:42 INFO - Contents: 01:52:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:42 INFO - Running post-action listener: _resource_record_post_action 01:52:42 INFO - Running post-action listener: set_extra_try_arguments 01:52:42 INFO - ##### 01:52:42 INFO - ##### Running populate-webroot step. 01:52:42 INFO - ##### 01:52:42 INFO - Running pre-action listener: _resource_record_pre_action 01:52:42 INFO - Running main action method: populate_webroot 01:52:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:52:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:52:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:52:42 INFO - '--tppagecycles', 01:52:42 INFO - '7'], 01:52:42 INFO - 'tests': ['tsvgm']}}, 01:52:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:52:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:52:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:52:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:52:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'tests': ['damp', 'tps']}, 01:52:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['damp', 'tps']}, 01:52:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:52:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:52:42 INFO - 'other': {'tests': ['a11yr', 01:52:42 INFO - 'ts_paint', 01:52:42 INFO - 'tpaint', 01:52:42 INFO - 'sessionrestore', 01:52:42 INFO - 'sessionrestore_no_auto_restore']}, 01:52:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['a11yr', 01:52:42 INFO - 'ts_paint', 01:52:42 INFO - 'tpaint', 01:52:42 INFO - 'sessionrestore', 01:52:42 INFO - 'sessionrestore_no_auto_restore']}, 01:52:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['a11yr', 01:52:42 INFO - 'ts_paint', 01:52:42 INFO - 'tpaint', 01:52:42 INFO - 'sessionrestore', 01:52:42 INFO - 'sessionrestore_no_auto_restore']}, 01:52:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['a11yr', 01:52:42 INFO - 'ts_paint', 01:52:42 INFO - 'tpaint', 01:52:42 INFO - 'sessionrestore', 01:52:42 INFO - 'sessionrestore_no_auto_restore']}, 01:52:42 INFO - 'other_l64': {'tests': ['a11yr', 01:52:42 INFO - 'ts_paint', 01:52:42 INFO - 'tpaint', 01:52:42 INFO - 'sessionrestore', 01:52:42 INFO - 'sessionrestore_no_auto_restore']}, 01:52:42 INFO - 'other_nol64': {'tests': ['a11yr', 01:52:42 INFO - 'ts_paint', 01:52:42 INFO - 'tpaint', 01:52:42 INFO - 'sessionrestore', 01:52:42 INFO - 'sessionrestore_no_auto_restore']}, 01:52:42 INFO - 'svgr': {'tests': ['tsvgx', 01:52:42 INFO - 'tsvgr_opacity', 01:52:42 INFO - 'tart', 01:52:42 INFO - 'tscrollx', 01:52:42 INFO - 'cart']}, 01:52:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['tsvgx', 01:52:42 INFO - 'tsvgr_opacity', 01:52:42 INFO - 'tart', 01:52:42 INFO - 'tscrollx', 01:52:42 INFO - 'cart']}, 01:52:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'tests': ['tp5o']}, 01:52:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'talos_options': ['--e10s'], 01:52:42 INFO - 'tests': ['tp5o']}, 01:52:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'talos_options': ['--xperf_path', 01:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:42 INFO - 'tests': ['tp5n']}, 01:52:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:42 INFO - 'talos_options': ['--e10s', 01:52:42 INFO - '--xperf_path', 01:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:42 INFO - 'tests': ['tp5n']}}, 01:52:42 INFO - 'talos.zip': {'path': '', 01:52:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:52:42 INFO - Running post-action listener: _resource_record_post_action 01:52:42 INFO - ##### 01:52:42 INFO - ##### Running create-virtualenv step. 01:52:42 INFO - ##### 01:52:42 INFO - Running pre-action listener: _resource_record_pre_action 01:52:42 INFO - Running main action method: create_virtualenv 01:52:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:52:42 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 01:52:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:52:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:52:42 INFO - Using real prefix '/usr' 01:52:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:52:42 INFO - Installing distribute.............................................................................................................................................................................................done. 01:52:44 INFO - Installing pip.................done. 01:52:45 INFO - Return code: 0 01:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:52:45 INFO - Using env: {'DISPLAY': ':0', 01:52:45 INFO - 'HOME': '/home/cltbld', 01:52:45 INFO - 'LANG': 'en_US.UTF-8', 01:52:45 INFO - 'LANGUAGE': 'en_US:en', 01:52:45 INFO - 'LOGNAME': 'cltbld', 01:52:45 INFO - 'MAIL': '/var/mail/cltbld', 01:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:45 INFO - 'MOZ_NO_REMOTE': '1', 01:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:45 INFO - 'NO_EM_RESTART': '1', 01:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:45 INFO - 'SHELL': '/bin/bash', 01:52:45 INFO - 'SHLVL': '1', 01:52:45 INFO - 'TERM': 'linux', 01:52:45 INFO - 'TMOUT': '86400', 01:52:45 INFO - 'USER': 'cltbld', 01:52:45 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:45 INFO - '_': '/tools/buildbot/bin/python'} 01:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:45 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 01:52:45 INFO - Cleaning up... 01:52:45 INFO - Return code: 0 01:52:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:52:45 INFO - Using env: {'DISPLAY': ':0', 01:52:45 INFO - 'HOME': '/home/cltbld', 01:52:45 INFO - 'LANG': 'en_US.UTF-8', 01:52:45 INFO - 'LANGUAGE': 'en_US:en', 01:52:45 INFO - 'LOGNAME': 'cltbld', 01:52:45 INFO - 'MAIL': '/var/mail/cltbld', 01:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:45 INFO - 'MOZ_NO_REMOTE': '1', 01:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:45 INFO - 'NO_EM_RESTART': '1', 01:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:45 INFO - 'SHELL': '/bin/bash', 01:52:45 INFO - 'SHLVL': '1', 01:52:45 INFO - 'TERM': 'linux', 01:52:45 INFO - 'TMOUT': '86400', 01:52:45 INFO - 'USER': 'cltbld', 01:52:45 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:45 INFO - '_': '/tools/buildbot/bin/python'} 01:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:45 INFO - Downloading/unpacking psutil>=0.7.1 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:52:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:52:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:47 INFO - Installing collected packages: psutil 01:52:47 INFO - Running setup.py install for psutil 01:52:47 INFO - building 'psutil._psutil_linux' extension 01:52:47 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 01:52:47 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 01:52:47 INFO - building 'psutil._psutil_posix' extension 01:52:47 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 01:52:47 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 01:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:47 INFO - Successfully installed psutil 01:52:47 INFO - Cleaning up... 01:52:47 INFO - Return code: 0 01:52:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:52:47 INFO - Using env: {'DISPLAY': ':0', 01:52:47 INFO - 'HOME': '/home/cltbld', 01:52:47 INFO - 'LANG': 'en_US.UTF-8', 01:52:47 INFO - 'LANGUAGE': 'en_US:en', 01:52:47 INFO - 'LOGNAME': 'cltbld', 01:52:47 INFO - 'MAIL': '/var/mail/cltbld', 01:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:47 INFO - 'MOZ_NO_REMOTE': '1', 01:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:47 INFO - 'NO_EM_RESTART': '1', 01:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:47 INFO - 'SHELL': '/bin/bash', 01:52:47 INFO - 'SHLVL': '1', 01:52:47 INFO - 'TERM': 'linux', 01:52:47 INFO - 'TMOUT': '86400', 01:52:47 INFO - 'USER': 'cltbld', 01:52:47 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:47 INFO - '_': '/tools/buildbot/bin/python'} 01:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:52:49 INFO - Installing collected packages: mozsystemmonitor 01:52:49 INFO - Running setup.py install for mozsystemmonitor 01:52:49 INFO - Successfully installed mozsystemmonitor 01:52:49 INFO - Cleaning up... 01:52:49 INFO - Return code: 0 01:52:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:49 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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:52:49 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 01:52:49 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 01:52:49 INFO - Using env: {'DISPLAY': ':0', 01:52:49 INFO - 'HOME': '/home/cltbld', 01:52:49 INFO - 'LANG': 'en_US.UTF-8', 01:52:49 INFO - 'LANGUAGE': 'en_US:en', 01:52:49 INFO - 'LOGNAME': 'cltbld', 01:52:49 INFO - 'MAIL': '/var/mail/cltbld', 01:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:49 INFO - 'MOZ_NO_REMOTE': '1', 01:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:49 INFO - 'NO_EM_RESTART': '1', 01:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:49 INFO - 'SHELL': '/bin/bash', 01:52:49 INFO - 'SHLVL': '1', 01:52:49 INFO - 'TERM': 'linux', 01:52:49 INFO - 'TMOUT': '86400', 01:52:49 INFO - 'USER': 'cltbld', 01:52:49 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:49 INFO - '_': '/tools/buildbot/bin/python'} 01:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:51 INFO - Downloading blobuploader-1.2.4.tar.gz 01:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:52:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:52:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:52 INFO - Downloading docopt-0.6.1.tar.gz 01:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:52:52 INFO - Installing collected packages: blobuploader, requests, docopt 01:52:52 INFO - Running setup.py install for blobuploader 01:52:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:52:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:52:52 INFO - Running setup.py install for requests 01:52:52 INFO - Running setup.py install for docopt 01:52:53 INFO - Successfully installed blobuploader requests docopt 01:52:53 INFO - Cleaning up... 01:52:53 INFO - Return code: 0 01:52:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:53 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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:52:53 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 01:52:53 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 01:52:53 INFO - Using env: {'DISPLAY': ':0', 01:52:53 INFO - 'HOME': '/home/cltbld', 01:52:53 INFO - 'LANG': 'en_US.UTF-8', 01:52:53 INFO - 'LANGUAGE': 'en_US:en', 01:52:53 INFO - 'LOGNAME': 'cltbld', 01:52:53 INFO - 'MAIL': '/var/mail/cltbld', 01:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:53 INFO - 'MOZ_NO_REMOTE': '1', 01:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:53 INFO - 'NO_EM_RESTART': '1', 01:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:53 INFO - 'SHELL': '/bin/bash', 01:52:53 INFO - 'SHLVL': '1', 01:52:53 INFO - 'TERM': 'linux', 01:52:53 INFO - 'TMOUT': '86400', 01:52:53 INFO - 'USER': 'cltbld', 01:52:53 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:53 INFO - '_': '/tools/buildbot/bin/python'} 01:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:53 INFO - Running setup.py (path:/tmp/pip-1cJ6WJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:53 INFO - Running setup.py (path:/tmp/pip-aqhSbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:53 INFO - Running setup.py (path:/tmp/pip-wDovMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:53 INFO - Running setup.py (path:/tmp/pip-05Wb9k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:53 INFO - Running setup.py (path:/tmp/pip-XlIBXA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:53 INFO - Running setup.py (path:/tmp/pip-Aj_UTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:53 INFO - Running setup.py (path:/tmp/pip-wWz94_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:53 INFO - Running setup.py (path:/tmp/pip-oMjUzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:53 INFO - Running setup.py (path:/tmp/pip-I5MSBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:53 INFO - Running setup.py (path:/tmp/pip-v35jrQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:53 INFO - Running setup.py (path:/tmp/pip-jPeFh_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:54 INFO - Running setup.py (path:/tmp/pip-uo4HQv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:54 INFO - Running setup.py (path:/tmp/pip-jfO5TB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:54 INFO - Running setup.py (path:/tmp/pip-VgBkJT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:54 INFO - Running setup.py (path:/tmp/pip-lMRLRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:54 INFO - Running setup.py (path:/tmp/pip-0c_JmM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:54 INFO - Running setup.py (path:/tmp/pip-mCX4Eo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:52:54 INFO - Running setup.py install for manifestparser 01:52:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:52:54 INFO - Running setup.py install for mozcrash 01:52:54 INFO - Running setup.py install for mozdebug 01:52:54 INFO - Running setup.py install for mozdevice 01:52:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:52:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:52:54 INFO - Running setup.py install for mozfile 01:52:55 INFO - Running setup.py install for mozhttpd 01:52:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Running setup.py install for mozinfo 01:52:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Running setup.py install for mozInstall 01:52:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Running setup.py install for mozleak 01:52:55 INFO - Running setup.py install for mozlog 01:52:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Running setup.py install for moznetwork 01:52:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Running setup.py install for mozprocess 01:52:55 INFO - Running setup.py install for mozprofile 01:52:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Running setup.py install for mozrunner 01:52:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:52:55 INFO - Running setup.py install for mozscreenshot 01:52:56 INFO - Running setup.py install for moztest 01:52:56 INFO - Running setup.py install for mozversion 01:52:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:52:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:52:56 INFO - Cleaning up... 01:52:56 INFO - Return code: 0 01:52:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:52:56 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 01:52:56 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 01:52:56 INFO - Using env: {'DISPLAY': ':0', 01:52:56 INFO - 'HOME': '/home/cltbld', 01:52:56 INFO - 'LANG': 'en_US.UTF-8', 01:52:56 INFO - 'LANGUAGE': 'en_US:en', 01:52:56 INFO - 'LOGNAME': 'cltbld', 01:52:56 INFO - 'MAIL': '/var/mail/cltbld', 01:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:56 INFO - 'MOZ_NO_REMOTE': '1', 01:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:56 INFO - 'NO_EM_RESTART': '1', 01:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:56 INFO - 'SHELL': '/bin/bash', 01:52:56 INFO - 'SHLVL': '1', 01:52:56 INFO - 'TERM': 'linux', 01:52:56 INFO - 'TMOUT': '86400', 01:52:56 INFO - 'USER': 'cltbld', 01:52:56 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:56 INFO - '_': '/tools/buildbot/bin/python'} 01:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:56 INFO - Running setup.py (path:/tmp/pip-FUpfbC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:56 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)) 01:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:56 INFO - Running setup.py (path:/tmp/pip-X8939D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:56 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)) 01:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:56 INFO - Running setup.py (path:/tmp/pip-YYXkqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:56 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)) 01:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:56 INFO - Running setup.py (path:/tmp/pip-YTw6QF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:56 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)) 01:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:56 INFO - Running setup.py (path:/tmp/pip-IJeDtb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:56 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)) 01:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:56 INFO - Running setup.py (path:/tmp/pip-e61b2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:56 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)) 01:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:56 INFO - Running setup.py (path:/tmp/pip-mS5NNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:57 INFO - Running setup.py (path:/tmp/pip-NP71_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:57 INFO - Running setup.py (path:/tmp/pip-3mrvIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:57 INFO - Running setup.py (path:/tmp/pip-_B6fDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:57 INFO - Running setup.py (path:/tmp/pip-A_UnU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:57 INFO - Running setup.py (path:/tmp/pip-ASCIyp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:57 INFO - Running setup.py (path:/tmp/pip-4Ai_GR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:57 INFO - Running setup.py (path:/tmp/pip-eT_a1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:57 INFO - Running setup.py (path:/tmp/pip-tYUXfu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:57 INFO - Running setup.py (path:/tmp/pip-OL_kab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:57 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)) 01:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:57 INFO - Running setup.py (path:/tmp/pip-XBDEiU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:57 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)) 01:52:57 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)) 01:52:57 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)) 01:52:57 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)) 01:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:52:57 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)) 01:52:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:59 INFO - Downloading blessings-1.5.1.tar.gz 01:52:59 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 01:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:59 INFO - Installing collected packages: blessings 01:52:59 INFO - Running setup.py install for blessings 01:52:59 INFO - Successfully installed blessings 01:52:59 INFO - Cleaning up... 01:52:59 INFO - Return code: 0 01:52:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:52:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:52:59 INFO - Reading from file tmpfile_stdout 01:52:59 INFO - Current package versions: 01:52:59 INFO - argparse == 1.2.1 01:52:59 INFO - blessings == 1.5.1 01:52:59 INFO - blobuploader == 1.2.4 01:52:59 INFO - docopt == 0.6.1 01:52:59 INFO - manifestparser == 1.1 01:52:59 INFO - mozInstall == 1.12 01:52:59 INFO - mozcrash == 0.16 01:52:59 INFO - mozdebug == 0.1 01:52:59 INFO - mozdevice == 0.47 01:52:59 INFO - mozfile == 1.2 01:52:59 INFO - mozhttpd == 0.7 01:52:59 INFO - mozinfo == 0.9 01:52:59 INFO - mozleak == 0.1 01:52:59 INFO - mozlog == 3.1 01:52:59 INFO - moznetwork == 0.27 01:52:59 INFO - mozprocess == 0.22 01:52:59 INFO - mozprofile == 0.28 01:52:59 INFO - mozrunner == 6.11 01:52:59 INFO - mozscreenshot == 0.1 01:52:59 INFO - mozsystemmonitor == 0.0 01:52:59 INFO - moztest == 0.7 01:52:59 INFO - mozversion == 1.4 01:52:59 INFO - psutil == 3.1.1 01:52:59 INFO - requests == 1.2.3 01:52:59 INFO - wsgiref == 0.1.2 01:52:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:52:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 01:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 01:52:59 INFO - Using env: {'DISPLAY': ':0', 01:52:59 INFO - 'HOME': '/home/cltbld', 01:52:59 INFO - 'LANG': 'en_US.UTF-8', 01:52:59 INFO - 'LANGUAGE': 'en_US:en', 01:52:59 INFO - 'LOGNAME': 'cltbld', 01:52:59 INFO - 'MAIL': '/var/mail/cltbld', 01:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:59 INFO - 'MOZ_NO_REMOTE': '1', 01:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:59 INFO - 'NO_EM_RESTART': '1', 01:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:59 INFO - 'SHELL': '/bin/bash', 01:52:59 INFO - 'SHLVL': '1', 01:52:59 INFO - 'TERM': 'linux', 01:52:59 INFO - 'TMOUT': '86400', 01:52:59 INFO - 'USER': 'cltbld', 01:52:59 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:59 INFO - '_': '/tools/buildbot/bin/python'} 01:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 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)) 01:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 01:53:00 INFO - Cleaning up... 01:53:00 INFO - Return code: 0 01:53:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:53:00 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')]} 01:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:00 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')]} 01:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:00 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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:53:00 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 01:53:00 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 01:53:00 INFO - Using env: {'DISPLAY': ':0', 01:53:00 INFO - 'HOME': '/home/cltbld', 01:53:00 INFO - 'LANG': 'en_US.UTF-8', 01:53:00 INFO - 'LANGUAGE': 'en_US:en', 01:53:00 INFO - 'LOGNAME': 'cltbld', 01:53:00 INFO - 'MAIL': '/var/mail/cltbld', 01:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:00 INFO - 'MOZ_NO_REMOTE': '1', 01:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:00 INFO - 'NO_EM_RESTART': '1', 01:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:00 INFO - 'SHELL': '/bin/bash', 01:53:00 INFO - 'SHLVL': '1', 01:53:00 INFO - 'TERM': 'linux', 01:53:00 INFO - 'TMOUT': '86400', 01:53:00 INFO - 'USER': 'cltbld', 01:53:00 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:00 INFO - '_': '/tools/buildbot/bin/python'} 01:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:00 INFO - Downloading/unpacking jsonschema 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53: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 01:53:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:53:02 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 01:53:02 INFO - Downloading/unpacking functools32 (from jsonschema) 01:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:02 INFO - Downloading functools32-3.2.3-2.tar.gz 01:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:53:02 INFO - warning: no files found matching '*.txt' 01:53:02 INFO - no previously-included directories found matching 'build' 01:53:02 INFO - no previously-included directories found matching 'dist' 01:53:02 INFO - no previously-included directories found matching '.git*' 01:53:02 INFO - Installing collected packages: jsonschema, functools32 01:53:02 INFO - Running setup.py install for functools32 01:53:02 INFO - warning: no files found matching '*.txt' 01:53:02 INFO - no previously-included directories found matching 'build' 01:53:02 INFO - no previously-included directories found matching 'dist' 01:53:02 INFO - no previously-included directories found matching '.git*' 01:53:02 INFO - Successfully installed jsonschema functools32 01:53:02 INFO - Cleaning up... 01:53:02 INFO - Return code: 0 01:53:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fab762a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, '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': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', '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 01:53:02 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 01:53:02 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 01:53:02 INFO - Using env: {'DISPLAY': ':0', 01:53:02 INFO - 'HOME': '/home/cltbld', 01:53:02 INFO - 'LANG': 'en_US.UTF-8', 01:53:02 INFO - 'LANGUAGE': 'en_US:en', 01:53:02 INFO - 'LOGNAME': 'cltbld', 01:53:02 INFO - 'MAIL': '/var/mail/cltbld', 01:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:02 INFO - 'MOZ_NO_REMOTE': '1', 01:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:02 INFO - 'NO_EM_RESTART': '1', 01:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:02 INFO - 'SHELL': '/bin/bash', 01:53:02 INFO - 'SHLVL': '1', 01:53:02 INFO - 'TERM': 'linux', 01:53:02 INFO - 'TMOUT': '86400', 01:53:02 INFO - 'USER': 'cltbld', 01:53:02 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:02 INFO - '_': '/tools/buildbot/bin/python'} 01:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:02 INFO - Downloading/unpacking flake8 01:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:53:04 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 01:53:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:53:04 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 01:53:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 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 01:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:53:05 INFO - no previously-included directories found matching 'docs/_build' 01:53:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:53:05 INFO - Running setup.py install for pep8 01:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:53:05 INFO - no previously-included directories found matching 'docs/_build' 01:53:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:53:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:53:05 INFO - Cleaning up... 01:53:05 INFO - Return code: 0 01:53:05 INFO - Running post-action listener: _resource_record_post_action 01:53:05 INFO - Running post-action listener: _start_resource_monitoring 01:53:05 INFO - Starting resource monitoring. 01:53:05 INFO - ##### 01:53:05 INFO - ##### Running install step. 01:53:05 INFO - ##### 01:53:05 INFO - Running pre-action listener: _resource_record_pre_action 01:53:05 INFO - Running main action method: install 01:53:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:53:05 INFO - Reading from file tmpfile_stdout 01:53:05 INFO - Detecting whether we're running mozinstall >=1.0... 01:53:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:53:05 INFO - Reading from file tmpfile_stdout 01:53:05 INFO - Output received: 01:53:05 INFO - Usage: mozinstall [options] installer 01:53:05 INFO - Options: 01:53:05 INFO - -h, --help show this help message and exit 01:53:05 INFO - -d DEST, --destination=DEST 01:53:05 INFO - Directory to install application into. [default: 01:53:05 INFO - "/builds/slave/test-pgo"] 01:53:05 INFO - --app=APP Application being installed. [default: firefox] 01:53:05 INFO - mkdir: /builds/slave/test-pgo/build/application 01:53:05 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'] 01:53:05 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 01:53:21 INFO - Reading from file tmpfile_stdout 01:53:21 INFO - Output received: 01:53:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:53:21 INFO - Running post-action listener: _resource_record_post_action 01:53:21 INFO - ##### 01:53:21 INFO - ##### Running run-tests step. 01:53:21 INFO - ##### 01:53:21 INFO - Running pre-action listener: _resource_record_pre_action 01:53:21 INFO - Running main action method: run_tests 01:53:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:53:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:53:21 INFO - Python 2.7.3 01:53:21 INFO - Return code: 0 01:53:21 INFO - grabbing minidump binary from tooltool 01:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:21 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 0x2d33840>, '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 0x2ca06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:53:21 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 01:53:21 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 01:53:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:53:21 INFO - Return code: 0 01:53:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:53:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:53:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:53:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:53:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:53:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:53:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:53:22 INFO - Return code: 0 01:53:22 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/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 01:53:22 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/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 01:53:22 INFO - Using env: {'DISPLAY': ':0', 01:53:22 INFO - 'HOME': '/home/cltbld', 01:53:22 INFO - 'LANG': 'en_US.UTF-8', 01:53:22 INFO - 'LANGUAGE': 'en_US:en', 01:53:22 INFO - 'LOGNAME': 'cltbld', 01:53:22 INFO - 'MAIL': '/var/mail/cltbld', 01:53:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:53:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:22 INFO - 'MOZ_NO_REMOTE': '1', 01:53:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:22 INFO - 'NO_EM_RESTART': '1', 01:53:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:22 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:53:22 INFO - 'SHELL': '/bin/bash', 01:53:22 INFO - 'SHLVL': '1', 01:53:22 INFO - 'TERM': 'linux', 01:53:22 INFO - 'TMOUT': '86400', 01:53:22 INFO - 'USER': 'cltbld', 01:53:22 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450949214.168830-402457626', 01:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:22 INFO - '_': '/tools/buildbot/bin/python'} 01:53:22 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/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 01:53:22 INFO - mozversion application_buildid: 20151223233008 01:53:22 INFO - mozversion application_changeset: b49e416249d3083d86f7f0487d31449cf57d5dd7 01:53:22 INFO - mozversion application_display_name: Nightly 01:53:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:53:22 INFO - mozversion application_name: Firefox 01:53:22 INFO - mozversion application_remotingname: firefox 01:53:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:53:22 INFO - mozversion application_vendor: Mozilla 01:53:22 INFO - mozversion application_version: 46.0a1 01:53:22 INFO - mozversion platform_buildid: 20151223233008 01:53:22 INFO - mozversion platform_changeset: b49e416249d3083d86f7f0487d31449cf57d5dd7 01:53:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:53:22 INFO - mozversion platform_version: 46.0a1 01:53:22 INFO - using testdate: 1450950802 01:53:22 INFO - actual date: 1450950802 01:53:22 INFO - starting webserver on 'localhost:56917' 01:53:22 INFO - SUITE-START | Running 3 tests 01:53:22 INFO - TEST-START | dromaeo_css 01:53:22 INFO - operating with platform_type : linux_ 01:53:22 INFO - Initialising browser for dromaeo_css test... 01:53:22 INFO - TEST-INFO | started process 3459 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpagoMc3/profile http://localhost:56917/getInfo.html) 01:53:26 INFO - PROCESS | 3459 | __metrics Screen width/height:1600/1200 01:53:26 INFO - PROCESS | 3459 | colorDepth:24 01:53:26 INFO - PROCESS | 3459 | Browser inner width/height: 1024/697 01:53:26 INFO - PROCESS | 3459 | __metrics 01:53:26 INFO - PROCESS | 3459 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:53:27 INFO - PROCESS | 3459 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:53:27 ERROR - PROCESS | 3459 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 01:53:27 INFO - TEST-INFO | 3459: exit 0 01:53:27 INFO - Browser initialized. 01:53:27 INFO - Running cycle 1/1 for dromaeo_css test... 01:53:27 INFO - TEST-INFO | started process 3554 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpagoMc3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:39 INFO - PROCESS | 3554 | RSS: Main: 150360064 01:53:39 INFO - PROCESS | 3554 | 01:54:31 INFO - PROCESS | 3554 | 1450950871085 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] 01:56:39 INFO - PROCESS | 3554 | Cycle 1(1): loaded http://localhost:56917/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56917/tests/dromaeo/cssquery-ext.html) 01:56:40 INFO - PROCESS | 3554 | RSS: Main: 275992576 01:56:40 INFO - PROCESS | 3554 | 01:59:43 INFO - PROCESS | 3554 | Cycle 1(1): loaded http://localhost:56917/tests/dromaeo/cssquery-ext.html (next: http://localhost:56917/tests/dromaeo/cssquery-jquery.html) 01:59:43 INFO - PROCESS | 3554 | RSS: Main: 230703104 01:59:43 INFO - PROCESS | 3554 | 02:02:45 INFO - PROCESS | 3554 | Cycle 1(1): loaded http://localhost:56917/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56917/tests/dromaeo/cssquery-mootools.html) 02:02:46 INFO - PROCESS | 3554 | RSS: Main: 234328064 02:02:46 INFO - PROCESS | 3554 | 02:05:48 INFO - PROCESS | 3554 | Cycle 1(1): loaded http://localhost:56917/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56917/tests/dromaeo/cssquery-prototype.html) 02:05:48 INFO - PROCESS | 3554 | RSS: Main: 212185088 02:05:48 INFO - PROCESS | 3554 | 02:08:51 INFO - PROCESS | 3554 | Cycle 1(1): loaded http://localhost:56917/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56917/tests/dromaeo/cssquery-yui.html) 02:08:51 INFO - PROCESS | 3554 | RSS: Main: 213348352 02:08:51 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | Cycle 1(1): loaded http://localhost:56917/tests/dromaeo/cssquery-yui.html (next: http://localhost:56917/tests/dromaeo/cssquery-dojo.html) 02:11:54 INFO - PROCESS | 3554 | RSS: Main: 282357760 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | __start_tp_report 02:11:54 INFO - PROCESS | 3554 | _x_x_mozilla_page_load 02:11:54 INFO - PROCESS | 3554 | _x_x_mozilla_page_load_details 02:11:54 INFO - PROCESS | 3554 | |i|pagename|runs| 02:11:54 INFO - PROCESS | 3554 | |0;dojo.html;3151.8739250429985;3165.730912872406;3225.9999400185943;3229.7739158258933;3258.4134855725965;5153.665011774241;5233.528982391584;5285.392179899312;5314.813981510643;5391.272178255935;5142.562882155012;5180.844574662757;5213.139831927728;5220.817271395502;5221.425643179247;4665.813367465297;4763.642726795487;4793.976030119853;4919.60643148549;4947.52998465147;4707.670463067587;4814.350062741538;4918.754062296889;4932.457429682732;5027.522385373402;4773.856784296477;4831.855044348676;4836.298736683161;4842.080004799077;4855.247436647308;4782.282657601353;4790.976045119787;4799.3760811094335;4805.399325084364;4884.804607815683;4674.555917187861;4776.5701086902;4777.880552986168;4802.207635740098;4832.033593281358;5169.172932330809;5170.896582068338;5174.560162386202;5180.844574662766;5182.041322355339;5724.255846739898;5726.0838265877255;5728.856778580569;5732.168835518826;5734.713264336767;5524.171374293848;5609;5636.689982050985;5732.340780810218;5790.826275211751;5291.973540132275;5293.655912365684;5297.8145764898045;5299.735013249322;5303.946960530384;5788.450097240755;5789.478946894716;5791.478766910914;5792.8551786204835;5803.738831752581;5420.945790542123;5524.8066317679495;5535.5848311376;5539.695316757537;5639.689817060019;5763.596548241667;5781.739821708034;5782.566307526952;5783.334916484574;5789.8263052108505;5712.942870571324;5761.107028410603;5768.3366412862215;5769.826905192851;5778.826635200867;5511.779528818883;5613.242212301368;5622.690752008597;5752.769889204469;5763.337216220105;4341.544137865541;4355.60799528044;4391.934120988188;4418.536053714313;4426.15902978433;3965.7422267552515;3965.841366345314;3970.9602903971168;3981.601839816053;4004.2992476316526;5173.63784535079;5267.499587539254;5345.812896548602;5363.704996225167;5363.81226657073;5542.224088627595;5702.401247868997;5790.131480277992;5800.680962547016;5803.65178089316;5300.284461597635;5338.97330513345;5347.973260133675;5351.491608297206;5351.625386222927;4739.502352253033;4821.7589120543835;4943.595886992128;4955.628327875352;5002.59979201663;5831.88336233273;5931.881362372728;5932;5946.494547963385;5963.463288303987;5633.295838020247;5651.802186923438;5712.828615141552;5717.313922329181;5718.542516598579;5924.792632258022;5925.081612350093;5929.051351783866;5929.288485381781;5946.821595352147;5432.619716619799;5536.086545719912;5537.889242215214;5562.3047119110115;5678.346990096026;5661;5687.090065589486;5688.232088668143;5690.914636280542;5696.971515142398;5531.9723401382735;5532.30846144232;5538.224648549126;5538.418466061005;5544.362398324244;5471.316085489314;5532.86167845791;5543.695096769717;5576.442355764391;5678.886422271449;5487.835364939058;5488.313960754906;5494.917576236439;5497.175423686479;5512.6968016759465;5579.6652200868075;5599.524040456607;5599.748011339418;5607.579431542732;5665.575081868794;5217.0870097733505;5309.495597918191;5310.8937821244135;5388.703621300866;5464.1257398816 02:11:54 INFO - PROCESS | 3554 | |1;ext.html;560.9663420194788;607.4714997951781;612.9846753831157;615.418429584043;635.2853040329626;34765.652343476555;35430.8228458858;35456.64543354566;35479.64520354796;35484;39472.40791388132;40019.399709004385;40032;40060.59939400612;40084.19831603366;7453.813654658623;7566.4325175611775;8610.397272190965;8816.250618697386;8817.250533704642;10290;10592.682219533426;10600.840987385196;10611.628592999246;10618.044376006157;10353.32703374282;10435.947820260888;10496.317739346918;10510.421926794023;10516.211284153718;7730.613469326568;7890.2109789021215;7902.24928631779;10392.792144157112;10458.581656733722;10228.488575571191;10345.741356466073;10349.016843399864;10355.585776568929;10359.844602330972;38953;39346.40980385296;39445.21109577821;39507;39528.60471395278;3092.7989680670685;3110.1136176189902;3147.134538002045;3151.086185006345;3164.224764932583;29380.26549336262;29869.40261194764;29878;30064.54903176454;30719.539206911915;3820.6752426043818;3938;3958.2875082485143;4055.452513910614;4061.228366610364;247996;249530.7523462371;275643;276309;276328.99999999796;57201.42798571961;57484.952106705096;57513.424865751644;57584;57586.71206644024;60569.69715151396;60767;60839.69580152159;60865;60900.69549652223;15427.30577124032;15879.28543215535;15958.521244362455;15974;15979;12212;12347.506099756089;12402.75194496123;12403.069769767304;12408.379581020912;18811.623767524572;18840.246390144242;18982.620347592972;18990.52523686891;19050.714239286423;7146.606936618432;7261.3101755333155;7299.270072992658;7385.113786345565;7390.002349682832;932.7341707613433;934.9762010598384;966.4587830814767;967.5065716484644;1050.9421981790922;27923;28244.43511129807;28518;28680.71319286822;28705.712942870723;921.4747593871429;983.8720966274338;1017.5421060522647;1057.9209206609216;1191.255465334166;12942.676433089247;13749.381277842522;13929.86070139306;14118.294085295694;15499.612509687347;337108;340016;341447;341546;342098;50973.7451312741;51111.488885111416;51169;51188.48811511837;51272;1187.323225761325;1232.6733415644862;1306.4382315604382;1345.9367099990898;1356.7286542691502;24973.87513062423;25755.356116097246;25867.870660646575;25872.611910820975;25947.61078583785;35751.28497430089;35925.820370899026;36116;36479.45280820737;44317.556824432635;220680;406898;420847;423216;423243;28489.28776780597;28857.56713649255;28921.85539072291;29038;29110;38489.23021539609;39569;39841.40237896376;39853;40154.19691606093;34602.26988650507;35136.12159696028;35391.82304088463;35736.106597335274;35930;31176;31752.36495270128;31941.36117277688;32219.838900805345;34128.48807267843;33379.666203337656;34652;34670.65329346674;34711.652883470844;34754.82622586871;27902.86048569744;31031;31050.844745776125;31265.68734312628;31490.212744681565;23519.647205291592;23792.52414951726;23862.16482423107;24133.637995430432;24224 02:11:54 INFO - PROCESS | 3554 | |2;jquery.html;352.918828669406;359.73559433816143;362.76964127778854;366.2199515032979;369.2596344329619;13307.268100254481;13495.463083513047;15842.92078539607;16541;17431.73852392215;12061.698457538567;12357.32034738089;15334.539963801077;15451.613709657237;16471.423500177498;5284.154535274357;5383.219433182187;5393.217983392406;5401.918971215435;5405.891882162355;3748.1941382602736;3848.5766565677754;5287.762050707708;5422.105352616833;5435.510804027636;3835.6931445484292;5374.838754837361;5548.639338442988;5551.944480555203;5557.416471270519;5497.505224529791;5515.751791169427;5531.723413829312;5676.574256930706;5970.13433052205;5300.92048619271;5302.44324345942;5302.628815982883;5305.867353316159;5308.787648494055;12215.144939854214;15163;19415.708764368545;19432.514187145294;20058.498537536532;1859.4421673497895;2041.6018876319124;2184.770599087089;2200.2739096098408;2214.5460180662926;9698.70903872885;9806.215502759762;12744.362781860962;12785.10504264702;13136.934315328457;1818.354484158118;1822.3439561757757;1889.8677092603523;1906.4376009077355;1924.0475964397572;53701.73149134268;57827;58008.419915800725;58276;60754.784904302105;9424.246060315158;9851.802963940681;10283.07452329294;10316.226283028804;10360.792784144274;13150.27673477968;13197.406116724771;13243.801342979863;13260.668483287995;13269.66825829362;7295.52579082358;7354.889676654854;7361.411087113018;7379.151397589346;7412.592307423036;6807.693653785592;6820.863582728318;6832.419244364285;7028.718851245995;7135.5361901476235;4340.500842403164;4345.283028300359;4382.890427739332;4385.802638881258;4437.068215674744;1748.379325339486;1779.28828468611;1800.801911789702;1852.19429548147;1852.51834523025;815.4495715392087;890.8930928288518;946.0397696338222;985.6599473181741;1042.4006196437078;15547.455839045579;16340.50978470624;16977.49067527976;17062.146892655317;17097.316107355568;804.7867315161487;886.2909672262165;922.8338898998245;948.2698322291797;979.644396018025;8025.357971362277;8996.685116020908;9016.459012459141;9079.500627465553;9601.183899368492;415001;544837.2758136184;550858;551090;556690;78026.21973780303;78091;80764.59617701992;80803.99999999882;81406.59296703478;1162.91859569831;1168.0713832503181;1214.6295379909213;1218.214251807579;1234.6110975042832;15129.924350378178;15163;15185.16481593523;15320.923395382952;15575.92212038978;33743.4938475928;34034;34405.65594344125;34694.30611387808;35510.28979420449;46636.7668161657;47482.28776568285;47510;48006;48098.759506202245;9185.586648600696;9677.080677335924;9678.467684277432;9682.9031709682;9685.806283874424;11418.714532136763;12669.80995285053;17111.486655400357;17220.138993050048;17563.297468101642;14254;14265.786013210018;14357.64105897361;14729.92635036818;14762.409503619734;14100.506482273071;14163.858361416254;14446.855531444551;14624.707505850036;14822.332995015466;14623.488177913721;14778.48275310359;14865.10809351399;15079.170645614597;15110.773338400153;9379.484128373006;9456.33805633599;9519.90480095218;9536.094071063515;9550.092741189575;13930.303484825516;14064.507742228972;14356;14377.28113594337;14450.494232701805 02:11:54 INFO - PROCESS | 3554 | |3;mootools.html;1365.515242089059;1706.3857011475866;1729.3082766893233;1729.4292883348492;1775.9112044397777;7194.496385253028;7631.961840190806;7938.682452701885;7945.92054079459;7948.801279968004;7815.765527034198;7947.761567152995;7994.320482758958;8001.599920004006;8002.399820013493;1997.700344948255;2034.2676636410881;2285.268714011517;2287.325239054479;2335.089315167086;2293.850899691523;2299.2297580310533;2300.2409204962323;2301.0795681727277;2301.2750983440246;2257.322803159054;2323.035940084863;2324;2325.5813953488364;2326.232343326698;2278.5556816420803;2281.6121259385945;2292.2779324512726;2295.231097582312;2300.252417964168;2277.9316620501413;2285.748567657573;2290.141197051106;2308.1229132929548;2313.5719891820067;7896.842063158762;7972.60136993148;7975;7977.601119944037;7979.281864632211;4671.743054132022;4777.641676874214;4779.784909679072;4782.736949467778;4783.28250762385;3009.593704849839;3059.7552195824505;3083.0750774767703;3207.8075315480914;3222.2105584131805;941.0307383395113;959.1128206409044;979.1628157924943;1004.7488127968008;1017.8574999500075;11034.062104721108;11040.282381645247;11045.33727976324;11049.226554141213;11052.557897684082;4250.341197114452;4311.698181127354;4359.629431498358;4366.6506679465565;4376.584224498668;9493.762655933657;9496.667616633524;9504.857427138599;9507.239420846316;9515.524223788922;4848.418189817245;4853.878653033632;4882.731449770296;4887.340209071801;4889.828855990095;4422.513523512411;4422.778861056934;4422.84520041797;4423.447069116361;4425.756583387944;3137.8587963541695;3175.666555011737;3474.722022238215;3517.6834084931966;3717.498137751423;1240.7394447166016;1241.5406299669;1248.2572869142846;1252.154795513025;1255.7488502299577;1018.511114664965;1018.8013337399284;1076.499427766077;1097.3086955218162;1203.8314635950974;6991.161060672752;7045.964770176219;7059.647017649199;7062.611556364346;7067.293270672994;1115.2304909612342;1115.966521004371;1125.6004118537965;1137.647329327911;1148.6668866028758;5115.1559992600805;5191;5234.18870075139;5235.73821308933;5242.056429842665;8548.187922147386;8722.215000649972;8903.643854245887;8921.464712117293;9188.724338269863;9108.316876234308;9340.626374944926;9403.059694030542;9417.15245627883;9426.764330891645;7346.375558077623;7348.338649521569;7531.510451820614;7553.131389890233;7554.2823431775;6821.556598821061;6861.519693621399;6869.141357330333;6874.587524748531;6883.346082122191;8235.794105147419;8354.289885359813;8365.121662225622;8548;8594;8607.612657430305;8682;8721.956390218009;8740.650373984969;8760.868586971073;6655.700493477902;6938.855088910475;6980.406665433495;6985.9301406987315;6988.021676965331;6633.270340262471;6759.391654751096;6765.763198288037;7041.260667629826;7266.890996634949;6802.455803535607;6842.315768423118;6937.028815965869;6963;6994.090768200102;6791.286914873867;6872.931270687229;6964.965175174092;7001.894971575329;7023.613701246481;6617.371349721769;6619.404253617197;6621.900671489835;6634.203895532567;6657.933420665925;6191.25704915413;6226.315105338319;6256;6357.332480089524;6362.395572420613;6387.776427825004;6425.389587989133;6432.710528026344;6434.613923164625;6441.194850643669 02:11:54 INFO - PROCESS | 3554 | |4;prototype.html;332.7571520371412;334.12292731579606;338.3824520250542;341.57644520794213;343.0377790298214;5818.912716309259;5881.500072493838;5898.11528270759;5898.351181370052;5944.673042982634;5741.885162296751;5850.502707269877;5856.47291743743;5857.6485410875275;5875.236219291486;4550.476695180064;4563.133004729108;4563.7489938053395;4564.224081906067;4567.109413664337;4364.9781751091205;4394.516603173648;4493.707908985905;4573.245414506602;4580.038191979672;4525.049739554681;4551.8634440966825;4556.270996640538;4562.224421848294;4574.062317224961;4535.387722657432;4537.296719008559;4538.273876179812;4549.067441174551;4552.294394368878;3992.3811809169624;3994.1612261425134;4007.458993035932;4018.095928416083;4026.879193624196;5531.059719847595;5594.272744543224;5615.298087739033;5625.915611265835;5630.09918413056;5279.683219006872;5284.762185701653;5286.36563612369;5292.814751483679;5294.6029047821185;6172.629642221481;6210.254769427653;6212.0371342441995;6213.596116252429;6216.222972128484;4259.76571288579;4294.527601963781;4337.956620433787;4388.868333949987;4434.179676759777;6474.061261117112;6485.902711459332;6502.284748677689;6508.446782023534;6513.902291465632;4524.434445694288;4525.660575456854;4528.071745292207;4530.478994915561;4533.52397998212;4360.7601581913295;4568.520305367955;4579.335996280521;4581.839635612804;4583.816647334069;5135.537801597874;5169.327987361619;5206.687598744087;5208.947910520922;5212.478752124833;6262.5929314594405;6283.6858157091965;6285.465735412449;6287.151234583364;6294.527910406646;1582.3907795498815;1596.9441069562743;1599.6480774229651;1599.6640705451985;1599.720048991445;1064.0583083970741;1064.9680509584725;1066.9519871605642;1090.1333439915286;1092.257265059751;5995.310539288038;5998.3701711320555;5999.040153575407;6000.699965001732;6007.759689612454;6445.258795238514;6445.677716114175;6446.226452825691;6448.516361272923;6484.157059582224;5976.940230597638;5990.820275391745;5991.910121348184;6000.03999360109;6000.759969601254;3427.7600567960003;3534.2578058607464;3537.34559106561;3540.168060505779;3544.3088597723713;6835;6836.6923488443135;6839.658017099126;6842;6844.110265665432;6633.9668301658185;6666;6674.299198584175;6685.6322902240845;6690.230623478362;6652.600843949379;6715.764948226789;6799.150106236721;6803.829904252334;6822.317768223138;6333.303336633059;6506.544541882023;6511.609303441809;6531.804045878631;6537.248216455168;6318.652474113968;6374.3306952771145;6453.645049522322;6454.5159113065765;6478.546501744832;6772.221194562689;6776.627285499345;6794.3545363190415;6800.353966373186;6806.115205023513;4393.758343291021;4443.844465443694;4447.377367168534;4449.17690227296;4452.087322099027;6388.584741991942;6565.540412171103;6580.8354791130605;6584.473242140713;6589.934100659124;6354.142190804182;6392.264889537762;6399.968000159969;6401.199850018747;6407.519436042408;6210.720517576629;6317;6361.363863613602;6365.363463653597;6370.554061215856;6201.751929922933;6229.3770622937345;6252.468540173954;6253.343398943045;6261.74953001893;6399.712012959521;6400.359964003563;6402.35976402356;6403.455706265019;6405.03924411342;6111.174991376285;6249.687515624109;6255.468285195628;6256.968715156395;6258.530610204162 02:11:54 INFO - PROCESS | 3554 | |5;yui.html;784.7410354582986;855.2431098477846;863.887694599702;863.9006514250863;886.3662481325855;13424.597262082129;13662.521811736591;13692.52076177334;13695.589132326033;13698.72602547951;10633.46832658368;13033.152845065064;13130.409131589078;13160.934195329033;13162;680.1701923653135;810.4610434061342;831.5925196653657;832.5421018439833;833.0336809301211;818.6970820796284;818.8648872935959;819.8360327934437;825.2531459029558;826.5247482697444;718.6299055986171;728.9088863892014;875.1467319363601;881.2201201936268;882.9205371516563;866.1035827918106;870.9738707838775;874.9981271444225;877.55244825139;879.0330636300051;648.8864448721455;649.9740010399578;652.1098700274092;652.9477641788645;652.9706163222667;12367.938160309232;12656.493740250378;12674.239545627292;12678.239305641599;12697.301648409333;11975;12120.151589388746;12671.619851404472;12910.483580656763;13123.212607243597;10479;10529.526171322308;10601.628942987036;10750.623728169554;10754.946225268903;3535.6641119093647;3623.365910965597;3707.443883417509;3730.7761534307756;3789.412641040643;46728.53271467276;47565;48216.517834821905;48226.27660585094;48424;9300.953495232481;9325.720228393158;9390.577424015935;9455.167237462792;9765.462899540451;17001.659966800842;17063.402780902856;17065.573360665836;17082.487525374258;17175.828241717423;7340.559566426032;7506.587137707369;7539.660715267826;7591.3547348475995;7874.173211812792;4276.144771045803;4306.20335237982;4330.285502891988;4337.067530480898;4350.216960946997;3133.85897634607;3154.41643295991;3155.3058327167987;3159.573457583197;3165.7625678073778;572.3075079154187;589.7434615942079;595.8450802791219;615.4184295840388;625.5027253333611;474.40699126092386;512.8948565544055;515.4613428966738;553.5028045128662;681.3220845258999;8267.421280510427;8484.236418722345;8532.829343413097;8590.098039705867;8742.169493898196;497.36337488015397;591.4588151841103;626.1734510446258;685.5167107189419;703.8345988692653;3713.8700145494777;3743.47591337213;3890.105275786585;3938.12938854042;4075.3683179107284;58746;58809;59592;59901.70049149814;60237.39762602405;49841;51174.48825511697;51200.48799512032;51368.74315628398;51534.22698659523;46517;48062.279065814044;48145.518544814804;48155.75922120367;48261.5173848257;7999.480033797785;8240.711575094843;8246.793830154294;8436.620352084294;8469.872951905849;33365;33769.15577110494;34083.65916340805;35643.28713425769;35647.82176089103;41855;42410.787946060074;43409.3488597665;43845.12309753851;43953.12093758043;11204.88795112071;11367.602133925273;11606.88393116058;11618.070554355461;11676;12295.44670489848;12554.811677824657;12643.620691379274;13027.544035958696;13033.348332583144;10364.326318789255;10383.2212584055;10467.110295624958;10479.318844275098;10986.560537578407;10458.790824183321;10785.298955567863;10794.352338859693;10800.729981750519;11121.221514493907;6720.9674692444005;9223;9742.512874356396;9835.508224588599;9933.056359645821;9784;10192.439415832201;10262.457094036026;10283.94858025705;10346.37921724699;9299.72100836976;9539.618415263312;9540.284478664267;9557.378770379903;9557.713268601952 02:11:54 INFO - PROCESS | 3554 | __end_tp_report 02:11:54 INFO - PROCESS | 3554 | __start_cc_report 02:11:54 INFO - PROCESS | 3554 | _x_x_mozilla_cycle_collect,929 02:11:54 INFO - PROCESS | 3554 | __end_cc_report 02:11:54 INFO - PROCESS | 3554 | __startTimestamp1450951914634__endTimestamp 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | ------- Summary: start ------- 02:11:54 INFO - PROCESS | 3554 | Number of tests: 6 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | [#0] dojo.html Cycles:165 Average:5276.00 Median:5471.32 stddev:583.29 (10.7%) stddev-sans-first:560.77 02:11:54 INFO - PROCESS | 3554 | Values: 3151.9 3165.7 3226.0 3229.8 3258.4 5153.7 5233.5 5285.4 5314.8 5391.3 5142.6 5180.8 5213.1 5220.8 5221.4 4665.8 4763.6 4794.0 4919.6 4947.5 4707.7 4814.4 4918.8 4932.5 5027.5 4773.9 4831.9 4836.3 4842.1 4855.2 4782.3 4791.0 4799.4 4805.4 4884.8 4674.6 4776.6 4777.9 4802.2 4832.0 5169.2 5170.9 5174.6 5180.8 5182.0 5724.3 5726.1 5728.9 5732.2 5734.7 5524.2 5609.0 5636.7 5732.3 5790.8 5292.0 5293.7 5297.8 5299.7 5303.9 5788.5 5789.5 5791.5 5792.9 5803.7 5420.9 5524.8 5535.6 5539.7 5639.7 5763.6 5781.7 5782.6 5783.3 5789.8 5712.9 5761.1 5768.3 5769.8 5778.8 5511.8 5613.2 5622.7 5752.8 5763.3 4341.5 4355.6 4391.9 4418.5 4426.2 3965.7 3965.8 3971.0 3981.6 4004.3 5173.6 5267.5 5345.8 5363.7 5363.8 5542.2 5702.4 5790.1 5800.7 5803.7 5300.3 5339.0 5348.0 5351.5 5351.6 4739.5 4821.8 4943.6 4955.6 5002.6 5831.9 5931.9 5932.0 5946.5 5963.5 5633.3 5651.8 5712.8 5717.3 5718.5 5924.8 5925.1 5929.1 5929.3 5946.8 5432.6 5536.1 5537.9 5562.3 5678.3 5661.0 5687.1 5688.2 5690.9 5697.0 5532.0 5532.3 5538.2 5538.4 5544.4 5471.3 5532.9 5543.7 5576.4 5678.9 5487.8 5488.3 5494.9 5497.2 5512.7 5579.7 5599.5 5599.7 5607.6 5665.6 5217.1 5309.5 5310.9 5388.7 5464.1 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | [#1] ext.html Cycles:180 Average:48424.71 Median:32799.75 stddev:88218.14 (269.0%) stddev-sans-first:88392.42 02:11:54 INFO - PROCESS | 3554 | Values: 561.0 607.5 613.0 615.4 635.3 34765.7 35430.8 35456.6 35479.6 35484.0 39472.4 40019.4 40032.0 40060.6 40084.2 7453.8 7566.4 8610.4 8816.3 8817.3 10290.0 10592.7 10600.8 10611.6 10618.0 10353.3 10435.9 10496.3 10510.4 10516.2 7730.6 7890.2 7902.2 10392.8 10458.6 10228.5 10345.7 10349.0 10355.6 10359.8 38953.0 39346.4 39445.2 39507.0 39528.6 3092.8 3110.1 3147.1 3151.1 3164.2 29380.3 29869.4 29878.0 30064.5 30719.5 3820.7 3938.0 3958.3 4055.5 4061.2 247996.0 249530.8 275643.0 276309.0 276329.0 57201.4 57485.0 57513.4 57584.0 57586.7 60569.7 60767.0 60839.7 60865.0 60900.7 15427.3 15879.3 15958.5 15974.0 15979.0 12212.0 12347.5 12402.8 12403.1 12408.4 18811.6 18840.2 18982.6 18990.5 19050.7 7146.6 7261.3 7299.3 7385.1 7390.0 932.7 935.0 966.5 967.5 1050.9 27923.0 28244.4 28518.0 28680.7 28705.7 921.5 983.9 1017.5 1057.9 1191.3 12942.7 13749.4 13929.9 14118.3 15499.6 337108.0 340016.0 341447.0 341546.0 342098.0 50973.7 51111.5 51169.0 51188.5 51272.0 1187.3 1232.7 1306.4 1345.9 1356.7 24973.9 25755.4 25867.9 25872.6 25947.6 35751.3 35925.8 36116.0 36479.5 44317.6 220680.0 406898.0 420847.0 423216.0 423243.0 28489.3 28857.6 28921.9 29038.0 29110.0 38489.2 39569.0 39841.4 39853.0 40154.2 34602.3 35136.1 35391.8 35736.1 35930.0 31176.0 31752.4 31941.4 32219.8 34128.5 33379.7 34652.0 34670.7 34711.7 34754.8 27902.9 31031.0 31050.8 31265.7 31490.2 23519.6 23792.5 23862.2 24133.6 24224.0 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | [#2] jquery.html Cycles:180 Average:28119.02 Median:367.74 stddev:86070.80 (23405.4%) stddev-sans-first:86287.00 02:11:54 INFO - PROCESS | 3554 | Values: 352.9 359.7 362.8 366.2 369.3 13307.3 13495.5 15842.9 16541.0 17431.7 12061.7 12357.3 15334.5 15451.6 16471.4 5284.2 5383.2 5393.2 5401.9 5405.9 3748.2 3848.6 5287.8 5422.1 5435.5 3835.7 5374.8 5548.6 5551.9 5557.4 5497.5 5515.8 5531.7 5676.6 5970.1 5300.9 5302.4 5302.6 5305.9 5308.8 12215.1 15163.0 19415.7 19432.5 20058.5 1859.4 2041.6 2184.8 2200.3 2214.5 9698.7 9806.2 12744.4 12785.1 13136.9 1818.4 1822.3 1889.9 1906.4 1924.0 53701.7 57827.0 58008.4 58276.0 60754.8 9424.2 9851.8 10283.1 10316.2 10360.8 13150.3 13197.4 13243.8 13260.7 13269.7 7295.5 7354.9 7361.4 7379.2 7412.6 6807.7 6820.9 6832.4 7028.7 7135.5 4340.5 4345.3 4382.9 4385.8 4437.1 1748.4 1779.3 1800.8 1852.2 1852.5 815.4 890.9 946.0 985.7 1042.4 15547.5 16340.5 16977.5 17062.1 17097.3 804.8 886.3 922.8 948.3 979.6 8025.4 8996.7 9016.5 9079.5 9601.2 415001.0 544837.3 550858.0 551090.0 556690.0 78026.2 78091.0 80764.6 80804.0 81406.6 1162.9 1168.1 1214.6 1218.2 1234.6 15129.9 15163.0 15185.2 15320.9 15575.9 33743.5 34034.0 34405.7 34694.3 35510.3 46636.8 47482.3 47510.0 48006.0 48098.8 9185.6 9677.1 9678.5 9682.9 9685.8 11418.7 12669.8 17111.5 17220.1 17563.3 14254.0 14265.8 14357.6 14729.9 14762.4 14100.5 14163.9 14446.9 14624.7 14822.3 14623.5 14778.5 14865.1 15079.2 15110.8 9379.5 9456.3 9519.9 9536.1 9550.1 13930.3 14064.5 14356.0 14377.3 14450.5 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | [#3] mootools.html Cycles:180 Average:5429.34 Median:6359.86 stddev:2821.82 (44.4%) stddev-sans-first:2813.20 02:11:54 INFO - PROCESS | 3554 | Values: 1365.5 1706.4 1729.3 1729.4 1775.9 7194.5 7632.0 7938.7 7945.9 7948.8 7815.8 7947.8 7994.3 8001.6 8002.4 1997.7 2034.3 2285.3 2287.3 2335.1 2293.9 2299.2 2300.2 2301.1 2301.3 2257.3 2323.0 2324.0 2325.6 2326.2 2278.6 2281.6 2292.3 2295.2 2300.3 2277.9 2285.7 2290.1 2308.1 2313.6 7896.8 7972.6 7975.0 7977.6 7979.3 4671.7 4777.6 4779.8 4782.7 4783.3 3009.6 3059.8 3083.1 3207.8 3222.2 941.0 959.1 979.2 1004.7 1017.9 11034.1 11040.3 11045.3 11049.2 11052.6 4250.3 4311.7 4359.6 4366.7 4376.6 9493.8 9496.7 9504.9 9507.2 9515.5 4848.4 4853.9 4882.7 4887.3 4889.8 4422.5 4422.8 4422.8 4423.4 4425.8 3137.9 3175.7 3474.7 3517.7 3717.5 1240.7 1241.5 1248.3 1252.2 1255.7 1018.5 1018.8 1076.5 1097.3 1203.8 6991.2 7046.0 7059.6 7062.6 7067.3 1115.2 1116.0 1125.6 1137.6 1148.7 5115.2 5191.0 5234.2 5235.7 5242.1 8548.2 8722.2 8903.6 8921.5 9188.7 9108.3 9340.6 9403.1 9417.2 9426.8 7346.4 7348.3 7531.5 7553.1 7554.3 6821.6 6861.5 6869.1 6874.6 6883.3 8235.8 8354.3 8365.1 8548.0 8594.0 8607.6 8682.0 8722.0 8740.7 8760.9 6655.7 6938.9 6980.4 6985.9 6988.0 6633.3 6759.4 6765.8 7041.3 7266.9 6802.5 6842.3 6937.0 6963.0 6994.1 6791.3 6872.9 6965.0 7001.9 7023.6 6617.4 6619.4 6621.9 6634.2 6657.9 6191.3 6226.3 6256.0 6357.3 6362.4 6387.8 6425.4 6432.7 6434.6 6441.2 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | [#4] prototype.html Cycles:180 Average:5273.07 Median:5983.88 stddev:1589.88 (26.6%) stddev-sans-first:1550.50 02:11:54 INFO - PROCESS | 3554 | Values: 332.8 334.1 338.4 341.6 343.0 5818.9 5881.5 5898.1 5898.4 5944.7 5741.9 5850.5 5856.5 5857.6 5875.2 4550.5 4563.1 4563.7 4564.2 4567.1 4365.0 4394.5 4493.7 4573.2 4580.0 4525.0 4551.9 4556.3 4562.2 4574.1 4535.4 4537.3 4538.3 4549.1 4552.3 3992.4 3994.2 4007.5 4018.1 4026.9 5531.1 5594.3 5615.3 5625.9 5630.1 5279.7 5284.8 5286.4 5292.8 5294.6 6172.6 6210.3 6212.0 6213.6 6216.2 4259.8 4294.5 4338.0 4388.9 4434.2 6474.1 6485.9 6502.3 6508.4 6513.9 4524.4 4525.7 4528.1 4530.5 4533.5 4360.8 4568.5 4579.3 4581.8 4583.8 5135.5 5169.3 5206.7 5208.9 5212.5 6262.6 6283.7 6285.5 6287.2 6294.5 1582.4 1596.9 1599.6 1599.7 1599.7 1064.1 1065.0 1067.0 1090.1 1092.3 5995.3 5998.4 5999.0 6000.7 6007.8 6445.3 6445.7 6446.2 6448.5 6484.2 5976.9 5990.8 5991.9 6000.0 6000.8 3427.8 3534.3 3537.3 3540.2 3544.3 6835.0 6836.7 6839.7 6842.0 6844.1 6634.0 6666.0 6674.3 6685.6 6690.2 6652.6 6715.8 6799.2 6803.8 6822.3 6333.3 6506.5 6511.6 6531.8 6537.2 6318.7 6374.3 6453.6 6454.5 6478.5 6772.2 6776.6 6794.4 6800.4 6806.1 4393.8 4443.8 4447.4 4449.2 4452.1 6388.6 6565.5 6580.8 6584.5 6589.9 6354.1 6392.3 6400.0 6401.2 6407.5 6210.7 6317.0 6361.4 6365.4 6370.6 6201.8 6229.4 6252.5 6253.3 6261.7 6399.7 6400.4 6402.4 6403.5 6405.0 6111.2 6249.7 6255.5 6257.0 6258.5 02:11:54 INFO - PROCESS | 3554 | 02:11:54 INFO - PROCESS | 3554 | [#5] yui.html Cycles:180 Average:13683.18 Median:48186.14 stddev:16066.91 (33.3%) stddev-sans-first:16082.79 02:11:54 INFO - PROCESS | 3554 | Values: 784.7 855.2 863.9 863.9 886.4 13424.6 13662.5 13692.5 13695.6 13698.7 10633.5 13033.2 13130.4 13160.9 13162.0 680.2 810.5 831.6 832.5 833.0 818.7 818.9 819.8 825.3 826.5 718.6 728.9 875.1 881.2 882.9 866.1 871.0 875.0 877.6 879.0 648.9 650.0 652.1 652.9 653.0 12367.9 12656.5 12674.2 12678.2 12697.3 11975.0 12120.2 12671.6 12910.5 13123.2 10479.0 10529.5 10601.6 10750.6 10754.9 3535.7 3623.4 3707.4 3730.8 3789.4 46728.5 47565.0 48216.5 48226.3 48424.0 9301.0 9325.7 9390.6 9455.2 9765.5 17001.7 17063.4 17065.6 17082.5 17175.8 7340.6 7506.6 7539.7 7591.4 7874.2 4276.1 4306.2 4330.3 4337.1 4350.2 3133.9 3154.4 3155.3 3159.6 3165.8 572.3 589.7 595.8 615.4 625.5 474.4 512.9 515.5 553.5 681.3 8267.4 8484.2 8532.8 8590.1 8742.2 497.4 591.5 626.2 685.5 703.8 3713.9 3743.5 3890.1 3938.1 4075.4 58746.0 58809.0 59592.0 59901.7 60237.4 49841.0 51174.5 51200.5 51368.7 51534.2 46517.0 48062.3 48145.5 48155.8 48261.5 7999.5 8240.7 8246.8 8436.6 8469.9 33365.0 33769.2 34083.7 35643.3 35647.8 41855.0 42410.8 43409.3 43845.1 43953.1 11204.9 11367.6 11606.9 11618.1 11676.0 12295.4 12554.8 12643.6 13027.5 13033.3 10364.3 10383.2 10467.1 10479.3 10986.6 10458.8 10785.3 10794.4 10800.7 11121.2 6721.0 9223.0 9742.5 9835.5 9933.1 9784.0 10192.4 10262.5 10283.9 10346.4 9299.7 9539.6 9540.3 9557.4 9557.7 02:11:54 INFO - PROCESS | 3554 | -------- Summary: end -------- 02:11:54 INFO - PROCESS | 3554 | 02:11:55 INFO - TEST-INFO | 3554: exit 0 02:11:55 INFO - TEST-OK | dromaeo_css | took 1112651ms 02:11:55 INFO - TEST-START | kraken 02:11:55 INFO - operating with platform_type : linux_ 02:11:55 INFO - Initialising browser for kraken test... 02:11:55 INFO - TEST-INFO | started process 3743 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTo1N3H/profile http://localhost:56917/getInfo.html) 02:11:59 INFO - PROCESS | 3743 | __metrics Screen width/height:1600/1200 02:11:59 INFO - PROCESS | 3743 | colorDepth:24 02:11:59 INFO - PROCESS | 3743 | Browser inner width/height: 1024/697 02:11:59 INFO - PROCESS | 3743 | __metrics 02:11:59 INFO - PROCESS | 3743 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:11:59 INFO - PROCESS | 3743 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:12:00 INFO - TEST-INFO | 3743: exit 0 02:12:00 INFO - Browser initialized. 02:12:00 INFO - Running cycle 1/1 for kraken test... 02:12:00 INFO - TEST-INFO | started process 3826 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTo1N3H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:12 INFO - PROCESS | 3826 | RSS: Main: 150470656 02:12:12 INFO - PROCESS | 3826 | 02:12:14 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56917/tests/kraken/driver.html?testName=audio-beat-detection) 02:12:15 INFO - PROCESS | 3826 | RSS: Main: 186916864 02:12:15 INFO - PROCESS | 3826 | 02:12:17 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56917/tests/kraken/driver.html?testName=audio-dft) 02:12:18 INFO - PROCESS | 3826 | RSS: Main: 176914432 02:12:18 INFO - PROCESS | 3826 | 02:12:21 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56917/tests/kraken/driver.html?testName=audio-fft) 02:12:21 INFO - PROCESS | 3826 | RSS: Main: 160227328 02:12:21 INFO - PROCESS | 3826 | 02:12:23 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56917/tests/kraken/driver.html?testName=audio-oscillator) 02:12:24 INFO - PROCESS | 3826 | RSS: Main: 161918976 02:12:24 INFO - PROCESS | 3826 | 02:12:26 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56917/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:12:27 INFO - PROCESS | 3826 | RSS: Main: 164442112 02:12:27 INFO - PROCESS | 3826 | 02:12:29 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56917/tests/kraken/driver.html?testName=imaging-darkroom) 02:12:30 INFO - PROCESS | 3826 | RSS: Main: 164913152 02:12:30 INFO - PROCESS | 3826 | 02:12:33 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56917/tests/kraken/driver.html?testName=imaging-desaturate) 02:12:34 INFO - PROCESS | 3826 | RSS: Main: 166088704 02:12:34 INFO - PROCESS | 3826 | 02:12:37 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56917/tests/kraken/driver.html?testName=json-parse-financial) 02:12:37 INFO - PROCESS | 3826 | RSS: Main: 166875136 02:12:37 INFO - PROCESS | 3826 | 02:12:39 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56917/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:12:39 INFO - PROCESS | 3826 | RSS: Main: 177057792 02:12:39 INFO - PROCESS | 3826 | 02:12:41 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:12:42 INFO - PROCESS | 3826 | RSS: Main: 174682112 02:12:42 INFO - PROCESS | 3826 | 02:12:44 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:12:44 INFO - PROCESS | 3826 | RSS: Main: 180125696 02:12:44 INFO - PROCESS | 3826 | 02:12:47 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:12:47 INFO - PROCESS | 3826 | RSS: Main: 189894656 02:12:47 INFO - PROCESS | 3826 | 02:12:50 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:12:51 INFO - PROCESS | 3826 | RSS: Main: 186560512 02:12:51 INFO - PROCESS | 3826 | 02:12:52 INFO - PROCESS | 3826 | Cycle 1(1): loaded http://localhost:56917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56917/tests/kraken/driver.html?testName=ai-astar) 02:12:53 INFO - PROCESS | 3826 | RSS: Main: 244994048 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | __start_tp_report 02:12:53 INFO - PROCESS | 3826 | _x_x_mozilla_page_load 02:12:53 INFO - PROCESS | 3826 | _x_x_mozilla_page_load_details 02:12:53 INFO - PROCESS | 3826 | |i|pagename|runs| 02:12:53 INFO - PROCESS | 3826 | |0;ai-astar;110;110;105;109;109;109;97;109;110;115 02:12:53 INFO - PROCESS | 3826 | |1;audio-beat-detection;149;122;161;161;127;151;156;128;164;125 02:12:53 INFO - PROCESS | 3826 | |2;audio-dft;160;162;162;160;162;159;158;162;161;160 02:12:53 INFO - PROCESS | 3826 | |3;audio-fft;70;72;84;89;72;73;73;105;89;70 02:12:53 INFO - PROCESS | 3826 | |4;audio-oscillator;94;93;132;92;94;93;132;93;93;140 02:12:53 INFO - PROCESS | 3826 | |5;imaging-gaussian-blur;109;109;110;109;109;109;110;110;110;109 02:12:53 INFO - PROCESS | 3826 | |6;imaging-darkroom;145;145;145;147;146;145;145;146;146;145 02:12:53 INFO - PROCESS | 3826 | |7;imaging-desaturate;95;95;95;96;95;97;95;95;95;96 02:12:53 INFO - PROCESS | 3826 | |8;json-parse-financial;57;57;58;57;57;57;57;58;56;56 02:12:53 INFO - PROCESS | 3826 | |9;json-stringify-tinderbox;67;66;67;66;66;67;67;67;67;67 02:12:53 INFO - PROCESS | 3826 | |10;stanford-crypto-aes;82;85;83;92;85;84;84;93;85;85 02:12:53 INFO - PROCESS | 3826 | |11;stanford-crypto-ccm;120;120;121;130;117;125;127;122;123;123 02:12:53 INFO - PROCESS | 3826 | |12;stanford-crypto-pbkdf2;151;150;162;148;156;140;152;149;166;142 02:12:53 INFO - PROCESS | 3826 | |13;stanford-crypto-sha256-iterative;65;65;66;65;65;65;65;65;65;66 02:12:53 INFO - PROCESS | 3826 | __end_tp_report 02:12:53 INFO - PROCESS | 3826 | __start_cc_report 02:12:53 INFO - PROCESS | 3826 | _x_x_mozilla_cycle_collect,905 02:12:53 INFO - PROCESS | 3826 | __end_cc_report 02:12:53 INFO - PROCESS | 3826 | __startTimestamp1450951973082__endTimestamp 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | ------- Summary: start ------- 02:12:53 INFO - PROCESS | 3826 | Number of tests: 14 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:4.64 (4.2%) stddev-sans-first:4.88 02:12:53 INFO - PROCESS | 3826 | Values: 110.0 110.0 105.0 109.0 109.0 109.0 97.0 109.0 110.0 115.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.50 stddev:16.95 (11.0%) stddev-sans-first:17.89 02:12:53 INFO - PROCESS | 3826 | Values: 149.0 122.0 161.0 161.0 127.0 151.0 156.0 128.0 164.0 125.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.50 02:12:53 INFO - PROCESS | 3826 | Values: 160.0 162.0 162.0 160.0 162.0 159.0 158.0 162.0 161.0 160.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#3] audio-fft Cycles:10 Average:79.70 Median:73.00 stddev:11.68 (16.0%) stddev-sans-first:11.85 02:12:53 INFO - PROCESS | 3826 | Values: 70.0 72.0 84.0 89.0 72.0 73.0 73.0 105.0 89.0 70.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:93.00 stddev:20.18 (21.7%) stddev-sans-first:20.97 02:12:53 INFO - PROCESS | 3826 | Values: 94.0 93.0 132.0 92.0 94.0 93.0 132.0 93.0 93.0 140.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:12:53 INFO - PROCESS | 3826 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:12:53 INFO - PROCESS | 3826 | Values: 145.0 145.0 145.0 147.0 146.0 145.0 145.0 146.0 146.0 145.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 02:12:53 INFO - PROCESS | 3826 | Values: 95.0 95.0 95.0 96.0 95.0 97.0 95.0 95.0 95.0 96.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 02:12:53 INFO - PROCESS | 3826 | Values: 57.0 57.0 58.0 57.0 57.0 57.0 57.0 58.0 56.0 56.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 02:12:53 INFO - PROCESS | 3826 | Values: 67.0 66.0 67.0 66.0 66.0 67.0 67.0 67.0 67.0 67.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:3.68 (4.3%) stddev-sans-first:3.63 02:12:53 INFO - PROCESS | 3826 | Values: 82.0 85.0 83.0 92.0 85.0 84.0 84.0 93.0 85.0 85.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:123.00 stddev:3.77 (3.1%) stddev-sans-first:3.86 02:12:53 INFO - PROCESS | 3826 | Values: 120.0 120.0 121.0 130.0 117.0 125.0 127.0 122.0 123.0 123.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:151.50 stddev:8.06 (5.3%) stddev-sans-first:8.54 02:12:53 INFO - PROCESS | 3826 | Values: 151.0 150.0 162.0 148.0 156.0 140.0 152.0 149.0 166.0 142.0 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - PROCESS | 3826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 02:12:53 INFO - PROCESS | 3826 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 02:12:53 INFO - PROCESS | 3826 | -------- Summary: end -------- 02:12:53 INFO - PROCESS | 3826 | 02:12:53 INFO - TEST-INFO | 3826: exit 0 02:12:53 INFO - TEST-OK | kraken | took 58596ms 02:12:53 INFO - TEST-START | v8_7 02:12:53 INFO - operating with platform_type : linux_ 02:12:53 INFO - Initialising browser for v8_7 test... 02:12:53 INFO - TEST-INFO | started process 4075 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnip6jx/profile http://localhost:56917/getInfo.html) 02:12:58 INFO - PROCESS | 4075 | __metrics Screen width/height:1600/1200 02:12:58 INFO - PROCESS | 4075 | colorDepth:24 02:12:58 INFO - PROCESS | 4075 | Browser inner width/height: 1024/697 02:12:58 INFO - PROCESS | 4075 | __metrics 02:12:58 INFO - PROCESS | 4075 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:12:58 INFO - PROCESS | 4075 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:12:58 ERROR - PROCESS | 4075 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 02:12:59 INFO - TEST-INFO | 4075: exit 0 02:12:59 INFO - Browser initialized. 02:12:59 INFO - Running cycle 1/1 for v8_7 test... 02:12:59 INFO - TEST-INFO | started process 4156 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnip6jx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:10 INFO - PROCESS | 4156 | RSS: Main: 149557248 02:13:10 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:56917/tests/v8_7/run.html (next: http://localhost:56917/tests/v8_7/run.html) 02:13:32 INFO - PROCESS | 4156 | RSS: Main: 626987008 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | __start_tp_report 02:13:32 INFO - PROCESS | 4156 | _x_x_mozilla_page_load 02:13:32 INFO - PROCESS | 4156 | _x_x_mozilla_page_load_details 02:13:32 INFO - PROCESS | 4156 | |i|pagename|runs| 02:13:32 INFO - PROCESS | 4156 | |0;Richards;165.94756057085962 02:13:32 INFO - PROCESS | 4156 | |1;DeltaBlue;189.60940462646948 02:13:32 INFO - PROCESS | 4156 | |2;Encrypt;283.60748723766307 02:13:32 INFO - PROCESS | 4156 | |3;Decrypt;5143.589743589743 02:13:32 INFO - PROCESS | 4156 | |4;RayTrace;1104.9723756906078 02:13:32 INFO - PROCESS | 4156 | |5;Earley;780.811232449298 02:13:32 INFO - PROCESS | 4156 | |6;Boyer;12207.317073170732 02:13:32 INFO - PROCESS | 4156 | |7;RegExp;25794.871794871793 02:13:32 INFO - PROCESS | 4156 | |8;Splay;614.2506142506143 02:13:32 INFO - PROCESS | 4156 | |9;NavierStokes;4835.748792270531 02:13:32 INFO - PROCESS | 4156 | __end_tp_report 02:13:32 INFO - PROCESS | 4156 | __startTimestamp1450952012543__endTimestamp 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | ------- Summary: start ------- 02:13:32 INFO - PROCESS | 4156 | Number of tests: 10 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#0] Richards Cycles:1 Average:165.95 Median:165.95 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 165.9 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#1] DeltaBlue Cycles:1 Average:189.61 Median:189.61 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 189.6 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#2] Encrypt Cycles:1 Average:283.61 Median:283.61 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 283.6 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 5143.6 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 1105.0 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#5] Earley Cycles:1 Average:780.81 Median:780.81 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 780.8 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 12207.3 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 25794.9 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#8] Splay Cycles:1 Average:614.25 Median:614.25 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 614.3 02:13:32 INFO - PROCESS | 4156 | 02:13:32 INFO - PROCESS | 4156 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 02:13:32 INFO - PROCESS | 4156 | Values: 4835.7 02:13:32 INFO - PROCESS | 4156 | -------- Summary: end -------- 02:13:32 INFO - PROCESS | 4156 | 02:13:33 INFO - TEST-INFO | 4156: exit 0 02:13:33 INFO - TEST-OK | v8_7 | took 39407ms 02:13:33 INFO - SUITE-END | took 1210s 02:13:33 INFO - Completed test suite (00:20:10) 02:13:33 INFO - Working with test: dromaeo_css 02:13:33 INFO - Generating results file: dromaeo_css 02:13:33 INFO - Working with test: kraken 02:13:33 INFO - Generating results file: kraken 02:13:33 INFO - javascript benchmark 02:13:33 INFO - Working with test: v8_7 02:13:33 INFO - Generating results file: v8_7 02:13:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:13:33 INFO - process_Request line: dromaeo_css 6930.68 graph.html#tests=[[72,201,35]] 02:13:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:33 INFO - process_Request line: kraken 1498.00 graph.html#tests=[[232,201,35]] 02:13:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:33 INFO - process_Request line: v8_7 21017.99 graph.html#tests=[[230,201,35]] 02:13:33 INFO - RETURN: dromaeo_css: 6930.68 02:13:33 INFO - RETURN: kraken: 1498.00 02:13:33 INFO - RETURN: v8_7: 21017.99 02:13:33 INFO - javascript benchmark 02:13:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3151.8739250429985, 3165.730912872406, 3225.9999400185943, 3229.7739158258933, 3258.4134855725965, 5153.665011774241, 5233.528982391584, 5285.392179899312, 5314.813981510643, 5391.272178255935, 5142.562882155012, 5180.844574662757, 5213.139831927728, 5220.817271395502, 5221.425643179247, 4665.813367465297, 4763.642726795487, 4793.976030119853, 4919.60643148549, 4947.52998465147, 4707.670463067587, 4814.350062741538, 4918.754062296889, 4932.457429682732, 5027.522385373402, 4773.856784296477, 4831.855044348676, 4836.298736683161, 4842.080004799077, 4855.247436647308, 4782.282657601353, 4790.976045119787, 4799.3760811094335, 4805.399325084364, 4884.804607815683, 4674.555917187861, 4776.5701086902, 4777.880552986168, 4802.207635740098, 4832.033593281358, 5169.172932330809, 5170.896582068338, 5174.560162386202, 5180.844574662766, 5182.041322355339, 5724.255846739898, 5726.0838265877255, 5728.856778580569, 5732.168835518826, 5734.713264336767, 5524.171374293848, 5609.0, 5636.689982050985, 5732.340780810218, 5790.826275211751, 5291.973540132275, 5293.655912365684, 5297.8145764898045, 5299.735013249322, 5303.946960530384, 5788.450097240755, 5789.478946894716, 5791.478766910914, 5792.8551786204835, 5803.738831752581, 5420.945790542123, 5524.8066317679495, 5535.5848311376, 5539.695316757537, 5639.689817060019, 5763.596548241667, 5781.739821708034, 5782.566307526952, 5783.334916484574, 5789.8263052108505, 5712.942870571324, 5761.107028410603, 5768.3366412862215, 5769.826905192851, 5778.826635200867, 5511.779528818883, 5613.242212301368, 5622.690752008597, 5752.769889204469, 5763.337216220105, 4341.544137865541, 4355.60799528044, 4391.934120988188, 4418.536053714313, 4426.15902978433, 3965.7422267552515, 3965.841366345314, 3970.9602903971168, 3981.601839816053, 4004.2992476316526, 5173.63784535079, 5267.499587539254, 5345.812896548602, 5363.704996225167, 5363.81226657073, 5542.224088627595, 5702.401247868997, 5790.131480277992, 5800.680962547016, 5803.65178089316, 5300.284461597635, 5338.97330513345, 5347.973260133675, 5351.491608297206, 5351.625386222927, 4739.502352253033, 4821.7589120543835, 4943.595886992128, 4955.628327875352, 5002.59979201663, 5831.88336233273, 5931.881362372728, 5932.0, 5946.494547963385, 5963.463288303987, 5633.295838020247, 5651.802186923438, 5712.828615141552, 5717.313922329181, 5718.542516598579, 5924.792632258022, 5925.081612350093, 5929.051351783866, 5929.288485381781, 5946.821595352147, 5432.619716619799, 5536.086545719912, 5537.889242215214, 5562.3047119110115, 5678.346990096026, 5661.0, 5687.090065589486, 5688.232088668143, 5690.914636280542, 5696.971515142398, 5531.9723401382735, 5532.30846144232, 5538.224648549126, 5538.418466061005, 5544.362398324244, 5471.316085489314, 5532.86167845791, 5543.695096769717, 5576.442355764391, 5678.886422271449, 5487.835364939058, 5488.313960754906, 5494.917576236439, 5497.175423686479, 5512.6968016759465, 5579.6652200868075, 5599.524040456607, 5599.748011339418, 5607.579431542732, 5665.575081868794, 5217.0870097733505, 5309.495597918191, 5310.8937821244135, 5388.703621300866, 5464.1257398816], "unit": "score", "name": "dojo.html", "value": 5238.821338041733}, {"lowerIsBetter": false, "replicates": [560.9663420194788, 607.4714997951781, 612.9846753831157, 615.418429584043, 635.2853040329626, 34765.652343476555, 35430.8228458858, 35456.64543354566, 35479.64520354796, 35484.0, 39472.40791388132, 40019.399709004385, 40032.0, 40060.59939400612, 40084.19831603366, 7453.813654658623, 7566.4325175611775, 8610.397272190965, 8816.250618697386, 8817.250533704642, 10290.0, 10592.682219533426, 10600.840987385196, 10611.628592999246, 10618.044376006157, 10353.32703374282, 10435.947820260888, 10496.317739346918, 10510.421926794023, 10516.211284153718, 7730.613469326568, 7890.2109789021215, 7902.24928631779, 10392.792144157112, 10458.581656733722, 10228.488575571191, 10345.741356466073, 10349.016843399864, 10355.585776568929, 10359.844602330972, 38953.0, 39346.40980385296, 39445.21109577821, 39507.0, 39528.60471395278, 3092.7989680670685, 3110.1136176189902, 3147.134538002045, 3151.086185006345, 3164.224764932583, 29380.26549336262, 29869.40261194764, 29878.0, 30064.54903176454, 30719.539206911915, 3820.6752426043818, 3938.0, 3958.2875082485143, 4055.452513910614, 4061.228366610364, 247996.0, 249530.7523462371, 275643.0, 276309.0, 276328.99999999796, 57201.42798571961, 57484.952106705096, 57513.424865751644, 57584.0, 57586.71206644024, 60569.69715151396, 60767.0, 60839.69580152159, 60865.0, 60900.69549652223, 15427.30577124032, 15879.28543215535, 15958.521244362455, 15974.0, 15979.0, 12212.0, 12347.506099756089, 12402.75194496123, 12403.069769767304, 12408.379581020912, 18811.623767524572, 18840.246390144242, 18982.620347592972, 18990.52523686891, 19050.714239286423, 7146.606936618432, 7261.3101755333155, 7299.270072992658, 7385.113786345565, 7390.002349682832, 932.7341707613433, 934.9762010598384, 966.4587830814767, 967.5065716484644, 1050.9421981790922, 27923.0, 28244.43511129807, 28518.0, 28680.71319286822, 28705.712942870723, 921.4747593871429, 983.8720966274338, 1017.5421060522647, 1057.9209206609216, 1191.255465334166, 12942.676433089247, 13749.381277842522, 13929.86070139306, 14118.294085295694, 15499.612509687347, 337108.0, 340016.0, 341447.0, 341546.0, 342098.0, 50973.7451312741, 51111.488885111416, 51169.0, 51188.48811511837, 51272.0, 1187.323225761325, 1232.6733415644862, 1306.4382315604382, 1345.9367099990898, 1356.7286542691502, 24973.87513062423, 25755.356116097246, 25867.870660646575, 25872.611910820975, 25947.61078583785, 35751.28497430089, 35925.820370899026, 36116.0, 36479.45280820737, 44317.556824432635, 220680.0, 406898.0, 420847.0, 423216.0, 423243.0, 28489.28776780597, 28857.56713649255, 28921.85539072291, 29038.0, 29110.0, 38489.23021539609, 39569.0, 39841.40237896376, 39853.0, 40154.19691606093, 34602.26988650507, 35136.12159696028, 35391.82304088463, 35736.106597335274, 35930.0, 31176.0, 31752.36495270128, 31941.36117277688, 32219.838900805345, 34128.48807267843, 33379.666203337656, 34652.0, 34670.65329346674, 34711.652883470844, 34754.82622586871, 27902.86048569744, 31031.0, 31050.844745776125, 31265.68734312628, 31490.212744681565, 23519.647205291592, 23792.52414951726, 23862.16482423107, 24133.637995430432, 24224.0], "unit": "score", "name": "ext.html", "value": 18306.583692469503}, {"lowerIsBetter": false, "replicates": [352.918828669406, 359.73559433816143, 362.76964127778854, 366.2199515032979, 369.2596344329619, 13307.268100254481, 13495.463083513047, 15842.92078539607, 16541.0, 17431.73852392215, 12061.698457538567, 12357.32034738089, 15334.539963801077, 15451.613709657237, 16471.423500177498, 5284.154535274357, 5383.219433182187, 5393.217983392406, 5401.918971215435, 5405.891882162355, 3748.1941382602736, 3848.5766565677754, 5287.762050707708, 5422.105352616833, 5435.510804027636, 3835.6931445484292, 5374.838754837361, 5548.639338442988, 5551.944480555203, 5557.416471270519, 5497.505224529791, 5515.751791169427, 5531.723413829312, 5676.574256930706, 5970.13433052205, 5300.92048619271, 5302.44324345942, 5302.628815982883, 5305.867353316159, 5308.787648494055, 12215.144939854214, 15163.0, 19415.708764368545, 19432.514187145294, 20058.498537536532, 1859.4421673497895, 2041.6018876319124, 2184.770599087089, 2200.2739096098408, 2214.5460180662926, 9698.70903872885, 9806.215502759762, 12744.362781860962, 12785.10504264702, 13136.934315328457, 1818.354484158118, 1822.3439561757757, 1889.8677092603523, 1906.4376009077355, 1924.0475964397572, 53701.73149134268, 57827.0, 58008.419915800725, 58276.0, 60754.784904302105, 9424.246060315158, 9851.802963940681, 10283.07452329294, 10316.226283028804, 10360.792784144274, 13150.27673477968, 13197.406116724771, 13243.801342979863, 13260.668483287995, 13269.66825829362, 7295.52579082358, 7354.889676654854, 7361.411087113018, 7379.151397589346, 7412.592307423036, 6807.693653785592, 6820.863582728318, 6832.419244364285, 7028.718851245995, 7135.5361901476235, 4340.500842403164, 4345.283028300359, 4382.890427739332, 4385.802638881258, 4437.068215674744, 1748.379325339486, 1779.28828468611, 1800.801911789702, 1852.19429548147, 1852.51834523025, 815.4495715392087, 890.8930928288518, 946.0397696338222, 985.6599473181741, 1042.4006196437078, 15547.455839045579, 16340.50978470624, 16977.49067527976, 17062.146892655317, 17097.316107355568, 804.7867315161487, 886.2909672262165, 922.8338898998245, 948.2698322291797, 979.644396018025, 8025.357971362277, 8996.685116020908, 9016.459012459141, 9079.500627465553, 9601.183899368492, 415001.0, 544837.2758136184, 550858.0, 551090.0, 556690.0, 78026.21973780303, 78091.0, 80764.59617701992, 80803.99999999882, 81406.59296703478, 1162.91859569831, 1168.0713832503181, 1214.6295379909213, 1218.214251807579, 1234.6110975042832, 15129.924350378178, 15163.0, 15185.16481593523, 15320.923395382952, 15575.92212038978, 33743.4938475928, 34034.0, 34405.65594344125, 34694.30611387808, 35510.28979420449, 46636.7668161657, 47482.28776568285, 47510.0, 48006.0, 48098.759506202245, 9185.586648600696, 9677.080677335924, 9678.467684277432, 9682.9031709682, 9685.806283874424, 11418.714532136763, 12669.80995285053, 17111.486655400357, 17220.138993050048, 17563.297468101642, 14254.0, 14265.786013210018, 14357.64105897361, 14729.92635036818, 14762.409503619734, 14100.506482273071, 14163.858361416254, 14446.855531444551, 14624.707505850036, 14822.332995015466, 14623.488177913721, 14778.48275310359, 14865.10809351399, 15079.170645614597, 15110.773338400153, 9379.484128373006, 9456.33805633599, 9519.90480095218, 9536.094071063515, 9550.092741189575, 13930.303484825516, 14064.507742228972, 14356.0, 14377.28113594337, 14450.494232701805], "unit": "score", "name": "jquery.html", "value": 8728.625063277581}, {"lowerIsBetter": false, "replicates": [1365.515242089059, 1706.3857011475866, 1729.3082766893233, 1729.4292883348492, 1775.9112044397777, 7194.496385253028, 7631.961840190806, 7938.682452701885, 7945.92054079459, 7948.801279968004, 7815.765527034198, 7947.761567152995, 7994.320482758958, 8001.599920004006, 8002.399820013493, 1997.700344948255, 2034.2676636410881, 2285.268714011517, 2287.325239054479, 2335.089315167086, 2293.850899691523, 2299.2297580310533, 2300.2409204962323, 2301.0795681727277, 2301.2750983440246, 2257.322803159054, 2323.035940084863, 2324.0, 2325.5813953488364, 2326.232343326698, 2278.5556816420803, 2281.6121259385945, 2292.2779324512726, 2295.231097582312, 2300.252417964168, 2277.9316620501413, 2285.748567657573, 2290.141197051106, 2308.1229132929548, 2313.5719891820067, 7896.842063158762, 7972.60136993148, 7975.0, 7977.601119944037, 7979.281864632211, 4671.743054132022, 4777.641676874214, 4779.784909679072, 4782.736949467778, 4783.28250762385, 3009.593704849839, 3059.7552195824505, 3083.0750774767703, 3207.8075315480914, 3222.2105584131805, 941.0307383395113, 959.1128206409044, 979.1628157924943, 1004.7488127968008, 1017.8574999500075, 11034.062104721108, 11040.282381645247, 11045.33727976324, 11049.226554141213, 11052.557897684082, 4250.341197114452, 4311.698181127354, 4359.629431498358, 4366.6506679465565, 4376.584224498668, 9493.762655933657, 9496.667616633524, 9504.857427138599, 9507.239420846316, 9515.524223788922, 4848.418189817245, 4853.878653033632, 4882.731449770296, 4887.340209071801, 4889.828855990095, 4422.513523512411, 4422.778861056934, 4422.84520041797, 4423.447069116361, 4425.756583387944, 3137.8587963541695, 3175.666555011737, 3474.722022238215, 3517.6834084931966, 3717.498137751423, 1240.7394447166016, 1241.5406299669, 1248.2572869142846, 1252.154795513025, 1255.7488502299577, 1018.511114664965, 1018.8013337399284, 1076.499427766077, 1097.3086955218162, 1203.8314635950974, 6991.161060672752, 7045.964770176219, 7059.647017649199, 7062.611556364346, 7067.293270672994, 1115.2304909612342, 1115.966521004371, 1125.6004118537965, 1137.647329327911, 1148.6668866028758, 5115.1559992600805, 5191.0, 5234.18870075139, 5235.73821308933, 5242.056429842665, 8548.187922147386, 8722.215000649972, 8903.643854245887, 8921.464712117293, 9188.724338269863, 9108.316876234308, 9340.626374944926, 9403.059694030542, 9417.15245627883, 9426.764330891645, 7346.375558077623, 7348.338649521569, 7531.510451820614, 7553.131389890233, 7554.2823431775, 6821.556598821061, 6861.519693621399, 6869.141357330333, 6874.587524748531, 6883.346082122191, 8235.794105147419, 8354.289885359813, 8365.121662225622, 8548.0, 8594.0, 8607.612657430305, 8682.0, 8721.956390218009, 8740.650373984969, 8760.868586971073, 6655.700493477902, 6938.855088910475, 6980.406665433495, 6985.9301406987315, 6988.021676965331, 6633.270340262471, 6759.391654751096, 6765.763198288037, 7041.260667629826, 7266.890996634949, 6802.455803535607, 6842.315768423118, 6937.028815965869, 6963.0, 6994.090768200102, 6791.286914873867, 6872.931270687229, 6964.965175174092, 7001.894971575329, 7023.613701246481, 6617.371349721769, 6619.404253617197, 6621.900671489835, 6634.203895532567, 6657.933420665925, 6191.25704915413, 6226.315105338319, 6256.0, 6357.332480089524, 6362.395572420613, 6387.776427825004, 6425.389587989133, 6432.710528026344, 6434.613923164625, 6441.194850643669], "unit": "score", "name": "mootools.html", "value": 4469.146911220713}, {"lowerIsBetter": false, "replicates": [332.7571520371412, 334.12292731579606, 338.3824520250542, 341.57644520794213, 343.0377790298214, 5818.912716309259, 5881.500072493838, 5898.11528270759, 5898.351181370052, 5944.673042982634, 5741.885162296751, 5850.502707269877, 5856.47291743743, 5857.6485410875275, 5875.236219291486, 4550.476695180064, 4563.133004729108, 4563.7489938053395, 4564.224081906067, 4567.109413664337, 4364.9781751091205, 4394.516603173648, 4493.707908985905, 4573.245414506602, 4580.038191979672, 4525.049739554681, 4551.8634440966825, 4556.270996640538, 4562.224421848294, 4574.062317224961, 4535.387722657432, 4537.296719008559, 4538.273876179812, 4549.067441174551, 4552.294394368878, 3992.3811809169624, 3994.1612261425134, 4007.458993035932, 4018.095928416083, 4026.879193624196, 5531.059719847595, 5594.272744543224, 5615.298087739033, 5625.915611265835, 5630.09918413056, 5279.683219006872, 5284.762185701653, 5286.36563612369, 5292.814751483679, 5294.6029047821185, 6172.629642221481, 6210.254769427653, 6212.0371342441995, 6213.596116252429, 6216.222972128484, 4259.76571288579, 4294.527601963781, 4337.956620433787, 4388.868333949987, 4434.179676759777, 6474.061261117112, 6485.902711459332, 6502.284748677689, 6508.446782023534, 6513.902291465632, 4524.434445694288, 4525.660575456854, 4528.071745292207, 4530.478994915561, 4533.52397998212, 4360.7601581913295, 4568.520305367955, 4579.335996280521, 4581.839635612804, 4583.816647334069, 5135.537801597874, 5169.327987361619, 5206.687598744087, 5208.947910520922, 5212.478752124833, 6262.5929314594405, 6283.6858157091965, 6285.465735412449, 6287.151234583364, 6294.527910406646, 1582.3907795498815, 1596.9441069562743, 1599.6480774229651, 1599.6640705451985, 1599.720048991445, 1064.0583083970741, 1064.9680509584725, 1066.9519871605642, 1090.1333439915286, 1092.257265059751, 5995.310539288038, 5998.3701711320555, 5999.040153575407, 6000.699965001732, 6007.759689612454, 6445.258795238514, 6445.677716114175, 6446.226452825691, 6448.516361272923, 6484.157059582224, 5976.940230597638, 5990.820275391745, 5991.910121348184, 6000.03999360109, 6000.759969601254, 3427.7600567960003, 3534.2578058607464, 3537.34559106561, 3540.168060505779, 3544.3088597723713, 6835.0, 6836.6923488443135, 6839.658017099126, 6842.0, 6844.110265665432, 6633.9668301658185, 6666.0, 6674.299198584175, 6685.6322902240845, 6690.230623478362, 6652.600843949379, 6715.764948226789, 6799.150106236721, 6803.829904252334, 6822.317768223138, 6333.303336633059, 6506.544541882023, 6511.609303441809, 6531.804045878631, 6537.248216455168, 6318.652474113968, 6374.3306952771145, 6453.645049522322, 6454.5159113065765, 6478.546501744832, 6772.221194562689, 6776.627285499345, 6794.3545363190415, 6800.353966373186, 6806.115205023513, 4393.758343291021, 4443.844465443694, 4447.377367168534, 4449.17690227296, 4452.087322099027, 6388.584741991942, 6565.540412171103, 6580.8354791130605, 6584.473242140713, 6589.934100659124, 6354.142190804182, 6392.264889537762, 6399.968000159969, 6401.199850018747, 6407.519436042408, 6210.720517576629, 6317.0, 6361.363863613602, 6365.363463653597, 6370.554061215856, 6201.751929922933, 6229.3770622937345, 6252.468540173954, 6253.343398943045, 6261.74953001893, 6399.712012959521, 6400.359964003563, 6402.35976402356, 6403.455706265019, 6405.03924411342, 6111.174991376285, 6249.687515624109, 6255.468285195628, 6256.968715156395, 6258.530610204162], "unit": "score", "name": "prototype.html", "value": 4757.947967674286}, {"lowerIsBetter": false, "replicates": [784.7410354582986, 855.2431098477846, 863.887694599702, 863.9006514250863, 886.3662481325855, 13424.597262082129, 13662.521811736591, 13692.52076177334, 13695.589132326033, 13698.72602547951, 10633.46832658368, 13033.152845065064, 13130.409131589078, 13160.934195329033, 13162.0, 680.1701923653135, 810.4610434061342, 831.5925196653657, 832.5421018439833, 833.0336809301211, 818.6970820796284, 818.8648872935959, 819.8360327934437, 825.2531459029558, 826.5247482697444, 718.6299055986171, 728.9088863892014, 875.1467319363601, 881.2201201936268, 882.9205371516563, 866.1035827918106, 870.9738707838775, 874.9981271444225, 877.55244825139, 879.0330636300051, 648.8864448721455, 649.9740010399578, 652.1098700274092, 652.9477641788645, 652.9706163222667, 12367.938160309232, 12656.493740250378, 12674.239545627292, 12678.239305641599, 12697.301648409333, 11975.0, 12120.151589388746, 12671.619851404472, 12910.483580656763, 13123.212607243597, 10479.0, 10529.526171322308, 10601.628942987036, 10750.623728169554, 10754.946225268903, 3535.6641119093647, 3623.365910965597, 3707.443883417509, 3730.7761534307756, 3789.412641040643, 46728.53271467276, 47565.0, 48216.517834821905, 48226.27660585094, 48424.0, 9300.953495232481, 9325.720228393158, 9390.577424015935, 9455.167237462792, 9765.462899540451, 17001.659966800842, 17063.402780902856, 17065.573360665836, 17082.487525374258, 17175.828241717423, 7340.559566426032, 7506.587137707369, 7539.660715267826, 7591.3547348475995, 7874.173211812792, 4276.144771045803, 4306.20335237982, 4330.285502891988, 4337.067530480898, 4350.216960946997, 3133.85897634607, 3154.41643295991, 3155.3058327167987, 3159.573457583197, 3165.7625678073778, 572.3075079154187, 589.7434615942079, 595.8450802791219, 615.4184295840388, 625.5027253333611, 474.40699126092386, 512.8948565544055, 515.4613428966738, 553.5028045128662, 681.3220845258999, 8267.421280510427, 8484.236418722345, 8532.829343413097, 8590.098039705867, 8742.169493898196, 497.36337488015397, 591.4588151841103, 626.1734510446258, 685.5167107189419, 703.8345988692653, 3713.8700145494777, 3743.47591337213, 3890.105275786585, 3938.12938854042, 4075.3683179107284, 58746.0, 58809.0, 59592.0, 59901.70049149814, 60237.39762602405, 49841.0, 51174.48825511697, 51200.48799512032, 51368.74315628398, 51534.22698659523, 46517.0, 48062.279065814044, 48145.518544814804, 48155.75922120367, 48261.5173848257, 7999.480033797785, 8240.711575094843, 8246.793830154294, 8436.620352084294, 8469.872951905849, 33365.0, 33769.15577110494, 34083.65916340805, 35643.28713425769, 35647.82176089103, 41855.0, 42410.787946060074, 43409.3488597665, 43845.12309753851, 43953.12093758043, 11204.88795112071, 11367.602133925273, 11606.88393116058, 11618.070554355461, 11676.0, 12295.44670489848, 12554.811677824657, 12643.620691379274, 13027.544035958696, 13033.348332583144, 10364.326318789255, 10383.2212584055, 10467.110295624958, 10479.318844275098, 10986.560537578407, 10458.790824183321, 10785.298955567863, 10794.352338859693, 10800.729981750519, 11121.221514493907, 6720.9674692444005, 9223.0, 9742.512874356396, 9835.508224588599, 9933.056359645821, 9784.0, 10192.439415832201, 10262.457094036026, 10283.94858025705, 10346.37921724699, 9299.72100836976, 9539.618415263312, 9540.284478664267, 9557.378770379903, 9557.713268601952], "unit": "score", "name": "yui.html", "value": 6225.671416372285}], "name": "dromaeo_css", "value": 6930.68204199992}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 109.0, 109.0, 109.0, 97.0, 109.0, 110.0, 115.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [149.0, 122.0, 161.0, 161.0, 127.0, 151.0, 156.0, 128.0, 164.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 162.0, 160.0, 162.0, 159.0, 158.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 84.0, 89.0, 72.0, 73.0, 73.0, 105.0, 89.0, 70.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 132.0, 92.0, 94.0, 93.0, 132.0, 93.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0, 58.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 83.0, 92.0, 85.0, 84.0, 84.0, 93.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 121.0, 130.0, 117.0, 125.0, 127.0, 122.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [151.0, 150.0, 162.0, 148.0, 156.0, 140.0, 152.0, 149.0, 166.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1497.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.94756057085962], "unit": "score", "name": "Richards", "value": 212.72985200000008}, {"lowerIsBetter": false, "replicates": [189.60940462646948], "unit": "score", "name": "DeltaBlue", "value": 348.7063319999999}, {"lowerIsBetter": false, "replicates": [283.60748723766307], "unit": "score", "name": "Encrypt", "value": 938.5542060000004}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [780.811232449298], "unit": "score", "name": "Earley", "value": 853.5520139860142}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [614.2506142506143], "unit": "score", "name": "Splay", "value": 132.66734799999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21017.98568832166}]} 02:13:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21017.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1498.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6930.68"}}} 02:13:33 INFO - Return code: 0 02:13:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:13:33 ERROR - # TBPL SUCCESS # 02:13:33 INFO - Running post-action listener: _resource_record_post_action 02:13:33 INFO - Running post-run listener: _resource_record_post_run 02:13:34 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547090432; Read time: 12; Write time: 460392 02:13:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235147264; Read time: 0; Write time: 239088 02:13:34 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311943168; Read time: 12; Write time: 221304 02:13:34 INFO - Running post-run listener: _upload_blobber_files 02:13:34 INFO - Blob upload gear active. 02:13:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:13:34 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:13:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:13:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:13:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:35 INFO - (blobuploader) - INFO - Done attempting. 02:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:36 INFO - (blobuploader) - INFO - Done attempting. 02:13:36 INFO - (blobuploader) - INFO - Iteration through files over. 02:13:36 INFO - Return code: 0 02:13:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:13:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:13:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f52acf430fc50c669e7b82a2ada93d057fa6b5637d8e8250f0b0d5e444e21cd803b7895802033d61966287496fa05a9774c199b0fd4f55b98e49dc96f6235ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/779b750f760a44d95e8e8362fffb6e9f543c50482eb8c1e5dedf0ffce05b99cebaa2cb907285804918f00eef03d953351868c6076691e5c949e3f9a52ac06f38"} 02:13:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:13:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:13:36 INFO - Contents: 02:13:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f52acf430fc50c669e7b82a2ada93d057fa6b5637d8e8250f0b0d5e444e21cd803b7895802033d61966287496fa05a9774c199b0fd4f55b98e49dc96f6235ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/779b750f760a44d95e8e8362fffb6e9f543c50482eb8c1e5dedf0ffce05b99cebaa2cb907285804918f00eef03d953351868c6076691e5c949e3f9a52ac06f38"} 02:13:36 INFO - Copying logs to upload dir... 02:13:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.956323 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-24 02:13:36.728667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 02:13:36.732798) ========= 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=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 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/5f52acf430fc50c669e7b82a2ada93d057fa6b5637d8e8250f0b0d5e444e21cd803b7895802033d61966287496fa05a9774c199b0fd4f55b98e49dc96f6235ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/779b750f760a44d95e8e8362fffb6e9f543c50482eb8c1e5dedf0ffce05b99cebaa2cb907285804918f00eef03d953351868c6076691e5c949e3f9a52ac06f38"} build_url:https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/Xl-xdT2nS-6Z31EVDV2lYA/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/5f52acf430fc50c669e7b82a2ada93d057fa6b5637d8e8250f0b0d5e444e21cd803b7895802033d61966287496fa05a9774c199b0fd4f55b98e49dc96f6235ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/779b750f760a44d95e8e8362fffb6e9f543c50482eb8c1e5dedf0ffce05b99cebaa2cb907285804918f00eef03d953351868c6076691e5c949e3f9a52ac06f38"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 02:13:36.759900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 02:13:36.760386) ========= 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=dd132779db58144225c4cf24000001c8-1450949214.168830-402457626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 02:13:36.841044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 02:13:36.841371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 02:13:36.841683) ========= ========= Total master_lag: 0.27 =========