builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1451000664.55 results: success (0) buildid: 20151224133004 builduid: a83994666f8c42b6a0a3b27c88a89f05 revision: fedf404c32d9759b27e8493dc03413ed37bd1224 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.551741) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.552264) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.552609) ========= 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=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006403 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.591209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.591886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.677127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.677416) ========= 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=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.761752) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.762409) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.762829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.763155) ========= 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=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 15:44:27-- 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.1M=0s 2015-12-24 15:44:27 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181234 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.963549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.963863) ========= 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=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014595 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.015776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.016200) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fedf404c32d9759b27e8493dc03413ed37bd1224 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fedf404c32d9759b27e8493dc03413ed37bd1224 --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=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 15:44:27,550 truncating revision to first 12 chars 2015-12-24 15:44:27,551 Setting DEBUG logging. 2015-12-24 15:44:27,551 attempt 1/10 2015-12-24 15:44:27,551 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fedf404c32d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 15:44:27,876 unpacking tar archive at: mozilla-inbound-fedf404c32d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.639909) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.640268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.648484) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.648793) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.649270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-12-24 15:44:25.649617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:44:28 INFO - MultiFileLogger online at 20151224 15:44:28 in /builds/slave/test-pgo 15:44:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:44:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:44:28 INFO - {'append_to_log': False, 15:44:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:44:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:44:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:44:28 INFO - 'branch': 'Mozilla-Inbound', 15:44:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:44:28 INFO - 'config_files': ('talos/linux_config.py',), 15:44:28 INFO - 'default_actions': ('clobber', 15:44:28 INFO - 'read-buildbot-config', 15:44:28 INFO - 'download-and-extract', 15:44:28 INFO - 'populate-webroot', 15:44:28 INFO - 'create-virtualenv', 15:44:28 INFO - 'install', 15:44:28 INFO - 'run-tests'), 15:44:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:44:28 INFO - 'download_minidump_stackwalk': True, 15:44:28 INFO - 'download_symbols': 'ondemand', 15:44:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:44:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:44:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:44:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:44:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:44:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:44:28 INFO - 'installer_path': 'installer.exe', 15:44:28 INFO - 'log_level': 'info', 15:44:28 INFO - 'log_name': 'talos', 15:44:28 INFO - 'log_to_console': True, 15:44:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:44:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:44:28 INFO - 'opt_config_files': (), 15:44:28 INFO - 'pip_index': False, 15:44:28 INFO - 'sps_profile': False, 15:44:28 INFO - 'sps_profile_interval': 0, 15:44:28 INFO - 'suite': 'dromaeojs', 15:44:28 INFO - 'system_bits': '64', 15:44:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:44:28 INFO - 'title': 'talos-linux64-ix-066', 15:44:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:44:28 INFO - 'use_talos_json': True, 15:44:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:44:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:44:28 INFO - 'work_dir': 'build'} 15:44:28 INFO - ##### 15:44:28 INFO - ##### Running clobber step. 15:44:28 INFO - ##### 15:44:28 INFO - Running pre-action listener: _resource_record_pre_action 15:44:28 INFO - Running main action method: clobber 15:44:28 INFO - rmtree: /builds/slave/test-pgo/build 15:44:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:44:29 INFO - Running post-action listener: _resource_record_post_action 15:44:29 INFO - ##### 15:44:29 INFO - ##### Running read-buildbot-config step. 15:44:29 INFO - ##### 15:44:29 INFO - Running pre-action listener: _resource_record_pre_action 15:44:29 INFO - Running main action method: read_buildbot_config 15:44:29 INFO - Using buildbot properties: 15:44:29 INFO - { 15:44:29 INFO - "project": "", 15:44:29 INFO - "product": "firefox", 15:44:29 INFO - "script_repo_revision": "production", 15:44:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:44:29 INFO - "repository": "", 15:44:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:44:29 INFO - "buildid": "20151224133004", 15:44:29 INFO - "pgo_build": "True", 15:44:29 INFO - "basedir": "/builds/slave/test-pgo", 15:44:29 INFO - "buildnumber": 1373, 15:44:29 INFO - "slavename": "talos-linux64-ix-066", 15:44:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:44:29 INFO - "platform": "ubuntu64_hw", 15:44:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:44:29 INFO - "branch": "mozilla-inbound", 15:44:29 INFO - "repo_path": "integration/mozilla-inbound", 15:44:29 INFO - "revision": "fedf404c32d9759b27e8493dc03413ed37bd1224", 15:44:29 INFO - "stage_platform": "linux64-pgo", 15:44:29 INFO - "builduid": "a83994666f8c42b6a0a3b27c88a89f05", 15:44:29 INFO - "slavebuilddir": "test" 15:44:29 INFO - } 15:44:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:44:29 INFO - Running post-action listener: _resource_record_post_action 15:44:29 INFO - ##### 15:44:29 INFO - ##### Running download-and-extract step. 15:44:29 INFO - ##### 15:44:29 INFO - Running pre-action listener: _resource_record_pre_action 15:44:29 INFO - Running main action method: download_and_extract 15:44:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:29 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json 15:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json 15:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:44:29 INFO - Downloaded 1302 bytes. 15:44:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:44:29 INFO - Using the following test package requirements: 15:44:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:44:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:29 INFO - u'jsshell-linux-x86_64.zip'], 15:44:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:44:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:44:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:44:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:44:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:44:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:29 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:32 INFO - Downloaded 23189967 bytes. 15:44:32 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 15:44:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:32 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 15:44:33 INFO - Return code: 0 15:44:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:33 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:47 INFO - Downloaded 23189967 bytes. 15:44:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:44:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:44:48 INFO - Return code: 0 15:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:48 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:44:49 INFO - Downloaded 11132270 bytes. 15:44:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:44:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:44:49 INFO - Return code: 0 15:44: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')]} 15:44:49 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:44:51 INFO - Downloaded 54879000 bytes. 15:44:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:51 INFO - mkdir: /builds/slave/test-pgo/properties 15:44:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:44:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:44:51 INFO - Contents: 15:44:51 INFO - build_url:https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:51 INFO - Running post-action listener: _resource_record_post_action 15:44:51 INFO - Running post-action listener: set_extra_try_arguments 15:44:51 INFO - ##### 15:44:51 INFO - ##### Running populate-webroot step. 15:44:51 INFO - ##### 15:44:51 INFO - Running pre-action listener: _resource_record_pre_action 15:44:51 INFO - Running main action method: populate_webroot 15:44:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:51 INFO - '--tppagecycles', 15:44:51 INFO - '7'], 15:44:51 INFO - 'tests': ['tsvgm']}}, 15:44:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:44:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:44:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:44:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'tests': ['damp', 'tps']}, 15:44:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['damp', 'tps']}, 15:44:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:44:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:51 INFO - 'other': {'tests': ['a11yr', 15:44:51 INFO - 'ts_paint', 15:44:51 INFO - 'tpaint', 15:44:51 INFO - 'sessionrestore', 15:44:51 INFO - 'sessionrestore_no_auto_restore']}, 15:44:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['a11yr', 15:44:51 INFO - 'ts_paint', 15:44:51 INFO - 'tpaint', 15:44:51 INFO - 'sessionrestore', 15:44:51 INFO - 'sessionrestore_no_auto_restore']}, 15:44:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['a11yr', 15:44:51 INFO - 'ts_paint', 15:44:51 INFO - 'tpaint', 15:44:51 INFO - 'sessionrestore', 15:44:51 INFO - 'sessionrestore_no_auto_restore']}, 15:44:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['a11yr', 15:44:51 INFO - 'ts_paint', 15:44:51 INFO - 'tpaint', 15:44:51 INFO - 'sessionrestore', 15:44:51 INFO - 'sessionrestore_no_auto_restore']}, 15:44:51 INFO - 'other_l64': {'tests': ['a11yr', 15:44:51 INFO - 'ts_paint', 15:44:51 INFO - 'tpaint', 15:44:51 INFO - 'sessionrestore', 15:44:51 INFO - 'sessionrestore_no_auto_restore']}, 15:44:51 INFO - 'other_nol64': {'tests': ['a11yr', 15:44:51 INFO - 'ts_paint', 15:44:51 INFO - 'tpaint', 15:44:51 INFO - 'sessionrestore', 15:44:51 INFO - 'sessionrestore_no_auto_restore']}, 15:44:51 INFO - 'svgr': {'tests': ['tsvgx', 15:44:51 INFO - 'tsvgr_opacity', 15:44:51 INFO - 'tart', 15:44:51 INFO - 'tscrollx', 15:44:51 INFO - 'cart']}, 15:44:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['tsvgx', 15:44:51 INFO - 'tsvgr_opacity', 15:44:51 INFO - 'tart', 15:44:51 INFO - 'tscrollx', 15:44:51 INFO - 'cart']}, 15:44:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'tests': ['tp5o']}, 15:44:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'talos_options': ['--e10s'], 15:44:51 INFO - 'tests': ['tp5o']}, 15:44:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'talos_options': ['--xperf_path', 15:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:51 INFO - 'tests': ['tp5n']}, 15:44:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:51 INFO - 'talos_options': ['--e10s', 15:44:51 INFO - '--xperf_path', 15:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:51 INFO - 'tests': ['tp5n']}}, 15:44:51 INFO - 'talos.zip': {'path': '', 15:44:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:51 INFO - Running post-action listener: _resource_record_post_action 15:44:51 INFO - ##### 15:44:51 INFO - ##### Running create-virtualenv step. 15:44:51 INFO - ##### 15:44:51 INFO - Running pre-action listener: _resource_record_pre_action 15:44:51 INFO - Running main action method: create_virtualenv 15:44:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:44:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:44:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:44:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:51 INFO - Using real prefix '/usr' 15:44:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:44:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:54 INFO - Installing pip.................done. 15:44:54 INFO - Return code: 0 15:44:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:44:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:44:54 INFO - Using env: {'DISPLAY': ':0', 15:44:54 INFO - 'HOME': '/home/cltbld', 15:44:54 INFO - 'LANG': 'en_US.UTF-8', 15:44:54 INFO - 'LANGUAGE': 'en_US:en', 15:44:54 INFO - 'LOGNAME': 'cltbld', 15:44:54 INFO - 'MAIL': '/var/mail/cltbld', 15:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:54 INFO - 'MOZ_NO_REMOTE': '1', 15:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:54 INFO - 'NO_EM_RESTART': '1', 15:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:54 INFO - 'SHELL': '/bin/bash', 15:44:54 INFO - 'SHLVL': '1', 15:44:54 INFO - 'TERM': 'linux', 15:44:54 INFO - 'TMOUT': '86400', 15:44:54 INFO - 'USER': 'cltbld', 15:44:54 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:54 INFO - '_': '/tools/buildbot/bin/python'} 15:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:44:54 INFO - Cleaning up... 15:44:54 INFO - Return code: 0 15:44:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:44:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:44:54 INFO - Using env: {'DISPLAY': ':0', 15:44:54 INFO - 'HOME': '/home/cltbld', 15:44:54 INFO - 'LANG': 'en_US.UTF-8', 15:44:54 INFO - 'LANGUAGE': 'en_US:en', 15:44:54 INFO - 'LOGNAME': 'cltbld', 15:44:54 INFO - 'MAIL': '/var/mail/cltbld', 15:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:54 INFO - 'MOZ_NO_REMOTE': '1', 15:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:54 INFO - 'NO_EM_RESTART': '1', 15:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:54 INFO - 'SHELL': '/bin/bash', 15:44:54 INFO - 'SHLVL': '1', 15:44:54 INFO - 'TERM': 'linux', 15:44:54 INFO - 'TMOUT': '86400', 15:44:54 INFO - 'USER': 'cltbld', 15:44:54 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:54 INFO - '_': '/tools/buildbot/bin/python'} 15:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:54 INFO - Downloading/unpacking psutil>=0.7.1 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:44:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:44:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:56 INFO - Installing collected packages: psutil 15:44:56 INFO - Running setup.py install for psutil 15:44:56 INFO - building 'psutil._psutil_linux' extension 15:44:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:44:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:44:56 INFO - building 'psutil._psutil_posix' extension 15:44:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:44:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:56 INFO - Successfully installed psutil 15:44:56 INFO - Cleaning up... 15:44:56 INFO - Return code: 0 15:44:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:44:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:44:56 INFO - Using env: {'DISPLAY': ':0', 15:44:56 INFO - 'HOME': '/home/cltbld', 15:44:56 INFO - 'LANG': 'en_US.UTF-8', 15:44:56 INFO - 'LANGUAGE': 'en_US:en', 15:44:56 INFO - 'LOGNAME': 'cltbld', 15:44:56 INFO - 'MAIL': '/var/mail/cltbld', 15:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:56 INFO - 'MOZ_NO_REMOTE': '1', 15:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:56 INFO - 'NO_EM_RESTART': '1', 15:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:56 INFO - 'SHELL': '/bin/bash', 15:44:56 INFO - 'SHLVL': '1', 15:44:56 INFO - 'TERM': 'linux', 15:44:56 INFO - 'TMOUT': '86400', 15:44:56 INFO - 'USER': 'cltbld', 15:44:56 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:56 INFO - '_': '/tools/buildbot/bin/python'} 15:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:44:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:44:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:44:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:44:58 INFO - Installing collected packages: mozsystemmonitor 15:44:58 INFO - Running setup.py install for mozsystemmonitor 15:44:58 INFO - Successfully installed mozsystemmonitor 15:44:58 INFO - Cleaning up... 15:44:59 INFO - Return code: 0 15:44:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:44:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:44:59 INFO - Using env: {'DISPLAY': ':0', 15:44:59 INFO - 'HOME': '/home/cltbld', 15:44:59 INFO - 'LANG': 'en_US.UTF-8', 15:44:59 INFO - 'LANGUAGE': 'en_US:en', 15:44:59 INFO - 'LOGNAME': 'cltbld', 15:44:59 INFO - 'MAIL': '/var/mail/cltbld', 15:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:59 INFO - 'MOZ_NO_REMOTE': '1', 15:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:59 INFO - 'NO_EM_RESTART': '1', 15:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:59 INFO - 'SHELL': '/bin/bash', 15:44:59 INFO - 'SHLVL': '1', 15:44:59 INFO - 'TERM': 'linux', 15:44:59 INFO - 'TMOUT': '86400', 15:44:59 INFO - 'USER': 'cltbld', 15:44:59 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:59 INFO - '_': '/tools/buildbot/bin/python'} 15:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:59 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:45:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:45:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:01 INFO - Downloading docopt-0.6.1.tar.gz 15:45:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:45:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:01 INFO - Running setup.py install for blobuploader 15:45:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:45:01 INFO - Running setup.py install for requests 15:45:02 INFO - Running setup.py install for docopt 15:45:02 INFO - Successfully installed blobuploader requests docopt 15:45:02 INFO - Cleaning up... 15:45:02 INFO - Return code: 0 15:45:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:02 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 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:45:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:45:02 INFO - Using env: {'DISPLAY': ':0', 15:45:02 INFO - 'HOME': '/home/cltbld', 15:45:02 INFO - 'LANG': 'en_US.UTF-8', 15:45:02 INFO - 'LANGUAGE': 'en_US:en', 15:45:02 INFO - 'LOGNAME': 'cltbld', 15:45:02 INFO - 'MAIL': '/var/mail/cltbld', 15:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:02 INFO - 'MOZ_NO_REMOTE': '1', 15:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:02 INFO - 'NO_EM_RESTART': '1', 15:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:02 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:02 INFO - 'SHELL': '/bin/bash', 15:45:02 INFO - 'SHLVL': '1', 15:45:02 INFO - 'TERM': 'linux', 15:45:02 INFO - 'TMOUT': '86400', 15:45:02 INFO - 'USER': 'cltbld', 15:45:02 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:02 INFO - '_': '/tools/buildbot/bin/python'} 15:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:02 INFO - Running setup.py (path:/tmp/pip-W06eKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:02 INFO - Running setup.py (path:/tmp/pip-du3G0L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:02 INFO - Running setup.py (path:/tmp/pip-t3SllX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:02 INFO - Running setup.py (path:/tmp/pip-0U9WGQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:02 INFO - Running setup.py (path:/tmp/pip-Wr2xnZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:02 INFO - Running setup.py (path:/tmp/pip-RUZXpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:02 INFO - Running setup.py (path:/tmp/pip-1aFlhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:02 INFO - Running setup.py (path:/tmp/pip-7paf9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:03 INFO - Running setup.py (path:/tmp/pip-XqUxtB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:03 INFO - Running setup.py (path:/tmp/pip-DSFKG0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:03 INFO - Running setup.py (path:/tmp/pip-Hhmnpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:03 INFO - Running setup.py (path:/tmp/pip-I0Bp_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:03 INFO - Running setup.py (path:/tmp/pip-hcC15D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:03 INFO - Running setup.py (path:/tmp/pip-PeslsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:03 INFO - Running setup.py (path:/tmp/pip-4PFcqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:03 INFO - Running setup.py (path:/tmp/pip-rBOrlC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:03 INFO - Running setup.py (path:/tmp/pip-c84Bq_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:03 INFO - Running setup.py install for manifestparser 15:45:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:45:03 INFO - Running setup.py install for mozcrash 15:45:03 INFO - Running setup.py install for mozdebug 15:45:03 INFO - Running setup.py install for mozdevice 15:45:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Running setup.py install for mozfile 15:45:04 INFO - Running setup.py install for mozhttpd 15:45:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Running setup.py install for mozinfo 15:45:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Running setup.py install for mozInstall 15:45:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Running setup.py install for mozleak 15:45:04 INFO - Running setup.py install for mozlog 15:45:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Running setup.py install for moznetwork 15:45:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Running setup.py install for mozprocess 15:45:04 INFO - Running setup.py install for mozprofile 15:45:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:45:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:45:05 INFO - Running setup.py install for mozrunner 15:45:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:45:05 INFO - Running setup.py install for mozscreenshot 15:45:05 INFO - Running setup.py install for moztest 15:45:05 INFO - Running setup.py install for mozversion 15:45:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:45:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:05 INFO - Cleaning up... 15:45:05 INFO - Return code: 0 15:45:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:45:05 INFO - Using env: {'DISPLAY': ':0', 15:45:05 INFO - 'HOME': '/home/cltbld', 15:45:05 INFO - 'LANG': 'en_US.UTF-8', 15:45:05 INFO - 'LANGUAGE': 'en_US:en', 15:45:05 INFO - 'LOGNAME': 'cltbld', 15:45:05 INFO - 'MAIL': '/var/mail/cltbld', 15:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:05 INFO - 'MOZ_NO_REMOTE': '1', 15:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:05 INFO - 'NO_EM_RESTART': '1', 15:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:05 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:05 INFO - 'SHELL': '/bin/bash', 15:45:05 INFO - 'SHLVL': '1', 15:45:05 INFO - 'TERM': 'linux', 15:45:05 INFO - 'TMOUT': '86400', 15:45:05 INFO - 'USER': 'cltbld', 15:45:05 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:05 INFO - '_': '/tools/buildbot/bin/python'} 15:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:05 INFO - Running setup.py (path:/tmp/pip-GLHWbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:05 INFO - Running setup.py (path:/tmp/pip-LhB2Ug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:05 INFO - Running setup.py (path:/tmp/pip-HeG8v5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:05 INFO - Running setup.py (path:/tmp/pip-senuUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:05 INFO - Running setup.py (path:/tmp/pip-b7J7KX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:06 INFO - Running setup.py (path:/tmp/pip-KiKKL1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:06 INFO - Running setup.py (path:/tmp/pip-Or2A8i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:06 INFO - Running setup.py (path:/tmp/pip-wNrlje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:06 INFO - Running setup.py (path:/tmp/pip-WPP916-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:06 INFO - Running setup.py (path:/tmp/pip-oruaiz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:06 INFO - Running setup.py (path:/tmp/pip-4BYT3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:06 INFO - Running setup.py (path:/tmp/pip-Ihapt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:06 INFO - Running setup.py (path:/tmp/pip-OSG1rw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:06 INFO - Running setup.py (path:/tmp/pip-5H9FaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:06 INFO - Running setup.py (path:/tmp/pip-tH9hIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:06 INFO - Running setup.py (path:/tmp/pip-tOA9R2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:06 INFO - Running setup.py (path:/tmp/pip-4RYPf0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:08 INFO - Downloading blessings-1.5.1.tar.gz 15:45:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:45:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:08 INFO - Installing collected packages: blessings 15:45:08 INFO - Running setup.py install for blessings 15:45:08 INFO - Successfully installed blessings 15:45:08 INFO - Cleaning up... 15:45:08 INFO - Return code: 0 15:45:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:45:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:45:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:45:09 INFO - Reading from file tmpfile_stdout 15:45:09 INFO - Current package versions: 15:45:09 INFO - argparse == 1.2.1 15:45:09 INFO - blessings == 1.5.1 15:45:09 INFO - blobuploader == 1.2.4 15:45:09 INFO - docopt == 0.6.1 15:45:09 INFO - manifestparser == 1.1 15:45:09 INFO - mozInstall == 1.12 15:45:09 INFO - mozcrash == 0.16 15:45:09 INFO - mozdebug == 0.1 15:45:09 INFO - mozdevice == 0.47 15:45:09 INFO - mozfile == 1.2 15:45:09 INFO - mozhttpd == 0.7 15:45:09 INFO - mozinfo == 0.9 15:45:09 INFO - mozleak == 0.1 15:45:09 INFO - mozlog == 3.1 15:45:09 INFO - moznetwork == 0.27 15:45:09 INFO - mozprocess == 0.22 15:45:09 INFO - mozprofile == 0.28 15:45:09 INFO - mozrunner == 6.11 15:45:09 INFO - mozscreenshot == 0.1 15:45:09 INFO - mozsystemmonitor == 0.0 15:45:09 INFO - moztest == 0.7 15:45:09 INFO - mozversion == 1.4 15:45:09 INFO - psutil == 3.1.1 15:45:09 INFO - requests == 1.2.3 15:45:09 INFO - wsgiref == 0.1.2 15:45:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 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 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:45:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:45:09 INFO - Using env: {'DISPLAY': ':0', 15:45:09 INFO - 'HOME': '/home/cltbld', 15:45:09 INFO - 'LANG': 'en_US.UTF-8', 15:45:09 INFO - 'LANGUAGE': 'en_US:en', 15:45:09 INFO - 'LOGNAME': 'cltbld', 15:45:09 INFO - 'MAIL': '/var/mail/cltbld', 15:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:09 INFO - 'MOZ_NO_REMOTE': '1', 15:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:09 INFO - 'NO_EM_RESTART': '1', 15:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:09 INFO - 'SHELL': '/bin/bash', 15:45:09 INFO - 'SHLVL': '1', 15:45:09 INFO - 'TERM': 'linux', 15:45:09 INFO - 'TMOUT': '86400', 15:45:09 INFO - 'USER': 'cltbld', 15:45:09 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:09 INFO - '_': '/tools/buildbot/bin/python'} 15:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:45:09 INFO - Cleaning up... 15:45:09 INFO - Return code: 0 15:45:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 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 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:45:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:45:09 INFO - Using env: {'DISPLAY': ':0', 15:45:09 INFO - 'HOME': '/home/cltbld', 15:45:09 INFO - 'LANG': 'en_US.UTF-8', 15:45:09 INFO - 'LANGUAGE': 'en_US:en', 15:45:09 INFO - 'LOGNAME': 'cltbld', 15:45:09 INFO - 'MAIL': '/var/mail/cltbld', 15:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:09 INFO - 'MOZ_NO_REMOTE': '1', 15:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:09 INFO - 'NO_EM_RESTART': '1', 15:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:09 INFO - 'SHELL': '/bin/bash', 15:45:09 INFO - 'SHLVL': '1', 15:45:09 INFO - 'TERM': 'linux', 15:45:09 INFO - 'TMOUT': '86400', 15:45:09 INFO - 'USER': 'cltbld', 15:45:09 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:09 INFO - '_': '/tools/buildbot/bin/python'} 15:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:09 INFO - Downloading/unpacking jsonschema 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:45:11 INFO - Downloading/unpacking functools32 (from jsonschema) 15:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:45:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:11 INFO - warning: no files found matching '*.txt' 15:45:11 INFO - no previously-included directories found matching 'build' 15:45:11 INFO - no previously-included directories found matching 'dist' 15:45:11 INFO - no previously-included directories found matching '.git*' 15:45:11 INFO - Installing collected packages: jsonschema, functools32 15:45:11 INFO - Running setup.py install for functools32 15:45:11 INFO - warning: no files found matching '*.txt' 15:45:11 INFO - no previously-included directories found matching 'build' 15:45:11 INFO - no previously-included directories found matching 'dist' 15:45:11 INFO - no previously-included directories found matching '.git*' 15:45:11 INFO - Successfully installed jsonschema functools32 15:45:11 INFO - Cleaning up... 15:45:11 INFO - Return code: 0 15:45:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f523258df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, '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': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:45:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:45:11 INFO - Using env: {'DISPLAY': ':0', 15:45:11 INFO - 'HOME': '/home/cltbld', 15:45:11 INFO - 'LANG': 'en_US.UTF-8', 15:45:11 INFO - 'LANGUAGE': 'en_US:en', 15:45:11 INFO - 'LOGNAME': 'cltbld', 15:45:11 INFO - 'MAIL': '/var/mail/cltbld', 15:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:11 INFO - 'MOZ_NO_REMOTE': '1', 15:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:11 INFO - 'NO_EM_RESTART': '1', 15:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:11 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:11 INFO - 'SHELL': '/bin/bash', 15:45:11 INFO - 'SHLVL': '1', 15:45:11 INFO - 'TERM': 'linux', 15:45:11 INFO - 'TMOUT': '86400', 15:45:11 INFO - 'USER': 'cltbld', 15:45:11 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:11 INFO - '_': '/tools/buildbot/bin/python'} 15:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:11 INFO - Downloading/unpacking flake8 15:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:45:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:45:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:45:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:45:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:45:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:45:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:14 INFO - no previously-included directories found matching 'docs/_build' 15:45:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:45:14 INFO - Running setup.py install for pep8 15:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:14 INFO - no previously-included directories found matching 'docs/_build' 15:45:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:45:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:45:14 INFO - Cleaning up... 15:45:14 INFO - Return code: 0 15:45:14 INFO - Running post-action listener: _resource_record_post_action 15:45:14 INFO - Running post-action listener: _start_resource_monitoring 15:45:14 INFO - Starting resource monitoring. 15:45:14 INFO - ##### 15:45:14 INFO - ##### Running install step. 15:45:14 INFO - ##### 15:45:14 INFO - Running pre-action listener: _resource_record_pre_action 15:45:14 INFO - Running main action method: install 15:45:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:45:14 INFO - Reading from file tmpfile_stdout 15:45:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:45:14 INFO - Reading from file tmpfile_stdout 15:45:14 INFO - Output received: 15:45:14 INFO - Usage: mozinstall [options] installer 15:45:14 INFO - Options: 15:45:14 INFO - -h, --help show this help message and exit 15:45:14 INFO - -d DEST, --destination=DEST 15:45:14 INFO - Directory to install application into. [default: 15:45:14 INFO - "/builds/slave/test-pgo"] 15:45:14 INFO - --app=APP Application being installed. [default: firefox] 15:45:14 INFO - mkdir: /builds/slave/test-pgo/build/application 15:45:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:45:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:45:30 INFO - Reading from file tmpfile_stdout 15:45:30 INFO - Output received: 15:45:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:45:30 INFO - Running post-action listener: _resource_record_post_action 15:45:30 INFO - ##### 15:45:30 INFO - ##### Running run-tests step. 15:45:30 INFO - ##### 15:45:30 INFO - Running pre-action listener: _resource_record_pre_action 15:45:30 INFO - Running main action method: run_tests 15:45:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:45:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:45:30 INFO - Python 2.7.3 15:45:30 INFO - Return code: 0 15:45:30 INFO - grabbing minidump binary from tooltool 15:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea540>, '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 0x14eb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:45:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:45:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:45:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:30 INFO - Return code: 0 15:45:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:45:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:45:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:45:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:45:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:45:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:45:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:45:31 INFO - Return code: 0 15:45:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 15:45:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 15:45:31 INFO - Using env: {'DISPLAY': ':0', 15:45:31 INFO - 'HOME': '/home/cltbld', 15:45:31 INFO - 'LANG': 'en_US.UTF-8', 15:45:31 INFO - 'LANGUAGE': 'en_US:en', 15:45:31 INFO - 'LOGNAME': 'cltbld', 15:45:31 INFO - 'MAIL': '/var/mail/cltbld', 15:45:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:45:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:31 INFO - 'MOZ_NO_REMOTE': '1', 15:45:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:31 INFO - 'NO_EM_RESTART': '1', 15:45:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:31 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:45:31 INFO - 'SHELL': '/bin/bash', 15:45:31 INFO - 'SHLVL': '1', 15:45:31 INFO - 'TERM': 'linux', 15:45:31 INFO - 'TMOUT': '86400', 15:45:31 INFO - 'USER': 'cltbld', 15:45:31 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941', 15:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:31 INFO - '_': '/tools/buildbot/bin/python'} 15:45:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:45:31 INFO - mozversion application_buildid: 20151224133004 15:45:31 INFO - mozversion application_changeset: fedf404c32d9759b27e8493dc03413ed37bd1224 15:45:31 INFO - mozversion application_display_name: Nightly 15:45:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:31 INFO - mozversion application_name: Firefox 15:45:31 INFO - mozversion application_remotingname: firefox 15:45:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:31 INFO - mozversion application_vendor: Mozilla 15:45:31 INFO - mozversion application_version: 46.0a1 15:45:31 INFO - mozversion platform_buildid: 20151224133004 15:45:31 INFO - mozversion platform_changeset: fedf404c32d9759b27e8493dc03413ed37bd1224 15:45:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:31 INFO - mozversion platform_version: 46.0a1 15:45:31 INFO - using testdate: 1451000731 15:45:31 INFO - actual date: 1451000731 15:45:31 INFO - starting webserver on 'localhost:34327' 15:45:31 INFO - SUITE-START | Running 3 tests 15:45:31 INFO - TEST-START | dromaeo_css 15:45:31 INFO - operating with platform_type : linux_ 15:45:31 INFO - Initialising browser for dromaeo_css test... 15:45:31 INFO - TEST-INFO | started process 18443 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcKArIl/profile http://localhost:34327/getInfo.html) 15:45:36 INFO - PROCESS | 18443 | __metrics Screen width/height:1600/1200 15:45:36 INFO - PROCESS | 18443 | colorDepth:24 15:45:36 INFO - PROCESS | 18443 | Browser inner width/height: 1024/697 15:45:36 INFO - PROCESS | 18443 | __metrics 15:45:36 INFO - PROCESS | 18443 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:45:36 INFO - PROCESS | 18443 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:45:36 ERROR - PROCESS | 18443 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 15:45:37 INFO - TEST-INFO | 18443: exit 0 15:45:37 INFO - Browser initialized. 15:45:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:37 INFO - TEST-INFO | started process 18539 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcKArIl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:49 INFO - PROCESS | 18539 | RSS: Main: 151502848 15:45:49 INFO - PROCESS | 18539 | 15:46:41 INFO - PROCESS | 18539 | 1451000801031 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:48:48 INFO - PROCESS | 18539 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34327/tests/dromaeo/cssquery-ext.html) 15:48:50 INFO - PROCESS | 18539 | RSS: Main: 335802368 15:48:50 INFO - PROCESS | 18539 | 15:51:52 INFO - PROCESS | 18539 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-ext.html (next: http://localhost:34327/tests/dromaeo/cssquery-jquery.html) 15:51:53 INFO - PROCESS | 18539 | RSS: Main: 240832512 15:51:53 INFO - PROCESS | 18539 | 15:54:55 INFO - PROCESS | 18539 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34327/tests/dromaeo/cssquery-mootools.html) 15:54:56 INFO - PROCESS | 18539 | RSS: Main: 229851136 15:54:56 INFO - PROCESS | 18539 | 15:57:57 INFO - PROCESS | 18539 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34327/tests/dromaeo/cssquery-prototype.html) 15:57:58 INFO - PROCESS | 18539 | RSS: Main: 208760832 15:57:58 INFO - PROCESS | 18539 | 16:01:00 INFO - PROCESS | 18539 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34327/tests/dromaeo/cssquery-yui.html) 16:01:01 INFO - PROCESS | 18539 | RSS: Main: 216272896 16:01:01 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-yui.html (next: http://localhost:34327/tests/dromaeo/cssquery-dojo.html) 16:04:04 INFO - PROCESS | 18539 | RSS: Main: 277520384 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | __start_tp_report 16:04:04 INFO - PROCESS | 18539 | _x_x_mozilla_page_load 16:04:04 INFO - PROCESS | 18539 | _x_x_mozilla_page_load_details 16:04:04 INFO - PROCESS | 18539 | |i|pagename|runs| 16:04:04 INFO - PROCESS | 18539 | |0;dojo.html;3033.0900729781065;3091.350816328571;3134.655187929329;3142.324400253945;3172.9365412691745;4945.035718034985;5046;5053.797848086077;5061.569766569842;5121;4989.376327959005;5052.418971818242;5068.163752980754;5082.84751457456;5093.006863661588;4609.492955774862;4618.49196588375;4622.745748983804;4626.606738427237;4710.90578188436;4694.694844835092;4734.408198975111;4740.6918550294295;4749.097671442415;4781.139394908915;4561.954380456186;4594.977025114853;4666.136764698542;4671.369365135714;4715.976420117895;4606.723596584182;4635.559621835921;4636.049609829976;4641.791119399635;4673.182193116225;4604.861854144381;4611.792469338888;4621.953780462186;4634.443866736014;4645.9303110453375;4849.781759820817;4879.902401951941;4884.047610715912;4930.112579735646;4952.356193694833;5437.211604317391;5442.482964118402;5449.373322067973;5483.287172667568;5489.670619762827;5474.698891560963;5486.177073438977;5488.17677348397;5491.176323551459;5497.532709719679;5004.724740139291;5092.847214583531;5096.745162741848;5098.056859481007;5137.588992880561;5486.835394938158;5510.586705997066;5575.776968921197;5592.161175823659;5601.047821870292;5330.413654498002;5336.653117547347;5349.4650534946195;5353.491418315254;5360.70516121617;5356.035913535523;5389.649672771257;5497.340319161726;5517.4482551745305;5520.861978450491;5307.6284660073425;5338.839834804962;5345.38528069277;5348.91976620351;5390.54180394663;5365.651232669864;5396.757145928443;5400.270963419966;5402.8919421611345;5443.074677304868;4148.979255103705;4214.241436541452;4220.85227017053;4228.344606585984;4245.12974840157;3811.5235595550557;3820.67524260441;3824.043989002749;3852.3836186210074;3859.459675645412;5038.84883453497;5082.313887625197;5083.38999320084;5088.491150884956;5114.769835357418;5302.2311764793885;5340.706261155596;5386.757595908193;5399.028174928472;5425.348958125051;5044.445111037783;5057.317262169634;5058.696478211319;5067.721275329818;5090.134677104827;4736.052789442126;4736.360591320127;4739.3601863748645;4743.620510359163;4769;5359.3032905722;5464.207689884945;5465.398806131322;5467.535259502987;5523.613347065747;5467;5468.207109968953;5472.343318801769;5473.233747275305;5487.478689524489;5470.53500452466;5495.807646732345;5498.422665620213;5504.614676972734;5507.228987941611;5295.814646487354;5344.438833922382;5386.434424385383;5414.783408663767;5444.128939369682;5455.7817687293655;5461.344638643388;5462.8361149165585;5463.180522921593;5468.91796623059;5314.5216930476445;5315.867103322448;5316.229146773773;5322.787088516416;5339.25250464943;5164.612654050886;5225.294585230945;5245.659032162897;5247.291615631993;5247.868803279948;5201;5226.555742761908;5253.23828044939;5256.264123022704;5259.368875734936;5292.232626269247;5302.867428314323;5330.333708286465;5335.866603334947;5351.224072509386;5116.951025039783;5157.922631160461;5186.766595503136;5226.398964119175;5227.111391063452 16:04:04 INFO - PROCESS | 18539 | |1;ext.html;540.4414701887785;575.6172145523225;582.6300299309938;590.3977942498651;594.5897330841722;27842.164735057955;35830;36490;36505.45241821368;36549.26901461973;39414.21171576574;39769.80115099427;39813.402798958035;39830.20339593206;39850.20299594006;7146.106736657918;8495.447795893278;8658.913410865905;8662.30701543875;8664.263537599312;7483.550986940773;10126.29115961883;10278.7430314242;10318;10327.896721032806;10078.748031299203;10166.13587845034;10213.948930255376;10236.283460157792;10243.84634230487;7530.246975302426;7723.459357844897;9820.214382849355;9896.455694936813;9900.603975840957;7414.406847452191;10004.59981600735;10241.231907606885;10251.79496410075;10269.589216431334;35710.46434303487;36326.27347453036;36461.81769091164;36462.27075458476;36522.269554609025;3048.588440560518;3068.5704001439817;3093.551435041929;3100;3139.089663997461;27412;27681;28312.716872831214;28475.57286640702;28698.569521457193;3681.482957943015;3697.718016678543;3858.054776579756;3874.2638898609175;3893.377059670439;257129;257223;258610;259199.70400148068;259612;53459.732701336245;54276;58573.70713146492;59106.40893591009;59188.704056479444;69811;70006;70707.2929270711;70779;70836.97885679672;14967.775483367759;15020.624484387978;15069.698606027818;15151.924240378728;15164.545063648107;10981.505832237568;11010.614628488125;11014.50434730439;11020.338779673086;11039.951204635547;19566.608667826564;19574;19615.509612259808;19759.802401975798;19781.703274450894;7630.580318082448;7815.843683126419;7853.057633084067;7930.5638189898955;7941.880871786928;956.8421210500189;976.6728146071003;981.0532835813474;1024.5594394410325;1069.4706120470262;28351.71648283532;28691.28271793222;30475.542866857017;31076.533851992237;31467.84266078655;1060.9204309676804;1089.4879406679006;1090.7037565382918;1099.356876227416;1114.4761961877905;14862.777058344134;14971.326290316962;14979.40082396692;14985.775213371808;15130.167840768863;373862;381203;381506;382071;382269;51445.48554514407;51968.22047669288;51970;51997.48002520002;52093.47906520962;1323.0540163782941;1326.197650421481;1331.391927875449;1338.692100816798;1343.4290426568668;27036.594451082856;28259.174847189424;28280.85859570689;28535.145215560922;28677.28306792347;44606;45072;45152;45237.77381113073;45254.32118518159;288588;288976;289870;290470;291614;28661.42677146487;30908.536371954888;31307.217319567193;31662.841685791424;31765;36128;37090.62909370872;37397.43903841499;37825;37839.24321513609;38331.66932907326;38390.808045959595;39670.404943925285;40671;42827.828952295116;32946.50580241346;35585.46621800727;37967.43048854324;39624.60375396209;39652.40521392239;32620.510692339158;33018.367979522714;33283.66716332806;33403.1649208762;33412;28293;28684.713152868204;31288.374232515678;32326.854029961618;32429.18927026843;25041.87479062593;25053;25084.62373064369;25195.32024588524;25436.872815636543 16:04:04 INFO - PROCESS | 18539 | |2;jquery.html;356.4653020469294;358.99282014359704;359.62778524227423;361.65100677845874;364.42420974859726;16388.18059097045;17269.568260793487;18158.18288177032;18323.08384580769;18352.265909363625;14778.261086945664;14930.328135233913;16736.16319184042;17591.912040439813;17640.647187056253;5085.898282034357;5287.788488460466;5426.430224826396;5430.782768689248;5431.701256430894;5181.378234611851;5190.844274671747;5194.818181363653;5197.766100525486;5199.818006369759;3736.6637002669754;3836.1176929306275;5237.8428647140645;5359;5411.621186516945;5367.35591728995;5369.033573956686;5369.114096174107;5379.462053794628;5396.541293990015;5247.47525247476;5380.192971054334;5401.216823560561;5401.216823560601;5403.891922161574;12235.388230588524;12478.251304921734;16105.516834494983;19966;19968.101435435296;2111.187192930717;2164.231697747293;2168.6313326734494;2189.7810218978134;2219.966700499494;10632.681019569425;13145.73708525824;13254.072214944958;13606.523771668044;13693.109947853358;1843.2626949220285;1876.8029356917464;1887.7451544041517;1894.7063205203215;1902.5243689077731;55995;57022.42977570213;58927.116093258206;59007.70496147535;62402.37597624057;9914.652987145415;10138.847917281246;10245.59017639301;10264.384136951658;10287.485625718833;13307;13330.666733331744;13348.332583370793;13356.065075444625;13360.131591446525;7140.214576396592;7436.070491188601;7536.924630753732;7540.019797426409;7578.621068946531;6796.286389929085;6845.281245469154;6852;7388.37198838094;7403;4144.70987030905;4220.746755194698;4441.9117316257725;4509.481409637868;4532.70537415067;1811.1035037656445;1859.7210418437342;1871.2702046201991;1883.604443066944;1885;748.569572495817;788.692409960116;835.415209353455;991.3556188477547;1022.2537547590152;16359.34562617482;17100.828991709925;17994.820051799576;18004.279828806702;18272.543186420447;819.2790344496924;877.7454538183982;900.8738776571286;916.5554705967601;934.2152591822901;9216.631334746535;9454.243660507143;9488.193503552275;9585.9041409585;9663.951680241555;540836;542257;549001;557566;557991;82463.58768206241;83062.58468707738;83065.58467207746;83532;83830.58084709538;1097.6048622495896;1146.7706458708292;1155.4915837031679;1157.056998546182;1162.959296424621;15884;15979.280932358304;16038.278277477308;16120.193990300673;16195;34750.13124671904;34773.652263477044;35556.466653000745;35974;36085.819570903026;47649.52350476451;48110;48347.758261208466;50573.241401378276;52106;9612.471314077793;10114.949425252827;10115.898841011496;10128.645497407555;10129.544170512198;17511;17555;17828.554286142433;18012.63974720472;18209.45371638853;14326.641833954234;14388.784168237695;14868.107913525224;15109.168995705342;15225;14296;14364.497242596459;14428;14553.12681239129;15164.014339067926;15058.472953446577;15155.242237888282;15176.620584485476;15267.541973740805;15389.538313850602;8351.41540092212;8375.832483350177;9143.725688229099;9267.258619310303;9734.269929755155;13790.862091378958;13823.79264311016;14070;14201.431942722176;14313.141211527342 16:04:04 INFO - PROCESS | 18539 | |3;mootools.html;1287.246960528091;1344.9932750336247;1381.3645722967435;1506.8041154649893;1753.438899552143;6712.765053223138;7246.782596522106;7347.338739513442;7350.522216055952;7366.668499917503;6887.207971083314;7065.328793764585;7065.6113913734725;7066.96466517668;7074.363307302342;1889.7165425186263;1916.8370688491495;2115.428834214761;2165.101482884601;2218.1460137846966;2151.0427859602405;2155.795199456057;2161.6649419339947;2164.0586344939925;2166.2309879992613;2063.040686080972;2133.925312614059;2142.4965133193687;2146.61360955028;2149.9032543535577;2119.756228033773;2130.7336582927132;2155.795199456049;2163.1996161420375;2164.2425151197112;2156.9892150539304;2164.978350216509;2190.6494960806194;2191.9452013699624;2193.7696541863193;7353.411727061823;7456;7459.403247740168;7461.477696561243;7471.813204669927;4526.615237704799;4576.839810606612;4602.05657840142;4607.424071991001;4610.031893302411;2968.85155742212;3073.3699591583895;3076.6923307669053;3098.922526936822;3106.6427360853563;970.3983530211243;974.5468357213858;1022.6880801355584;1030.3354336452946;1032.958681652733;9758.316917815755;9831.90168098317;9852.064053914866;9858.112769850675;9872.950635246849;3935.822887970048;3975.741576797499;4062.8374865005067;4095.201435720006;4098.754074755524;8200.794980125425;8404.747857564284;8408.621612027473;8409.159084091665;8415.579221039046;4561.110583436264;4563.498015218323;4579.763463864738;4595.448546174481;4603.217453032992;4167.562405947332;4179.101493178981;4222.155568886235;4247.915041699149;4250.659947204216;3184.1084496341064;3227.2415982244156;3287.2603664175367;3451.8964431067106;3489.7906125632035;1062.4050531702117;1077.28898926708;1079.071998081649;1084.35480888871;1085.2837127495973;1025.3642741500169;1084.4306738962107;1231.9137660363688;1283.2044132637825;1304.7586196553477;6882.724691012303;7022.824429389306;7023.157221133497;7044.119485064367;7057.89413158803;593.7506247376112;605.9303180134253;623.0996210475819;624.753222477119;757.8560073586001;5475.5072043516275;5558.305211848519;5641.605087643908;5651.943480565142;5668.489835914787;8703.564821759013;8977.955110224408;9072.183503484586;9095.226905713089;9097.363184577016;8317.584120793936;8925.553722313858;8957.596908139149;8958.507282099547;8967.10328967098;7055.823604409931;7136.964315178391;7137.393321567621;7208;7209.6034718091005;6908.930910690829;6999.860002799814;7000.964995174992;7040.049593304839;7041.5422997505;7769.92230077692;7774.416918731004;7922.881156782538;7966.601669916597;7969.402294827795;7833.49082309648;7982.481138725964;8147.185281471805;8154.306883914934;8169.101398846004;6588.341165883565;6671.099401580725;6671.532992690465;6674.232463266787;6676.031975363448;6549.214094308713;6675;6680.498962577729;6839.589624622538;6840.692168852314;6697.464202863856;6727.562708423937;6817.727290908507;6931.237563868071;6985.0220969065385;6668.366505182;6732.192136943598;6775.186977562724;6833.282505337067;6848.863022739617;6833.658317084027;6875.381215690411;6876.724931002904;6884.586924784529;6884.759033433806;6236.688165591793;6264.060390941395;6297.496200304056;6307.96846015767;6316.557840951089;6447.194100737408;6484.70818813164;6489.383508566679;6492.091107244895;6498.317676644074 16:04:04 INFO - PROCESS | 18539 | |4;prototype.html;331.8937939859245;339.94390925497294;340.62531215662773;341.8222524287372;351.446471806904;5784.595078344507;5879.176915231871;5897.616654917433;5906.527477801782;6004.399560044004;5719.313682358113;5845.123231515275;5873.089671100986;5879.441453061963;5881.264841894763;4615.14619795339;4615.353850460938;4617.515160908107;4619.076184763044;4621.537846215385;4420.756858372804;4479.350494178342;4500.752458614775;4584.358189853423;4605.194091034073;4514.932276015862;4517.209488339544;4527.958569529011;4541.65937554683;4542.795574199169;4501.932471012905;4529.909401811962;4532.184206842767;4540.8864778380475;4542.6138778203895;4031.496062992126;4042.939355909664;4043.2722110020186;4046.7774272415004;4047.057412442015;5527.39198688144;5637.069883469223;5638;5707.942920570783;5712.457316554921;5277.86805329866;5282.128448805943;5282.577393808486;5283.603729720248;5284.524392804666;5981.401859814027;6306.9684651576445;6307.684615769193;6309.08518264849;6310.684465776692;4213.747175169499;4283.357496375537;4341.565843415665;4370.978145109254;4376.6936314458;6440.227172739301;6538.607683539003;6543.345665433466;6556.475481961479;6558.93441065588;4477.686561940633;4480.820767169342;4481.700306911024;4483.820647174077;4484.1255955088445;4457.863244872537;4542.11428771393;4542.500324964251;4549.158405694957;4569.086182763461;5243.2659427680155;5254;5254.842354729364;5258.158694608845;5259.605529585297;6299.0866324382705;6315.621062736251;6321.1782468278825;6322.9051564226575;6325.715342809584;1583.52494251724;1584.1049806859319;1584.1683116364002;1584.1762283612456;1585.2390852390918;1046.8482070099792;1048.0515133803767;1049.5801679328329;1055.37205362809;1086.4947799273375;5946.554008449383;5968.37332080134;5968.403159683997;5970.9701451492465;5979.1629171915965;6477.6437295948235;6480.675966201671;6486.2216534016225;6489.805305840832;6492.805215843532;5931.377205393458;5959.731812068468;5961.970190149108;5963.761449542057;5968.37332080134;3439.518467414514;3492.633273506296;3522.8238588070494;3541.9822900885847;3545.2554963457446;6621.834454138685;6626.204855417381;6637.1703537057865;6639.966800165968;6654.800355989328;6726.764563240263;6740.865182696319;6742.258351581322;6745.8650826983185;6754.0881980931945;6432.485401167895;6590.143281373391;6599.340065993459;6599.439047680905;6614.603123812491;6274;6346.619202847844;6548.47612191014;6548.607083575001;6551.705173267119;6336.524760642878;6422.197225346832;6463.450606698295;6466.32103629131;6515.609063456208;6603.966980165068;6605.669716514251;6613.239477459962;6613.735450581923;6618.305077966937;4377.233984052715;4492.101579684011;4497.460304763449;4522.186006518858;4528.230200865795;6485;6507.219133703986;6509.283978762427;6515.902261466176;6516.804495865132;6331.335209803088;6332.461740752087;6339.936600633934;6344.841378965562;6347.904781428375;6210.658413787104;6303.1175635412;6324.146240257506;6325.557210995186;6335.366463353628;6183.103449999635;6208.81373558794;6217.533684973555;6217.626942383471;6218.347073557211;6341.302456729848;6348.396902294275;6349.238091429058;6356.491480681442;6366.344750364846;6016.217891674054;6189.381061893955;6190.50475961931;6194.473469755121;6202.255729312511 16:04:04 INFO - PROCESS | 18539 | |5;yui.html;752.2966026764975;821.1255013410718;830.9376796740243;848.4909054567256;869.6695255802794;12932.741345173103;13179.80230296544;13199.472021119143;13199.868001319985;13212.339383030858;12402;12439.68900777481;12470.376481175928;12478.37608119595;12481.750364992695;667.5427332277393;673.5722816011843;809.360605121953;825.6449726617552;829.8630725930215;822.0751654388813;831.3930830493744;832.014063334947;832.317499650287;832.367400775412;702.9683664235096;857.2798848966867;864.5072308783996;865.6018231613465;865.8398196333667;706.2125729811249;844.2654890245495;856.5117882806771;858.8153546987428;864.2696921101659;629.2134831460675;633.1990032608753;633.7845132654919;634.8952422850224;635.6091004032533;12906.677333066655;12990.87009129906;12998.805017924738;13014;13021.544245951347;11692.824607630891;11801.704957376049;12168.756624867454;12404.13171078025;12492.81260781089;9862.704118876445;10135.594576216943;10359.171266298677;10442.321249118782;10604.681859544226;3557.4308110702423;3562;3563.732720045981;3614.981925090358;3637.1452708613456;48415.51584484181;48680.26979595309;48865;49281;49460.75269623665;9171.40385874916;9195.448273103635;9942.30403871722;9947.353422027545;10082.949585252027;17864.821351786315;17867.37464188773;17912.641747164984;17942.19260133271;17961.640767184585;7253.093363329584;7345.8898116527225;7380.114386273682;7424.183339832614;7490.775276741707;4144.668426525871;4145.91708165835;4285.292926667065;4373.781310934504;4390.297552391666;2925.3710452252867;2958.4083183363414;2958.5710072039433;2959.7040295970232;2961.7334439900515;558.9357223919301;561.2423228641302;570.1191658887029;572.7451284178501;575.6315957787019;649.7336092202174;667.7128834601072;677.1975209376905;680.9489288303298;702.1048163591462;8170.142135075732;8503.61733721984;8792.34057445694;8803.42777719459;9327.207187389013;651.9152510173647;652.1294072413381;671.3487916720773;675.9594424334556;676.6684324680871;3773.660370566662;3989.3816458448987;4048.67610591152;4123.793810309473;4284.914301713949;47715;47978.5202147981;49053.50946490489;59319;59943;51569;53199.20201196985;54279.72860135674;54871.72564137234;55269.44730552643;48987.75506122447;49303.753481232365;49871.75064124656;50141.74929125404;50873.23690144651;8073.313768329758;8439.2267948691;8607.526586037828;8613.440126391764;8905.243054340453;33317;33689.326213475106;33719.49420758642;35141.82429087838;36035.099122522144;42017.78991105025;45317.77341113273;45921.31118033299;46075.76962115168;46697.2995405076;10543.027313620025;10863.511141998788;11348.375839328586;11445.370504622326;11541.769164616828;12504.749905001667;12644.683882903;12806.039547033823;13084.869151308365;13190.406431710788;10810.56757729682;11281.21031527818;11312.26470279462;11380.260283081574;11564.653060408202;11617;11931.284122952651;11958.820617690915;12362.44369003415;12373.13388062827;11097.889021109686;11445.885541144482;11476.483558239732;11496.827547586625;11711.707207319545;9541.521631029338;9739.756506087404;9758.951205243928;9921.751956201153;10545.683629491128;9234.399764015317;9320.860187097063;9492.762680933032;9885.752856178653;10006.44964526958 16:04:04 INFO - PROCESS | 18539 | __end_tp_report 16:04:04 INFO - PROCESS | 18539 | __start_cc_report 16:04:04 INFO - PROCESS | 18539 | _x_x_mozilla_cycle_collect,1475 16:04:04 INFO - PROCESS | 18539 | __end_cc_report 16:04:04 INFO - PROCESS | 18539 | __startTimestamp1451001844554__endTimestamp 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | ------- Summary: start ------- 16:04:04 INFO - PROCESS | 18539 | Number of tests: 6 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | [#0] dojo.html Cycles:165 Average:5042.42 Median:5226.56 stddev:526.69 (10.1%) stddev-sans-first:504.17 16:04:04 INFO - PROCESS | 18539 | Values: 3033.1 3091.4 3134.7 3142.3 3172.9 4945.0 5046.0 5053.8 5061.6 5121.0 4989.4 5052.4 5068.2 5082.8 5093.0 4609.5 4618.5 4622.7 4626.6 4710.9 4694.7 4734.4 4740.7 4749.1 4781.1 4562.0 4595.0 4666.1 4671.4 4716.0 4606.7 4635.6 4636.0 4641.8 4673.2 4604.9 4611.8 4622.0 4634.4 4645.9 4849.8 4879.9 4884.0 4930.1 4952.4 5437.2 5442.5 5449.4 5483.3 5489.7 5474.7 5486.2 5488.2 5491.2 5497.5 5004.7 5092.8 5096.7 5098.1 5137.6 5486.8 5510.6 5575.8 5592.2 5601.0 5330.4 5336.7 5349.5 5353.5 5360.7 5356.0 5389.6 5497.3 5517.4 5520.9 5307.6 5338.8 5345.4 5348.9 5390.5 5365.7 5396.8 5400.3 5402.9 5443.1 4149.0 4214.2 4220.9 4228.3 4245.1 3811.5 3820.7 3824.0 3852.4 3859.5 5038.8 5082.3 5083.4 5088.5 5114.8 5302.2 5340.7 5386.8 5399.0 5425.3 5044.4 5057.3 5058.7 5067.7 5090.1 4736.1 4736.4 4739.4 4743.6 4769.0 5359.3 5464.2 5465.4 5467.5 5523.6 5467.0 5468.2 5472.3 5473.2 5487.5 5470.5 5495.8 5498.4 5504.6 5507.2 5295.8 5344.4 5386.4 5414.8 5444.1 5455.8 5461.3 5462.8 5463.2 5468.9 5314.5 5315.9 5316.2 5322.8 5339.3 5164.6 5225.3 5245.7 5247.3 5247.9 5201.0 5226.6 5253.2 5256.3 5259.4 5292.2 5302.9 5330.3 5335.9 5351.2 5117.0 5157.9 5186.8 5226.4 5227.1 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | [#1] ext.html Cycles:180 Average:47504.65 Median:32524.85 stddev:82408.34 (253.4%) stddev-sans-first:82564.07 16:04:04 INFO - PROCESS | 18539 | Values: 540.4 575.6 582.6 590.4 594.6 27842.2 35830.0 36490.0 36505.5 36549.3 39414.2 39769.8 39813.4 39830.2 39850.2 7146.1 8495.4 8658.9 8662.3 8664.3 7483.6 10126.3 10278.7 10318.0 10327.9 10078.7 10166.1 10213.9 10236.3 10243.8 7530.2 7723.5 9820.2 9896.5 9900.6 7414.4 10004.6 10241.2 10251.8 10269.6 35710.5 36326.3 36461.8 36462.3 36522.3 3048.6 3068.6 3093.6 3100.0 3139.1 27412.0 27681.0 28312.7 28475.6 28698.6 3681.5 3697.7 3858.1 3874.3 3893.4 257129.0 257223.0 258610.0 259199.7 259612.0 53459.7 54276.0 58573.7 59106.4 59188.7 69811.0 70006.0 70707.3 70779.0 70837.0 14967.8 15020.6 15069.7 15151.9 15164.5 10981.5 11010.6 11014.5 11020.3 11040.0 19566.6 19574.0 19615.5 19759.8 19781.7 7630.6 7815.8 7853.1 7930.6 7941.9 956.8 976.7 981.1 1024.6 1069.5 28351.7 28691.3 30475.5 31076.5 31467.8 1060.9 1089.5 1090.7 1099.4 1114.5 14862.8 14971.3 14979.4 14985.8 15130.2 373862.0 381203.0 381506.0 382071.0 382269.0 51445.5 51968.2 51970.0 51997.5 52093.5 1323.1 1326.2 1331.4 1338.7 1343.4 27036.6 28259.2 28280.9 28535.1 28677.3 44606.0 45072.0 45152.0 45237.8 45254.3 288588.0 288976.0 289870.0 290470.0 291614.0 28661.4 30908.5 31307.2 31662.8 31765.0 36128.0 37090.6 37397.4 37825.0 37839.2 38331.7 38390.8 39670.4 40671.0 42827.8 32946.5 35585.5 37967.4 39624.6 39652.4 32620.5 33018.4 33283.7 33403.2 33412.0 28293.0 28684.7 31288.4 32326.9 32429.2 25041.9 25053.0 25084.6 25195.3 25436.9 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | [#2] jquery.html Cycles:180 Average:29312.93 Median:35165.06 stddev:89810.19 (255.4%) stddev-sans-first:90035.81 16:04:04 INFO - PROCESS | 18539 | Values: 356.5 359.0 359.6 361.7 364.4 16388.2 17269.6 18158.2 18323.1 18352.3 14778.3 14930.3 16736.2 17591.9 17640.6 5085.9 5287.8 5426.4 5430.8 5431.7 5181.4 5190.8 5194.8 5197.8 5199.8 3736.7 3836.1 5237.8 5359.0 5411.6 5367.4 5369.0 5369.1 5379.5 5396.5 5247.5 5380.2 5401.2 5401.2 5403.9 12235.4 12478.3 16105.5 19966.0 19968.1 2111.2 2164.2 2168.6 2189.8 2220.0 10632.7 13145.7 13254.1 13606.5 13693.1 1843.3 1876.8 1887.7 1894.7 1902.5 55995.0 57022.4 58927.1 59007.7 62402.4 9914.7 10138.8 10245.6 10264.4 10287.5 13307.0 13330.7 13348.3 13356.1 13360.1 7140.2 7436.1 7536.9 7540.0 7578.6 6796.3 6845.3 6852.0 7388.4 7403.0 4144.7 4220.7 4441.9 4509.5 4532.7 1811.1 1859.7 1871.3 1883.6 1885.0 748.6 788.7 835.4 991.4 1022.3 16359.3 17100.8 17994.8 18004.3 18272.5 819.3 877.7 900.9 916.6 934.2 9216.6 9454.2 9488.2 9585.9 9664.0 540836.0 542257.0 549001.0 557566.0 557991.0 82463.6 83062.6 83065.6 83532.0 83830.6 1097.6 1146.8 1155.5 1157.1 1163.0 15884.0 15979.3 16038.3 16120.2 16195.0 34750.1 34773.7 35556.5 35974.0 36085.8 47649.5 48110.0 48347.8 50573.2 52106.0 9612.5 10114.9 10115.9 10128.6 10129.5 17511.0 17555.0 17828.6 18012.6 18209.5 14326.6 14388.8 14868.1 15109.2 15225.0 14296.0 14364.5 14428.0 14553.1 15164.0 15058.5 15155.2 15176.6 15267.5 15389.5 8351.4 8375.8 9143.7 9267.3 9734.3 13790.9 13823.8 14070.0 14201.4 14313.1 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | [#3] mootools.html Cycles:180 Average:5190.14 Median:6495.20 stddev:2675.94 (41.2%) stddev-sans-first:2667.37 16:04:04 INFO - PROCESS | 18539 | Values: 1287.2 1345.0 1381.4 1506.8 1753.4 6712.8 7246.8 7347.3 7350.5 7366.7 6887.2 7065.3 7065.6 7067.0 7074.4 1889.7 1916.8 2115.4 2165.1 2218.1 2151.0 2155.8 2161.7 2164.1 2166.2 2063.0 2133.9 2142.5 2146.6 2149.9 2119.8 2130.7 2155.8 2163.2 2164.2 2157.0 2165.0 2190.6 2191.9 2193.8 7353.4 7456.0 7459.4 7461.5 7471.8 4526.6 4576.8 4602.1 4607.4 4610.0 2968.9 3073.4 3076.7 3098.9 3106.6 970.4 974.5 1022.7 1030.3 1033.0 9758.3 9831.9 9852.1 9858.1 9873.0 3935.8 3975.7 4062.8 4095.2 4098.8 8200.8 8404.7 8408.6 8409.2 8415.6 4561.1 4563.5 4579.8 4595.4 4603.2 4167.6 4179.1 4222.2 4247.9 4250.7 3184.1 3227.2 3287.3 3451.9 3489.8 1062.4 1077.3 1079.1 1084.4 1085.3 1025.4 1084.4 1231.9 1283.2 1304.8 6882.7 7022.8 7023.2 7044.1 7057.9 593.8 605.9 623.1 624.8 757.9 5475.5 5558.3 5641.6 5651.9 5668.5 8703.6 8978.0 9072.2 9095.2 9097.4 8317.6 8925.6 8957.6 8958.5 8967.1 7055.8 7137.0 7137.4 7208.0 7209.6 6908.9 6999.9 7001.0 7040.0 7041.5 7769.9 7774.4 7922.9 7966.6 7969.4 7833.5 7982.5 8147.2 8154.3 8169.1 6588.3 6671.1 6671.5 6674.2 6676.0 6549.2 6675.0 6680.5 6839.6 6840.7 6697.5 6727.6 6817.7 6931.2 6985.0 6668.4 6732.2 6775.2 6833.3 6848.9 6833.7 6875.4 6876.7 6884.6 6884.8 6236.7 6264.1 6297.5 6308.0 6316.6 6447.2 6484.7 6489.4 6492.1 6498.3 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | [#4] prototype.html Cycles:180 Average:5257.51 Median:5953.14 stddev:1575.53 (26.5%) stddev-sans-first:1535.96 16:04:04 INFO - PROCESS | 18539 | Values: 331.9 339.9 340.6 341.8 351.4 5784.6 5879.2 5897.6 5906.5 6004.4 5719.3 5845.1 5873.1 5879.4 5881.3 4615.1 4615.4 4617.5 4619.1 4621.5 4420.8 4479.4 4500.8 4584.4 4605.2 4514.9 4517.2 4528.0 4541.7 4542.8 4501.9 4529.9 4532.2 4540.9 4542.6 4031.5 4042.9 4043.3 4046.8 4047.1 5527.4 5637.1 5638.0 5707.9 5712.5 5277.9 5282.1 5282.6 5283.6 5284.5 5981.4 6307.0 6307.7 6309.1 6310.7 4213.7 4283.4 4341.6 4371.0 4376.7 6440.2 6538.6 6543.3 6556.5 6558.9 4477.7 4480.8 4481.7 4483.8 4484.1 4457.9 4542.1 4542.5 4549.2 4569.1 5243.3 5254.0 5254.8 5258.2 5259.6 6299.1 6315.6 6321.2 6322.9 6325.7 1583.5 1584.1 1584.2 1584.2 1585.2 1046.8 1048.1 1049.6 1055.4 1086.5 5946.6 5968.4 5968.4 5971.0 5979.2 6477.6 6480.7 6486.2 6489.8 6492.8 5931.4 5959.7 5962.0 5963.8 5968.4 3439.5 3492.6 3522.8 3542.0 3545.3 6621.8 6626.2 6637.2 6640.0 6654.8 6726.8 6740.9 6742.3 6745.9 6754.1 6432.5 6590.1 6599.3 6599.4 6614.6 6274.0 6346.6 6548.5 6548.6 6551.7 6336.5 6422.2 6463.5 6466.3 6515.6 6604.0 6605.7 6613.2 6613.7 6618.3 4377.2 4492.1 4497.5 4522.2 4528.2 6485.0 6507.2 6509.3 6515.9 6516.8 6331.3 6332.5 6339.9 6344.8 6347.9 6210.7 6303.1 6324.1 6325.6 6335.4 6183.1 6208.8 6217.5 6217.6 6218.3 6341.3 6348.4 6349.2 6356.5 6366.3 6016.2 6189.4 6190.5 6194.5 6202.3 16:04:04 INFO - PROCESS | 18539 | 16:04:04 INFO - PROCESS | 18539 | [#5] yui.html Cycles:180 Average:13830.55 Median:48772.63 stddev:16077.10 (33.0%) stddev-sans-first:16092.20 16:04:04 INFO - PROCESS | 18539 | Values: 752.3 821.1 830.9 848.5 869.7 12932.7 13179.8 13199.5 13199.9 13212.3 12402.0 12439.7 12470.4 12478.4 12481.8 667.5 673.6 809.4 825.6 829.9 822.1 831.4 832.0 832.3 832.4 703.0 857.3 864.5 865.6 865.8 706.2 844.3 856.5 858.8 864.3 629.2 633.2 633.8 634.9 635.6 12906.7 12990.9 12998.8 13014.0 13021.5 11692.8 11801.7 12168.8 12404.1 12492.8 9862.7 10135.6 10359.2 10442.3 10604.7 3557.4 3562.0 3563.7 3615.0 3637.1 48415.5 48680.3 48865.0 49281.0 49460.8 9171.4 9195.4 9942.3 9947.4 10082.9 17864.8 17867.4 17912.6 17942.2 17961.6 7253.1 7345.9 7380.1 7424.2 7490.8 4144.7 4145.9 4285.3 4373.8 4390.3 2925.4 2958.4 2958.6 2959.7 2961.7 558.9 561.2 570.1 572.7 575.6 649.7 667.7 677.2 680.9 702.1 8170.1 8503.6 8792.3 8803.4 9327.2 651.9 652.1 671.3 676.0 676.7 3773.7 3989.4 4048.7 4123.8 4284.9 47715.0 47978.5 49053.5 59319.0 59943.0 51569.0 53199.2 54279.7 54871.7 55269.4 48987.8 49303.8 49871.8 50141.7 50873.2 8073.3 8439.2 8607.5 8613.4 8905.2 33317.0 33689.3 33719.5 35141.8 36035.1 42017.8 45317.8 45921.3 46075.8 46697.3 10543.0 10863.5 11348.4 11445.4 11541.8 12504.7 12644.7 12806.0 13084.9 13190.4 10810.6 11281.2 11312.3 11380.3 11564.7 11617.0 11931.3 11958.8 12362.4 12373.1 11097.9 11445.9 11476.5 11496.8 11711.7 9541.5 9739.8 9759.0 9921.8 10545.7 9234.4 9320.9 9492.8 9885.8 10006.4 16:04:04 INFO - PROCESS | 18539 | -------- Summary: end -------- 16:04:04 INFO - PROCESS | 18539 | 16:04:05 INFO - TEST-INFO | 18539: exit 0 16:04:05 INFO - TEST-OK | dromaeo_css | took 1113513ms 16:04:05 INFO - TEST-START | kraken 16:04:05 INFO - operating with platform_type : linux_ 16:04:05 INFO - Initialising browser for kraken test... 16:04:05 INFO - TEST-INFO | started process 18726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQH4NHt/profile http://localhost:34327/getInfo.html) 16:04:09 INFO - PROCESS | 18726 | __metrics Screen width/height:1600/1200 16:04:09 INFO - PROCESS | 18726 | colorDepth:24 16:04:09 INFO - PROCESS | 18726 | Browser inner width/height: 1024/697 16:04:09 INFO - PROCESS | 18726 | __metrics 16:04:09 INFO - PROCESS | 18726 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:04:09 INFO - PROCESS | 18726 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:10 INFO - TEST-INFO | 18726: exit 0 16:04:10 INFO - Browser initialized. 16:04:10 INFO - Running cycle 1/1 for kraken test... 16:04:10 INFO - TEST-INFO | started process 18810 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQH4NHt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:22 INFO - PROCESS | 18810 | RSS: Main: 151875584 16:04:22 INFO - PROCESS | 18810 | 16:04:24 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:25 INFO - PROCESS | 18810 | RSS: Main: 186990592 16:04:25 INFO - PROCESS | 18810 | 16:04:28 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-dft) 16:04:28 INFO - PROCESS | 18810 | RSS: Main: 176594944 16:04:28 INFO - PROCESS | 18810 | 16:04:31 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-fft) 16:04:32 INFO - PROCESS | 18810 | RSS: Main: 159100928 16:04:32 INFO - PROCESS | 18810 | 16:04:33 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-oscillator) 16:04:34 INFO - PROCESS | 18810 | RSS: Main: 161837056 16:04:34 INFO - PROCESS | 18810 | 16:04:36 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:37 INFO - PROCESS | 18810 | RSS: Main: 164708352 16:04:37 INFO - PROCESS | 18810 | 16:04:40 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34327/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:40 INFO - PROCESS | 18810 | RSS: Main: 164257792 16:04:40 INFO - PROCESS | 18810 | 16:04:44 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34327/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:44 INFO - PROCESS | 18810 | RSS: Main: 166522880 16:04:44 INFO - PROCESS | 18810 | 16:04:47 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34327/tests/kraken/driver.html?testName=json-parse-financial) 16:04:48 INFO - PROCESS | 18810 | RSS: Main: 167333888 16:04:48 INFO - PROCESS | 18810 | 16:04:49 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:04:50 INFO - PROCESS | 18810 | RSS: Main: 181559296 16:04:50 INFO - PROCESS | 18810 | 16:04:52 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:04:52 INFO - PROCESS | 18810 | RSS: Main: 173842432 16:04:52 INFO - PROCESS | 18810 | 16:04:54 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:04:55 INFO - PROCESS | 18810 | RSS: Main: 181026816 16:04:55 INFO - PROCESS | 18810 | 16:04:57 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:58 INFO - PROCESS | 18810 | RSS: Main: 189919232 16:04:58 INFO - PROCESS | 18810 | 16:05:00 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:01 INFO - PROCESS | 18810 | RSS: Main: 188690432 16:05:01 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34327/tests/kraken/driver.html?testName=ai-astar) 16:05:03 INFO - PROCESS | 18810 | RSS: Main: 247681024 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | __start_tp_report 16:05:03 INFO - PROCESS | 18810 | _x_x_mozilla_page_load 16:05:03 INFO - PROCESS | 18810 | _x_x_mozilla_page_load_details 16:05:03 INFO - PROCESS | 18810 | |i|pagename|runs| 16:05:03 INFO - PROCESS | 18810 | |0;ai-astar;111;110;108;111;111;110;99;112;110;101 16:05:03 INFO - PROCESS | 18810 | |1;audio-beat-detection;145;125;151;177;125;152;161;123;160;122 16:05:03 INFO - PROCESS | 18810 | |2;audio-dft;161;160;161;161;163;164;162;161;162;162 16:05:03 INFO - PROCESS | 18810 | |3;audio-fft;71;71;84;103;72;73;71;99;91;71 16:05:03 INFO - PROCESS | 18810 | |4;audio-oscillator;95;97;144;96;96;96;153;96;96;142 16:05:03 INFO - PROCESS | 18810 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;108;109;108 16:05:03 INFO - PROCESS | 18810 | |6;imaging-darkroom;147;146;147;146;146;146;147;145;146;146 16:05:03 INFO - PROCESS | 18810 | |7;imaging-desaturate;95;96;95;96;96;95;95;95;96;96 16:05:03 INFO - PROCESS | 18810 | |8;json-parse-financial;64;62;60;61;61;60;63;63;62;61 16:05:03 INFO - PROCESS | 18810 | |9;json-stringify-tinderbox;68;68;69;69;69;68;70;69;68;68 16:05:03 INFO - PROCESS | 18810 | |10;stanford-crypto-aes;85;86;85;85;86;84;92;87;87;88 16:05:03 INFO - PROCESS | 18810 | |11;stanford-crypto-ccm;121;116;121;116;125;118;119;120;117;123 16:05:03 INFO - PROCESS | 18810 | |12;stanford-crypto-pbkdf2;143;152;151;150;154;140;152;157;151;140 16:05:03 INFO - PROCESS | 18810 | |13;stanford-crypto-sha256-iterative;69;67;68;66;68;67;67;66;69;67 16:05:03 INFO - PROCESS | 18810 | __end_tp_report 16:05:03 INFO - PROCESS | 18810 | __start_cc_report 16:05:03 INFO - PROCESS | 18810 | _x_x_mozilla_cycle_collect,953 16:05:03 INFO - PROCESS | 18810 | __end_cc_report 16:05:03 INFO - PROCESS | 18810 | __startTimestamp1451001903479__endTimestamp 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | ------- Summary: start ------- 16:05:03 INFO - PROCESS | 18810 | Number of tests: 14 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#0] ai-astar Cycles:10 Average:108.30 Median:111.00 stddev:4.52 (4.1%) stddev-sans-first:4.69 16:05:03 INFO - PROCESS | 18810 | Values: 111.0 110.0 108.0 111.0 111.0 110.0 99.0 112.0 110.0 101.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:151.50 stddev:19.42 (12.8%) stddev-sans-first:20.60 16:05:03 INFO - PROCESS | 18810 | Values: 145.0 125.0 151.0 177.0 125.0 152.0 161.0 123.0 160.0 122.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 16:05:03 INFO - PROCESS | 18810 | Values: 161.0 160.0 161.0 161.0 163.0 164.0 162.0 161.0 162.0 162.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:12.74 (17.6%) stddev-sans-first:13.03 16:05:03 INFO - PROCESS | 18810 | Values: 71.0 71.0 84.0 103.0 72.0 73.0 71.0 99.0 91.0 71.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:96.00 stddev:24.47 (25.5%) stddev-sans-first:25.26 16:05:03 INFO - PROCESS | 18810 | Values: 95.0 97.0 144.0 96.0 96.0 96.0 153.0 96.0 96.0 142.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:05:03 INFO - PROCESS | 18810 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 109.0 108.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:05:03 INFO - PROCESS | 18810 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:05:03 INFO - PROCESS | 18810 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.13 16:05:03 INFO - PROCESS | 18810 | Values: 64.0 62.0 60.0 61.0 61.0 60.0 63.0 63.0 62.0 61.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 16:05:03 INFO - PROCESS | 18810 | Values: 68.0 68.0 69.0 69.0 69.0 68.0 70.0 69.0 68.0 68.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:2.27 (2.6%) stddev-sans-first:2.35 16:05:03 INFO - PROCESS | 18810 | Values: 85.0 86.0 85.0 85.0 86.0 84.0 92.0 87.0 87.0 88.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:120.50 stddev:2.99 (2.5%) stddev-sans-first:3.13 16:05:03 INFO - PROCESS | 18810 | Values: 121.0 116.0 121.0 116.0 125.0 118.0 119.0 120.0 117.0 123.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:151.50 stddev:5.91 (3.9%) stddev-sans-first:5.85 16:05:03 INFO - PROCESS | 18810 | Values: 143.0 152.0 151.0 150.0 154.0 140.0 152.0 157.0 151.0 140.0 16:05:03 INFO - PROCESS | 18810 | 16:05:03 INFO - PROCESS | 18810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:0.97 16:05:03 INFO - PROCESS | 18810 | Values: 69.0 67.0 68.0 66.0 68.0 67.0 67.0 66.0 69.0 67.0 16:05:03 INFO - PROCESS | 18810 | -------- Summary: end -------- 16:05:03 INFO - PROCESS | 18810 | 16:05:04 INFO - TEST-INFO | 18810: exit 0 16:05:04 INFO - TEST-OK | kraken | took 59206ms 16:05:04 INFO - TEST-START | v8_7 16:05:04 INFO - operating with platform_type : linux_ 16:05:04 INFO - Initialising browser for v8_7 test... 16:05:04 INFO - TEST-INFO | started process 19063 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVZfrZW/profile http://localhost:34327/getInfo.html) 16:05:08 INFO - PROCESS | 19063 | __metrics Screen width/height:1600/1200 16:05:08 INFO - PROCESS | 19063 | colorDepth:24 16:05:08 INFO - PROCESS | 19063 | Browser inner width/height: 1024/697 16:05:08 INFO - PROCESS | 19063 | __metrics 16:05:08 INFO - PROCESS | 19063 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:05:08 INFO - PROCESS | 19063 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:05:08 ERROR - PROCESS | 19063 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 16:05:09 INFO - TEST-INFO | 19063: exit 0 16:05:09 INFO - Browser initialized. 16:05:09 INFO - Running cycle 1/1 for v8_7 test... 16:05:09 INFO - TEST-INFO | started process 19144 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVZfrZW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:21 INFO - PROCESS | 19144 | RSS: Main: 151556096 16:05:21 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | Cycle 1(1): loaded http://localhost:34327/tests/v8_7/run.html (next: http://localhost:34327/tests/v8_7/run.html) 16:05:43 INFO - PROCESS | 19144 | RSS: Main: 596221952 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | __start_tp_report 16:05:43 INFO - PROCESS | 19144 | _x_x_mozilla_page_load 16:05:43 INFO - PROCESS | 19144 | _x_x_mozilla_page_load_details 16:05:43 INFO - PROCESS | 19144 | |i|pagename|runs| 16:05:43 INFO - PROCESS | 19144 | |0;Richards;167.42005692281936 16:05:43 INFO - PROCESS | 19144 | |1;DeltaBlue;191.0219675262655 16:05:43 INFO - PROCESS | 19144 | |2;Encrypt;282.4858757062147 16:05:43 INFO - PROCESS | 19144 | |3;Decrypt;5223.958333333333 16:05:43 INFO - PROCESS | 19144 | |4;RayTrace;2066.115702479339 16:05:43 INFO - PROCESS | 19144 | |5;Earley;797.4481658692185 16:05:43 INFO - PROCESS | 19144 | |6;Boyer;12419.753086419752 16:05:43 INFO - PROCESS | 19144 | |7;RegExp;25600 16:05:43 INFO - PROCESS | 19144 | |8;Splay;648.9292667099286 16:05:43 INFO - PROCESS | 19144 | |9;NavierStokes;4830.917874396136 16:05:43 INFO - PROCESS | 19144 | __end_tp_report 16:05:43 INFO - PROCESS | 19144 | __startTimestamp1451001943358__endTimestamp 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | ------- Summary: start ------- 16:05:43 INFO - PROCESS | 19144 | Number of tests: 10 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 167.4 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#1] DeltaBlue Cycles:1 Average:191.02 Median:191.02 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 191.0 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#2] Encrypt Cycles:1 Average:282.49 Median:282.49 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 282.5 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 5224.0 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#4] RayTrace Cycles:1 Average:2066.12 Median:2066.12 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 2066.1 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 797.4 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 12419.8 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#7] RegExp Cycles:1 Average:25600.00 Median:25600.00 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 25600.0 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#8] Splay Cycles:1 Average:648.93 Median:648.93 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 648.9 16:05:43 INFO - PROCESS | 19144 | 16:05:43 INFO - PROCESS | 19144 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:05:43 INFO - PROCESS | 19144 | Values: 4830.9 16:05:43 INFO - PROCESS | 19144 | -------- Summary: end -------- 16:05:43 INFO - PROCESS | 19144 | 16:05:44 INFO - TEST-INFO | 19144: exit 0 16:05:44 INFO - TEST-OK | v8_7 | took 39675ms 16:05:44 INFO - SUITE-END | took 1212s 16:05:44 INFO - Completed test suite (00:20:12) 16:05:44 INFO - Working with test: dromaeo_css 16:05:44 INFO - Generating results file: dromaeo_css 16:05:44 INFO - Working with test: kraken 16:05:44 INFO - Generating results file: kraken 16:05:44 INFO - javascript benchmark 16:05:44 INFO - Working with test: v8_7 16:05:44 INFO - Generating results file: v8_7 16:05:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 16:05:44 INFO - process_Request line: dromaeo_css 6859.96 graph.html#tests=[[72,63,35]] 16:05:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:44 INFO - process_Request line: kraken 1509.10 graph.html#tests=[[232,63,35]] 16:05:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:44 INFO - process_Request line: v8_7 19519.28 graph.html#tests=[[230,63,35]] 16:05:44 INFO - RETURN: dromaeo_css: 6859.96 16:05:44 INFO - RETURN: kraken: 1509.10 16:05:44 INFO - RETURN: v8_7: 19519.28 16:05:44 INFO - javascript benchmark 16:05:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3033.0900729781065, 3091.350816328571, 3134.655187929329, 3142.324400253945, 3172.9365412691745, 4945.035718034985, 5046.0, 5053.797848086077, 5061.569766569842, 5121.0, 4989.376327959005, 5052.418971818242, 5068.163752980754, 5082.84751457456, 5093.006863661588, 4609.492955774862, 4618.49196588375, 4622.745748983804, 4626.606738427237, 4710.90578188436, 4694.694844835092, 4734.408198975111, 4740.6918550294295, 4749.097671442415, 4781.139394908915, 4561.954380456186, 4594.977025114853, 4666.136764698542, 4671.369365135714, 4715.976420117895, 4606.723596584182, 4635.559621835921, 4636.049609829976, 4641.791119399635, 4673.182193116225, 4604.861854144381, 4611.792469338888, 4621.953780462186, 4634.443866736014, 4645.9303110453375, 4849.781759820817, 4879.902401951941, 4884.047610715912, 4930.112579735646, 4952.356193694833, 5437.211604317391, 5442.482964118402, 5449.373322067973, 5483.287172667568, 5489.670619762827, 5474.698891560963, 5486.177073438977, 5488.17677348397, 5491.176323551459, 5497.532709719679, 5004.724740139291, 5092.847214583531, 5096.745162741848, 5098.056859481007, 5137.588992880561, 5486.835394938158, 5510.586705997066, 5575.776968921197, 5592.161175823659, 5601.047821870292, 5330.413654498002, 5336.653117547347, 5349.4650534946195, 5353.491418315254, 5360.70516121617, 5356.035913535523, 5389.649672771257, 5497.340319161726, 5517.4482551745305, 5520.861978450491, 5307.6284660073425, 5338.839834804962, 5345.38528069277, 5348.91976620351, 5390.54180394663, 5365.651232669864, 5396.757145928443, 5400.270963419966, 5402.8919421611345, 5443.074677304868, 4148.979255103705, 4214.241436541452, 4220.85227017053, 4228.344606585984, 4245.12974840157, 3811.5235595550557, 3820.67524260441, 3824.043989002749, 3852.3836186210074, 3859.459675645412, 5038.84883453497, 5082.313887625197, 5083.38999320084, 5088.491150884956, 5114.769835357418, 5302.2311764793885, 5340.706261155596, 5386.757595908193, 5399.028174928472, 5425.348958125051, 5044.445111037783, 5057.317262169634, 5058.696478211319, 5067.721275329818, 5090.134677104827, 4736.052789442126, 4736.360591320127, 4739.3601863748645, 4743.620510359163, 4769.0, 5359.3032905722, 5464.207689884945, 5465.398806131322, 5467.535259502987, 5523.613347065747, 5467.0, 5468.207109968953, 5472.343318801769, 5473.233747275305, 5487.478689524489, 5470.53500452466, 5495.807646732345, 5498.422665620213, 5504.614676972734, 5507.228987941611, 5295.814646487354, 5344.438833922382, 5386.434424385383, 5414.783408663767, 5444.128939369682, 5455.7817687293655, 5461.344638643388, 5462.8361149165585, 5463.180522921593, 5468.91796623059, 5314.5216930476445, 5315.867103322448, 5316.229146773773, 5322.787088516416, 5339.25250464943, 5164.612654050886, 5225.294585230945, 5245.659032162897, 5247.291615631993, 5247.868803279948, 5201.0, 5226.555742761908, 5253.23828044939, 5256.264123022704, 5259.368875734936, 5292.232626269247, 5302.867428314323, 5330.333708286465, 5335.866603334947, 5351.224072509386, 5116.951025039783, 5157.922631160461, 5186.766595503136, 5226.398964119175, 5227.111391063452], "unit": "score", "name": "dojo.html", "value": 5010.3652845410115}, {"lowerIsBetter": false, "replicates": [540.4414701887785, 575.6172145523225, 582.6300299309938, 590.3977942498651, 594.5897330841722, 27842.164735057955, 35830.0, 36490.0, 36505.45241821368, 36549.26901461973, 39414.21171576574, 39769.80115099427, 39813.402798958035, 39830.20339593206, 39850.20299594006, 7146.106736657918, 8495.447795893278, 8658.913410865905, 8662.30701543875, 8664.263537599312, 7483.550986940773, 10126.29115961883, 10278.7430314242, 10318.0, 10327.896721032806, 10078.748031299203, 10166.13587845034, 10213.948930255376, 10236.283460157792, 10243.84634230487, 7530.246975302426, 7723.459357844897, 9820.214382849355, 9896.455694936813, 9900.603975840957, 7414.406847452191, 10004.59981600735, 10241.231907606885, 10251.79496410075, 10269.589216431334, 35710.46434303487, 36326.27347453036, 36461.81769091164, 36462.27075458476, 36522.269554609025, 3048.588440560518, 3068.5704001439817, 3093.551435041929, 3100.0, 3139.089663997461, 27412.0, 27681.0, 28312.716872831214, 28475.57286640702, 28698.569521457193, 3681.482957943015, 3697.718016678543, 3858.054776579756, 3874.2638898609175, 3893.377059670439, 257129.0, 257223.0, 258610.0, 259199.70400148068, 259612.0, 53459.732701336245, 54276.0, 58573.70713146492, 59106.40893591009, 59188.704056479444, 69811.0, 70006.0, 70707.2929270711, 70779.0, 70836.97885679672, 14967.775483367759, 15020.624484387978, 15069.698606027818, 15151.924240378728, 15164.545063648107, 10981.505832237568, 11010.614628488125, 11014.50434730439, 11020.338779673086, 11039.951204635547, 19566.608667826564, 19574.0, 19615.509612259808, 19759.802401975798, 19781.703274450894, 7630.580318082448, 7815.843683126419, 7853.057633084067, 7930.5638189898955, 7941.880871786928, 956.8421210500189, 976.6728146071003, 981.0532835813474, 1024.5594394410325, 1069.4706120470262, 28351.71648283532, 28691.28271793222, 30475.542866857017, 31076.533851992237, 31467.84266078655, 1060.9204309676804, 1089.4879406679006, 1090.7037565382918, 1099.356876227416, 1114.4761961877905, 14862.777058344134, 14971.326290316962, 14979.40082396692, 14985.775213371808, 15130.167840768863, 373862.0, 381203.0, 381506.0, 382071.0, 382269.0, 51445.48554514407, 51968.22047669288, 51970.0, 51997.48002520002, 52093.47906520962, 1323.0540163782941, 1326.197650421481, 1331.391927875449, 1338.692100816798, 1343.4290426568668, 27036.594451082856, 28259.174847189424, 28280.85859570689, 28535.145215560922, 28677.28306792347, 44606.0, 45072.0, 45152.0, 45237.77381113073, 45254.32118518159, 288588.0, 288976.0, 289870.0, 290470.0, 291614.0, 28661.42677146487, 30908.536371954888, 31307.217319567193, 31662.841685791424, 31765.0, 36128.0, 37090.62909370872, 37397.43903841499, 37825.0, 37839.24321513609, 38331.66932907326, 38390.808045959595, 39670.404943925285, 40671.0, 42827.828952295116, 32946.50580241346, 35585.46621800727, 37967.43048854324, 39624.60375396209, 39652.40521392239, 32620.510692339158, 33018.367979522714, 33283.66716332806, 33403.1649208762, 33412.0, 28293.0, 28684.713152868204, 31288.374232515678, 32326.854029961618, 32429.18927026843, 25041.87479062593, 25053.0, 25084.62373064369, 25195.32024588524, 25436.872815636543], "unit": "score", "name": "ext.html", "value": 18445.808597894684}, {"lowerIsBetter": false, "replicates": [356.4653020469294, 358.99282014359704, 359.62778524227423, 361.65100677845874, 364.42420974859726, 16388.18059097045, 17269.568260793487, 18158.18288177032, 18323.08384580769, 18352.265909363625, 14778.261086945664, 14930.328135233913, 16736.16319184042, 17591.912040439813, 17640.647187056253, 5085.898282034357, 5287.788488460466, 5426.430224826396, 5430.782768689248, 5431.701256430894, 5181.378234611851, 5190.844274671747, 5194.818181363653, 5197.766100525486, 5199.818006369759, 3736.6637002669754, 3836.1176929306275, 5237.8428647140645, 5359.0, 5411.621186516945, 5367.35591728995, 5369.033573956686, 5369.114096174107, 5379.462053794628, 5396.541293990015, 5247.47525247476, 5380.192971054334, 5401.216823560561, 5401.216823560601, 5403.891922161574, 12235.388230588524, 12478.251304921734, 16105.516834494983, 19966.0, 19968.101435435296, 2111.187192930717, 2164.231697747293, 2168.6313326734494, 2189.7810218978134, 2219.966700499494, 10632.681019569425, 13145.73708525824, 13254.072214944958, 13606.523771668044, 13693.109947853358, 1843.2626949220285, 1876.8029356917464, 1887.7451544041517, 1894.7063205203215, 1902.5243689077731, 55995.0, 57022.42977570213, 58927.116093258206, 59007.70496147535, 62402.37597624057, 9914.652987145415, 10138.847917281246, 10245.59017639301, 10264.384136951658, 10287.485625718833, 13307.0, 13330.666733331744, 13348.332583370793, 13356.065075444625, 13360.131591446525, 7140.214576396592, 7436.070491188601, 7536.924630753732, 7540.019797426409, 7578.621068946531, 6796.286389929085, 6845.281245469154, 6852.0, 7388.37198838094, 7403.0, 4144.70987030905, 4220.746755194698, 4441.9117316257725, 4509.481409637868, 4532.70537415067, 1811.1035037656445, 1859.7210418437342, 1871.2702046201991, 1883.604443066944, 1885.0, 748.569572495817, 788.692409960116, 835.415209353455, 991.3556188477547, 1022.2537547590152, 16359.34562617482, 17100.828991709925, 17994.820051799576, 18004.279828806702, 18272.543186420447, 819.2790344496924, 877.7454538183982, 900.8738776571286, 916.5554705967601, 934.2152591822901, 9216.631334746535, 9454.243660507143, 9488.193503552275, 9585.9041409585, 9663.951680241555, 540836.0, 542257.0, 549001.0, 557566.0, 557991.0, 82463.58768206241, 83062.58468707738, 83065.58467207746, 83532.0, 83830.58084709538, 1097.6048622495896, 1146.7706458708292, 1155.4915837031679, 1157.056998546182, 1162.959296424621, 15884.0, 15979.280932358304, 16038.278277477308, 16120.193990300673, 16195.0, 34750.13124671904, 34773.652263477044, 35556.466653000745, 35974.0, 36085.819570903026, 47649.52350476451, 48110.0, 48347.758261208466, 50573.241401378276, 52106.0, 9612.471314077793, 10114.949425252827, 10115.898841011496, 10128.645497407555, 10129.544170512198, 17511.0, 17555.0, 17828.554286142433, 18012.63974720472, 18209.45371638853, 14326.641833954234, 14388.784168237695, 14868.107913525224, 15109.168995705342, 15225.0, 14296.0, 14364.497242596459, 14428.0, 14553.12681239129, 15164.014339067926, 15058.472953446577, 15155.242237888282, 15176.620584485476, 15267.541973740805, 15389.538313850602, 8351.41540092212, 8375.832483350177, 9143.725688229099, 9267.258619310303, 9734.269929755155, 13790.862091378958, 13823.79264311016, 14070.0, 14201.431942722176, 14313.141211527342], "unit": "score", "name": "jquery.html", "value": 8914.987546827831}, {"lowerIsBetter": false, "replicates": [1287.246960528091, 1344.9932750336247, 1381.3645722967435, 1506.8041154649893, 1753.438899552143, 6712.765053223138, 7246.782596522106, 7347.338739513442, 7350.522216055952, 7366.668499917503, 6887.207971083314, 7065.328793764585, 7065.6113913734725, 7066.96466517668, 7074.363307302342, 1889.7165425186263, 1916.8370688491495, 2115.428834214761, 2165.101482884601, 2218.1460137846966, 2151.0427859602405, 2155.795199456057, 2161.6649419339947, 2164.0586344939925, 2166.2309879992613, 2063.040686080972, 2133.925312614059, 2142.4965133193687, 2146.61360955028, 2149.9032543535577, 2119.756228033773, 2130.7336582927132, 2155.795199456049, 2163.1996161420375, 2164.2425151197112, 2156.9892150539304, 2164.978350216509, 2190.6494960806194, 2191.9452013699624, 2193.7696541863193, 7353.411727061823, 7456.0, 7459.403247740168, 7461.477696561243, 7471.813204669927, 4526.615237704799, 4576.839810606612, 4602.05657840142, 4607.424071991001, 4610.031893302411, 2968.85155742212, 3073.3699591583895, 3076.6923307669053, 3098.922526936822, 3106.6427360853563, 970.3983530211243, 974.5468357213858, 1022.6880801355584, 1030.3354336452946, 1032.958681652733, 9758.316917815755, 9831.90168098317, 9852.064053914866, 9858.112769850675, 9872.950635246849, 3935.822887970048, 3975.741576797499, 4062.8374865005067, 4095.201435720006, 4098.754074755524, 8200.794980125425, 8404.747857564284, 8408.621612027473, 8409.159084091665, 8415.579221039046, 4561.110583436264, 4563.498015218323, 4579.763463864738, 4595.448546174481, 4603.217453032992, 4167.562405947332, 4179.101493178981, 4222.155568886235, 4247.915041699149, 4250.659947204216, 3184.1084496341064, 3227.2415982244156, 3287.2603664175367, 3451.8964431067106, 3489.7906125632035, 1062.4050531702117, 1077.28898926708, 1079.071998081649, 1084.35480888871, 1085.2837127495973, 1025.3642741500169, 1084.4306738962107, 1231.9137660363688, 1283.2044132637825, 1304.7586196553477, 6882.724691012303, 7022.824429389306, 7023.157221133497, 7044.119485064367, 7057.89413158803, 593.7506247376112, 605.9303180134253, 623.0996210475819, 624.753222477119, 757.8560073586001, 5475.5072043516275, 5558.305211848519, 5641.605087643908, 5651.943480565142, 5668.489835914787, 8703.564821759013, 8977.955110224408, 9072.183503484586, 9095.226905713089, 9097.363184577016, 8317.584120793936, 8925.553722313858, 8957.596908139149, 8958.507282099547, 8967.10328967098, 7055.823604409931, 7136.964315178391, 7137.393321567621, 7208.0, 7209.6034718091005, 6908.930910690829, 6999.860002799814, 7000.964995174992, 7040.049593304839, 7041.5422997505, 7769.92230077692, 7774.416918731004, 7922.881156782538, 7966.601669916597, 7969.402294827795, 7833.49082309648, 7982.481138725964, 8147.185281471805, 8154.306883914934, 8169.101398846004, 6588.341165883565, 6671.099401580725, 6671.532992690465, 6674.232463266787, 6676.031975363448, 6549.214094308713, 6675.0, 6680.498962577729, 6839.589624622538, 6840.692168852314, 6697.464202863856, 6727.562708423937, 6817.727290908507, 6931.237563868071, 6985.0220969065385, 6668.366505182, 6732.192136943598, 6775.186977562724, 6833.282505337067, 6848.863022739617, 6833.658317084027, 6875.381215690411, 6876.724931002904, 6884.586924784529, 6884.759033433806, 6236.688165591793, 6264.060390941395, 6297.496200304056, 6307.96846015767, 6316.557840951089, 6447.194100737408, 6484.70818813164, 6489.383508566679, 6492.091107244895, 6498.317676644074], "unit": "score", "name": "mootools.html", "value": 4227.049179124519}, {"lowerIsBetter": false, "replicates": [331.8937939859245, 339.94390925497294, 340.62531215662773, 341.8222524287372, 351.446471806904, 5784.595078344507, 5879.176915231871, 5897.616654917433, 5906.527477801782, 6004.399560044004, 5719.313682358113, 5845.123231515275, 5873.089671100986, 5879.441453061963, 5881.264841894763, 4615.14619795339, 4615.353850460938, 4617.515160908107, 4619.076184763044, 4621.537846215385, 4420.756858372804, 4479.350494178342, 4500.752458614775, 4584.358189853423, 4605.194091034073, 4514.932276015862, 4517.209488339544, 4527.958569529011, 4541.65937554683, 4542.795574199169, 4501.932471012905, 4529.909401811962, 4532.184206842767, 4540.8864778380475, 4542.6138778203895, 4031.496062992126, 4042.939355909664, 4043.2722110020186, 4046.7774272415004, 4047.057412442015, 5527.39198688144, 5637.069883469223, 5638.0, 5707.942920570783, 5712.457316554921, 5277.86805329866, 5282.128448805943, 5282.577393808486, 5283.603729720248, 5284.524392804666, 5981.401859814027, 6306.9684651576445, 6307.684615769193, 6309.08518264849, 6310.684465776692, 4213.747175169499, 4283.357496375537, 4341.565843415665, 4370.978145109254, 4376.6936314458, 6440.227172739301, 6538.607683539003, 6543.345665433466, 6556.475481961479, 6558.93441065588, 4477.686561940633, 4480.820767169342, 4481.700306911024, 4483.820647174077, 4484.1255955088445, 4457.863244872537, 4542.11428771393, 4542.500324964251, 4549.158405694957, 4569.086182763461, 5243.2659427680155, 5254.0, 5254.842354729364, 5258.158694608845, 5259.605529585297, 6299.0866324382705, 6315.621062736251, 6321.1782468278825, 6322.9051564226575, 6325.715342809584, 1583.52494251724, 1584.1049806859319, 1584.1683116364002, 1584.1762283612456, 1585.2390852390918, 1046.8482070099792, 1048.0515133803767, 1049.5801679328329, 1055.37205362809, 1086.4947799273375, 5946.554008449383, 5968.37332080134, 5968.403159683997, 5970.9701451492465, 5979.1629171915965, 6477.6437295948235, 6480.675966201671, 6486.2216534016225, 6489.805305840832, 6492.805215843532, 5931.377205393458, 5959.731812068468, 5961.970190149108, 5963.761449542057, 5968.37332080134, 3439.518467414514, 3492.633273506296, 3522.8238588070494, 3541.9822900885847, 3545.2554963457446, 6621.834454138685, 6626.204855417381, 6637.1703537057865, 6639.966800165968, 6654.800355989328, 6726.764563240263, 6740.865182696319, 6742.258351581322, 6745.8650826983185, 6754.0881980931945, 6432.485401167895, 6590.143281373391, 6599.340065993459, 6599.439047680905, 6614.603123812491, 6274.0, 6346.619202847844, 6548.47612191014, 6548.607083575001, 6551.705173267119, 6336.524760642878, 6422.197225346832, 6463.450606698295, 6466.32103629131, 6515.609063456208, 6603.966980165068, 6605.669716514251, 6613.239477459962, 6613.735450581923, 6618.305077966937, 4377.233984052715, 4492.101579684011, 4497.460304763449, 4522.186006518858, 4528.230200865795, 6485.0, 6507.219133703986, 6509.283978762427, 6515.902261466176, 6516.804495865132, 6331.335209803088, 6332.461740752087, 6339.936600633934, 6344.841378965562, 6347.904781428375, 6210.658413787104, 6303.1175635412, 6324.146240257506, 6325.557210995186, 6335.366463353628, 6183.103449999635, 6208.81373558794, 6217.533684973555, 6217.626942383471, 6218.347073557211, 6341.302456729848, 6348.396902294275, 6349.238091429058, 6356.491480681442, 6366.344750364846, 6016.217891674054, 6189.381061893955, 6190.50475961931, 6194.473469755121, 6202.255729312511], "unit": "score", "name": "prototype.html", "value": 4746.1706081988605}, {"lowerIsBetter": false, "replicates": [752.2966026764975, 821.1255013410718, 830.9376796740243, 848.4909054567256, 869.6695255802794, 12932.741345173103, 13179.80230296544, 13199.472021119143, 13199.868001319985, 13212.339383030858, 12402.0, 12439.68900777481, 12470.376481175928, 12478.37608119595, 12481.750364992695, 667.5427332277393, 673.5722816011843, 809.360605121953, 825.6449726617552, 829.8630725930215, 822.0751654388813, 831.3930830493744, 832.014063334947, 832.317499650287, 832.367400775412, 702.9683664235096, 857.2798848966867, 864.5072308783996, 865.6018231613465, 865.8398196333667, 706.2125729811249, 844.2654890245495, 856.5117882806771, 858.8153546987428, 864.2696921101659, 629.2134831460675, 633.1990032608753, 633.7845132654919, 634.8952422850224, 635.6091004032533, 12906.677333066655, 12990.87009129906, 12998.805017924738, 13014.0, 13021.544245951347, 11692.824607630891, 11801.704957376049, 12168.756624867454, 12404.13171078025, 12492.81260781089, 9862.704118876445, 10135.594576216943, 10359.171266298677, 10442.321249118782, 10604.681859544226, 3557.4308110702423, 3562.0, 3563.732720045981, 3614.981925090358, 3637.1452708613456, 48415.51584484181, 48680.26979595309, 48865.0, 49281.0, 49460.75269623665, 9171.40385874916, 9195.448273103635, 9942.30403871722, 9947.353422027545, 10082.949585252027, 17864.821351786315, 17867.37464188773, 17912.641747164984, 17942.19260133271, 17961.640767184585, 7253.093363329584, 7345.8898116527225, 7380.114386273682, 7424.183339832614, 7490.775276741707, 4144.668426525871, 4145.91708165835, 4285.292926667065, 4373.781310934504, 4390.297552391666, 2925.3710452252867, 2958.4083183363414, 2958.5710072039433, 2959.7040295970232, 2961.7334439900515, 558.9357223919301, 561.2423228641302, 570.1191658887029, 572.7451284178501, 575.6315957787019, 649.7336092202174, 667.7128834601072, 677.1975209376905, 680.9489288303298, 702.1048163591462, 8170.142135075732, 8503.61733721984, 8792.34057445694, 8803.42777719459, 9327.207187389013, 651.9152510173647, 652.1294072413381, 671.3487916720773, 675.9594424334556, 676.6684324680871, 3773.660370566662, 3989.3816458448987, 4048.67610591152, 4123.793810309473, 4284.914301713949, 47715.0, 47978.5202147981, 49053.50946490489, 59319.0, 59943.0, 51569.0, 53199.20201196985, 54279.72860135674, 54871.72564137234, 55269.44730552643, 48987.75506122447, 49303.753481232365, 49871.75064124656, 50141.74929125404, 50873.23690144651, 8073.313768329758, 8439.2267948691, 8607.526586037828, 8613.440126391764, 8905.243054340453, 33317.0, 33689.326213475106, 33719.49420758642, 35141.82429087838, 36035.099122522144, 42017.78991105025, 45317.77341113273, 45921.31118033299, 46075.76962115168, 46697.2995405076, 10543.027313620025, 10863.511141998788, 11348.375839328586, 11445.370504622326, 11541.769164616828, 12504.749905001667, 12644.683882903, 12806.039547033823, 13084.869151308365, 13190.406431710788, 10810.56757729682, 11281.21031527818, 11312.26470279462, 11380.260283081574, 11564.653060408202, 11617.0, 11931.284122952651, 11958.820617690915, 12362.44369003415, 12373.13388062827, 11097.889021109686, 11445.885541144482, 11476.483558239732, 11496.827547586625, 11711.707207319545, 9541.521631029338, 9739.756506087404, 9758.951205243928, 9921.751956201153, 10545.683629491128, 9234.399764015317, 9320.860187097063, 9492.762680933032, 9885.752856178653, 10006.44964526958], "unit": "score", "name": "yui.html", "value": 6304.0125945629425}], "name": "dromaeo_css", "value": 6859.955417390332}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 108.0, 111.0, 111.0, 110.0, 99.0, 112.0, 110.0, 101.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [145.0, 125.0, 151.0, 177.0, 125.0, 152.0, 161.0, 123.0, 160.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 164.0, 162.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 84.0, 103.0, 72.0, 73.0, 71.0, 99.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 144.0, 96.0, 96.0, 96.0, 153.0, 96.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 60.0, 61.0, 61.0, 60.0, 63.0, 63.0, 62.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 61.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 85.0, 86.0, 84.0, 92.0, 87.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 121.0, 116.0, 125.0, 118.0, 119.0, 120.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [143.0, 152.0, 151.0, 150.0, 154.0, 140.0, 152.0, 157.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 66.0, 68.0, 67.0, 67.0, 66.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1509.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [191.0219675262655], "unit": "score", "name": "DeltaBlue", "value": 346.12773000000004}, {"lowerIsBetter": false, "replicates": [282.4858757062147], "unit": "score", "name": "Encrypt", "value": 942.2807399999999}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [2066.115702479339], "unit": "score", "name": "RayTrace", "value": 358.1546759999999}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25600.0], "unit": "score", "name": "RegExp", "value": 35.58535156250002}, {"lowerIsBetter": false, "replicates": [648.9292667099286], "unit": "score", "name": "Splay", "value": 125.57763100000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19519.282151129406}]} 16:05:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19519.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1509.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6859.96"}}} 16:05:44 INFO - Return code: 0 16:05:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:05:44 ERROR - # TBPL SUCCESS # 16:05:44 INFO - Running post-action listener: _resource_record_post_action 16:05:44 INFO - Running post-run listener: _resource_record_post_run 16:05:45 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559329280; Read time: 4; Write time: 779892 16:05:45 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 235241472; Read time: 0; Write time: 525264 16:05:45 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324087808; Read time: 4; Write time: 254628 16:05:45 INFO - Running post-run listener: _upload_blobber_files 16:05:45 INFO - Blob upload gear active. 16:05:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:05:45 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:05:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:05:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:05:46 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:05:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:47 INFO - (blobuploader) - INFO - Done attempting. 16:05:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:05:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:05:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:47 INFO - (blobuploader) - INFO - Done attempting. 16:05:47 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:47 INFO - Return code: 0 16:05:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:05:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f22fd468e679bce354b01a6819ed36426763c81b14acbe594cb5e8f58d768dd1b6bd60f6107a0ae997b7c50b9ea08a32665e26aa44436e5cf86fca07d9ad9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a41f25e5efc3f3fd978cbb35c9821926a82437c75799e70f41074ed8cbb7988d44c1782cee2e6369bd0bdad1111a0fa9af198dc7d9fbf72f786eb0d5926d69"} 16:05:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:05:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:05:47 INFO - Contents: 16:05:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f22fd468e679bce354b01a6819ed36426763c81b14acbe594cb5e8f58d768dd1b6bd60f6107a0ae997b7c50b9ea08a32665e26aa44436e5cf86fca07d9ad9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a41f25e5efc3f3fd978cbb35c9821926a82437c75799e70f41074ed8cbb7988d44c1782cee2e6369bd0bdad1111a0fa9af198dc7d9fbf72f786eb0d5926d69"} 16:05:47 INFO - Copying logs to upload dir... 16:05:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.711004 ========= master_lag: 34.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-12-24 16:06:19.764485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 16:06:19.768475) ========= 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=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f22fd468e679bce354b01a6819ed36426763c81b14acbe594cb5e8f58d768dd1b6bd60f6107a0ae997b7c50b9ea08a32665e26aa44436e5cf86fca07d9ad9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a41f25e5efc3f3fd978cbb35c9821926a82437c75799e70f41074ed8cbb7988d44c1782cee2e6369bd0bdad1111a0fa9af198dc7d9fbf72f786eb0d5926d69"} build_url:https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f22fd468e679bce354b01a6819ed36426763c81b14acbe594cb5e8f58d768dd1b6bd60f6107a0ae997b7c50b9ea08a32665e26aa44436e5cf86fca07d9ad9747", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8a41f25e5efc3f3fd978cbb35c9821926a82437c75799e70f41074ed8cbb7988d44c1782cee2e6369bd0bdad1111a0fa9af198dc7d9fbf72f786eb0d5926d69"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 16:06:19.965849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 16:06:19.966219) ========= 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=004b26eee9c3b360c8654f40000001e1-1450996158.623467-56965941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 16:06:20.248923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 16:06:20.252315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 16:06:20.253565) ========= ========= Total master_lag: 35.05 =========