builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1450450178.15 results: success (0) buildid: 20151218043022 builduid: 974d3b68cbaf44fb9592f0e1a21a16ba revision: 22bb9e57553b227f3d55a1f71010b8ab1e7c2ffa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.146932) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.147537) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.147904) ========= 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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006327 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.171538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.171885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.185515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.185944) ========= 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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.236901) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.237437) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.238090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.238526) ========= 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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 06:49:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-18 06:49:39 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.368317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.368683) ========= 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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021541 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.418635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.419047) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 22bb9e57553b227f3d55a1f71010b8ab1e7c2ffa --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 22bb9e57553b227f3d55a1f71010b8ab1e7c2ffa --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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 06:49:39,519 truncating revision to first 12 chars 2015-12-18 06:49:39,519 Setting DEBUG logging. 2015-12-18 06:49:39,519 attempt 1/10 2015-12-18 06:49:39,519 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/22bb9e57553b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 06:49:39,771 unpacking tar archive at: mozilla-inbound-22bb9e57553b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527671 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.960749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.961120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.969824) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.970126) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:38.970578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-18 06:49:38.970941) ========= /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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:40 INFO - MultiFileLogger online at 20151218 06:49:40 in /builds/slave/test-pgo 06:49:40 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 06:49:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:49:40 INFO - {'append_to_log': False, 06:49:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:49:40 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:49:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:49:40 INFO - 'branch': 'Mozilla-Inbound', 06:49:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:40 INFO - 'config_files': ('talos/linux_config.py',), 06:49:40 INFO - 'default_actions': ('clobber', 06:49:40 INFO - 'read-buildbot-config', 06:49:40 INFO - 'download-and-extract', 06:49:40 INFO - 'populate-webroot', 06:49:40 INFO - 'create-virtualenv', 06:49:40 INFO - 'install', 06:49:40 INFO - 'run-tests'), 06:49:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:40 INFO - 'download_minidump_stackwalk': True, 06:49:40 INFO - 'download_symbols': 'ondemand', 06:49:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:40 INFO - 'installer_path': 'installer.exe', 06:49:40 INFO - 'log_level': 'info', 06:49:40 INFO - 'log_name': 'talos', 06:49:40 INFO - 'log_to_console': True, 06:49:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:40 INFO - 'opt_config_files': (), 06:49:40 INFO - 'pip_index': False, 06:49:40 INFO - 'sps_profile': False, 06:49:40 INFO - 'sps_profile_interval': 0, 06:49:40 INFO - 'suite': 'dromaeojs', 06:49:40 INFO - 'system_bits': '64', 06:49:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:40 INFO - 'title': 'talos-linux64-ix-067', 06:49:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:40 INFO - 'use_talos_json': True, 06:49:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:49:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:40 INFO - 'work_dir': 'build'} 06:49:40 INFO - ##### 06:49:40 INFO - ##### Running clobber step. 06:49:40 INFO - ##### 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: clobber 06:49:40 INFO - rmtree: /builds/slave/test-pgo/build 06:49:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - ##### 06:49:40 INFO - ##### Running read-buildbot-config step. 06:49:40 INFO - ##### 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: read_buildbot_config 06:49:40 INFO - Using buildbot properties: 06:49:40 INFO - { 06:49:40 INFO - "project": "", 06:49:40 INFO - "product": "firefox", 06:49:40 INFO - "script_repo_revision": "production", 06:49:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:49:40 INFO - "repository": "", 06:49:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:49:40 INFO - "buildid": "20151218043022", 06:49:40 INFO - "pgo_build": "True", 06:49:40 INFO - "basedir": "/builds/slave/test-pgo", 06:49:40 INFO - "buildnumber": 1361, 06:49:40 INFO - "slavename": "talos-linux64-ix-067", 06:49:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:49:40 INFO - "platform": "ubuntu64_hw", 06:49:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:49:40 INFO - "branch": "mozilla-inbound", 06:49:40 INFO - "repo_path": "integration/mozilla-inbound", 06:49:40 INFO - "revision": "22bb9e57553b227f3d55a1f71010b8ab1e7c2ffa", 06:49:40 INFO - "stage_platform": "linux64-pgo", 06:49:40 INFO - "builduid": "974d3b68cbaf44fb9592f0e1a21a16ba", 06:49:40 INFO - "slavebuilddir": "test" 06:49:40 INFO - } 06:49:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - ##### 06:49:40 INFO - ##### Running download-and-extract step. 06:49:40 INFO - ##### 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: download_and_extract 06:49:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:49:40 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')]} 06:49:40 INFO - https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/test_packages.json 06:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/test_packages.json 06:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:49:41 INFO - Downloaded 1302 bytes. 06:49:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:49:41 INFO - Using the following test package requirements: 06:49:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:41 INFO - u'jsshell-linux-x86_64.zip'], 06:49:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:49:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:49:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:41 INFO - https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:45 INFO - Downloaded 23120825 bytes. 06:49:45 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 06:49:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:45 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 06:49:46 INFO - Return code: 0 06:49:46 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 06:49:46 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')]} 06:49:46 INFO - https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:51 INFO - Downloaded 23120825 bytes. 06:49:51 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 06:49:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:51 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 06:49:52 INFO - Return code: 0 06:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:52 INFO - https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:53 INFO - Downloaded 11132039 bytes. 06:49:53 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 06:49:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:53 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 06:49:53 INFO - Return code: 0 06:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:53 INFO - https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:49:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/31dStQReQqqHyEY42aioMw/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 06:49:54 INFO - Downloaded 54645047 bytes. 06:49:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:54 INFO - mkdir: /builds/slave/test-pgo/properties 06:49:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:49:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:49:54 INFO - Contents: 06:49:54 INFO - build_url:https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:54 INFO - Running post-action listener: _resource_record_post_action 06:49:54 INFO - Running post-action listener: set_extra_try_arguments 06:49:54 INFO - ##### 06:49:54 INFO - ##### Running populate-webroot step. 06:49:54 INFO - ##### 06:49:54 INFO - Running pre-action listener: _resource_record_pre_action 06:49:54 INFO - Running main action method: populate_webroot 06:49:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:54 INFO - '--tppagecycles', 06:49:54 INFO - '7'], 06:49:54 INFO - 'tests': ['tsvgm']}}, 06:49:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:49:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'tests': ['damp', 'tps']}, 06:49:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['damp', 'tps']}, 06:49:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:49:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:54 INFO - 'other': {'tests': ['a11yr', 06:49:54 INFO - 'ts_paint', 06:49:54 INFO - 'tpaint', 06:49:54 INFO - 'sessionrestore', 06:49:54 INFO - 'sessionrestore_no_auto_restore']}, 06:49:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['a11yr', 06:49:54 INFO - 'ts_paint', 06:49:54 INFO - 'tpaint', 06:49:54 INFO - 'sessionrestore', 06:49:54 INFO - 'sessionrestore_no_auto_restore']}, 06:49:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['a11yr', 06:49:54 INFO - 'ts_paint', 06:49:54 INFO - 'tpaint', 06:49:54 INFO - 'sessionrestore', 06:49:54 INFO - 'sessionrestore_no_auto_restore']}, 06:49:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['a11yr', 06:49:54 INFO - 'ts_paint', 06:49:54 INFO - 'tpaint', 06:49:54 INFO - 'sessionrestore', 06:49:54 INFO - 'sessionrestore_no_auto_restore']}, 06:49:54 INFO - 'other_l64': {'tests': ['a11yr', 06:49:54 INFO - 'ts_paint', 06:49:54 INFO - 'tpaint', 06:49:54 INFO - 'sessionrestore', 06:49:54 INFO - 'sessionrestore_no_auto_restore']}, 06:49:54 INFO - 'other_nol64': {'tests': ['a11yr', 06:49:54 INFO - 'ts_paint', 06:49:54 INFO - 'tpaint', 06:49:54 INFO - 'sessionrestore', 06:49:54 INFO - 'sessionrestore_no_auto_restore']}, 06:49:54 INFO - 'svgr': {'tests': ['tsvgx', 06:49:54 INFO - 'tsvgr_opacity', 06:49:54 INFO - 'tart', 06:49:54 INFO - 'tscrollx', 06:49:54 INFO - 'cart']}, 06:49:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['tsvgx', 06:49:54 INFO - 'tsvgr_opacity', 06:49:54 INFO - 'tart', 06:49:54 INFO - 'tscrollx', 06:49:54 INFO - 'cart']}, 06:49:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'tests': ['tp5o']}, 06:49:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'talos_options': ['--e10s'], 06:49:54 INFO - 'tests': ['tp5o']}, 06:49:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'talos_options': ['--xperf_path', 06:49:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:54 INFO - 'tests': ['tp5n']}, 06:49:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:54 INFO - 'talos_options': ['--e10s', 06:49:54 INFO - '--xperf_path', 06:49:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:54 INFO - 'tests': ['tp5n']}}, 06:49:54 INFO - 'talos.zip': {'path': '', 06:49:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:54 INFO - Running post-action listener: _resource_record_post_action 06:49:54 INFO - ##### 06:49:54 INFO - ##### Running create-virtualenv step. 06:49:54 INFO - ##### 06:49:54 INFO - Running pre-action listener: _resource_record_pre_action 06:49:54 INFO - Running main action method: create_virtualenv 06:49:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:49:54 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 06:49:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:49:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:55 INFO - Using real prefix '/usr' 06:49:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:49:55 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:57 INFO - Installing pip.................done. 06:49:57 INFO - Return code: 0 06:49:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:49:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:49:57 INFO - Using env: {'DISPLAY': ':0', 06:49:57 INFO - 'HOME': '/home/cltbld', 06:49:57 INFO - 'LANG': 'en_US.UTF-8', 06:49:57 INFO - 'LANGUAGE': 'en_US:en', 06:49:57 INFO - 'LOGNAME': 'cltbld', 06:49:57 INFO - 'MAIL': '/var/mail/cltbld', 06:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:57 INFO - 'MOZ_NO_REMOTE': '1', 06:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:57 INFO - 'NO_EM_RESTART': '1', 06:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:57 INFO - 'SHELL': '/bin/bash', 06:49:57 INFO - 'SHLVL': '1', 06:49:57 INFO - 'TERM': 'linux', 06:49:57 INFO - 'TMOUT': '86400', 06:49:57 INFO - 'USER': 'cltbld', 06:49:57 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:57 INFO - '_': '/tools/buildbot/bin/python'} 06:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:57 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 06:49:57 INFO - Cleaning up... 06:49:57 INFO - Return code: 0 06:49:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:49:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:49:57 INFO - Using env: {'DISPLAY': ':0', 06:49:57 INFO - 'HOME': '/home/cltbld', 06:49:57 INFO - 'LANG': 'en_US.UTF-8', 06:49:57 INFO - 'LANGUAGE': 'en_US:en', 06:49:57 INFO - 'LOGNAME': 'cltbld', 06:49:57 INFO - 'MAIL': '/var/mail/cltbld', 06:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:57 INFO - 'MOZ_NO_REMOTE': '1', 06:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:57 INFO - 'NO_EM_RESTART': '1', 06:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:57 INFO - 'SHELL': '/bin/bash', 06:49:57 INFO - 'SHLVL': '1', 06:49:57 INFO - 'TERM': 'linux', 06:49:57 INFO - 'TMOUT': '86400', 06:49:57 INFO - 'USER': 'cltbld', 06:49:57 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:57 INFO - '_': '/tools/buildbot/bin/python'} 06:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:57 INFO - Downloading/unpacking psutil>=0.7.1 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:59 INFO - Installing collected packages: psutil 06:49:59 INFO - Running setup.py install for psutil 06:49:59 INFO - building 'psutil._psutil_linux' extension 06:49:59 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 06:49:59 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 06:50:00 INFO - building 'psutil._psutil_posix' extension 06:50:00 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 06:50:00 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 06:50:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:00 INFO - Successfully installed psutil 06:50:00 INFO - Cleaning up... 06:50:00 INFO - Return code: 0 06:50:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:50:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:50:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:50:00 INFO - Using env: {'DISPLAY': ':0', 06:50:00 INFO - 'HOME': '/home/cltbld', 06:50:00 INFO - 'LANG': 'en_US.UTF-8', 06:50:00 INFO - 'LANGUAGE': 'en_US:en', 06:50:00 INFO - 'LOGNAME': 'cltbld', 06:50:00 INFO - 'MAIL': '/var/mail/cltbld', 06:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:00 INFO - 'MOZ_NO_REMOTE': '1', 06:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:00 INFO - 'NO_EM_RESTART': '1', 06:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:00 INFO - 'SHELL': '/bin/bash', 06:50:00 INFO - 'SHLVL': '1', 06:50:00 INFO - 'TERM': 'linux', 06:50:00 INFO - 'TMOUT': '86400', 06:50:00 INFO - 'USER': 'cltbld', 06:50:00 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:00 INFO - '_': '/tools/buildbot/bin/python'} 06:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:02 INFO - Installing collected packages: mozsystemmonitor 06:50:02 INFO - Running setup.py install for mozsystemmonitor 06:50:02 INFO - Successfully installed mozsystemmonitor 06:50:02 INFO - Cleaning up... 06:50:02 INFO - Return code: 0 06:50:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:50:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:50:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:50:02 INFO - Using env: {'DISPLAY': ':0', 06:50:02 INFO - 'HOME': '/home/cltbld', 06:50:02 INFO - 'LANG': 'en_US.UTF-8', 06:50:02 INFO - 'LANGUAGE': 'en_US:en', 06:50:02 INFO - 'LOGNAME': 'cltbld', 06:50:02 INFO - 'MAIL': '/var/mail/cltbld', 06:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:02 INFO - 'MOZ_NO_REMOTE': '1', 06:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:02 INFO - 'NO_EM_RESTART': '1', 06:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:02 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:02 INFO - 'SHELL': '/bin/bash', 06:50:02 INFO - 'SHLVL': '1', 06:50:02 INFO - 'TERM': 'linux', 06:50:02 INFO - 'TMOUT': '86400', 06:50:02 INFO - 'USER': 'cltbld', 06:50:02 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:02 INFO - '_': '/tools/buildbot/bin/python'} 06:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:02 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:50:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:50:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:50:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:04 INFO - Downloading docopt-0.6.1.tar.gz 06:50:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:04 INFO - Running setup.py install for blobuploader 06:50:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:50:05 INFO - Running setup.py install for requests 06:50:05 INFO - Running setup.py install for docopt 06:50:05 INFO - Successfully installed blobuploader requests docopt 06:50:05 INFO - Cleaning up... 06:50:05 INFO - Return code: 0 06:50:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:50:05 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 06:50:05 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 06:50:05 INFO - Using env: {'DISPLAY': ':0', 06:50:05 INFO - 'HOME': '/home/cltbld', 06:50:05 INFO - 'LANG': 'en_US.UTF-8', 06:50:05 INFO - 'LANGUAGE': 'en_US:en', 06:50:05 INFO - 'LOGNAME': 'cltbld', 06:50:05 INFO - 'MAIL': '/var/mail/cltbld', 06:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:05 INFO - 'MOZ_NO_REMOTE': '1', 06:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:05 INFO - 'NO_EM_RESTART': '1', 06:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:05 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:05 INFO - 'SHELL': '/bin/bash', 06:50:05 INFO - 'SHLVL': '1', 06:50:05 INFO - 'TERM': 'linux', 06:50:05 INFO - 'TMOUT': '86400', 06:50:05 INFO - 'USER': 'cltbld', 06:50:05 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:05 INFO - '_': '/tools/buildbot/bin/python'} 06:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:05 INFO - Running setup.py (path:/tmp/pip-tXqrMR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:05 INFO - Running setup.py (path:/tmp/pip-hZ78mE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:05 INFO - Running setup.py (path:/tmp/pip-iDW6lK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:05 INFO - Running setup.py (path:/tmp/pip-kJr2za-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:06 INFO - Running setup.py (path:/tmp/pip-6kEwYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:06 INFO - Running setup.py (path:/tmp/pip-VsJRSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:06 INFO - Running setup.py (path:/tmp/pip-JpGFdv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:06 INFO - Running setup.py (path:/tmp/pip-CZoBfP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:06 INFO - Running setup.py (path:/tmp/pip-zDweF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:06 INFO - Running setup.py (path:/tmp/pip-D8rben-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:06 INFO - Running setup.py (path:/tmp/pip-112Ip0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:06 INFO - Running setup.py (path:/tmp/pip-GyUiTg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:06 INFO - Running setup.py (path:/tmp/pip-4P1s0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:06 INFO - Running setup.py (path:/tmp/pip-QDx_lf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:06 INFO - Running setup.py (path:/tmp/pip-EsO3gU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:06 INFO - Running setup.py (path:/tmp/pip-WSKjig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:06 INFO - Running setup.py (path:/tmp/pip-FGEvLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:06 INFO - Running setup.py install for manifestparser 06:50:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Running setup.py install for mozcrash 06:50:07 INFO - Running setup.py install for mozdebug 06:50:07 INFO - Running setup.py install for mozdevice 06:50:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Running setup.py install for mozfile 06:50:07 INFO - Running setup.py install for mozhttpd 06:50:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Running setup.py install for mozinfo 06:50:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Running setup.py install for mozInstall 06:50:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:50:07 INFO - Running setup.py install for mozleak 06:50:07 INFO - Running setup.py install for mozlog 06:50:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:50:08 INFO - Running setup.py install for moznetwork 06:50:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:50:08 INFO - Running setup.py install for mozprocess 06:50:08 INFO - Running setup.py install for mozprofile 06:50:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:50:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:50:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:50:08 INFO - Running setup.py install for mozrunner 06:50:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:50:08 INFO - Running setup.py install for mozscreenshot 06:50:08 INFO - Running setup.py install for moztest 06:50:08 INFO - Running setup.py install for mozversion 06:50:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:50:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:08 INFO - Cleaning up... 06:50:08 INFO - Return code: 0 06:50:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:50:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 06:50:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 06:50:08 INFO - Using env: {'DISPLAY': ':0', 06:50:08 INFO - 'HOME': '/home/cltbld', 06:50:08 INFO - 'LANG': 'en_US.UTF-8', 06:50:08 INFO - 'LANGUAGE': 'en_US:en', 06:50:08 INFO - 'LOGNAME': 'cltbld', 06:50:08 INFO - 'MAIL': '/var/mail/cltbld', 06:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:08 INFO - 'MOZ_NO_REMOTE': '1', 06:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:08 INFO - 'NO_EM_RESTART': '1', 06:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:08 INFO - 'SHELL': '/bin/bash', 06:50:08 INFO - 'SHLVL': '1', 06:50:08 INFO - 'TERM': 'linux', 06:50:08 INFO - 'TMOUT': '86400', 06:50:08 INFO - 'USER': 'cltbld', 06:50:08 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:08 INFO - '_': '/tools/buildbot/bin/python'} 06:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:08 INFO - Running setup.py (path:/tmp/pip-qb2hr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:09 INFO - Running setup.py (path:/tmp/pip-ePw1I6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:09 INFO - Running setup.py (path:/tmp/pip-vZdzsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:09 INFO - Running setup.py (path:/tmp/pip-ilN81X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:09 INFO - Running setup.py (path:/tmp/pip-Mm_IXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:09 INFO - Running setup.py (path:/tmp/pip-RzSzLn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:09 INFO - Running setup.py (path:/tmp/pip-pOBBX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:09 INFO - Running setup.py (path:/tmp/pip-0g5VQi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:09 INFO - Running setup.py (path:/tmp/pip-0LF5Qg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:09 INFO - Running setup.py (path:/tmp/pip-OXsBXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:09 INFO - Running setup.py (path:/tmp/pip-wObPL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:09 INFO - Running setup.py (path:/tmp/pip-p0y2Hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:09 INFO - Running setup.py (path:/tmp/pip-8HwRTj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:09 INFO - Running setup.py (path:/tmp/pip-Ti07Pf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:10 INFO - Running setup.py (path:/tmp/pip-0K4301-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:10 INFO - Running setup.py (path:/tmp/pip-AUil5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:10 INFO - Running setup.py (path:/tmp/pip-k4Vsje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:10 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)) 06:50:10 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)) 06:50:10 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)) 06:50:10 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)) 06:50:10 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)) 06:50:10 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)) 06:50:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:11 INFO - Downloading blessings-1.5.1.tar.gz 06:50:11 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 06:50:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:11 INFO - Installing collected packages: blessings 06:50:11 INFO - Running setup.py install for blessings 06:50:12 INFO - Successfully installed blessings 06:50:12 INFO - Cleaning up... 06:50:12 INFO - Return code: 0 06:50:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:50:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:12 INFO - Reading from file tmpfile_stdout 06:50:12 INFO - Current package versions: 06:50:12 INFO - argparse == 1.2.1 06:50:12 INFO - blessings == 1.5.1 06:50:12 INFO - blobuploader == 1.2.4 06:50:12 INFO - docopt == 0.6.1 06:50:12 INFO - manifestparser == 1.1 06:50:12 INFO - mozInstall == 1.12 06:50:12 INFO - mozcrash == 0.16 06:50:12 INFO - mozdebug == 0.1 06:50:12 INFO - mozdevice == 0.47 06:50:12 INFO - mozfile == 1.2 06:50:12 INFO - mozhttpd == 0.7 06:50:12 INFO - mozinfo == 0.9 06:50:12 INFO - mozleak == 0.1 06:50:12 INFO - mozlog == 3.1 06:50:12 INFO - moznetwork == 0.27 06:50:12 INFO - mozprocess == 0.22 06:50:12 INFO - mozprofile == 0.27 06:50:12 INFO - mozrunner == 6.11 06:50:12 INFO - mozscreenshot == 0.1 06:50:12 INFO - mozsystemmonitor == 0.0 06:50:12 INFO - moztest == 0.7 06:50:12 INFO - mozversion == 1.4 06:50:12 INFO - psutil == 3.1.1 06:50:12 INFO - requests == 1.2.3 06:50:12 INFO - wsgiref == 0.1.2 06:50:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:12 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')]} 06:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:12 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')]} 06:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:12 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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:50:12 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 06:50:12 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 06:50:12 INFO - Using env: {'DISPLAY': ':0', 06:50:12 INFO - 'HOME': '/home/cltbld', 06:50:12 INFO - 'LANG': 'en_US.UTF-8', 06:50:12 INFO - 'LANGUAGE': 'en_US:en', 06:50:12 INFO - 'LOGNAME': 'cltbld', 06:50:12 INFO - 'MAIL': '/var/mail/cltbld', 06:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:12 INFO - 'MOZ_NO_REMOTE': '1', 06:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:12 INFO - 'NO_EM_RESTART': '1', 06:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:12 INFO - 'SHELL': '/bin/bash', 06:50:12 INFO - 'SHLVL': '1', 06:50:12 INFO - 'TERM': 'linux', 06:50:12 INFO - 'TMOUT': '86400', 06:50:12 INFO - 'USER': 'cltbld', 06:50:12 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:12 INFO - '_': '/tools/buildbot/bin/python'} 06:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:12 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 1)) 06:50:12 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 2)) 06:50:12 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 3)) 06:50:12 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 4)) 06:50:12 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 5)) 06:50:12 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 6)) 06:50:12 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 7)) 06:50:12 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 8)) 06:50:12 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:50:12 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 3)) 06:50:12 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:50:12 INFO - Cleaning up... 06:50:12 INFO - Return code: 0 06:50:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:50:12 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')]} 06:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:12 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')]} 06:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:12 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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:50:12 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 06:50:12 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 06:50:12 INFO - Using env: {'DISPLAY': ':0', 06:50:12 INFO - 'HOME': '/home/cltbld', 06:50:12 INFO - 'LANG': 'en_US.UTF-8', 06:50:12 INFO - 'LANGUAGE': 'en_US:en', 06:50:12 INFO - 'LOGNAME': 'cltbld', 06:50:12 INFO - 'MAIL': '/var/mail/cltbld', 06:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:12 INFO - 'MOZ_NO_REMOTE': '1', 06:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:12 INFO - 'NO_EM_RESTART': '1', 06:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:12 INFO - 'SHELL': '/bin/bash', 06:50:12 INFO - 'SHLVL': '1', 06:50:12 INFO - 'TERM': 'linux', 06:50:12 INFO - 'TMOUT': '86400', 06:50:12 INFO - 'USER': 'cltbld', 06:50:12 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:12 INFO - '_': '/tools/buildbot/bin/python'} 06:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:12 INFO - Downloading/unpacking jsonschema 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:14 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 06:50:14 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50:14 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 06:50:14 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 06:50:14 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 06:50:14 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 06:50:14 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 06:50:14 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 06:50:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:50:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:14 INFO - warning: no files found matching '*.txt' 06:50:14 INFO - no previously-included directories found matching 'build' 06:50:14 INFO - no previously-included directories found matching 'dist' 06:50:14 INFO - no previously-included directories found matching '.git*' 06:50:14 INFO - Installing collected packages: jsonschema, functools32 06:50:14 INFO - Running setup.py install for functools32 06:50:14 INFO - warning: no files found matching '*.txt' 06:50:14 INFO - no previously-included directories found matching 'build' 06:50:14 INFO - no previously-included directories found matching 'dist' 06:50:14 INFO - no previously-included directories found matching '.git*' 06:50:14 INFO - Successfully installed jsonschema functools32 06:50:14 INFO - Cleaning up... 06:50:14 INFO - Return code: 0 06:50:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:50:14 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')]} 06:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:14 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')]} 06:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:14 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 0x7f863f0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, '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': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', '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 06:50:14 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 06:50:14 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 06:50:14 INFO - Using env: {'DISPLAY': ':0', 06:50:14 INFO - 'HOME': '/home/cltbld', 06:50:14 INFO - 'LANG': 'en_US.UTF-8', 06:50:14 INFO - 'LANGUAGE': 'en_US:en', 06:50:14 INFO - 'LOGNAME': 'cltbld', 06:50:14 INFO - 'MAIL': '/var/mail/cltbld', 06:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:14 INFO - 'MOZ_NO_REMOTE': '1', 06:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:14 INFO - 'NO_EM_RESTART': '1', 06:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:14 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:14 INFO - 'SHELL': '/bin/bash', 06:50:14 INFO - 'SHLVL': '1', 06:50:14 INFO - 'TERM': 'linux', 06:50:14 INFO - 'TMOUT': '86400', 06:50:14 INFO - 'USER': 'cltbld', 06:50:14 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:14 INFO - '_': '/tools/buildbot/bin/python'} 06:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:15 INFO - Downloading/unpacking flake8 06:50:15 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 06:50:15 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 06:50:15 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 06:50:15 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 06:50:15 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 06:50:15 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 06:50:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:16 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 06:50:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:16 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 06:50:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:17 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 06:50:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:50:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:17 INFO - no previously-included directories found matching 'docs/_build' 06:50:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:17 INFO - Running setup.py install for pep8 06:50:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:17 INFO - no previously-included directories found matching 'docs/_build' 06:50:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:50:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:17 INFO - Cleaning up... 06:50:17 INFO - Return code: 0 06:50:17 INFO - Running post-action listener: _resource_record_post_action 06:50:17 INFO - Running post-action listener: _start_resource_monitoring 06:50:17 INFO - Starting resource monitoring. 06:50:17 INFO - ##### 06:50:17 INFO - ##### Running install step. 06:50:17 INFO - ##### 06:50:17 INFO - Running pre-action listener: _resource_record_pre_action 06:50:17 INFO - Running main action method: install 06:50:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:17 INFO - Reading from file tmpfile_stdout 06:50:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:50:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:50:17 INFO - Reading from file tmpfile_stdout 06:50:17 INFO - Output received: 06:50:17 INFO - Usage: mozinstall [options] installer 06:50:17 INFO - Options: 06:50:17 INFO - -h, --help show this help message and exit 06:50:17 INFO - -d DEST, --destination=DEST 06:50:17 INFO - Directory to install application into. [default: 06:50:17 INFO - "/builds/slave/test-pgo"] 06:50:17 INFO - --app=APP Application being installed. [default: firefox] 06:50:17 INFO - mkdir: /builds/slave/test-pgo/build/application 06:50:17 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'] 06:50:17 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 06:50:33 INFO - Reading from file tmpfile_stdout 06:50:33 INFO - Output received: 06:50:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:50:33 INFO - Running post-action listener: _resource_record_post_action 06:50:33 INFO - ##### 06:50:33 INFO - ##### Running run-tests step. 06:50:33 INFO - ##### 06:50:33 INFO - Running pre-action listener: _resource_record_pre_action 06:50:33 INFO - Running main action method: run_tests 06:50:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:50:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:50:33 INFO - Python 2.7.3 06:50:33 INFO - Return code: 0 06:50:33 INFO - grabbing minidump binary from tooltool 06:50: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')]} 06:50:33 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 0x222d350>, '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 0x222e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222e6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:50:33 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 06:50:33 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 06:50:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:33 INFO - Return code: 0 06:50:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:50:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:50:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:50:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:50:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:50:34 INFO - Return code: 0 06:50:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:50:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 06:50:34 INFO - Using env: {'DISPLAY': ':0', 06:50:34 INFO - 'HOME': '/home/cltbld', 06:50:34 INFO - 'LANG': 'en_US.UTF-8', 06:50:34 INFO - 'LANGUAGE': 'en_US:en', 06:50:34 INFO - 'LOGNAME': 'cltbld', 06:50:34 INFO - 'MAIL': '/var/mail/cltbld', 06:50:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:34 INFO - 'MOZ_NO_REMOTE': '1', 06:50:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:34 INFO - 'NO_EM_RESTART': '1', 06:50:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:34 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:50:34 INFO - 'SHELL': '/bin/bash', 06:50:34 INFO - 'SHLVL': '1', 06:50:34 INFO - 'TERM': 'linux', 06:50:34 INFO - 'TMOUT': '86400', 06:50:34 INFO - 'USER': 'cltbld', 06:50:34 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517', 06:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:34 INFO - '_': '/tools/buildbot/bin/python'} 06:50:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 06:50:34 INFO - mozversion INFO | application_buildid: 20151218043022 06:50:34 INFO - mozversion INFO | application_changeset: 22bb9e57553b227f3d55a1f71010b8ab1e7c2ffa 06:50:34 INFO - mozversion INFO | application_display_name: Nightly 06:50:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:34 INFO - mozversion INFO | application_name: Firefox 06:50:34 INFO - mozversion INFO | application_remotingname: firefox 06:50:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:50:34 INFO - mozversion INFO | application_vendor: Mozilla 06:50:34 INFO - mozversion INFO | application_version: 46.0a1 06:50:34 INFO - mozversion INFO | platform_buildid: 20151218043022 06:50:34 INFO - mozversion INFO | platform_changeset: 22bb9e57553b227f3d55a1f71010b8ab1e7c2ffa 06:50:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:50:34 INFO - mozversion INFO | platform_version: 46.0a1 06:50:34 INFO - 2015-12-18 06:50:34,941 DEBUG : using testdate: 1450450234 06:50:34 INFO - 2015-12-18 06:50:34,941 DEBUG : actual date: 1450450234 06:50:35 INFO - 2015-12-18 06:50:35,036 INFO : starting webserver on 'localhost:39786' 06:50:35 INFO - 2015-12-18 06:50:35,037 INFO : Starting test suite talos-linux64-ix-067 06:50:35 INFO - 2015-12-18 06:50:35,037 INFO : Starting test dromaeo_css 06:50:35 INFO - 2015-12-18 06:50:35,037 DEBUG : operating with platform_type : linux_ 06:50:35 INFO - 2015-12-18 06:50:35,038 INFO : Initialising browser for dromaeo_css test... 06:50:35 INFO - 2015-12-18 06:50:35,054 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJV5KM9/profile http://localhost:39786/getInfo.html 06:50:39 INFO - 2015-12-18 06:50:39,338 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:50:39 INFO - 2015-12-18 06:50:39,339 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:50:39 INFO - 2015-12-18 06:50:39,339 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:50:39 INFO - 2015-12-18 06:50:39,339 DEBUG : BROWSER_OUTPUT: __metrics 06:50:39 INFO - 2015-12-18 06:50:39,424 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:50:39 INFO - 2015-12-18 06:50:39,480 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:39 ERROR - 2015-12-18 06:50:39,487 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 06:50:40 INFO - 2015-12-18 06:50:40,224 INFO : Browser initialized. 06:50:40 INFO - 2015-12-18 06:50:40,224 INFO : Running cycle 1/1 for dromaeo_css test... 06:50:40 INFO - 2015-12-18 06:50:40,224 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJV5KM9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:50:52 INFO - 2015-12-18 06:50:52,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 149393408 06:50:52 INFO - 2015-12-18 06:50:52,005 DEBUG : BROWSER_OUTPUT: 06:51:43 INFO - 2015-12-18 06:51:43,547 DEBUG : BROWSER_OUTPUT: 1450450303544 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] 06:53:52 INFO - 2015-12-18 06:53:52,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39786/tests/dromaeo/cssquery-ext.html) 06:53:53 INFO - 2015-12-18 06:53:53,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 263327744 06:53:53 INFO - 2015-12-18 06:53:53,094 DEBUG : BROWSER_OUTPUT: 06:56:55 INFO - 2015-12-18 06:56:55,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-ext.html (next: http://localhost:39786/tests/dromaeo/cssquery-jquery.html) 06:56:56 INFO - 2015-12-18 06:56:56,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 238583808 06:56:56 INFO - 2015-12-18 06:56:56,083 DEBUG : BROWSER_OUTPUT: 06:59:58 INFO - 2015-12-18 06:59:58,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39786/tests/dromaeo/cssquery-mootools.html) 06:59:58 INFO - 2015-12-18 06:59:58,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 219439104 06:59:58 INFO - 2015-12-18 06:59:58,607 DEBUG : BROWSER_OUTPUT: 07:03:00 INFO - 2015-12-18 07:03:00,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39786/tests/dromaeo/cssquery-prototype.html) 07:03:00 INFO - 2015-12-18 07:03:00,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 209248256 07:03:00 INFO - 2015-12-18 07:03:00,987 DEBUG : BROWSER_OUTPUT: 07:06:03 INFO - 2015-12-18 07:06:03,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39786/tests/dromaeo/cssquery-yui.html) 07:06:03 INFO - 2015-12-18 07:06:03,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 213991424 07:06:03 INFO - 2015-12-18 07:06:03,919 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/dromaeo/cssquery-yui.html (next: http://localhost:39786/tests/dromaeo/cssquery-dojo.html) 07:09:06 INFO - 2015-12-18 07:09:06,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 309080064 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3077.753779697624;3134.6081739782526;3162.8892988745397;3166.73082787963;3202.69574390433;5116;5218.791248350061;5227.921581176281;5251.947480525194;5334.51989320961;5134.589232861372;5167.48325167484;5175.508326708957;5212.947870521293;5350.91973620396;4635.536446355354;4737.50256223095;4760.690555113915;4821.228603423453;4949.554540091391;4899.534544218312;4903.2645103234445;4962.206047032476;4963.280324352967;4970.627202959774;4701.341812146302;4712.64655150865;4777.641676874214;4804.519548045202;4814.06125805468;4840.104580652555;4848.054629347279;4856.732879691615;4862.100511405401;4907.950920490785;4688.718676879398;4813.374261346037;4819.2530157825595;4846.273059041137;4846.733429661367;5095.974520127413;5112.846614601568;5213.504717051874;5218.060749065166;5244.187150991603;5709.514691251248;5710.571707121982;5710.628809127394;5712.971435142797;5714.771409143629;5603.327600687903;5741.397153298885;5741.8277451676095;5749;5760.2511673482595;5250;5299.549538289289;5306.336707911511;5344.038073146832;5346.652467589594;5758.107493338539;5772.682502462321;5775.451332123442;5780.71096445176;5826.679532625746;5293.470652934676;5389.191621256765;5602.943970560324;5610.074337734228;5611.915821262603;5608.887822243532;5674.886502270014;5693.572982026365;5699.629524080921;5722.513586345207;5687.260656114679;5690.459406356389;5691.373948865621;5691.9146212806845;5700.087985922232;5642.097264437671;5684.6020778545935;5697.886042279131;5700;5705.087186050212;4282.807273672693;4285.421468101767;4369.213541562549;4398.758068306274;4401.559844015637;3887.358585833362;3919.470871432377;3924.1955399143108;3952.209558088394;3958.188571342868;5340.786368545292;5366.141417373279;5367.275417818622;5367.973160134253;5371.3822910365025;5503.394626591072;5627.859303517363;5737.483626473638;5739.454751798572;5746.770129194869;5246.685198888079;5250.816221432232;5276.261323414725;5283.788648454019;5302.867428314323;4847.248676455155;4858.344123543347;4858.975705121452;4874.2444921037295;4899.951000490021;5613.214150019001;5668.8866222675315;5676.574256930747;5696.658200507983;5821.388754180834;5615.241942337732;5706.743196556082;5709.029464990878;5716.9142462862255;5760.366359700346;5725.942740572541;5769.480746732646;5776.451237132465;5788.21859049023;5793.9420605795085;5505.559555235652;5597.216389705526;5599.356074051536;5602.775888964396;5610.410906854721;5552.056150454513;5571.526420254162;5616.5787565931905;5655.7172141393585;5695.943040569541;5510.228568000403;5552.52803511706;5554.611177217556;5566.805161819479;5578.442155784389;5466.070767969534;5548.056830338772;5554.750036248298;5566.359868614999;5572.665640061609;5435.2934118564335;5488.039593071277;5491.341039075336;5499.725013749377;5519.641223320471;5485.61600687948;5490.6431081979545;5517.61376703643;5556.138798486241;5576.470235327637;5324.707141107277;5354.464553544614;5387.892242155213;5405.78376864921;5421.864453388697 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.3432437269918;585.584235193013;590.6692252338694;595.8004068637007;601.4076135007018;30041.399172016572;38772;38875.02812429687;38906.22187556247;38988.61011389885;42466.57533424665;42924.141517169635;42934.141317173635;42968.78515607418;42980.785096074556;7607.923920760777;7740.612969351538;8816;8991.055939126396;8995.055519170459;10568.52441640128;10798.136149108053;10800.675979720621;10801.513931873085;10801.891981080167;10454.68635940923;10500.579976800918;10542.47287635619;10562.419066951315;10562.841557376607;7953.5227886327;8107.797305067362;8120.878186827203;10446.791064178711;10687.679369618847;10353.689389318257;10490.108340791043;10497.107745841613;10498.37009779408;10498.632547860789;39416.80291598552;39647.603523964965;39669;39689.20621587581;39704.404433933516;2814.226087825844;3174.714275715197;3377.831108444568;3430.9656903430896;3765.416360464105;28642.570361444596;29075.56386654202;29211.707882921324;29269.97555085583;29357.559636605467;3732.5894151643297;3769.11425814936;3823.713221508398;3869.2454971280613;3911.413288006793;221818;223172;223274;223487;224115;57080.42919570751;57401;57495.712521437126;57618.711906441036;57785.71107144438;59735;59901.700491497264;59971.400285996584;59988;60002.69998650066;15876.52370428889;16060.839391605934;16075;16078;16096.114713690626;12150.210236334788;12223;12224.266544007389;12227.266364018187;12232.266064036186;18482.168302426424;20191.4952126198;20335.4916127098;20403;20491.69262461064;7542.434317426215;7618.352440042548;7732.381409487228;7798.869163971192;7814.296713295831;910.7814124610046;950.6767698982379;954.3319676226669;981.3621146254991;986.0583143098324;27831;28517.572236416472;28769.712302876702;28867.133985980454;28966.710332896822;971.4462756228882;1047.5914393386586;1089.2701889733896;1129.5199540195383;1133.6089049277987;13500.594982150355;14028.22844743549;14099.506517272051;14244.145351278956;14259.500917467838;309232;317002;317296;317851;318061;50435.24347134796;50967.490325096274;50974.49025509771;51029.489705102475;51142.74428627833;1343.993280033613;1353.9622867584224;1377.738229736347;1385.639733669233;1388.5834249725042;27160.456790864468;28098.578521322605;28216.29459263535;28232.29419264535;29076;42753.14493710171;42965.57034429616;43115.353269701605;43145.3528197071;43152.35271470993;199401;396415;397782;400596;402813;30285.69714302917;30977.690223098383;30982.22544436317;30992.22519437032;31004.22489437782;42508.78745606252;42877.571224287356;42983.140337193705;43489.34765978449;44136.33795493006;35186.824065879504;36059.45910811392;36110.819445902605;36288;36311.636883630825;32162;32634;32885.67114328826;35060.824695876356;35901;31523.52714709327;32390.190245243113;32390.35219295648;32423.189420264684;32530.51204231891;27647.30881727973;28770.85614571914;29707.851460742557;32453.18867028343;33302.17025042151;22815;23062.654060189445;23154.3053708389;23227;23312.417189570395 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.16828868015824;360.56191727051646;361.317110660851;363.07959323115904;363.1466054771288;13708.520201792915;13856.445742170326;16393.42623008195;16461.917690411545;17122.571935701628;13328.40022199001;13827.101238419496;16426.67146657066;16611.83388166118;17269.481915542554;5344.198370244465;5468.9726551367185;5472.20653005314;5472.671639701631;5473.0695781717;5278.498542638463;5379.220013098098;5395.163749618796;5402.91895621566;5417.214503896933;5323.893522129555;5341.866453338659;5348.491893270133;5373;5380.488853558905;5218.947810521884;5350.705711185883;5354.625176237665;5355.062863998784;5359.356877174744;4750.311204875274;4751.619870410359;4752.619790416758;4759.78580963854;4778.689385189951;20134;20274.5945081099;20293.391198264075;20486.18055277787;20978.685319720218;2111.3138230075288;2158.600658878097;2253.7182852143483;2329.2546385156757;2475.282168171228;13118.344082795822;13430.992675549373;13439.932800336033;13442.52951146715;13753.449862005507;1883.1902282018727;1904.228787341129;1971.8619696621242;1999.1303782854504;2003.889786061766;47227.527724722655;48784.26823597649;48961.75519122417;60033.39966600322;62757;9443.386179898285;9677.90322096784;9691;9734.221262299141;9777.706668799947;12941.805872911726;13013.934930325287;13016.609501714964;13020.283884386261;13024.088313817942;7557.659905304275;7630.694772209161;7635.389168866477;7670.386369090459;7676.040494938133;7489.550626962399;7528.021357223635;7541.47209695327;7549.396048316232;7565.130010048915;4170.666346692318;4196.895077623084;4222.535521092677;4238.23711731885;4257.148570285955;1736.5398169485097;1768.8673349498838;1778.1376032624426;1780.3234770787276;1781.9041289606798;837.821663674445;853.117023880281;1027.994860025695;1039.18424037132;1042.47876061969;16629.25168367402;16796.496105116865;17156.571085722957;17168.31326746941;17280.13599320029;860.2300940658201;892.9508877011697;906.1572737354323;918.9399300329885;954.6944977607099;9569.760755981017;9771.657991970247;9852.45811480361;9862.753431164278;9873.259505537113;504880;514542;519020;544420;549322;75345;78784.21215787884;79049.60475197702;79083.02292442735;81336.59331703304;1085.5060947269133;1125.482278152043;1154.468944285638;1184.2184158455377;1194.635636130971;14793.482228122395;14906.478273260384;14919.104853708812;14978.700425991201;15393.076415415111;26544.938202471683;29874.701252987194;31959.201019974687;32115.67884321127;32992.340153196325;43221.567784323015;43404.78297608492;45115;46288;46324.53675463202;9270.582823772811;9307.162355388047;9363.250939924927;9457.38526995743;9492.525373731423;14624.780628290797;17667.29330826804;17742.733858992382;17958.19188136563;18427.53931151732;14392.928035359757;14449.711005779614;14843.183624900734;14883.181425021729;14916.179610121548;13676.31618419095;13813.24027178515;14182.503612373517;15017.02389344689;15038.6992260152;12728;12746.681332966378;13045.152065115737;13093.869061309266;14273.286335683382;8965.148310910454;9099.49952752605;9194.862077068716;9302.488363140092;9368.297377696836;8972.327075469497;9061.22979546746;10141.543630536496;13876.098053626481;14245.358958847084 07:09:06 INFO - 2015-12-18 07:09:06,896 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1281.8718128187188;1450.891183161263;1499.145487072369;1601.759736039594;1722.5865792209866;6436.549441539094;7227.494075414723;7437.405007599393;7443.776686699408;7444.404447644189;7080.610566418845;7245.67394467249;7248.7462938797025;7252.963735181317;7255.963720181405;1961.3625571689188;1998.760148782141;2202.2622421488823;2226.6214743493565;2268.4782500025003;2253.853499522534;2256.029907139929;2258.0516183203094;2259.8531095478743;2261.852979556332;2131.7015617813518;2178.9891050544807;2181.301983365324;2182;2186.0818456248335;2208.194009186643;2213.4687674958054;2244.9438764030865;2255.4474153832252;2258.67249248858;2207.569523942832;2219.6226641470826;2228.9554208915893;2247.6516139998325;2249.876256805875;7442.7395041173295;7524.962375188144;7528.322450979438;7532.058492688414;7532.623368831537;4415.381846541487;4485.551444855521;4497.302918047708;4507.887302817423;4519.661025423074;2982.6719060903283;3071.385722855438;3104.627444706627;3109.2226943264186;3112.6264848218134;1028.1825948371063;1035.3735989726183;1059.6291298045699;1070.2882583082242;1072.7318170457386;9723.076307750824;9826.213902887752;9843.114119729187;9844.803103937953;9871.358361706538;3909.4722212500947;3979.3434083376496;3993.4209539616595;4001.899952501211;4027.234825383168;8382.07797142314;8397.286230670461;8435.662573496991;8442.451240669337;8461.238488535939;4437.356583295468;4442.244818380883;4475.865724028285;4477.977610111929;4482.798274077674;4093.4473846031;4093.8771836844944;4098.897527561775;4101.794910254475;4104.938425923614;3187.729043031322;3226.9838650806596;3290.2925870937866;3454.3264063507377;3465.8267086645565;1075.4676435164642;1096.0957210301533;1099.120703437247;1099.8680158380885;1102.3496137279044;1023.5087158164123;1085.9294145880651;1281.6667666406802;1290.045366428836;1315.53298579005;7068.823279417953;7146.7141314346845;7150.3922166615375;7158.642067896584;7176.569405835667;1096.5010920031366;1105.2926127278547;1116.8883111688765;1120.7254222715324;1133.1557989298026;5556.91664625031;5700.600957932905;5702.8289151325525;5706.3722990471015;5716.371199168088;8670.479771213748;8718.346124040723;8936;8945.73162805117;8962.73111806647;8741.825163496822;8757;8780.78048048791;8847.601857916408;8880.689175878813;6839.931600684029;6998;7031.964840175869;7079.619474202584;7087.3267039631155;6773.796786096425;6779.93220067793;6799.898001529882;6802.115724955724;6812.386885180357;7761.61191940412;7778.533288002738;8015.799605009688;8058.556779377191;8071.556064416513;7915.366770658448;8066.516009039477;8095.7166499172245;8221.342292616457;8248.46384984974;6406.90389644165;6621.33786621334;6666.233383160805;6679.265280819009;6713.261541230363;5995.640261584319;6097.146399503984;6747.055412242388;6811.69347379379;7131.964340178266;6749.831254218684;6848.3494068063455;6868.107146070979;6944.756933507303;7019.543729657556;6710.094137291599;6713.295104014203;6742.898856517254;6847.691853866489;6848.383645471931;6648.867022659617;6683.966580167068;6694.29709880475;6712.160979877515;6718;6161.630302181883;6179.412955769195;6215.533834962486;6246.593971391845;6256;6082.4525792677105;6098.0852872069545;6115.266168059861;6119.44924956756;6124.418180272867 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: |4;prototype.html;323.332318761757;325.3850223078381;326.0902083187906;329.2197491944092;333.3982162197236;5895.322037965635;5935.436133567304;5984.521238300926;5994.040953447449;6008;5675.8581035474135;5718.971405142979;5790.420957904207;5841.386654401291;5871.148683440909;4530.501644819084;4539.773011349436;4543.886402839922;4559.726416415009;4573.291139873317;4337.913241735163;4551.158035763395;4558.814708175865;4561.612262957653;4564.201264778667;4362.389265502832;4427.579379958915;4502.729836209822;4527.071950250191;4541.364209010741;4498.977505112486;4500.774961251925;4514.796834142471;4516.074204788043;4523.932141017887;3972.0864201233876;3973.2450834341385;3978.781167035812;3979.920401591981;3982.143839074584;5530.225768392428;5597.104463285855;5597.160425936101;5622.91565626516;5623.49388555028;5226.81706140287;5227.242049902781;5227.79088836446;5232.9738351308;5240.973795131038;6184.165137706442;6186.7525298987985;6189.319174890758;6190.0405437157315;6196.907046394263;4389.144116897206;4392.494863090754;4398.47218333802;4408.382826404306;4409.625181859546;6261.655608941506;6418.711157997855;6426.8714625707225;6438.742450302029;6440.291567927524;4497.415336006364;4501.234790085693;4502;4503.437070366204;4505.752183629932;4525.117602067565;4548.113117942035;4556.840510582114;4557.134144512532;4561.429821272341;5170.71561064145;5217.7912883485;5226.503482169188;5226.712530810842;5240.528352448222;6161.8459538511;6278.6546739929745;6281.842953926097;6282.120503129566;6289.811305660837;1597.0657165558046;1614.9596260093592;1618.0938674342406;1618.1828176770891;1619.7651340555553;1060.5545670818274;1064.4890452582804;1068.1454836131063;1074.0494662223832;1085.6688709943385;6006.819795406145;6012.488938440281;6027.849303767441;6041.063635136561;6041.305249896318;6444.6133232005295;6490.610563366213;6509.056186852879;6512.73949042033;6516.837079073061;5881.676507792027;5915.3788852170765;6015.759369625253;6068.848278793065;6093.2078829751845;3515.3320869035315;3527.365074286653;3530.6645868642436;3531.1525233943667;3537.451694987281;6646.4350530205475;6656.8668626627195;6665.166854143232;6665.733370665216;6668.166479190101;6563.770268040691;6699.39705426514;6704.2625311215725;6706.161729783777;6712.865742685119;6638.004299355039;6644.83387915306;6646.069550262967;6647.900281495781;6681.732730690718;6550.984597387413;6551.967240163769;6553.868922621617;6554.770583029571;6558.508111891531;6323.462505687068;6468.741250350122;6469.676516174079;6470.320616335405;6481.254655714653;6635.867282654223;6640.369164929324;6640.535162538576;6640.601563906181;6641.26946035926;4486.910261794811;4488.730676159441;4491.887702807456;4494.056248187917;4495.932561011522;6388.648624325707;6533.248676402274;6533.314002029719;6540.542162048611;6542.869142617026;6347.270063942706;6360.77737279193;6364.904526432199;6366.29970703213;6370.554061215856;6300;6313.589616674902;6348;6349.841253968688;6350.555461117862;6068.908966365596;6187.350328215653;6214.471769899609;6229.3770622939155;6264.498840092872;6391.105245265573;6399.968000159969;6402.231732191981;6404.135441715495;6405.647689377129;6199.380061993765;6228.937710622836;6251.249850017845;6255.124282600348;6259.029850373199 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: |5;yui.html;685.2530741491773;764.3159372361737;790.996045019775;821.761689110158;854.6026097864492;13809.723805523896;14018;14023.649408764786;14025.298735063245;14037.859621403783;12925.159864608793;12983.545575904845;13001.479940802381;13022;13033.608991730263;669.822497038284;676.2392308652766;677.43434232416;679.8844196486609;814.340384288728;825.9174082591722;832.5213002523543;834.1116710703112;834.1491678487939;836.4437648963462;848.495145388496;853.0914575976597;858.3991206155684;859.9011113721908;860.1441565642194;707.2503146664501;716.9103862017248;858.120426562775;859.9914000860006;860.8708693695933;609.3388673289486;626.1609443345939;626.8996960486346;627.3882964110002;627.4980015987237;13455;13695.794563081561;13698.863011369858;13703.177809331472;13711.862881371258;11833.467493962793;12221.877781222252;12277.877221227764;12490.250584964931;13263.204207747565;10242.846357304647;10442.164626829835;10634.680959571226;10773.353598784099;10819.567217311298;3619.402798538238;3639.0720366306687;3643.8724644637578;3662.7985460799914;3786.2616789726017;46028.53971460276;46112.5388746115;46182;46268.76865615684;46722.5327746725;10310.536025878853;10335.17318614509;10379.11777498906;10560.947195263974;10630.20273479492;19097;19262.133204005855;19294.614107717767;19295.228190872207;19295.324663636704;7643.464957452925;7809.180036096128;7830.882536761953;7953.920460795433;8018.719344822904;4368.7815609219415;4414.933775993362;4447.132809102259;4448.466184057869;4484.080763443486;3076.923076923095;3097.535369694519;3098.1170366445454;3098.2254436390904;3102.5811515445125;555.2615022020702;562.1062510608152;563.3268244447845;567.8580354911272;575.8646718021262;467.2990514228657;567.3617180671745;607.3156647617541;628.2617923939353;630.8612105336819;8289.253967142866;8310.750677479686;8313.501189928502;8362.54006029662;8367;515.8942416804546;614.9784757533465;667.4260136282793;672.0993868216614;708.9964550177319;3778.301014312361;3792.6586607205486;3806.200697853482;3846.480725102075;4023.75857448554;51458.742706286226;54869.72565137149;54870;55005.44994550083;55341.169882451795;42042.57957420448;46239.30641040387;47137.29294060592;47347.053058938625;47595.76202119036;43704.56295437005;44252.3362149568;44479;44887.55112448899;45205.77397112994;8332.583370831555;8413.579321034047;8466.534340611326;8515.27620152294;8607.741767746978;34501.65498345085;34615.65384346225;35036.12409689778;35192;35210.647893520734;41249.587504125775;41738.16523669449;43380.202840162856;43533;43986.56013439953;9999.650012249536;10255.794884102126;10271.845922311022;10423.791524169323;10496.055355018085;11703.414829258332;11826.940865295963;11888.881111188777;11994.220375675553;12412.317322546985;11053.447327633747;11303.717407064889;11381.487833047699;11478.426078696199;11862.762744745229;11106.722331941766;11279.266847654877;11532.308061516;11834.11244156709;11958.282503049497;10237;10525.631602893862;10623;10747.89252107469;10990.120790336914;9436.575354108943;9441.291903107158;9724.222062235145;9730.562124704264;10009.74975625586;8801.559922004002;8803.911960880308;9520.143187113194;9520.619175232912;9563.330566860532 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,856 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: __startTimestamp1450451346889__endTimestamp 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,897 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:09:06 INFO - 2015-12-18 07:09:06,898 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:09:06 INFO - 2015-12-18 07:09:06,898 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,898 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5251.48 Median:5435.29 stddev:576.81 (10.6%) stddev-sans-first:552.80 07:09:06 INFO - 2015-12-18 07:09:06,899 DEBUG : BROWSER_OUTPUT: Values: 3077.8 3134.6 3162.9 3166.7 3202.7 5116.0 5218.8 5227.9 5251.9 5334.5 5134.6 5167.5 5175.5 5212.9 5350.9 4635.5 4737.5 4760.7 4821.2 4949.6 4899.5 4903.3 4962.2 4963.3 4970.6 4701.3 4712.6 4777.6 4804.5 4814.1 4840.1 4848.1 4856.7 4862.1 4908.0 4688.7 4813.4 4819.3 4846.3 4846.7 5096.0 5112.8 5213.5 5218.1 5244.2 5709.5 5710.6 5710.6 5713.0 5714.8 5603.3 5741.4 5741.8 5749.0 5760.3 5250.0 5299.5 5306.3 5344.0 5346.7 5758.1 5772.7 5775.5 5780.7 5826.7 5293.5 5389.2 5602.9 5610.1 5611.9 5608.9 5674.9 5693.6 5699.6 5722.5 5687.3 5690.5 5691.4 5691.9 5700.1 5642.1 5684.6 5697.9 5700.0 5705.1 4282.8 4285.4 4369.2 4398.8 4401.6 3887.4 3919.5 3924.2 3952.2 3958.2 5340.8 5366.1 5367.3 5368.0 5371.4 5503.4 5627.9 5737.5 5739.5 5746.8 5246.7 5250.8 5276.3 5283.8 5302.9 4847.2 4858.3 4859.0 4874.2 4900.0 5613.2 5668.9 5676.6 5696.7 5821.4 5615.2 5706.7 5709.0 5716.9 5760.4 5725.9 5769.5 5776.5 5788.2 5793.9 5505.6 5597.2 5599.4 5602.8 5610.4 5552.1 5571.5 5616.6 5655.7 5695.9 5510.2 5552.5 5554.6 5566.8 5578.4 5466.1 5548.1 5554.8 5566.4 5572.7 5435.3 5488.0 5491.3 5499.7 5519.6 5485.6 5490.6 5517.6 5556.1 5576.5 5324.7 5354.5 5387.9 5405.8 5421.9 07:09:06 INFO - 2015-12-18 07:09:06,899 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,899 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46529.94 Median:32390.27 stddev:81048.95 (250.2%) stddev-sans-first:81202.81 07:09:06 INFO - 2015-12-18 07:09:06,899 DEBUG : BROWSER_OUTPUT: Values: 555.3 585.6 590.7 595.8 601.4 30041.4 38772.0 38875.0 38906.2 38988.6 42466.6 42924.1 42934.1 42968.8 42980.8 7607.9 7740.6 8816.0 8991.1 8995.1 10568.5 10798.1 10800.7 10801.5 10801.9 10454.7 10500.6 10542.5 10562.4 10562.8 7953.5 8107.8 8120.9 10446.8 10687.7 10353.7 10490.1 10497.1 10498.4 10498.6 39416.8 39647.6 39669.0 39689.2 39704.4 2814.2 3174.7 3377.8 3431.0 3765.4 28642.6 29075.6 29211.7 29270.0 29357.6 3732.6 3769.1 3823.7 3869.2 3911.4 221818.0 223172.0 223274.0 223487.0 224115.0 57080.4 57401.0 57495.7 57618.7 57785.7 59735.0 59901.7 59971.4 59988.0 60002.7 15876.5 16060.8 16075.0 16078.0 16096.1 12150.2 12223.0 12224.3 12227.3 12232.3 18482.2 20191.5 20335.5 20403.0 20491.7 7542.4 7618.4 7732.4 7798.9 7814.3 910.8 950.7 954.3 981.4 986.1 27831.0 28517.6 28769.7 28867.1 28966.7 971.4 1047.6 1089.3 1129.5 1133.6 13500.6 14028.2 14099.5 14244.1 14259.5 309232.0 317002.0 317296.0 317851.0 318061.0 50435.2 50967.5 50974.5 51029.5 51142.7 1344.0 1354.0 1377.7 1385.6 1388.6 27160.5 28098.6 28216.3 28232.3 29076.0 42753.1 42965.6 43115.4 43145.4 43152.4 199401.0 396415.0 397782.0 400596.0 402813.0 30285.7 30977.7 30982.2 30992.2 31004.2 42508.8 42877.6 42983.1 43489.3 44136.3 35186.8 36059.5 36110.8 36288.0 36311.6 32162.0 32634.0 32885.7 35060.8 35901.0 31523.5 32390.2 32390.4 32423.2 32530.5 27647.3 28770.9 29707.9 32453.2 33302.2 22815.0 23062.7 23154.3 23227.0 23312.4 07:09:06 INFO - 2015-12-18 07:09:06,899 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,900 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27998.47 Median:2266.91 stddev:85992.95 (3793.4%) stddev-sans-first:86209.13 07:09:06 INFO - 2015-12-18 07:09:06,901 DEBUG : BROWSER_OUTPUT: Values: 353.2 360.6 361.3 363.1 363.1 13708.5 13856.4 16393.4 16461.9 17122.6 13328.4 13827.1 16426.7 16611.8 17269.5 5344.2 5469.0 5472.2 5472.7 5473.1 5278.5 5379.2 5395.2 5402.9 5417.2 5323.9 5341.9 5348.5 5373.0 5380.5 5218.9 5350.7 5354.6 5355.1 5359.4 4750.3 4751.6 4752.6 4759.8 4778.7 20134.0 20274.6 20293.4 20486.2 20978.7 2111.3 2158.6 2253.7 2329.3 2475.3 13118.3 13431.0 13439.9 13442.5 13753.4 1883.2 1904.2 1971.9 1999.1 2003.9 47227.5 48784.3 48961.8 60033.4 62757.0 9443.4 9677.9 9691.0 9734.2 9777.7 12941.8 13013.9 13016.6 13020.3 13024.1 7557.7 7630.7 7635.4 7670.4 7676.0 7489.6 7528.0 7541.5 7549.4 7565.1 4170.7 4196.9 4222.5 4238.2 4257.1 1736.5 1768.9 1778.1 1780.3 1781.9 837.8 853.1 1028.0 1039.2 1042.5 16629.3 16796.5 17156.6 17168.3 17280.1 860.2 893.0 906.2 918.9 954.7 9569.8 9771.7 9852.5 9862.8 9873.3 504880.0 514542.0 519020.0 544420.0 549322.0 75345.0 78784.2 79049.6 79083.0 81336.6 1085.5 1125.5 1154.5 1184.2 1194.6 14793.5 14906.5 14919.1 14978.7 15393.1 26544.9 29874.7 31959.2 32115.7 32992.3 43221.6 43404.8 45115.0 46288.0 46324.5 9270.6 9307.2 9363.3 9457.4 9492.5 14624.8 17667.3 17742.7 17958.2 18427.5 14392.9 14449.7 14843.2 14883.2 14916.2 13676.3 13813.2 14182.5 15017.0 15038.7 12728.0 12746.7 13045.2 13093.9 14273.3 8965.1 9099.5 9194.9 9302.5 9368.3 8972.3 9061.2 10141.5 13876.1 14245.4 07:09:06 INFO - 2015-12-18 07:09:06,901 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,901 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5187.80 Median:6121.93 stddev:2631.48 (43.0%) stddev-sans-first:2622.48 07:09:06 INFO - 2015-12-18 07:09:06,901 DEBUG : BROWSER_OUTPUT: Values: 1281.9 1450.9 1499.1 1601.8 1722.6 6436.5 7227.5 7437.4 7443.8 7444.4 7080.6 7245.7 7248.7 7253.0 7256.0 1961.4 1998.8 2202.3 2226.6 2268.5 2253.9 2256.0 2258.1 2259.9 2261.9 2131.7 2179.0 2181.3 2182.0 2186.1 2208.2 2213.5 2244.9 2255.4 2258.7 2207.6 2219.6 2229.0 2247.7 2249.9 7442.7 7525.0 7528.3 7532.1 7532.6 4415.4 4485.6 4497.3 4507.9 4519.7 2982.7 3071.4 3104.6 3109.2 3112.6 1028.2 1035.4 1059.6 1070.3 1072.7 9723.1 9826.2 9843.1 9844.8 9871.4 3909.5 3979.3 3993.4 4001.9 4027.2 8382.1 8397.3 8435.7 8442.5 8461.2 4437.4 4442.2 4475.9 4478.0 4482.8 4093.4 4093.9 4098.9 4101.8 4104.9 3187.7 3227.0 3290.3 3454.3 3465.8 1075.5 1096.1 1099.1 1099.9 1102.3 1023.5 1085.9 1281.7 1290.0 1315.5 7068.8 7146.7 7150.4 7158.6 7176.6 1096.5 1105.3 1116.9 1120.7 1133.2 5556.9 5700.6 5702.8 5706.4 5716.4 8670.5 8718.3 8936.0 8945.7 8962.7 8741.8 8757.0 8780.8 8847.6 8880.7 6839.9 6998.0 7032.0 7079.6 7087.3 6773.8 6779.9 6799.9 6802.1 6812.4 7761.6 7778.5 8015.8 8058.6 8071.6 7915.4 8066.5 8095.7 8221.3 8248.5 6406.9 6621.3 6666.2 6679.3 6713.3 5995.6 6097.1 6747.1 6811.7 7132.0 6749.8 6848.3 6868.1 6944.8 7019.5 6710.1 6713.3 6742.9 6847.7 6848.4 6648.9 6684.0 6694.3 6712.2 6718.0 6161.6 6179.4 6215.5 6246.6 6256.0 6082.5 6098.1 6115.3 6119.4 6124.4 07:09:06 INFO - 2015-12-18 07:09:06,902 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,902 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5258.71 Median:6000.43 stddev:1578.01 (26.3%) stddev-sans-first:1538.34 07:09:06 INFO - 2015-12-18 07:09:06,903 DEBUG : BROWSER_OUTPUT: Values: 323.3 325.4 326.1 329.2 333.4 5895.3 5935.4 5984.5 5994.0 6008.0 5675.9 5719.0 5790.4 5841.4 5871.1 4530.5 4539.8 4543.9 4559.7 4573.3 4337.9 4551.2 4558.8 4561.6 4564.2 4362.4 4427.6 4502.7 4527.1 4541.4 4499.0 4500.8 4514.8 4516.1 4523.9 3972.1 3973.2 3978.8 3979.9 3982.1 5530.2 5597.1 5597.2 5622.9 5623.5 5226.8 5227.2 5227.8 5233.0 5241.0 6184.2 6186.8 6189.3 6190.0 6196.9 4389.1 4392.5 4398.5 4408.4 4409.6 6261.7 6418.7 6426.9 6438.7 6440.3 4497.4 4501.2 4502.0 4503.4 4505.8 4525.1 4548.1 4556.8 4557.1 4561.4 5170.7 5217.8 5226.5 5226.7 5240.5 6161.8 6278.7 6281.8 6282.1 6289.8 1597.1 1615.0 1618.1 1618.2 1619.8 1060.6 1064.5 1068.1 1074.0 1085.7 6006.8 6012.5 6027.8 6041.1 6041.3 6444.6 6490.6 6509.1 6512.7 6516.8 5881.7 5915.4 6015.8 6068.8 6093.2 3515.3 3527.4 3530.7 3531.2 3537.5 6646.4 6656.9 6665.2 6665.7 6668.2 6563.8 6699.4 6704.3 6706.2 6712.9 6638.0 6644.8 6646.1 6647.9 6681.7 6551.0 6552.0 6553.9 6554.8 6558.5 6323.5 6468.7 6469.7 6470.3 6481.3 6635.9 6640.4 6640.5 6640.6 6641.3 4486.9 4488.7 4491.9 4494.1 4495.9 6388.6 6533.2 6533.3 6540.5 6542.9 6347.3 6360.8 6364.9 6366.3 6370.6 6300.0 6313.6 6348.0 6349.8 6350.6 6068.9 6187.4 6214.5 6229.4 6264.5 6391.1 6400.0 6402.2 6404.1 6405.6 6199.4 6228.9 6251.2 6255.1 6259.0 07:09:06 INFO - 2015-12-18 07:09:06,903 DEBUG : BROWSER_OUTPUT: 07:09:06 INFO - 2015-12-18 07:09:06,904 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13416.18 Median:24463.07 stddev:15075.76 (61.6%) stddev-sans-first:15087.74 07:09:06 INFO - 2015-12-18 07:09:06,905 DEBUG : BROWSER_OUTPUT: Values: 685.3 764.3 791.0 821.8 854.6 13809.7 14018.0 14023.6 14025.3 14037.9 12925.2 12983.5 13001.5 13022.0 13033.6 669.8 676.2 677.4 679.9 814.3 825.9 832.5 834.1 834.1 836.4 848.5 853.1 858.4 859.9 860.1 707.3 716.9 858.1 860.0 860.9 609.3 626.2 626.9 627.4 627.5 13455.0 13695.8 13698.9 13703.2 13711.9 11833.5 12221.9 12277.9 12490.3 13263.2 10242.8 10442.2 10634.7 10773.4 10819.6 3619.4 3639.1 3643.9 3662.8 3786.3 46028.5 46112.5 46182.0 46268.8 46722.5 10310.5 10335.2 10379.1 10560.9 10630.2 19097.0 19262.1 19294.6 19295.2 19295.3 7643.5 7809.2 7830.9 7953.9 8018.7 4368.8 4414.9 4447.1 4448.5 4484.1 3076.9 3097.5 3098.1 3098.2 3102.6 555.3 562.1 563.3 567.9 575.9 467.3 567.4 607.3 628.3 630.9 8289.3 8310.8 8313.5 8362.5 8367.0 515.9 615.0 667.4 672.1 709.0 3778.3 3792.7 3806.2 3846.5 4023.8 51458.7 54869.7 54870.0 55005.4 55341.2 42042.6 46239.3 47137.3 47347.1 47595.8 43704.6 44252.3 44479.0 44887.6 45205.8 8332.6 8413.6 8466.5 8515.3 8607.7 34501.7 34615.7 35036.1 35192.0 35210.6 41249.6 41738.2 43380.2 43533.0 43986.6 9999.7 10255.8 10271.8 10423.8 10496.1 11703.4 11826.9 11888.9 11994.2 12412.3 11053.4 11303.7 11381.5 11478.4 11862.8 11106.7 11279.3 11532.3 11834.1 11958.3 10237.0 10525.6 10623.0 10747.9 10990.1 9436.6 9441.3 9724.2 9730.6 10009.7 8801.6 8803.9 9520.1 9520.6 9563.3 07:09:06 INFO - 2015-12-18 07:09:06,905 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:09:06 INFO - 2015-12-18 07:09:06,905 DEBUG : BROWSER_OUTPUT: 07:09:07 INFO - 2015-12-18 07:09:07,645 INFO : Browser exited with error code: 0 07:09:07 INFO - 2015-12-18 07:09:07,666 INFO : Completed test dromaeo_css (00:18:32) 07:09:07 INFO - 2015-12-18 07:09:07,666 INFO : Starting test kraken 07:09:07 INFO - 2015-12-18 07:09:07,666 DEBUG : operating with platform_type : linux_ 07:09:07 INFO - 2015-12-18 07:09:07,666 INFO : Initialising browser for kraken test... 07:09:07 INFO - 2015-12-18 07:09:07,673 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptsQY5J/profile http://localhost:39786/getInfo.html 07:09:11 INFO - 2015-12-18 07:09:11,875 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:09:11 INFO - 2015-12-18 07:09:11,875 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:09:11 INFO - 2015-12-18 07:09:11,875 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:09:11 INFO - 2015-12-18 07:09:11,875 DEBUG : BROWSER_OUTPUT: __metrics 07:09:11 INFO - 2015-12-18 07:09:11,992 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:12 INFO - 2015-12-18 07:09:12,048 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:12 INFO - 2015-12-18 07:09:12,841 INFO : Browser initialized. 07:09:12 INFO - 2015-12-18 07:09:12,842 INFO : Running cycle 1/1 for kraken test... 07:09:12 INFO - 2015-12-18 07:09:12,842 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptsQY5J/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:09:24 INFO - 2015-12-18 07:09:24,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 149286912 07:09:24 INFO - 2015-12-18 07:09:24,640 DEBUG : BROWSER_OUTPUT: 07:09:27 INFO - 2015-12-18 07:09:27,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:27 INFO - 2015-12-18 07:09:27,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 187281408 07:09:27 INFO - 2015-12-18 07:09:27,696 DEBUG : BROWSER_OUTPUT: 07:09:30 INFO - 2015-12-18 07:09:30,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-dft) 07:09:30 INFO - 2015-12-18 07:09:30,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 176492544 07:09:30 INFO - 2015-12-18 07:09:30,884 DEBUG : BROWSER_OUTPUT: 07:09:33 INFO - 2015-12-18 07:09:33,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-fft) 07:09:34 INFO - 2015-12-18 07:09:34,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 159125504 07:09:34 INFO - 2015-12-18 07:09:34,337 DEBUG : BROWSER_OUTPUT: 07:09:36 INFO - 2015-12-18 07:09:36,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39786/tests/kraken/driver.html?testName=audio-oscillator) 07:09:36 INFO - 2015-12-18 07:09:36,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 163307520 07:09:36 INFO - 2015-12-18 07:09:36,891 DEBUG : BROWSER_OUTPUT: 07:09:39 INFO - 2015-12-18 07:09:39,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:39 INFO - 2015-12-18 07:09:39,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 164192256 07:09:39 INFO - 2015-12-18 07:09:39,667 DEBUG : BROWSER_OUTPUT: 07:09:42 INFO - 2015-12-18 07:09:42,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39786/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:43 INFO - 2015-12-18 07:09:43,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 165031936 07:09:43 INFO - 2015-12-18 07:09:43,099 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2015-12-18 07:09:46,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39786/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:47 INFO - 2015-12-18 07:09:47,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 164491264 07:09:47 INFO - 2015-12-18 07:09:47,052 DEBUG : BROWSER_OUTPUT: 07:09:49 INFO - 2015-12-18 07:09:49,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39786/tests/kraken/driver.html?testName=json-parse-financial) 07:09:50 INFO - 2015-12-18 07:09:50,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 165380096 07:09:50 INFO - 2015-12-18 07:09:50,367 DEBUG : BROWSER_OUTPUT: 07:09:51 INFO - 2015-12-18 07:09:51,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:52 INFO - 2015-12-18 07:09:52,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 178438144 07:09:52 INFO - 2015-12-18 07:09:52,481 DEBUG : BROWSER_OUTPUT: 07:09:54 INFO - 2015-12-18 07:09:54,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:54 INFO - 2015-12-18 07:09:54,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 175489024 07:09:54 INFO - 2015-12-18 07:09:54,890 DEBUG : BROWSER_OUTPUT: 07:09:56 INFO - 2015-12-18 07:09:56,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:57 INFO - 2015-12-18 07:09:57,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 182857728 07:09:57 INFO - 2015-12-18 07:09:57,506 DEBUG : BROWSER_OUTPUT: 07:09:59 INFO - 2015-12-18 07:09:59,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:00 INFO - 2015-12-18 07:10:00,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 190758912 07:10:00 INFO - 2015-12-18 07:10:00,455 DEBUG : BROWSER_OUTPUT: 07:10:03 INFO - 2015-12-18 07:10:03,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:03 INFO - 2015-12-18 07:10:03,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 189177856 07:10:03 INFO - 2015-12-18 07:10:03,677 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39786/tests/kraken/driver.html?testName=ai-astar) 07:10:05 INFO - 2015-12-18 07:10:05,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 246439936 07:10:05 INFO - 2015-12-18 07:10:05,584 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,584 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:05 INFO - 2015-12-18 07:10:05,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:05 INFO - 2015-12-18 07:10:05,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:05 INFO - 2015-12-18 07:10:05,584 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:05 INFO - 2015-12-18 07:10:05,584 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;106;109;110;110;100;112;110;117 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;122;163;159;134;152;160;126;160;132 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;163;161;162;160;161;162;162 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;89;71;72;72;98;94;72 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;141;93;93;94;136;93;95;134 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;110;111 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;146;146;146;148;146;146;147 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;96;96;96;96;96 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;58;56;61;56;57;66;54;55 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;66;67;66;68;68;67;67;67 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;85;92;83;84;85;88;87;94 07:10:05 INFO - 2015-12-18 07:10:05,585 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;119;117;114;121;119;116;124;115;119 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;152;152;153;157;152;154;153;156;148 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;69;67;67;66;66;66;66;67 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: __startTimestamp1450451405578__endTimestamp 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,586 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:4.33 (3.9%) stddev-sans-first:4.59 07:10:05 INFO - 2015-12-18 07:10:05,587 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 106.0 109.0 110.0 110.0 100.0 112.0 110.0 117.0 07:10:05 INFO - 2015-12-18 07:10:05,587 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,587 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.30 Median:155.50 stddev:15.63 (10.1%) stddev-sans-first:16.58 07:10:05 INFO - 2015-12-18 07:10:05,587 DEBUG : BROWSER_OUTPUT: Values: 145.0 122.0 163.0 159.0 134.0 152.0 160.0 126.0 160.0 132.0 07:10:05 INFO - 2015-12-18 07:10:05,587 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,588 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 07:10:05 INFO - 2015-12-18 07:10:05,588 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 163.0 161.0 162.0 160.0 161.0 162.0 162.0 07:10:05 INFO - 2015-12-18 07:10:05,588 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,588 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:76.50 stddev:10.53 (13.8%) stddev-sans-first:10.83 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 89.0 71.0 72.0 72.0 98.0 94.0 72.0 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.13 (22.7%) stddev-sans-first:21.83 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 141.0 93.0 93.0 94.0 136.0 93.0 95.0 134.0 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 111.0 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:10:05 INFO - 2015-12-18 07:10:05,589 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:3.46 (6.0%) stddev-sans-first:3.66 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 58.0 56.0 61.0 56.0 57.0 66.0 54.0 55.0 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 66.0 67.0 66.0 68.0 68.0 67.0 67.0 67.0 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.00 stddev:3.72 (4.3%) stddev-sans-first:3.82 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 92.0 83.0 84.0 85.0 88.0 87.0 94.0 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:119.00 stddev:3.46 (2.9%) stddev-sans-first:3.11 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: Values: 124.0 119.0 117.0 114.0 121.0 119.0 116.0 124.0 115.0 119.0 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:153.50 stddev:2.92 (1.9%) stddev-sans-first:2.60 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: Values: 158.0 152.0 152.0 153.0 157.0 152.0 154.0 153.0 156.0 148.0 07:10:05 INFO - 2015-12-18 07:10:05,590 DEBUG : BROWSER_OUTPUT: 07:10:05 INFO - 2015-12-18 07:10:05,591 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 07:10:05 INFO - 2015-12-18 07:10:05,591 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 69.0 67.0 67.0 66.0 66.0 66.0 66.0 67.0 07:10:05 INFO - 2015-12-18 07:10:05,591 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:05 INFO - 2015-12-18 07:10:05,591 DEBUG : BROWSER_OUTPUT: 07:10:06 INFO - 2015-12-18 07:10:06,441 INFO : Browser exited with error code: 0 07:10:06 INFO - 2015-12-18 07:10:06,489 INFO : Completed test kraken (00:00:58) 07:10:06 INFO - 2015-12-18 07:10:06,489 INFO : Starting test v8_7 07:10:06 INFO - 2015-12-18 07:10:06,489 DEBUG : operating with platform_type : linux_ 07:10:06 INFO - 2015-12-18 07:10:06,489 INFO : Initialising browser for v8_7 test... 07:10:06 INFO - 2015-12-18 07:10:06,495 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ92bam/profile http://localhost:39786/getInfo.html 07:10:10 INFO - 2015-12-18 07:10:10,413 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:10 INFO - 2015-12-18 07:10:10,413 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:10 INFO - 2015-12-18 07:10:10,413 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:10:10 INFO - 2015-12-18 07:10:10,413 DEBUG : BROWSER_OUTPUT: __metrics 07:10:10 INFO - 2015-12-18 07:10:10,510 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:10:10 INFO - 2015-12-18 07:10:10,553 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:11 INFO - 2015-12-18 07:10:11,715 INFO : Browser initialized. 07:10:11 INFO - 2015-12-18 07:10:11,715 INFO : Running cycle 1/1 for v8_7 test... 07:10:11 INFO - 2015-12-18 07:10:11,716 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ92bam/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:10:23 INFO - 2015-12-18 07:10:23,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 149843968 07:10:23 INFO - 2015-12-18 07:10:23,583 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39786/tests/v8_7/run.html (next: http://localhost:39786/tests/v8_7/run.html) 07:10:45 INFO - 2015-12-18 07:10:45,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 560304128 07:10:45 INFO - 2015-12-18 07:10:45,252 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,253 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:45 INFO - 2015-12-18 07:10:45,253 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:45 INFO - 2015-12-18 07:10:45,253 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:45 INFO - 2015-12-18 07:10:45,253 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:45 INFO - 2015-12-18 07:10:45,254 DEBUG : BROWSER_OUTPUT: |0;Richards;167.53224995811695 07:10:45 INFO - 2015-12-18 07:10:45,254 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.25301204819277 07:10:45 INFO - 2015-12-18 07:10:45,254 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 07:10:45 INFO - 2015-12-18 07:10:45,254 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 07:10:45 INFO - 2015-12-18 07:10:45,254 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1951.2670565302144 07:10:45 INFO - 2015-12-18 07:10:45,254 DEBUG : BROWSER_OUTPUT: |5;Earley;762.1951219512196 07:10:45 INFO - 2015-12-18 07:10:45,255 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 07:10:45 INFO - 2015-12-18 07:10:45,255 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 07:10:45 INFO - 2015-12-18 07:10:45,255 DEBUG : BROWSER_OUTPUT: |8;Splay;603.4793041391722 07:10:45 INFO - 2015-12-18 07:10:45,255 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 07:10:45 INFO - 2015-12-18 07:10:45,255 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:45 INFO - 2015-12-18 07:10:45,255 DEBUG : BROWSER_OUTPUT: __startTimestamp1450451445252__endTimestamp 07:10:45 INFO - 2015-12-18 07:10:45,256 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,256 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:45 INFO - 2015-12-18 07:10:45,256 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:10:45 INFO - 2015-12-18 07:10:45,256 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,256 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: Values: 167.5 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: Values: 188.3 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: Values: 280.1 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: Values: 5133.3 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1951.27 Median:1951.27 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: Values: 1951.3 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,258 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:762.20 Median:762.20 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: Values: 762.2 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: Values: 12207.3 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: Values: 25250.0 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,259 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.48 Median:603.48 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,260 DEBUG : BROWSER_OUTPUT: Values: 603.5 07:10:45 INFO - 2015-12-18 07:10:45,260 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-18 07:10:45,260 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 07:10:45 INFO - 2015-12-18 07:10:45,260 DEBUG : BROWSER_OUTPUT: Values: 4864.1 07:10:45 INFO - 2015-12-18 07:10:45,260 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:45 INFO - 2015-12-18 07:10:45,260 DEBUG : BROWSER_OUTPUT: 07:10:46 INFO - 2015-12-18 07:10:46,093 INFO : Browser exited with error code: 0 07:10:46 INFO - 2015-12-18 07:10:46,110 INFO : Completed test v8_7 (00:00:39) 07:10:46 INFO - 2015-12-18 07:10:46,256 INFO : Completed test suite (00:20:11) 07:10:46 INFO - 2015-12-18 07:10:46,256 DEBUG : Working with test: dromaeo_css 07:10:46 INFO - 2015-12-18 07:10:46,256 DEBUG : Generating results file: dromaeo_css 07:10:46 INFO - 2015-12-18 07:10:46,257 DEBUG : Working with test: kraken 07:10:46 INFO - 2015-12-18 07:10:46,257 DEBUG : Generating results file: kraken 07:10:46 INFO - 2015-12-18 07:10:46,257 INFO : javascript benchmark 07:10:46 INFO - 2015-12-18 07:10:46,258 DEBUG : Working with test: v8_7 07:10:46 INFO - 2015-12-18 07:10:46,258 DEBUG : Generating results file: v8_7 07:10:46 INFO - 2015-12-18 07:10:46,258 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:46 INFO - 2015-12-18 07:10:46,314 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 07:10:46 INFO - 2015-12-18 07:10:46,314 DEBUG : process_Request line: dromaeo_css 6888.69 graph.html#tests=[[72,63,35]] 07:10:46 INFO - 2015-12-18 07:10:46,314 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:46 INFO - 2015-12-18 07:10:46,361 DEBUG : process_Request line: kraken 1503.60 graph.html#tests=[[232,63,35]] 07:10:46 INFO - 2015-12-18 07:10:46,361 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:46 INFO - 2015-12-18 07:10:46,410 DEBUG : process_Request line: v8_7 19990.33 graph.html#tests=[[230,63,35]] 07:10:46 INFO - 2015-12-18 07:10:46,411 INFO : javascript benchmark 07:10:46 INFO - 2015-12-18 07:10:46,414 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3077.753779697624, 3134.6081739782526, 3162.8892988745397, 3166.73082787963, 3202.69574390433, 5116.0, 5218.791248350061, 5227.921581176281, 5251.947480525194, 5334.51989320961, 5134.589232861372, 5167.48325167484, 5175.508326708957, 5212.947870521293, 5350.91973620396, 4635.536446355354, 4737.50256223095, 4760.690555113915, 4821.228603423453, 4949.554540091391, 4899.534544218312, 4903.2645103234445, 4962.206047032476, 4963.280324352967, 4970.627202959774, 4701.341812146302, 4712.64655150865, 4777.641676874214, 4804.519548045202, 4814.06125805468, 4840.104580652555, 4848.054629347279, 4856.732879691615, 4862.100511405401, 4907.950920490785, 4688.718676879398, 4813.374261346037, 4819.2530157825595, 4846.273059041137, 4846.733429661367, 5095.974520127413, 5112.846614601568, 5213.504717051874, 5218.060749065166, 5244.187150991603, 5709.514691251248, 5710.571707121982, 5710.628809127394, 5712.971435142797, 5714.771409143629, 5603.327600687903, 5741.397153298885, 5741.8277451676095, 5749.0, 5760.2511673482595, 5250.0, 5299.549538289289, 5306.336707911511, 5344.038073146832, 5346.652467589594, 5758.107493338539, 5772.682502462321, 5775.451332123442, 5780.71096445176, 5826.679532625746, 5293.470652934676, 5389.191621256765, 5602.943970560324, 5610.074337734228, 5611.915821262603, 5608.887822243532, 5674.886502270014, 5693.572982026365, 5699.629524080921, 5722.513586345207, 5687.260656114679, 5690.459406356389, 5691.373948865621, 5691.9146212806845, 5700.087985922232, 5642.097264437671, 5684.6020778545935, 5697.886042279131, 5700.0, 5705.087186050212, 4282.807273672693, 4285.421468101767, 4369.213541562549, 4398.758068306274, 4401.559844015637, 3887.358585833362, 3919.470871432377, 3924.1955399143108, 3952.209558088394, 3958.188571342868, 5340.786368545292, 5366.141417373279, 5367.275417818622, 5367.973160134253, 5371.3822910365025, 5503.394626591072, 5627.859303517363, 5737.483626473638, 5739.454751798572, 5746.770129194869, 5246.685198888079, 5250.816221432232, 5276.261323414725, 5283.788648454019, 5302.867428314323, 4847.248676455155, 4858.344123543347, 4858.975705121452, 4874.2444921037295, 4899.951000490021, 5613.214150019001, 5668.8866222675315, 5676.574256930747, 5696.658200507983, 5821.388754180834, 5615.241942337732, 5706.743196556082, 5709.029464990878, 5716.9142462862255, 5760.366359700346, 5725.942740572541, 5769.480746732646, 5776.451237132465, 5788.21859049023, 5793.9420605795085, 5505.559555235652, 5597.216389705526, 5599.356074051536, 5602.775888964396, 5610.410906854721, 5552.056150454513, 5571.526420254162, 5616.5787565931905, 5655.7172141393585, 5695.943040569541, 5510.228568000403, 5552.52803511706, 5554.611177217556, 5566.805161819479, 5578.442155784389, 5466.070767969534, 5548.056830338772, 5554.750036248298, 5566.359868614999, 5572.665640061609, 5435.2934118564335, 5488.039593071277, 5491.341039075336, 5499.725013749377, 5519.641223320471, 5485.61600687948, 5490.6431081979545, 5517.61376703643, 5556.138798486241, 5576.470235327637, 5324.707141107277, 5354.464553544614, 5387.892242155213, 5405.78376864921, 5421.864453388697], "unit": "score", "name": "dojo.html", "value": 5214.337079077455}, {"lowerIsBetter": false, "replicates": [555.3432437269918, 585.584235193013, 590.6692252338694, 595.8004068637007, 601.4076135007018, 30041.399172016572, 38772.0, 38875.02812429687, 38906.22187556247, 38988.61011389885, 42466.57533424665, 42924.141517169635, 42934.141317173635, 42968.78515607418, 42980.785096074556, 7607.923920760777, 7740.612969351538, 8816.0, 8991.055939126396, 8995.055519170459, 10568.52441640128, 10798.136149108053, 10800.675979720621, 10801.513931873085, 10801.891981080167, 10454.68635940923, 10500.579976800918, 10542.47287635619, 10562.419066951315, 10562.841557376607, 7953.5227886327, 8107.797305067362, 8120.878186827203, 10446.791064178711, 10687.679369618847, 10353.689389318257, 10490.108340791043, 10497.107745841613, 10498.37009779408, 10498.632547860789, 39416.80291598552, 39647.603523964965, 39669.0, 39689.20621587581, 39704.404433933516, 2814.226087825844, 3174.714275715197, 3377.831108444568, 3430.9656903430896, 3765.416360464105, 28642.570361444596, 29075.56386654202, 29211.707882921324, 29269.97555085583, 29357.559636605467, 3732.5894151643297, 3769.11425814936, 3823.713221508398, 3869.2454971280613, 3911.413288006793, 221818.0, 223172.0, 223274.0, 223487.0, 224115.0, 57080.42919570751, 57401.0, 57495.712521437126, 57618.711906441036, 57785.71107144438, 59735.0, 59901.700491497264, 59971.400285996584, 59988.0, 60002.69998650066, 15876.52370428889, 16060.839391605934, 16075.0, 16078.0, 16096.114713690626, 12150.210236334788, 12223.0, 12224.266544007389, 12227.266364018187, 12232.266064036186, 18482.168302426424, 20191.4952126198, 20335.4916127098, 20403.0, 20491.69262461064, 7542.434317426215, 7618.352440042548, 7732.381409487228, 7798.869163971192, 7814.296713295831, 910.7814124610046, 950.6767698982379, 954.3319676226669, 981.3621146254991, 986.0583143098324, 27831.0, 28517.572236416472, 28769.712302876702, 28867.133985980454, 28966.710332896822, 971.4462756228882, 1047.5914393386586, 1089.2701889733896, 1129.5199540195383, 1133.6089049277987, 13500.594982150355, 14028.22844743549, 14099.506517272051, 14244.145351278956, 14259.500917467838, 309232.0, 317002.0, 317296.0, 317851.0, 318061.0, 50435.24347134796, 50967.490325096274, 50974.49025509771, 51029.489705102475, 51142.74428627833, 1343.993280033613, 1353.9622867584224, 1377.738229736347, 1385.639733669233, 1388.5834249725042, 27160.456790864468, 28098.578521322605, 28216.29459263535, 28232.29419264535, 29076.0, 42753.14493710171, 42965.57034429616, 43115.353269701605, 43145.3528197071, 43152.35271470993, 199401.0, 396415.0, 397782.0, 400596.0, 402813.0, 30285.69714302917, 30977.690223098383, 30982.22544436317, 30992.22519437032, 31004.22489437782, 42508.78745606252, 42877.571224287356, 42983.140337193705, 43489.34765978449, 44136.33795493006, 35186.824065879504, 36059.45910811392, 36110.819445902605, 36288.0, 36311.636883630825, 32162.0, 32634.0, 32885.67114328826, 35060.824695876356, 35901.0, 31523.52714709327, 32390.190245243113, 32390.35219295648, 32423.189420264684, 32530.51204231891, 27647.30881727973, 28770.85614571914, 29707.851460742557, 32453.18867028343, 33302.17025042151, 22815.0, 23062.654060189445, 23154.3053708389, 23227.0, 23312.417189570395], "unit": "score", "name": "ext.html", "value": 18499.784191794322}, {"lowerIsBetter": false, "replicates": [353.16828868015824, 360.56191727051646, 361.317110660851, 363.07959323115904, 363.1466054771288, 13708.520201792915, 13856.445742170326, 16393.42623008195, 16461.917690411545, 17122.571935701628, 13328.40022199001, 13827.101238419496, 16426.67146657066, 16611.83388166118, 17269.481915542554, 5344.198370244465, 5468.9726551367185, 5472.20653005314, 5472.671639701631, 5473.0695781717, 5278.498542638463, 5379.220013098098, 5395.163749618796, 5402.91895621566, 5417.214503896933, 5323.893522129555, 5341.866453338659, 5348.491893270133, 5373.0, 5380.488853558905, 5218.947810521884, 5350.705711185883, 5354.625176237665, 5355.062863998784, 5359.356877174744, 4750.311204875274, 4751.619870410359, 4752.619790416758, 4759.78580963854, 4778.689385189951, 20134.0, 20274.5945081099, 20293.391198264075, 20486.18055277787, 20978.685319720218, 2111.3138230075288, 2158.600658878097, 2253.7182852143483, 2329.2546385156757, 2475.282168171228, 13118.344082795822, 13430.992675549373, 13439.932800336033, 13442.52951146715, 13753.449862005507, 1883.1902282018727, 1904.228787341129, 1971.8619696621242, 1999.1303782854504, 2003.889786061766, 47227.527724722655, 48784.26823597649, 48961.75519122417, 60033.39966600322, 62757.0, 9443.386179898285, 9677.90322096784, 9691.0, 9734.221262299141, 9777.706668799947, 12941.805872911726, 13013.934930325287, 13016.609501714964, 13020.283884386261, 13024.088313817942, 7557.659905304275, 7630.694772209161, 7635.389168866477, 7670.386369090459, 7676.040494938133, 7489.550626962399, 7528.021357223635, 7541.47209695327, 7549.396048316232, 7565.130010048915, 4170.666346692318, 4196.895077623084, 4222.535521092677, 4238.23711731885, 4257.148570285955, 1736.5398169485097, 1768.8673349498838, 1778.1376032624426, 1780.3234770787276, 1781.9041289606798, 837.821663674445, 853.117023880281, 1027.994860025695, 1039.18424037132, 1042.47876061969, 16629.25168367402, 16796.496105116865, 17156.571085722957, 17168.31326746941, 17280.13599320029, 860.2300940658201, 892.9508877011697, 906.1572737354323, 918.9399300329885, 954.6944977607099, 9569.760755981017, 9771.657991970247, 9852.45811480361, 9862.753431164278, 9873.259505537113, 504880.0, 514542.0, 519020.0, 544420.0, 549322.0, 75345.0, 78784.21215787884, 79049.60475197702, 79083.02292442735, 81336.59331703304, 1085.5060947269133, 1125.482278152043, 1154.468944285638, 1184.2184158455377, 1194.635636130971, 14793.482228122395, 14906.478273260384, 14919.104853708812, 14978.700425991201, 15393.076415415111, 26544.938202471683, 29874.701252987194, 31959.201019974687, 32115.67884321127, 32992.340153196325, 43221.567784323015, 43404.78297608492, 45115.0, 46288.0, 46324.53675463202, 9270.582823772811, 9307.162355388047, 9363.250939924927, 9457.38526995743, 9492.525373731423, 14624.780628290797, 17667.29330826804, 17742.733858992382, 17958.19188136563, 18427.53931151732, 14392.928035359757, 14449.711005779614, 14843.183624900734, 14883.181425021729, 14916.179610121548, 13676.31618419095, 13813.24027178515, 14182.503612373517, 15017.02389344689, 15038.6992260152, 12728.0, 12746.681332966378, 13045.152065115737, 13093.869061309266, 14273.286335683382, 8965.148310910454, 9099.49952752605, 9194.862077068716, 9302.488363140092, 9368.297377696836, 8972.327075469497, 9061.22979546746, 10141.543630536496, 13876.098053626481, 14245.358958847084], "unit": "score", "name": "jquery.html", "value": 8746.473411130417}, {"lowerIsBetter": false, "replicates": [1281.8718128187188, 1450.891183161263, 1499.145487072369, 1601.759736039594, 1722.5865792209866, 6436.549441539094, 7227.494075414723, 7437.405007599393, 7443.776686699408, 7444.404447644189, 7080.610566418845, 7245.67394467249, 7248.7462938797025, 7252.963735181317, 7255.963720181405, 1961.3625571689188, 1998.760148782141, 2202.2622421488823, 2226.6214743493565, 2268.4782500025003, 2253.853499522534, 2256.029907139929, 2258.0516183203094, 2259.8531095478743, 2261.852979556332, 2131.7015617813518, 2178.9891050544807, 2181.301983365324, 2182.0, 2186.0818456248335, 2208.194009186643, 2213.4687674958054, 2244.9438764030865, 2255.4474153832252, 2258.67249248858, 2207.569523942832, 2219.6226641470826, 2228.9554208915893, 2247.6516139998325, 2249.876256805875, 7442.7395041173295, 7524.962375188144, 7528.322450979438, 7532.058492688414, 7532.623368831537, 4415.381846541487, 4485.551444855521, 4497.302918047708, 4507.887302817423, 4519.661025423074, 2982.6719060903283, 3071.385722855438, 3104.627444706627, 3109.2226943264186, 3112.6264848218134, 1028.1825948371063, 1035.3735989726183, 1059.6291298045699, 1070.2882583082242, 1072.7318170457386, 9723.076307750824, 9826.213902887752, 9843.114119729187, 9844.803103937953, 9871.358361706538, 3909.4722212500947, 3979.3434083376496, 3993.4209539616595, 4001.899952501211, 4027.234825383168, 8382.07797142314, 8397.286230670461, 8435.662573496991, 8442.451240669337, 8461.238488535939, 4437.356583295468, 4442.244818380883, 4475.865724028285, 4477.977610111929, 4482.798274077674, 4093.4473846031, 4093.8771836844944, 4098.897527561775, 4101.794910254475, 4104.938425923614, 3187.729043031322, 3226.9838650806596, 3290.2925870937866, 3454.3264063507377, 3465.8267086645565, 1075.4676435164642, 1096.0957210301533, 1099.120703437247, 1099.8680158380885, 1102.3496137279044, 1023.5087158164123, 1085.9294145880651, 1281.6667666406802, 1290.045366428836, 1315.53298579005, 7068.823279417953, 7146.7141314346845, 7150.3922166615375, 7158.642067896584, 7176.569405835667, 1096.5010920031366, 1105.2926127278547, 1116.8883111688765, 1120.7254222715324, 1133.1557989298026, 5556.91664625031, 5700.600957932905, 5702.8289151325525, 5706.3722990471015, 5716.371199168088, 8670.479771213748, 8718.346124040723, 8936.0, 8945.73162805117, 8962.73111806647, 8741.825163496822, 8757.0, 8780.78048048791, 8847.601857916408, 8880.689175878813, 6839.931600684029, 6998.0, 7031.964840175869, 7079.619474202584, 7087.3267039631155, 6773.796786096425, 6779.93220067793, 6799.898001529882, 6802.115724955724, 6812.386885180357, 7761.61191940412, 7778.533288002738, 8015.799605009688, 8058.556779377191, 8071.556064416513, 7915.366770658448, 8066.516009039477, 8095.7166499172245, 8221.342292616457, 8248.46384984974, 6406.90389644165, 6621.33786621334, 6666.233383160805, 6679.265280819009, 6713.261541230363, 5995.640261584319, 6097.146399503984, 6747.055412242388, 6811.69347379379, 7131.964340178266, 6749.831254218684, 6848.3494068063455, 6868.107146070979, 6944.756933507303, 7019.543729657556, 6710.094137291599, 6713.295104014203, 6742.898856517254, 6847.691853866489, 6848.383645471931, 6648.867022659617, 6683.966580167068, 6694.29709880475, 6712.160979877515, 6718.0, 6161.630302181883, 6179.412955769195, 6215.533834962486, 6246.593971391845, 6256.0, 6082.4525792677105, 6098.0852872069545, 6115.266168059861, 6119.44924956756, 6124.418180272867], "unit": "score", "name": "mootools.html", "value": 4302.684063046435}, {"lowerIsBetter": false, "replicates": [323.332318761757, 325.3850223078381, 326.0902083187906, 329.2197491944092, 333.3982162197236, 5895.322037965635, 5935.436133567304, 5984.521238300926, 5994.040953447449, 6008.0, 5675.8581035474135, 5718.971405142979, 5790.420957904207, 5841.386654401291, 5871.148683440909, 4530.501644819084, 4539.773011349436, 4543.886402839922, 4559.726416415009, 4573.291139873317, 4337.913241735163, 4551.158035763395, 4558.814708175865, 4561.612262957653, 4564.201264778667, 4362.389265502832, 4427.579379958915, 4502.729836209822, 4527.071950250191, 4541.364209010741, 4498.977505112486, 4500.774961251925, 4514.796834142471, 4516.074204788043, 4523.932141017887, 3972.0864201233876, 3973.2450834341385, 3978.781167035812, 3979.920401591981, 3982.143839074584, 5530.225768392428, 5597.104463285855, 5597.160425936101, 5622.91565626516, 5623.49388555028, 5226.81706140287, 5227.242049902781, 5227.79088836446, 5232.9738351308, 5240.973795131038, 6184.165137706442, 6186.7525298987985, 6189.319174890758, 6190.0405437157315, 6196.907046394263, 4389.144116897206, 4392.494863090754, 4398.47218333802, 4408.382826404306, 4409.625181859546, 6261.655608941506, 6418.711157997855, 6426.8714625707225, 6438.742450302029, 6440.291567927524, 4497.415336006364, 4501.234790085693, 4502.0, 4503.437070366204, 4505.752183629932, 4525.117602067565, 4548.113117942035, 4556.840510582114, 4557.134144512532, 4561.429821272341, 5170.71561064145, 5217.7912883485, 5226.503482169188, 5226.712530810842, 5240.528352448222, 6161.8459538511, 6278.6546739929745, 6281.842953926097, 6282.120503129566, 6289.811305660837, 1597.0657165558046, 1614.9596260093592, 1618.0938674342406, 1618.1828176770891, 1619.7651340555553, 1060.5545670818274, 1064.4890452582804, 1068.1454836131063, 1074.0494662223832, 1085.6688709943385, 6006.819795406145, 6012.488938440281, 6027.849303767441, 6041.063635136561, 6041.305249896318, 6444.6133232005295, 6490.610563366213, 6509.056186852879, 6512.73949042033, 6516.837079073061, 5881.676507792027, 5915.3788852170765, 6015.759369625253, 6068.848278793065, 6093.2078829751845, 3515.3320869035315, 3527.365074286653, 3530.6645868642436, 3531.1525233943667, 3537.451694987281, 6646.4350530205475, 6656.8668626627195, 6665.166854143232, 6665.733370665216, 6668.166479190101, 6563.770268040691, 6699.39705426514, 6704.2625311215725, 6706.161729783777, 6712.865742685119, 6638.004299355039, 6644.83387915306, 6646.069550262967, 6647.900281495781, 6681.732730690718, 6550.984597387413, 6551.967240163769, 6553.868922621617, 6554.770583029571, 6558.508111891531, 6323.462505687068, 6468.741250350122, 6469.676516174079, 6470.320616335405, 6481.254655714653, 6635.867282654223, 6640.369164929324, 6640.535162538576, 6640.601563906181, 6641.26946035926, 4486.910261794811, 4488.730676159441, 4491.887702807456, 4494.056248187917, 4495.932561011522, 6388.648624325707, 6533.248676402274, 6533.314002029719, 6540.542162048611, 6542.869142617026, 6347.270063942706, 6360.77737279193, 6364.904526432199, 6366.29970703213, 6370.554061215856, 6300.0, 6313.589616674902, 6348.0, 6349.841253968688, 6350.555461117862, 6068.908966365596, 6187.350328215653, 6214.471769899609, 6229.3770622939155, 6264.498840092872, 6391.105245265573, 6399.968000159969, 6402.231732191981, 6404.135441715495, 6405.647689377129, 6199.380061993765, 6228.937710622836, 6251.249850017845, 6255.124282600348, 6259.029850373199], "unit": "score", "name": "prototype.html", "value": 4744.194538652341}, {"lowerIsBetter": false, "replicates": [685.2530741491773, 764.3159372361737, 790.996045019775, 821.761689110158, 854.6026097864492, 13809.723805523896, 14018.0, 14023.649408764786, 14025.298735063245, 14037.859621403783, 12925.159864608793, 12983.545575904845, 13001.479940802381, 13022.0, 13033.608991730263, 669.822497038284, 676.2392308652766, 677.43434232416, 679.8844196486609, 814.340384288728, 825.9174082591722, 832.5213002523543, 834.1116710703112, 834.1491678487939, 836.4437648963462, 848.495145388496, 853.0914575976597, 858.3991206155684, 859.9011113721908, 860.1441565642194, 707.2503146664501, 716.9103862017248, 858.120426562775, 859.9914000860006, 860.8708693695933, 609.3388673289486, 626.1609443345939, 626.8996960486346, 627.3882964110002, 627.4980015987237, 13455.0, 13695.794563081561, 13698.863011369858, 13703.177809331472, 13711.862881371258, 11833.467493962793, 12221.877781222252, 12277.877221227764, 12490.250584964931, 13263.204207747565, 10242.846357304647, 10442.164626829835, 10634.680959571226, 10773.353598784099, 10819.567217311298, 3619.402798538238, 3639.0720366306687, 3643.8724644637578, 3662.7985460799914, 3786.2616789726017, 46028.53971460276, 46112.5388746115, 46182.0, 46268.76865615684, 46722.5327746725, 10310.536025878853, 10335.17318614509, 10379.11777498906, 10560.947195263974, 10630.20273479492, 19097.0, 19262.133204005855, 19294.614107717767, 19295.228190872207, 19295.324663636704, 7643.464957452925, 7809.180036096128, 7830.882536761953, 7953.920460795433, 8018.719344822904, 4368.7815609219415, 4414.933775993362, 4447.132809102259, 4448.466184057869, 4484.080763443486, 3076.923076923095, 3097.535369694519, 3098.1170366445454, 3098.2254436390904, 3102.5811515445125, 555.2615022020702, 562.1062510608152, 563.3268244447845, 567.8580354911272, 575.8646718021262, 467.2990514228657, 567.3617180671745, 607.3156647617541, 628.2617923939353, 630.8612105336819, 8289.253967142866, 8310.750677479686, 8313.501189928502, 8362.54006029662, 8367.0, 515.8942416804546, 614.9784757533465, 667.4260136282793, 672.0993868216614, 708.9964550177319, 3778.301014312361, 3792.6586607205486, 3806.200697853482, 3846.480725102075, 4023.75857448554, 51458.742706286226, 54869.72565137149, 54870.0, 55005.44994550083, 55341.169882451795, 42042.57957420448, 46239.30641040387, 47137.29294060592, 47347.053058938625, 47595.76202119036, 43704.56295437005, 44252.3362149568, 44479.0, 44887.55112448899, 45205.77397112994, 8332.583370831555, 8413.579321034047, 8466.534340611326, 8515.27620152294, 8607.741767746978, 34501.65498345085, 34615.65384346225, 35036.12409689778, 35192.0, 35210.647893520734, 41249.587504125775, 41738.16523669449, 43380.202840162856, 43533.0, 43986.56013439953, 9999.650012249536, 10255.794884102126, 10271.845922311022, 10423.791524169323, 10496.055355018085, 11703.414829258332, 11826.940865295963, 11888.881111188777, 11994.220375675553, 12412.317322546985, 11053.447327633747, 11303.717407064889, 11381.487833047699, 11478.426078696199, 11862.762744745229, 11106.722331941766, 11279.266847654877, 11532.308061516, 11834.11244156709, 11958.282503049497, 10237.0, 10525.631602893862, 10623.0, 10747.89252107469, 10990.120790336914, 9436.575354108943, 9441.291903107158, 9724.222062235145, 9730.562124704264, 10009.74975625586, 8801.559922004002, 8803.911960880308, 9520.143187113194, 9520.619175232912, 9563.330566860532], "unit": "score", "name": "yui.html", "value": 6204.085423372635}], "name": "dromaeo_css", "value": 6888.6879684907735}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 109.0, 110.0, 110.0, 100.0, 112.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 122.0, 163.0, 159.0, 134.0, 152.0, 160.0, 126.0, 160.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 163.0, 161.0, 162.0, 160.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 89.0, 71.0, 72.0, 72.0, 98.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 141.0, 93.0, 93.0, 94.0, 136.0, 93.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 56.0, 61.0, 56.0, 57.0, 66.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 67.0, 66.0, 68.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 92.0, 83.0, 84.0, 85.0, 88.0, 87.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 117.0, 114.0, 121.0, 119.0, 116.0, 124.0, 115.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [158.0, 152.0, 152.0, 153.0, 157.0, 152.0, 154.0, 153.0, 156.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1503.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1951.2670565302144], "unit": "score", "name": "RayTrace", "value": 379.23512187812196}, {"lowerIsBetter": false, "replicates": [762.1951219512196], "unit": "score", "name": "Earley", "value": 874.3994559999996}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [603.4793041391722], "unit": "score", "name": "Splay", "value": 135.0352852882704}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 19990.334425961075}]} 07:10:46 INFO - RETURN: dromaeo_css: 6888.69 07:10:46 INFO - RETURN: kraken: 1503.60 07:10:46 INFO - RETURN: v8_7: 19990.33 07:10:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19990.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1503.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6888.69"}}} 07:10:46 INFO - Return code: 0 07:10:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:46 ERROR - # TBPL SUCCESS # 07:10:46 INFO - Running post-action listener: _resource_record_post_action 07:10:46 INFO - Running post-run listener: _resource_record_post_run 07:10:47 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554602496; Read time: 8; Write time: 504432 07:10:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245534720; Read time: 0; Write time: 293588 07:10:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308781056; Read time: 8; Write time: 210820 07:10:47 INFO - Running post-run listener: _upload_blobber_files 07:10:47 INFO - Blob upload gear active. 07:10:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:10:47 INFO - Copying logs to upload dir... 07:10:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.636250 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-18 07:10:46.617022) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 07:10:46.620428) ========= 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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010020 build_url: 'https://queue.taskcluster.net/v1/task/31dStQReQqqHyEY42aioMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 07:10:46.671120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:10:46.671451) ========= 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=3e14eba40af1795cf0357910000001c3-1450446738.279400-1582178517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:10:46.720907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 07:10:46.721247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 07:10:46.721560) ========= ========= Total master_lag: 0.22 =========