builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1450407148.93 results: success (0) buildid: 20151217163007 builduid: be6ffaff701a490eaa3452aa84d0e90d revision: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:28.929008) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:28.929398) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:28.929695) ========= 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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006157 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:28.952459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:28.952739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:28.983363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:28.983754) ========= 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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022013 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.031466) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.031781) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.032205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.032515) ========= 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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 18:52:29-- 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% 221M=0s 2015-12-17 18:52:29 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191647 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.236507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.236828) ========= 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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.066085 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.315256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.315652) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66fb852962c0d5f6f5fe0604204da4f5d17763c9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 66fb852962c0d5f6f5fe0604204da4f5d17763c9 --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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 18:52:29,530 truncating revision to first 12 chars 2015-12-17 18:52:29,530 Setting DEBUG logging. 2015-12-17 18:52:29,530 attempt 1/10 2015-12-17 18:52:29,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66fb852962c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 18:52:29,786 unpacking tar archive at: mozilla-central-66fb852962c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.855150) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.855471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.865089) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.865349) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 18:52:29.865745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-17 18:52:29.866045) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:52:30 INFO - MultiFileLogger online at 20151217 18:52:30 in /builds/slave/test-pgo 18:52:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:52:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:52:30 INFO - {'append_to_log': False, 18:52:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:52:30 INFO - 'blob_upload_branch': 'Firefox', 18:52:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:52:30 INFO - 'branch': 'Firefox', 18:52:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:52:30 INFO - 'config_files': ('talos/linux_config.py',), 18:52:30 INFO - 'default_actions': ('clobber', 18:52:30 INFO - 'read-buildbot-config', 18:52:30 INFO - 'download-and-extract', 18:52:30 INFO - 'populate-webroot', 18:52:30 INFO - 'create-virtualenv', 18:52:30 INFO - 'install', 18:52:30 INFO - 'run-tests'), 18:52:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:52:30 INFO - 'download_minidump_stackwalk': True, 18:52:30 INFO - 'download_symbols': 'ondemand', 18:52:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:52:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:52:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:52:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:52:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:52:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:52:30 INFO - 'installer_path': 'installer.exe', 18:52:30 INFO - 'log_level': 'info', 18:52:30 INFO - 'log_name': 'talos', 18:52:30 INFO - 'log_to_console': True, 18:52:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:52:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:52:30 INFO - 'opt_config_files': (), 18:52:30 INFO - 'pip_index': False, 18:52:30 INFO - 'sps_profile': False, 18:52:30 INFO - 'sps_profile_interval': 0, 18:52:30 INFO - 'suite': 'dromaeojs', 18:52:30 INFO - 'system_bits': '64', 18:52:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:52:30 INFO - 'title': 'talos-linux64-ix-028', 18:52:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:52:30 INFO - 'use_talos_json': True, 18:52:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:52:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:52:30 INFO - 'work_dir': 'build'} 18:52:30 INFO - ##### 18:52:30 INFO - ##### Running clobber step. 18:52:30 INFO - ##### 18:52:30 INFO - Running pre-action listener: _resource_record_pre_action 18:52:30 INFO - Running main action method: clobber 18:52:30 INFO - rmtree: /builds/slave/test-pgo/build 18:52:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:52:31 INFO - Running post-action listener: _resource_record_post_action 18:52:31 INFO - ##### 18:52:31 INFO - ##### Running read-buildbot-config step. 18:52:31 INFO - ##### 18:52:31 INFO - Running pre-action listener: _resource_record_pre_action 18:52:31 INFO - Running main action method: read_buildbot_config 18:52:31 INFO - Using buildbot properties: 18:52:31 INFO - { 18:52:31 INFO - "project": "", 18:52:31 INFO - "product": "firefox", 18:52:31 INFO - "script_repo_revision": "production", 18:52:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:52:31 INFO - "repository": "", 18:52:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:52:31 INFO - "buildid": "20151217163007", 18:52:31 INFO - "pgo_build": "True", 18:52:31 INFO - "basedir": "/builds/slave/test-pgo", 18:52:31 INFO - "buildnumber": 143, 18:52:31 INFO - "slavename": "talos-linux64-ix-028", 18:52:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:52:31 INFO - "platform": "ubuntu64_hw", 18:52:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:52:31 INFO - "branch": "mozilla-central", 18:52:31 INFO - "repo_path": "mozilla-central", 18:52:31 INFO - "revision": "66fb852962c0d5f6f5fe0604204da4f5d17763c9", 18:52:31 INFO - "stage_platform": "linux64-pgo", 18:52:31 INFO - "builduid": "be6ffaff701a490eaa3452aa84d0e90d", 18:52:31 INFO - "slavebuilddir": "test" 18:52:31 INFO - } 18:52:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:52:31 INFO - Running post-action listener: _resource_record_post_action 18:52:31 INFO - ##### 18:52:31 INFO - ##### Running download-and-extract step. 18:52:31 INFO - ##### 18:52:31 INFO - Running pre-action listener: _resource_record_pre_action 18:52:31 INFO - Running main action method: download_and_extract 18:52:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:31 INFO - https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/test_packages.json 18:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/test_packages.json 18:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:52:32 INFO - Downloaded 1302 bytes. 18:52:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:52:32 INFO - Using the following test package requirements: 18:52:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:52:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:52:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:52:32 INFO - u'jsshell-linux-x86_64.zip'], 18:52:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:52:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:52:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:52:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:52:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:52:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:52:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:52:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:52:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:32 INFO - https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:33 INFO - Downloaded 23120769 bytes. 18:52:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:52:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:52:34 INFO - Return code: 0 18:52:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:34 INFO - https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:52:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:36 INFO - Downloaded 23120769 bytes. 18:52:36 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 18:52:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:52:36 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 18:52:37 INFO - Return code: 0 18:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:37 INFO - https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:38 INFO - Downloaded 11132039 bytes. 18:52:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:52:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:52:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:52:38 INFO - Return code: 0 18:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:38 INFO - https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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 18:52:40 INFO - Downloaded 54637639 bytes. 18:52:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:40 INFO - mkdir: /builds/slave/test-pgo/properties 18:52:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:52:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:52:40 INFO - Contents: 18:52:40 INFO - build_url:https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:52:40 INFO - Running post-action listener: _resource_record_post_action 18:52:40 INFO - Running post-action listener: set_extra_try_arguments 18:52:40 INFO - ##### 18:52:40 INFO - ##### Running populate-webroot step. 18:52:40 INFO - ##### 18:52:40 INFO - Running pre-action listener: _resource_record_pre_action 18:52:40 INFO - Running main action method: populate_webroot 18:52:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:52:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:52:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:52:40 INFO - '--tppagecycles', 18:52:40 INFO - '7'], 18:52:40 INFO - 'tests': ['tsvgm']}}, 18:52:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:52:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:52:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:52:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:52:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'tests': ['damp', 'tps']}, 18:52:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['damp', 'tps']}, 18:52:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:52:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:52:40 INFO - 'other': {'tests': ['a11yr', 18:52:40 INFO - 'ts_paint', 18:52:40 INFO - 'tpaint', 18:52:40 INFO - 'sessionrestore', 18:52:40 INFO - 'sessionrestore_no_auto_restore']}, 18:52:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['a11yr', 18:52:40 INFO - 'ts_paint', 18:52:40 INFO - 'tpaint', 18:52:40 INFO - 'sessionrestore', 18:52:40 INFO - 'sessionrestore_no_auto_restore']}, 18:52:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['a11yr', 18:52:40 INFO - 'ts_paint', 18:52:40 INFO - 'tpaint', 18:52:40 INFO - 'sessionrestore', 18:52:40 INFO - 'sessionrestore_no_auto_restore']}, 18:52:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['a11yr', 18:52:40 INFO - 'ts_paint', 18:52:40 INFO - 'tpaint', 18:52:40 INFO - 'sessionrestore', 18:52:40 INFO - 'sessionrestore_no_auto_restore']}, 18:52:40 INFO - 'other_l64': {'tests': ['a11yr', 18:52:40 INFO - 'ts_paint', 18:52:40 INFO - 'tpaint', 18:52:40 INFO - 'sessionrestore', 18:52:40 INFO - 'sessionrestore_no_auto_restore']}, 18:52:40 INFO - 'other_nol64': {'tests': ['a11yr', 18:52:40 INFO - 'ts_paint', 18:52:40 INFO - 'tpaint', 18:52:40 INFO - 'sessionrestore', 18:52:40 INFO - 'sessionrestore_no_auto_restore']}, 18:52:40 INFO - 'svgr': {'tests': ['tsvgx', 18:52:40 INFO - 'tsvgr_opacity', 18:52:40 INFO - 'tart', 18:52:40 INFO - 'tscrollx', 18:52:40 INFO - 'cart']}, 18:52:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['tsvgx', 18:52:40 INFO - 'tsvgr_opacity', 18:52:40 INFO - 'tart', 18:52:40 INFO - 'tscrollx', 18:52:40 INFO - 'cart']}, 18:52:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'tests': ['tp5o']}, 18:52:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'talos_options': ['--e10s'], 18:52:40 INFO - 'tests': ['tp5o']}, 18:52:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'talos_options': ['--xperf_path', 18:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:40 INFO - 'tests': ['tp5n']}, 18:52:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:40 INFO - 'talos_options': ['--e10s', 18:52:40 INFO - '--xperf_path', 18:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:40 INFO - 'tests': ['tp5n']}}, 18:52:40 INFO - 'talos.zip': {'path': '', 18:52:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:52:40 INFO - Running post-action listener: _resource_record_post_action 18:52:40 INFO - ##### 18:52:40 INFO - ##### Running create-virtualenv step. 18:52:40 INFO - ##### 18:52:40 INFO - Running pre-action listener: _resource_record_pre_action 18:52:40 INFO - Running main action method: create_virtualenv 18:52:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:52:40 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 18:52:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:52:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:52:40 INFO - Using real prefix '/usr' 18:52:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:52:40 INFO - Installing distribute.............................................................................................................................................................................................done. 18:52:42 INFO - Installing pip.................done. 18:52:42 INFO - Return code: 0 18:52:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:52:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:52:42 INFO - Using env: {'DISPLAY': ':0', 18:52:42 INFO - 'HOME': '/home/cltbld', 18:52:42 INFO - 'LANG': 'en_US.UTF-8', 18:52:42 INFO - 'LANGUAGE': 'en_US:en', 18:52:42 INFO - 'LOGNAME': 'cltbld', 18:52:42 INFO - 'MAIL': '/var/mail/cltbld', 18:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:42 INFO - 'MOZ_NO_REMOTE': '1', 18:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:42 INFO - 'NO_EM_RESTART': '1', 18:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:42 INFO - 'SHELL': '/bin/bash', 18:52:42 INFO - 'SHLVL': '1', 18:52:42 INFO - 'TERM': 'linux', 18:52:42 INFO - 'TMOUT': '86400', 18:52:42 INFO - 'USER': 'cltbld', 18:52:42 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:42 INFO - '_': '/tools/buildbot/bin/python'} 18:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:52:42 INFO - Cleaning up... 18:52:42 INFO - Return code: 0 18:52:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:52:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:52:42 INFO - Using env: {'DISPLAY': ':0', 18:52:42 INFO - 'HOME': '/home/cltbld', 18:52:42 INFO - 'LANG': 'en_US.UTF-8', 18:52:42 INFO - 'LANGUAGE': 'en_US:en', 18:52:42 INFO - 'LOGNAME': 'cltbld', 18:52:42 INFO - 'MAIL': '/var/mail/cltbld', 18:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:42 INFO - 'MOZ_NO_REMOTE': '1', 18:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:42 INFO - 'NO_EM_RESTART': '1', 18:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:42 INFO - 'SHELL': '/bin/bash', 18:52:42 INFO - 'SHLVL': '1', 18:52:42 INFO - 'TERM': 'linux', 18:52:42 INFO - 'TMOUT': '86400', 18:52:42 INFO - 'USER': 'cltbld', 18:52:42 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:42 INFO - '_': '/tools/buildbot/bin/python'} 18:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:43 INFO - Downloading/unpacking psutil>=0.7.1 18:52:43 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 18:52:43 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 18:52:43 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 18:52:43 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 18:52:43 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 18:52:43 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 18:52:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:52:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:52:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:44 INFO - Installing collected packages: psutil 18:52:44 INFO - Running setup.py install for psutil 18:52:44 INFO - building 'psutil._psutil_linux' extension 18:52:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:52:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:52:45 INFO - building 'psutil._psutil_posix' extension 18:52:45 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 18:52:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:52:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:45 INFO - Successfully installed psutil 18:52:45 INFO - Cleaning up... 18:52:45 INFO - Return code: 0 18:52:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:52:45 INFO - Using env: {'DISPLAY': ':0', 18:52:45 INFO - 'HOME': '/home/cltbld', 18:52:45 INFO - 'LANG': 'en_US.UTF-8', 18:52:45 INFO - 'LANGUAGE': 'en_US:en', 18:52:45 INFO - 'LOGNAME': 'cltbld', 18:52:45 INFO - 'MAIL': '/var/mail/cltbld', 18:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:45 INFO - 'MOZ_NO_REMOTE': '1', 18:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:45 INFO - 'NO_EM_RESTART': '1', 18:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:45 INFO - 'SHELL': '/bin/bash', 18:52:45 INFO - 'SHLVL': '1', 18:52:45 INFO - 'TERM': 'linux', 18:52:45 INFO - 'TMOUT': '86400', 18:52:45 INFO - 'USER': 'cltbld', 18:52:45 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:45 INFO - '_': '/tools/buildbot/bin/python'} 18:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:52:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:52:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:52:47 INFO - Installing collected packages: mozsystemmonitor 18:52:47 INFO - Running setup.py install for mozsystemmonitor 18:52:47 INFO - Successfully installed mozsystemmonitor 18:52:47 INFO - Cleaning up... 18:52:47 INFO - Return code: 0 18:52:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:52:47 INFO - Using env: {'DISPLAY': ':0', 18:52:47 INFO - 'HOME': '/home/cltbld', 18:52:47 INFO - 'LANG': 'en_US.UTF-8', 18:52:47 INFO - 'LANGUAGE': 'en_US:en', 18:52:47 INFO - 'LOGNAME': 'cltbld', 18:52:47 INFO - 'MAIL': '/var/mail/cltbld', 18:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:47 INFO - 'MOZ_NO_REMOTE': '1', 18:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:47 INFO - 'NO_EM_RESTART': '1', 18:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:47 INFO - 'SHELL': '/bin/bash', 18:52:47 INFO - 'SHLVL': '1', 18:52:47 INFO - 'TERM': 'linux', 18:52:47 INFO - 'TMOUT': '86400', 18:52:47 INFO - 'USER': 'cltbld', 18:52:47 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:47 INFO - '_': '/tools/buildbot/bin/python'} 18:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:52:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:50 INFO - Downloading docopt-0.6.1.tar.gz 18:52:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:52:50 INFO - Installing collected packages: blobuploader, requests, docopt 18:52:50 INFO - Running setup.py install for blobuploader 18:52:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:52:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:52:50 INFO - Running setup.py install for requests 18:52:50 INFO - Running setup.py install for docopt 18:52:50 INFO - Successfully installed blobuploader requests docopt 18:52:50 INFO - Cleaning up... 18:52:50 INFO - Return code: 0 18:52:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:52:50 INFO - Using env: {'DISPLAY': ':0', 18:52:50 INFO - 'HOME': '/home/cltbld', 18:52:50 INFO - 'LANG': 'en_US.UTF-8', 18:52:50 INFO - 'LANGUAGE': 'en_US:en', 18:52:50 INFO - 'LOGNAME': 'cltbld', 18:52:50 INFO - 'MAIL': '/var/mail/cltbld', 18:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:50 INFO - 'MOZ_NO_REMOTE': '1', 18:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:50 INFO - 'NO_EM_RESTART': '1', 18:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:50 INFO - 'SHELL': '/bin/bash', 18:52:50 INFO - 'SHLVL': '1', 18:52:50 INFO - 'TERM': 'linux', 18:52:50 INFO - 'TMOUT': '86400', 18:52:50 INFO - 'USER': 'cltbld', 18:52:50 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:50 INFO - '_': '/tools/buildbot/bin/python'} 18:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:52:50 INFO - Running setup.py (path:/tmp/pip-yD5RCn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:52:50 INFO - Running setup.py (path:/tmp/pip-y8pjGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:52:51 INFO - Running setup.py (path:/tmp/pip-ZZWBs0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:52:51 INFO - Running setup.py (path:/tmp/pip-IsP_sM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:52:51 INFO - Running setup.py (path:/tmp/pip-iX9gyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:52:51 INFO - Running setup.py (path:/tmp/pip-w_aiDx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:52:51 INFO - Running setup.py (path:/tmp/pip-MiV4fK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:52:51 INFO - Running setup.py (path:/tmp/pip-JgsyI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:52:51 INFO - Running setup.py (path:/tmp/pip-ipw5Ie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:52:51 INFO - Running setup.py (path:/tmp/pip-CxJ9eT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:52:51 INFO - Running setup.py (path:/tmp/pip-7TvOx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:52:51 INFO - Running setup.py (path:/tmp/pip-IAnZns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:52:51 INFO - Running setup.py (path:/tmp/pip-4LIMtL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:52:51 INFO - Running setup.py (path:/tmp/pip-U3dBkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:52:51 INFO - Running setup.py (path:/tmp/pip-CBE3K8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:52:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:52:52 INFO - Running setup.py (path:/tmp/pip-FM9n6h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:52:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:52:52 INFO - Running setup.py (path:/tmp/pip-ky5KTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:52:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:52:52 INFO - Running setup.py install for manifestparser 18:52:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Running setup.py install for mozcrash 18:52:52 INFO - Running setup.py install for mozdebug 18:52:52 INFO - Running setup.py install for mozdevice 18:52:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Running setup.py install for mozfile 18:52:52 INFO - Running setup.py install for mozhttpd 18:52:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Running setup.py install for mozinfo 18:52:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Running setup.py install for mozInstall 18:52:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:52:52 INFO - Running setup.py install for mozleak 18:52:53 INFO - Running setup.py install for mozlog 18:52:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:52:53 INFO - Running setup.py install for moznetwork 18:52:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:52:53 INFO - Running setup.py install for mozprocess 18:52:53 INFO - Running setup.py install for mozprofile 18:52:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:52:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:52:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:52:53 INFO - Running setup.py install for mozrunner 18:52:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:52:53 INFO - Running setup.py install for mozscreenshot 18:52:53 INFO - Running setup.py install for moztest 18:52:53 INFO - Running setup.py install for mozversion 18:52:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:52:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:52:53 INFO - Cleaning up... 18:52:53 INFO - Return code: 0 18:52:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:52:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:52:53 INFO - Using env: {'DISPLAY': ':0', 18:52:53 INFO - 'HOME': '/home/cltbld', 18:52:53 INFO - 'LANG': 'en_US.UTF-8', 18:52:53 INFO - 'LANGUAGE': 'en_US:en', 18:52:53 INFO - 'LOGNAME': 'cltbld', 18:52:53 INFO - 'MAIL': '/var/mail/cltbld', 18:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:53 INFO - 'MOZ_NO_REMOTE': '1', 18:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:53 INFO - 'NO_EM_RESTART': '1', 18:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:53 INFO - 'SHELL': '/bin/bash', 18:52:53 INFO - 'SHLVL': '1', 18:52:53 INFO - 'TERM': 'linux', 18:52:53 INFO - 'TMOUT': '86400', 18:52:53 INFO - 'USER': 'cltbld', 18:52:53 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:53 INFO - '_': '/tools/buildbot/bin/python'} 18:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:52:54 INFO - Running setup.py (path:/tmp/pip-cH3lN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:52:54 INFO - Running setup.py (path:/tmp/pip-Ov621i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:52:54 INFO - Running setup.py (path:/tmp/pip-_Jfzd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:52:54 INFO - Running setup.py (path:/tmp/pip-1ZOgOV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:52:54 INFO - Running setup.py (path:/tmp/pip-uou_ff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:52:54 INFO - Running setup.py (path:/tmp/pip-kth_CL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:52:54 INFO - Running setup.py (path:/tmp/pip-deWElN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:52:54 INFO - Running setup.py (path:/tmp/pip-8FlqBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:52:54 INFO - Running setup.py (path:/tmp/pip-Qj6lLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:52:54 INFO - Running setup.py (path:/tmp/pip-UA8Gzv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:52:54 INFO - Running setup.py (path:/tmp/pip-Ghthpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:52:54 INFO - Running setup.py (path:/tmp/pip-3DpSe9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:52:55 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)) 18:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:52:55 INFO - Running setup.py (path:/tmp/pip-JpyYY1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:52:55 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)) 18:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:52:55 INFO - Running setup.py (path:/tmp/pip-b4lhtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:52:55 INFO - Running setup.py (path:/tmp/pip-AodNcP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:52:55 INFO - Running setup.py (path:/tmp/pip-nvOf3L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:52:55 INFO - Running setup.py (path:/tmp/pip-8aHLLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:57 INFO - Downloading blessings-1.5.1.tar.gz 18:52:57 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 18:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:52:57 INFO - Installing collected packages: blessings 18:52:57 INFO - Running setup.py install for blessings 18:52:57 INFO - Successfully installed blessings 18:52:57 INFO - Cleaning up... 18:52:57 INFO - Return code: 0 18:52:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:52:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:52:57 INFO - Reading from file tmpfile_stdout 18:52:57 INFO - Current package versions: 18:52:57 INFO - argparse == 1.2.1 18:52:57 INFO - blessings == 1.5.1 18:52:57 INFO - blobuploader == 1.2.4 18:52:57 INFO - docopt == 0.6.1 18:52:57 INFO - manifestparser == 1.1 18:52:57 INFO - mozInstall == 1.12 18:52:57 INFO - mozcrash == 0.16 18:52:57 INFO - mozdebug == 0.1 18:52:57 INFO - mozdevice == 0.47 18:52:57 INFO - mozfile == 1.2 18:52:57 INFO - mozhttpd == 0.7 18:52:57 INFO - mozinfo == 0.9 18:52:57 INFO - mozleak == 0.1 18:52:57 INFO - mozlog == 3.1 18:52:57 INFO - moznetwork == 0.27 18:52:57 INFO - mozprocess == 0.22 18:52:57 INFO - mozprofile == 0.27 18:52:57 INFO - mozrunner == 6.11 18:52:57 INFO - mozscreenshot == 0.1 18:52:57 INFO - mozsystemmonitor == 0.0 18:52:57 INFO - moztest == 0.7 18:52:57 INFO - mozversion == 1.4 18:52:57 INFO - psutil == 3.1.1 18:52:57 INFO - requests == 1.2.3 18:52:57 INFO - wsgiref == 0.1.2 18:52:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:52: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')]} 18:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52: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')]} 18:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:52:57 INFO - Using env: {'DISPLAY': ':0', 18:52:57 INFO - 'HOME': '/home/cltbld', 18:52:57 INFO - 'LANG': 'en_US.UTF-8', 18:52:57 INFO - 'LANGUAGE': 'en_US:en', 18:52:57 INFO - 'LOGNAME': 'cltbld', 18:52:57 INFO - 'MAIL': '/var/mail/cltbld', 18:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:57 INFO - 'MOZ_NO_REMOTE': '1', 18:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:57 INFO - 'NO_EM_RESTART': '1', 18:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:57 INFO - 'SHELL': '/bin/bash', 18:52:57 INFO - 'SHLVL': '1', 18:52:57 INFO - 'TERM': 'linux', 18:52:57 INFO - 'TMOUT': '86400', 18:52:57 INFO - 'USER': 'cltbld', 18:52:57 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:57 INFO - '_': '/tools/buildbot/bin/python'} 18:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:52:57 INFO - Cleaning up... 18:52:57 INFO - Return code: 0 18:52:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:52: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')]} 18:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52: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')]} 18:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:52:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:52:57 INFO - Using env: {'DISPLAY': ':0', 18:52:57 INFO - 'HOME': '/home/cltbld', 18:52:57 INFO - 'LANG': 'en_US.UTF-8', 18:52:57 INFO - 'LANGUAGE': 'en_US:en', 18:52:57 INFO - 'LOGNAME': 'cltbld', 18:52:57 INFO - 'MAIL': '/var/mail/cltbld', 18:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:57 INFO - 'MOZ_NO_REMOTE': '1', 18:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:57 INFO - 'NO_EM_RESTART': '1', 18:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:57 INFO - 'SHELL': '/bin/bash', 18:52:57 INFO - 'SHLVL': '1', 18:52:57 INFO - 'TERM': 'linux', 18:52:57 INFO - 'TMOUT': '86400', 18:52:57 INFO - 'USER': 'cltbld', 18:52:57 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:57 INFO - '_': '/tools/buildbot/bin/python'} 18:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:57 INFO - Downloading/unpacking jsonschema 18:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:52:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:52:59 INFO - Downloading/unpacking functools32 (from jsonschema) 18:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:59 INFO - Downloading functools32-3.2.3-2.tar.gz 18:52:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:52:59 INFO - warning: no files found matching '*.txt' 18:52:59 INFO - no previously-included directories found matching 'build' 18:52:59 INFO - no previously-included directories found matching 'dist' 18:52:59 INFO - no previously-included directories found matching '.git*' 18:52:59 INFO - Installing collected packages: jsonschema, functools32 18:52:59 INFO - Running setup.py install for functools32 18:52:59 INFO - warning: no files found matching '*.txt' 18:52:59 INFO - no previously-included directories found matching 'build' 18:52:59 INFO - no previously-included directories found matching 'dist' 18:52:59 INFO - no previously-included directories found matching '.git*' 18:53:00 INFO - Successfully installed jsonschema functools32 18:53:00 INFO - Cleaning up... 18:53:00 INFO - Return code: 0 18:53:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc649a9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27650e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, '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': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', '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 18:53:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:53:00 INFO - Using env: {'DISPLAY': ':0', 18:53:00 INFO - 'HOME': '/home/cltbld', 18:53:00 INFO - 'LANG': 'en_US.UTF-8', 18:53:00 INFO - 'LANGUAGE': 'en_US:en', 18:53:00 INFO - 'LOGNAME': 'cltbld', 18:53:00 INFO - 'MAIL': '/var/mail/cltbld', 18:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:00 INFO - 'MOZ_NO_REMOTE': '1', 18:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:00 INFO - 'NO_EM_RESTART': '1', 18:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:00 INFO - 'SHELL': '/bin/bash', 18:53:00 INFO - 'SHLVL': '1', 18:53:00 INFO - 'TERM': 'linux', 18:53:00 INFO - 'TMOUT': '86400', 18:53:00 INFO - 'USER': 'cltbld', 18:53:00 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:00 INFO - '_': '/tools/buildbot/bin/python'} 18:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:00 INFO - Downloading/unpacking flake8 18:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:53:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:53:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:53:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:53:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:53:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:53:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:53:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:53:02 INFO - no previously-included directories found matching 'docs/_build' 18:53:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:53:02 INFO - Running setup.py install for pep8 18:53:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:53:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:53:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:53:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:53:02 INFO - no previously-included directories found matching 'docs/_build' 18:53:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:53:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:53:02 INFO - Cleaning up... 18:53:02 INFO - Return code: 0 18:53:02 INFO - Running post-action listener: _resource_record_post_action 18:53:02 INFO - Running post-action listener: _start_resource_monitoring 18:53:02 INFO - Starting resource monitoring. 18:53:02 INFO - ##### 18:53:02 INFO - ##### Running install step. 18:53:02 INFO - ##### 18:53:02 INFO - Running pre-action listener: _resource_record_pre_action 18:53:02 INFO - Running main action method: install 18:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:53:03 INFO - Reading from file tmpfile_stdout 18:53:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:53:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:53:03 INFO - Reading from file tmpfile_stdout 18:53:03 INFO - Output received: 18:53:03 INFO - Usage: mozinstall [options] installer 18:53:03 INFO - Options: 18:53:03 INFO - -h, --help show this help message and exit 18:53:03 INFO - -d DEST, --destination=DEST 18:53:03 INFO - Directory to install application into. [default: 18:53:03 INFO - "/builds/slave/test-pgo"] 18:53:03 INFO - --app=APP Application being installed. [default: firefox] 18:53:03 INFO - mkdir: /builds/slave/test-pgo/build/application 18:53:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:53:18 INFO - Reading from file tmpfile_stdout 18:53:18 INFO - Output received: 18:53:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:53:18 INFO - Running post-action listener: _resource_record_post_action 18:53:18 INFO - ##### 18:53:18 INFO - ##### Running run-tests step. 18:53:18 INFO - ##### 18:53:18 INFO - Running pre-action listener: _resource_record_pre_action 18:53:18 INFO - Running main action method: run_tests 18:53:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:53:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:53:18 INFO - Python 2.7.3 18:53:18 INFO - Return code: 0 18:53:18 INFO - grabbing minidump binary from tooltool 18:53:18 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')]} 18:53:18 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 0x27f3e30>, '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 0x27f4d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f51c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:53:18 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 18:53:18 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 18:53:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:53:18 INFO - Return code: 0 18:53:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:53:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:53:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:53:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:53:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:53:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:53:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:53:19 INFO - Return code: 0 18:53:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:53:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 18:53:19 INFO - Using env: {'DISPLAY': ':0', 18:53:19 INFO - 'HOME': '/home/cltbld', 18:53:19 INFO - 'LANG': 'en_US.UTF-8', 18:53:19 INFO - 'LANGUAGE': 'en_US:en', 18:53:19 INFO - 'LOGNAME': 'cltbld', 18:53:19 INFO - 'MAIL': '/var/mail/cltbld', 18:53:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:53:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:19 INFO - 'MOZ_NO_REMOTE': '1', 18:53:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:19 INFO - 'NO_EM_RESTART': '1', 18:53:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:53:19 INFO - 'SHELL': '/bin/bash', 18:53:19 INFO - 'SHLVL': '1', 18:53:19 INFO - 'TERM': 'linux', 18:53:19 INFO - 'TMOUT': '86400', 18:53:19 INFO - 'USER': 'cltbld', 18:53:19 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437', 18:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:19 INFO - '_': '/tools/buildbot/bin/python'} 18:53:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 18:53:20 INFO - mozversion INFO | application_buildid: 20151217163007 18:53:20 INFO - mozversion INFO | application_changeset: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 18:53:20 INFO - mozversion INFO | application_display_name: Nightly 18:53:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:53:20 INFO - mozversion INFO | application_name: Firefox 18:53:20 INFO - mozversion INFO | application_remotingname: firefox 18:53:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:53:20 INFO - mozversion INFO | application_vendor: Mozilla 18:53:20 INFO - mozversion INFO | application_version: 46.0a1 18:53:20 INFO - mozversion INFO | platform_buildid: 20151217163007 18:53:20 INFO - mozversion INFO | platform_changeset: 66fb852962c0d5f6f5fe0604204da4f5d17763c9 18:53:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:53:20 INFO - mozversion INFO | platform_version: 46.0a1 18:53:20 INFO - 2015-12-17 18:53:20,111 DEBUG : using testdate: 1450407200 18:53:20 INFO - 2015-12-17 18:53:20,111 DEBUG : actual date: 1450407200 18:53:20 INFO - 2015-12-17 18:53:20,120 INFO : starting webserver on 'localhost:35892' 18:53:20 INFO - 2015-12-17 18:53:20,121 INFO : Starting test suite talos-linux64-ix-028 18:53:20 INFO - 2015-12-17 18:53:20,121 INFO : Starting test dromaeo_css 18:53:20 INFO - 2015-12-17 18:53:20,121 DEBUG : operating with platform_type : linux_ 18:53:20 INFO - 2015-12-17 18:53:20,122 INFO : Initialising browser for dromaeo_css test... 18:53:20 INFO - 2015-12-17 18:53:20,136 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV_xCx1/profile http://localhost:35892/getInfo.html 18:53:24 INFO - 2015-12-17 18:53:24,356 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:53:24 INFO - 2015-12-17 18:53:24,356 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:53:24 INFO - 2015-12-17 18:53:24,357 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:53:24 INFO - 2015-12-17 18:53:24,357 DEBUG : BROWSER_OUTPUT: __metrics 18:53:24 INFO - 2015-12-17 18:53:24,445 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] 18:53:24 INFO - 2015-12-17 18:53:24,506 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] 18:53:24 INFO - 2015-12-17 18:53:24,784 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 18:53:25 INFO - 2015-12-17 18:53:25,405 INFO : Browser initialized. 18:53:25 INFO - 2015-12-17 18:53:25,405 INFO : Running cycle 1/1 for dromaeo_css test... 18:53:25 INFO - 2015-12-17 18:53:25,405 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV_xCx1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:53:37 INFO - 2015-12-17 18:53:37,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 146919424 18:53:37 INFO - 2015-12-17 18:53:37,237 DEBUG : BROWSER_OUTPUT: 18:54:28 INFO - 2015-12-17 18:54:28,923 DEBUG : BROWSER_OUTPUT: 1450407268916 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] 18:56:37 INFO - 2015-12-17 18:56:37,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35892/tests/dromaeo/cssquery-ext.html) 18:56:38 INFO - 2015-12-17 18:56:38,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 275570688 18:56:38 INFO - 2015-12-17 18:56:38,646 DEBUG : BROWSER_OUTPUT: 18:59:41 INFO - 2015-12-17 18:59:41,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/dromaeo/cssquery-ext.html (next: http://localhost:35892/tests/dromaeo/cssquery-jquery.html) 18:59:41 INFO - 2015-12-17 18:59:41,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 233881600 18:59:41 INFO - 2015-12-17 18:59:41,693 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-12-17 19:02:43,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35892/tests/dromaeo/cssquery-mootools.html) 19:02:44 INFO - 2015-12-17 19:02:44,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 223031296 19:02:44 INFO - 2015-12-17 19:02:44,227 DEBUG : BROWSER_OUTPUT: 19:05:45 INFO - 2015-12-17 19:05:45,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35892/tests/dromaeo/cssquery-prototype.html) 19:05:46 INFO - 2015-12-17 19:05:46,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 211423232 19:05:46 INFO - 2015-12-17 19:05:46,591 DEBUG : BROWSER_OUTPUT: 19:08:49 INFO - 2015-12-17 19:08:49,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35892/tests/dromaeo/cssquery-yui.html) 19:08:49 INFO - 2015-12-17 19:08:49,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 215375872 19:08:49 INFO - 2015-12-17 19:08:49,785 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/dromaeo/cssquery-yui.html (next: http://localhost:35892/tests/dromaeo/cssquery-dojo.html) 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 270979072 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3124.1564777510057;3127.7185053345197;3200.487921932491;3200.583924089868;3218.6459489456156;5112.693238405698;5217.530422261995;5298.947010529893;5338.199270109486;5353.9196912046355;5256.894862102756;5298.655587386817;5320.733963301829;5342.946570534294;5343;4785.760711964388;4807.663463557552;4846.66073374863;4948.2330238812865;4973.900521989558;4900.166971614816;4912.263160525932;4934.235193545006;4974.403071631409;5029.094762942669;4740.194166991585;4748.715077095368;4845.079434907374;4848.539388758062;4884.242942343943;4856.2958371036;4860.270959356089;4864.367632207825;4866.635002374836;4891.413030436335;4789.688670236424;4846.9515304846855;4861.8784530386665;4872;4910.705357678551;5072.695638261716;5098.4646612105935;5152.355955505562;5181.844544663666;5182.766775495112;5730.627509211888;5748;5766.740496677659;5768.625039372428;5772.076467765138;5680.914786278209;5784.913226301609;5798.188253644493;5799.768009279624;5802.4197580241635;5296.549793267577;5337.092694241988;5367.1680889462195;5376.354837419495;5386.48828361305;5802.47777700009;5813.709314534256;5820.330661973842;5821.2141360916585;5869.882602347929;5510.1459273812625;5642.322921249476;5643.407442218508;5644.604877658525;5653.689047102366;5653.123765816305;5669.4047125051275;5711.6001879868845;5718.628289161191;5759.884802303931;5702.971485142631;5722.399148089391;5754.4533269339345;5765.711714414262;5771.192033115367;5510;5756.7121643917635;5761.654300741969;5762.193292938992;5765.625234359753;4344.066025804467;4346.500152482505;4391.451068616423;4448.599626033672;4466.196084704784;3999.140184860211;4002.139539998856;4004.1190937993597;4007.599240075969;4041.151358214749;5498.477644623755;5500.4499550044675;5506.394296627368;5508.091164957817;5538.833834984876;5624.521915637217;5654.547636189095;5670.092785154356;5726.226959360516;5734.741936612779;5385.084535628953;5446.537044351196;5465.098258787335;5475.288212532345;5480.177973304037;5047.041062198171;5066.797328106908;5068.062408454448;5070.619703522177;5113.795448182031;5689.345725241567;5778.393268706809;5782.335031471434;5807.622504537276;5945.64326140433;5802.158686990447;5817.040188368872;5821.38875418075;5821.621594596338;5822.970885145547;5852.678102704393;5873.089671100986;5876.382979787061;5878.3239927408895;5881.794137205177;5435.83692489226;5444.537214336668;5500.972495137498;5537.667739935617;5655.971720141373;5768.1636162757;5779.942200577941;5800.709964501673;5805.767769289181;5807.8548036299435;5646.181303710857;5668.319801623831;5672.631278966854;5674.517665998436;5675.347335056521;5358.651687640291;5455.099908515051;5457.890842183214;5484.670919744828;5603.74783134768;5574.777008919597;5599.132134519156;5600.523955463831;5605.411431799603;5606.551475881838;5677.574181936454;5688.260526131577;5689.857753556194;5700.173474846041;5706.258186435737;5362.410134885237;5390;5412.729363531729;5462.9726851365485;5478.91781623268 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.2579026837465;587.8706684529404;592.6888383598612;596.2487266044787;602.3163709190068;30651;31397.215069623242;31538;31541.369172616534;31599.368012639792;32305.353892922187;40477;40978.79510602443;41175;41184.794076029655;8677.566121693922;8794.428362156472;8804.779880503007;8812.030676625565;8813.250873675714;7679.424043196755;7838;8599.22606965373;8722.520261385622;8726.432781869189;10431.73920651986;10586.78826423471;10624.15006799458;10633.840492392621;10652.840207396895;10209.744756381113;10273.126784223386;10313.535890884928;10318.690439286833;10321.225908056851;7737.806554836118;7997.600119993977;10142.543585538595;10364.429956352398;10619.30974486656;40350.798246008584;40520.392194117114;40739.1852162958;40851.591484085075;40895;3332.41682705528;3565.6969157621634;3794.487744154559;3951.130751234724;4059.5331536873045;30591;30930.690693093005;30966.690333096605;31180.53229201564;31979;3777.54669439669;3788.9227047871955;3795.886123416302;3815.9427608585893;3971.5631280559114;275642;276246;277631;278117;278145.99999999796;53304.466955330725;53916;58975;59733;60143.699281503315;59209.70395148083;59343.703281483315;59713.71574563441;59743;59780.70109649424;16175.757363639555;16406.917965410095;16416.507504774636;16422.917885410734;16423.753643695352;12391.93804030992;12452.81320780189;12454.065945054157;12477.5008999639;12514.49942002328;19788;20005.099770510362;20115.49711257201;20141.09365078575;20327.186912523335;7868.84262314762;8061.798455038554;8065.596720163969;8150.75547733569;8209.302209312274;989.1048601016092;990.4305024610734;1028.1928685981468;1056.9048785609332;1071.6035067025095;25485.3628659285;25518.390337263525;25840.22479325623;25993.22020339393;26588.46823063528;1048.764028093688;1050.5325130316935;1053.6786280184465;1057.8413238014205;1104.2932523185168;13540.93229533846;13548.932255338661;13637.360009565191;13656.453741850215;13670.17978921268;247968;250496;251485;252811;252845;47661.042369703784;47738.28392574114;47765.5223447768;47855.76072119617;47869;1362.3120324236395;1376.1467889908322;1376.291210026817;1382.882454991337;1399.3213291553589;25948;26624.334391640365;26778;26953.730462695123;27010.864945675145;44547.554524455634;44597.331040035075;44792;44918.550814491435;44922.32616510821;299877;300551;301545;301960;302706;28098.29754256078;28458.57312140361;30659.693403065685;32471.512927306583;32832.67167328296;37428;37664.43503347397;37741;38172.80913595414;38396.232075358894;34673.82663086769;34951;35198.64801351954;35207.82396088003;36116.819415902755;29366;34836.14085779609;35065.824670876485;35077.64922350744;35117.473237900944;35637;36499;36499.27001460009;36599;37507.24985500329;28811.5678264822;29947.70052299449;30064.54903176498;30098.699013010464;30115.247118821328;23210.1876434324;25355.746442536078;26651.866740666173;27179.72820271772;27180.456390872467 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.7723057243363;361.0810487309796;363.7671889990407;365.20567765110883;367.6470588235294;13734.793978090336;14048.578542643712;16883.662326753456;17336.30654773809;18113.909430452844;14882.925585372084;17200.483985480423;17573.472795816113;17591.472255832312;17695.203715832788;4760.262159365304;5383.43473935237;5484.341878974508;5496.148097044965;5503.147012213093;4087.9182416351655;4189.581041895802;4975.701457912519;5908.291005079396;6130.570860039799;5963.254593175853;6031.457168854802;6044.788432404866;6065.3934606539215;6068.757249710006;5270.472952704718;5443.101888188484;5456.181572764078;5462.781488740426;6095.817125486243;5233.921491177635;5240.161574148118;5243.501867322637;5251.08106081438;5263.894722105537;13548.593542193652;13551.39018744159;13554.118982266122;15162.848371516255;16523.83476165235;2057.763357213925;2133.4026472587702;2147.8174355179826;2169.2949791317883;2182.9235976740897;9959.75100622483;10024.54889529973;13263.336833158304;13377.130486518443;13401.860841828457;1762.1453595006412;1789.2395731813926;1869.392447454569;1872.419549939523;1933.1397528100001;57742;60980.085298721;61028;61352.69323653353;62067;10348.327358721659;10370.740731481774;10385;10391.636292729718;10435.217358698128;13611.523596674268;13628.114172578751;13628.182309061489;13632.863671363359;13635;7747.922520774833;7851.29338359539;7854.2145785421;7866.213378662203;7915.406344524184;7582.393408527415;7641.69433222676;7663.655135518915;7667.424943129287;7671.232876712284;4482.350059241392;4501.504834468205;4505.754469321135;4514.616257618073;4524;1722.6554689061986;1749.545118269259;1762.6739053275185;1771.2206629083162;1805.7359848106378;388.46391979069267;395.4720448201683;397.66794726403197;408.2243736899914;852.9317654587618;10370.377777333384;10620.575176992988;10742.462876856282;11024.559017639205;11221.382823944761;858.6222062292571;887.6981826179131;919.1727445299284;972.1979367022094;999.0708640963974;9305.232005918853;9515;9522.619095236252;9554.092361225672;9557.474338911426;485063;545384;555142;562240;564511;71477;71783.6410817953;73535;75481;80000.19999799927;1163.7032556697989;1165.1319766773809;1173.9882601173879;1192.358924981171;1211.678905090134;15575.221238937782;15598.532044038697;15878.60303492422;16042.278097485874;16061.518154455385;32047.679523204468;34007.4898876522;34282.65717342795;34412;35819.82090089533;38791.6120838788;39551.2089758209;40218.798906005286;42847;43093.784531077144;9723.951380243054;9802.50987450639;10004.299699021;10034;10034.899651003396;17415.738763918296;17788.911055445158;17837.821621783616;17997.190126444602;18120.27518899229;14380.28098595087;14495.057821241586;14601.780973285197;14777;15067.034485491236;14351.928240358731;14597.197154156198;14817.777733334224;14828.481003164838;14938.551843444715;9477.431354118775;10003.249756268455;10330.121939635215;10343.327683700536;15335.76996345078;14146.22195779242;14370;14397;14754.926225368805;15067.849321506645;16427;16458;16525.504234872973;16720.581985450463;16942.745858811882 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1473.4474572035488;1478.2756449339827;1486.3311509820576;1506.246876561719;1508.818941726993;6636.236832764233;7223.711051557938;7413.332800047994;7432;7438.107427108755;7301.123865136191;7449.068866391701;7455;7459.104907411118;7462.850742985137;2156.20220518408;2178.5098352870555;2187.453136715821;2188.5622875424897;2191.386411804697;2179.8256139508803;2212.0930418528405;2236.798688118069;2254.323702889135;2254.842161048727;2037.8879161646103;2064.4941989212666;2064.948376290597;2098.2970704813906;2220.378294077661;2032.0550943811124;2059.4233614588015;2059.721937538428;2061;2061.5258490547108;2183.3995651195887;2235.3852690510075;2236.6980457638174;2237.2617036377956;2239.955200895989;7371.299726525972;7457.962710186469;7463.626818659045;7464.104307483137;7465.589392583406;4397.2304846651705;4414.117176564668;4420.80106395213;4450.421445212101;4453.354263631755;2923.181509177434;2951.911442656724;3032.105528868989;3045.3909218156236;3063.0198336532317;991.1129539062499;1000.4397537379091;1003.894591067942;1009.3540134314045;1056.6935588679273;10112.797744045152;10151.543180556893;10183;10194;10207.489625518769;4033.4353190553347;4057.9797101014306;4100;4101.671866250693;4104.138130992465;8756.4308319959;8774.868376974351;8777.605007774666;8781.165789250012;8785.033646298902;4491.88770280739;4495.865124046284;4498.797554110073;4515;4517.11916176349;3640.7997560133917;3750.8124593770203;4064.349704047338;4142.896427589274;4143.440635514227;3468.1849765305133;3477.5305333779615;3479.2171761353493;3489.2498112905846;3525.065857547752;1121.7980763462492;1131.1742428027585;1131.5077941095649;1131.5530365505745;1142.9942850285695;1289.3488788162106;1300.2263653126374;1315.2700251360395;1322.2529270961875;1322.616441232051;6821.590704557643;6884.965575172092;6894.827629309308;6895.655217239118;6903.482238832108;492.5074925074925;493.5582653525075;494.7649866313544;496.87329730918384;513.6173550704749;5576.776928922797;5645.520130788929;5648.661080335193;5648.915266271009;5656.462636049569;8511.872321915176;8567.27178189861;8640.006399264164;8726.694565690297;8749.737507874774;8523.190296921783;8530.061693213742;8628.050914399411;8637.913620863837;8640.222379985831;7029.578225306498;7046.189688185924;7068.3285087916565;7084.645767711594;7103.751368702174;6693.062971184136;6726.159230096238;6750.32496750321;6753.527253092237;6770.627615481196;7563.281488258606;7747.18654541265;7829;7831.138574756658;7840.411969102226;7790.688372465038;7880.802979925547;8036.557989310644;8039.67841286342;8044.517328960281;6088.299845517822;6141.938580614136;6316.05259211122;6364.490840732823;6621.768238111643;6971.930280697331;7176.856462870818;7208.747693830691;7236.6019868905605;7250.9637451812405;6663.800085997428;6799.558028728117;6838.692258848264;6899.241083480913;6966.582005079711;6752.426043786137;6755.648870225876;6829.69266383004;6858.897116543156;6901.137357830271;6779.542747205238;6807.047013418027;6826.453883689393;6843.589384636938;6844.760433384808;6235.781747638811;6278.623282603058;6284.937150628618;6302.086197501429;6309.148264984168;6243.313235543996;6282.842928926813;6302.338254483213;6307.558470907176;6310.1796766420075 19:11:52 INFO - 2015-12-17 19:11:52,656 DEBUG : BROWSER_OUTPUT: |4;prototype.html;335.832083958021;341.4945880097454;344.36464722586834;345.57666858098816;348.5503700226708;5887.558433117512;6021.729022194001;6024.909626355608;6037.818865434038;6041.486473649734;5796.362400135981;5921.171036054956;5929.407059294069;5935.584509084366;5947.583669143161;4599.701019433743;4601.286800545904;4654.39492865927;4657.556157591141;4657.813687452498;4424.491183513889;4494.393256910308;4566.84016059438;4657.20827459331;4659.813607455698;4621.191291523986;4627.490975992638;4636.02643444877;4637.258038713807;4638.768061596924;4613.284940834159;4624.306354046903;4625.306204069383;4635.814567417299;4635.8377456789185;4089.407035979796;4094.9181016379507;4104.774237416971;4106.178764247133;4117.1765646870745;5614.129809879475;5718.857028574277;5726.971365143189;5733.741981610796;5743.942560574383;5391.73041347931;5400.162974738922;5403.189521571757;5405.5135037846785;5407.351117865842;6032.939670603326;6320.462760665303;6321.146645202931;6324.272708638519;6325.304216536178;4391.055922976543;4446.244138496431;4460.420145381112;4461.955380446187;4508.887277818048;6457.83855403614;6567.310432404576;6571.539992200548;6581.440577550914;6585.275619681879;4655.766221951186;4659.138059459011;4661.394018777537;4661.5804577587505;4665.113628410591;4629.51390104041;4723.126221649006;4723.929141062887;4732;4762.595179409789;5391;5398.703071331036;5400.91898621521;5404.972975135099;5407.702576358338;6402.839929001719;6411.5832470889245;6413.711382987777;6417.358264173638;6419.325970773095;1644.4408900973488;1646.7200575901886;1647.4316360855726;1649.0682764238168;1649.6205872649357;1078.7464945737745;1081.643057790927;1125.7861006408757;1126.2791813239533;1184.8222766584909;6013.609115407485;6069.241344831896;6070.817875463743;6072.453479186895;6073.058675905242;6515.869682606416;6516.087747715229;6517.771877984248;6520.804375868732;6556.901646475307;5926.970365148147;6062.060380641008;6066.7269972850445;6067.362926892701;6068.514518838482;3491.6159222485508;3535.7701749386206;3536.398812201932;3538.7345949053924;3541.6281290464644;6581.308962558958;6619.50353723463;6619.834504137435;6623.20521537409;6642.302558231316;6438.517111216677;6673.833154171185;6677.432418244406;6681.265060843303;6691.197056353171;6558.934410655832;6569.704363303663;6587.703553340111;6589.505787065989;6595.340465953463;6347.301796802256;6489.837754056186;6509.674516274262;6516;6524.608523488606;6577;6591.681663667382;6599.142111525471;6601.702923368556;6610.735570577123;6752.459803215829;6754.459643228432;6754.5947243165565;6755.121834161528;6759.290274521104;4413.536578659323;4508.797104130256;4514.706544074756;4724.905501889874;4730.148573256847;6519.185101862267;6534.934650653433;6593.175853018372;6597.703103360456;6600.372964568358;6426.807195784134;6427.164468619237;6429.839254018687;6430.582012169194;6434.227892652912;6315.715792789428;6395.968020159869;6405;6434.67826608677;6456.225252969673;6333.809985700436;6339.334369891095;6342.270638876588;6356.618602883842;6363.204599425072;6497.415232629086;6498.382653648085;6505.772297969548;6514.413702766774;6518.934810651833;6165.6570503208495;6302.65335406557;6330.778422755181;6332.0818481320875;6357.586756860789 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: |5;yui.html;778.5056489129402;830.7715378270979;834.3283656656394;850.9787255318619;853.5561508015828;13290.933545332271;13923.721525569508;13930.164190148598;13947.651308717288;13949.790753138699;13183.538576149836;13304.20174789511;13331.333433328318;13333.933330333335;13351.399187036583;670.6311528659243;680.5610381304056;818.643889907889;819.7622689420061;827.1976183102381;840.2983508770184;840.7141571865565;840.7645859159445;848.0120659431785;848.6096395658004;855;865.6104752861206;866.757307953774;871.8692196170562;878.0210065776645;703.6587255181233;709.1383968478298;866.4065115395974;873.9956300218522;874.8993865705398;637.579197729501;638.1385130074362;638.9009703495966;642.0818229931197;643.0129750832497;13589;13694.52069177584;13699.45202191911;13720.108192967526;13738.862611373857;11915.523379064914;12335;12702;12907.870921290762;12924.418401171875;10665.84001239982;10671.519781609768;10795.946020269927;10810.135189184924;10852.782944341068;3587.928241435183;3615.493830863681;3703.5000274962804;3719.0702324418894;3787.696984241282;46950;48456.27315590269;48482.51517484815;48635.51364486381;48937.02125957496;10083;10109.544138965117;10215;10226.53980570876;10454.52954617044;17549.473515794547;17582.208800604003;17599.560010999572;17603.11984400775;17607.383741568985;6964.756233531802;6999.790006299819;7024.859502809915;7038.824029399204;7212.783616491513;4436.245838207448;4439.311906654474;4460.7323560586465;4463.598276155161;4469.754163521037;2949.1889730324333;2967.540031295153;2977.8064425812254;2982.030839977016;2983.254186453387;545.0704506048544;545.1876703711441;546.4044191830924;555.9471850174227;558.0958846668423;532.6165161084014;612.21024877907;658.7496751234596;681.1213534540486;695.3359541637724;8052.005025025457;8633.223009929137;8682.6092825823;8873.689420870238;8895.46627202357;597.4205021129497;666.7699643622942;687.1994126842172;694.135800927838;731.4441024821068;3863.4977452931503;4074;4116.300228961084;4198.433211516467;4217.683673724483;52125;53329.73335133377;53533.73233133809;53633.1955020675;53711;48314.5168548317;48660.75669621629;48759;49657.255141172915;50033.749831250614;43211.783941080095;43326.78336608297;43880.56119438828;44483.55516444859;44819.87950301203;8167.469114507538;8415.116412776815;8586.313094952264;8714.433561818461;9323.580438880132;33651;33714.662853371156;33843.3231335367;35385.64614353926;36718.26563468769;41672.791636042835;42108.36837447502;42881;43451;43529.12941741211;11209.43952802373;11281;11329.81897752145;11440.599579014695;11446.599369022044;11970.22193557416;12204.389780511117;12232.449539770554;12294.20087694297;12302.75394492123;11688.47401866901;11830;11962.700932476757;12415.93792031034;12456.875431245933;11231.26996745209;11509.712257193638;11516.136289778133;11705.356205408785;11955.521779128738;11560.30638161713;11768.941155294511;11953.103517236415;12017.879821201675;12145.14983951115;10159.695209143738;10181.847272290774;10260.794784104126;10490.475476226005;10897.073748731447;9360.719178424659;9487.66793162236;9768.839620670164;10357.274990750575;10466.424346661006 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,943 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: __startTimestamp1450408312648__endTimestamp 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,657 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5318.42 Median:5500.45 stddev:583.54 (10.6%) stddev-sans-first:559.37 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: Values: 3124.2 3127.7 3200.5 3200.6 3218.6 5112.7 5217.5 5298.9 5338.2 5353.9 5256.9 5298.7 5320.7 5342.9 5343.0 4785.8 4807.7 4846.7 4948.2 4973.9 4900.2 4912.3 4934.2 4974.4 5029.1 4740.2 4748.7 4845.1 4848.5 4884.2 4856.3 4860.3 4864.4 4866.6 4891.4 4789.7 4847.0 4861.9 4872.0 4910.7 5072.7 5098.5 5152.4 5181.8 5182.8 5730.6 5748.0 5766.7 5768.6 5772.1 5680.9 5784.9 5798.2 5799.8 5802.4 5296.5 5337.1 5367.2 5376.4 5386.5 5802.5 5813.7 5820.3 5821.2 5869.9 5510.1 5642.3 5643.4 5644.6 5653.7 5653.1 5669.4 5711.6 5718.6 5759.9 5703.0 5722.4 5754.5 5765.7 5771.2 5510.0 5756.7 5761.7 5762.2 5765.6 4344.1 4346.5 4391.5 4448.6 4466.2 3999.1 4002.1 4004.1 4007.6 4041.2 5498.5 5500.4 5506.4 5508.1 5538.8 5624.5 5654.5 5670.1 5726.2 5734.7 5385.1 5446.5 5465.1 5475.3 5480.2 5047.0 5066.8 5068.1 5070.6 5113.8 5689.3 5778.4 5782.3 5807.6 5945.6 5802.2 5817.0 5821.4 5821.6 5823.0 5852.7 5873.1 5876.4 5878.3 5881.8 5435.8 5444.5 5501.0 5537.7 5656.0 5768.2 5779.9 5800.7 5805.8 5807.9 5646.2 5668.3 5672.6 5674.5 5675.3 5358.7 5455.1 5457.9 5484.7 5603.7 5574.8 5599.1 5600.5 5605.4 5606.6 5677.6 5688.3 5689.9 5700.2 5706.3 5362.4 5390.0 5412.7 5463.0 5478.9 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44254.42 Median:31467.61 stddev:72284.56 (229.7%) stddev-sans-first:72412.87 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: Values: 555.3 587.9 592.7 596.2 602.3 30651.0 31397.2 31538.0 31541.4 31599.4 32305.4 40477.0 40978.8 41175.0 41184.8 8677.6 8794.4 8804.8 8812.0 8813.3 7679.4 7838.0 8599.2 8722.5 8726.4 10431.7 10586.8 10624.2 10633.8 10652.8 10209.7 10273.1 10313.5 10318.7 10321.2 7737.8 7997.6 10142.5 10364.4 10619.3 40350.8 40520.4 40739.2 40851.6 40895.0 3332.4 3565.7 3794.5 3951.1 4059.5 30591.0 30930.7 30966.7 31180.5 31979.0 3777.5 3788.9 3795.9 3815.9 3971.6 275642.0 276246.0 277631.0 278117.0 278146.0 53304.5 53916.0 58975.0 59733.0 60143.7 59209.7 59343.7 59713.7 59743.0 59780.7 16175.8 16406.9 16416.5 16422.9 16423.8 12391.9 12452.8 12454.1 12477.5 12514.5 19788.0 20005.1 20115.5 20141.1 20327.2 7868.8 8061.8 8065.6 8150.8 8209.3 989.1 990.4 1028.2 1056.9 1071.6 25485.4 25518.4 25840.2 25993.2 26588.5 1048.8 1050.5 1053.7 1057.8 1104.3 13540.9 13548.9 13637.4 13656.5 13670.2 247968.0 250496.0 251485.0 252811.0 252845.0 47661.0 47738.3 47765.5 47855.8 47869.0 1362.3 1376.1 1376.3 1382.9 1399.3 25948.0 26624.3 26778.0 26953.7 27010.9 44547.6 44597.3 44792.0 44918.6 44922.3 299877.0 300551.0 301545.0 301960.0 302706.0 28098.3 28458.6 30659.7 32471.5 32832.7 37428.0 37664.4 37741.0 38172.8 38396.2 34673.8 34951.0 35198.6 35207.8 36116.8 29366.0 34836.1 35065.8 35077.6 35117.5 35637.0 36499.0 36499.3 36599.0 37507.2 28811.6 29947.7 30064.5 30098.7 30115.2 23210.2 25355.7 26651.9 27179.7 27180.5 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28541.28 Median:17115.30 stddev:88644.75 (517.9%) stddev-sans-first:88868.16 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: Values: 355.8 361.1 363.8 365.2 367.6 13734.8 14048.6 16883.7 17336.3 18113.9 14882.9 17200.5 17573.5 17591.5 17695.2 4760.3 5383.4 5484.3 5496.1 5503.1 4087.9 4189.6 4975.7 5908.3 6130.6 5963.3 6031.5 6044.8 6065.4 6068.8 5270.5 5443.1 5456.2 5462.8 6095.8 5233.9 5240.2 5243.5 5251.1 5263.9 13548.6 13551.4 13554.1 15162.8 16523.8 2057.8 2133.4 2147.8 2169.3 2182.9 9959.8 10024.5 13263.3 13377.1 13401.9 1762.1 1789.2 1869.4 1872.4 1933.1 57742.0 60980.1 61028.0 61352.7 62067.0 10348.3 10370.7 10385.0 10391.6 10435.2 13611.5 13628.1 13628.2 13632.9 13635.0 7747.9 7851.3 7854.2 7866.2 7915.4 7582.4 7641.7 7663.7 7667.4 7671.2 4482.4 4501.5 4505.8 4514.6 4524.0 1722.7 1749.5 1762.7 1771.2 1805.7 388.5 395.5 397.7 408.2 852.9 10370.4 10620.6 10742.5 11024.6 11221.4 858.6 887.7 919.2 972.2 999.1 9305.2 9515.0 9522.6 9554.1 9557.5 485063.0 545384.0 555142.0 562240.0 564511.0 71477.0 71783.6 73535.0 75481.0 80000.2 1163.7 1165.1 1174.0 1192.4 1211.7 15575.2 15598.5 15878.6 16042.3 16061.5 32047.7 34007.5 34282.7 34412.0 35819.8 38791.6 39551.2 40218.8 42847.0 43093.8 9724.0 9802.5 10004.3 10034.0 10034.9 17415.7 17788.9 17837.8 17997.2 18120.3 14380.3 14495.1 14601.8 14777.0 15067.0 14351.9 14597.2 14817.8 14828.5 14938.6 9477.4 10003.2 10330.1 10343.3 15335.8 14146.2 14370.0 14397.0 14754.9 15067.8 16427.0 16458.0 16525.5 16720.6 16942.7 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,659 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5180.98 Median:6188.86 stddev:2677.42 (43.3%) stddev-sans-first:2670.43 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: Values: 1473.4 1478.3 1486.3 1506.2 1508.8 6636.2 7223.7 7413.3 7432.0 7438.1 7301.1 7449.1 7455.0 7459.1 7462.9 2156.2 2178.5 2187.5 2188.6 2191.4 2179.8 2212.1 2236.8 2254.3 2254.8 2037.9 2064.5 2064.9 2098.3 2220.4 2032.1 2059.4 2059.7 2061.0 2061.5 2183.4 2235.4 2236.7 2237.3 2240.0 7371.3 7458.0 7463.6 7464.1 7465.6 4397.2 4414.1 4420.8 4450.4 4453.4 2923.2 2951.9 3032.1 3045.4 3063.0 991.1 1000.4 1003.9 1009.4 1056.7 10112.8 10151.5 10183.0 10194.0 10207.5 4033.4 4058.0 4100.0 4101.7 4104.1 8756.4 8774.9 8777.6 8781.2 8785.0 4491.9 4495.9 4498.8 4515.0 4517.1 3640.8 3750.8 4064.3 4142.9 4143.4 3468.2 3477.5 3479.2 3489.2 3525.1 1121.8 1131.2 1131.5 1131.6 1143.0 1289.3 1300.2 1315.3 1322.3 1322.6 6821.6 6885.0 6894.8 6895.7 6903.5 492.5 493.6 494.8 496.9 513.6 5576.8 5645.5 5648.7 5648.9 5656.5 8511.9 8567.3 8640.0 8726.7 8749.7 8523.2 8530.1 8628.1 8637.9 8640.2 7029.6 7046.2 7068.3 7084.6 7103.8 6693.1 6726.2 6750.3 6753.5 6770.6 7563.3 7747.2 7829.0 7831.1 7840.4 7790.7 7880.8 8036.6 8039.7 8044.5 6088.3 6141.9 6316.1 6364.5 6621.8 6971.9 7176.9 7208.7 7236.6 7251.0 6663.8 6799.6 6838.7 6899.2 6966.6 6752.4 6755.6 6829.7 6858.9 6901.1 6779.5 6807.0 6826.5 6843.6 6844.8 6235.8 6278.6 6284.9 6302.1 6309.1 6243.3 6282.8 6302.3 6307.6 6310.2 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5335.71 Median:6035.38 stddev:1579.07 (26.2%) stddev-sans-first:1538.26 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: Values: 335.8 341.5 344.4 345.6 348.6 5887.6 6021.7 6024.9 6037.8 6041.5 5796.4 5921.2 5929.4 5935.6 5947.6 4599.7 4601.3 4654.4 4657.6 4657.8 4424.5 4494.4 4566.8 4657.2 4659.8 4621.2 4627.5 4636.0 4637.3 4638.8 4613.3 4624.3 4625.3 4635.8 4635.8 4089.4 4094.9 4104.8 4106.2 4117.2 5614.1 5718.9 5727.0 5733.7 5743.9 5391.7 5400.2 5403.2 5405.5 5407.4 6032.9 6320.5 6321.1 6324.3 6325.3 4391.1 4446.2 4460.4 4462.0 4508.9 6457.8 6567.3 6571.5 6581.4 6585.3 4655.8 4659.1 4661.4 4661.6 4665.1 4629.5 4723.1 4723.9 4732.0 4762.6 5391.0 5398.7 5400.9 5405.0 5407.7 6402.8 6411.6 6413.7 6417.4 6419.3 1644.4 1646.7 1647.4 1649.1 1649.6 1078.7 1081.6 1125.8 1126.3 1184.8 6013.6 6069.2 6070.8 6072.5 6073.1 6515.9 6516.1 6517.8 6520.8 6556.9 5927.0 6062.1 6066.7 6067.4 6068.5 3491.6 3535.8 3536.4 3538.7 3541.6 6581.3 6619.5 6619.8 6623.2 6642.3 6438.5 6673.8 6677.4 6681.3 6691.2 6558.9 6569.7 6587.7 6589.5 6595.3 6347.3 6489.8 6509.7 6516.0 6524.6 6577.0 6591.7 6599.1 6601.7 6610.7 6752.5 6754.5 6754.6 6755.1 6759.3 4413.5 4508.8 4514.7 4724.9 4730.1 6519.2 6534.9 6593.2 6597.7 6600.4 6426.8 6427.2 6429.8 6430.6 6434.2 6315.7 6396.0 6405.0 6434.7 6456.2 6333.8 6339.3 6342.3 6356.6 6363.2 6497.4 6498.4 6505.8 6514.4 6518.9 6165.7 6302.7 6330.8 6332.1 6357.6 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13594.50 Median:43269.28 stddev:15224.71 (35.2%) stddev-sans-first:15236.99 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: Values: 778.5 830.8 834.3 851.0 853.6 13290.9 13923.7 13930.2 13947.7 13949.8 13183.5 13304.2 13331.3 13333.9 13351.4 670.6 680.6 818.6 819.8 827.2 840.3 840.7 840.8 848.0 848.6 855.0 865.6 866.8 871.9 878.0 703.7 709.1 866.4 874.0 874.9 637.6 638.1 638.9 642.1 643.0 13589.0 13694.5 13699.5 13720.1 13738.9 11915.5 12335.0 12702.0 12907.9 12924.4 10665.8 10671.5 10795.9 10810.1 10852.8 3587.9 3615.5 3703.5 3719.1 3787.7 46950.0 48456.3 48482.5 48635.5 48937.0 10083.0 10109.5 10215.0 10226.5 10454.5 17549.5 17582.2 17599.6 17603.1 17607.4 6964.8 6999.8 7024.9 7038.8 7212.8 4436.2 4439.3 4460.7 4463.6 4469.8 2949.2 2967.5 2977.8 2982.0 2983.3 545.1 545.2 546.4 555.9 558.1 532.6 612.2 658.7 681.1 695.3 8052.0 8633.2 8682.6 8873.7 8895.5 597.4 666.8 687.2 694.1 731.4 3863.5 4074.0 4116.3 4198.4 4217.7 52125.0 53329.7 53533.7 53633.2 53711.0 48314.5 48660.8 48759.0 49657.3 50033.7 43211.8 43326.8 43880.6 44483.6 44819.9 8167.5 8415.1 8586.3 8714.4 9323.6 33651.0 33714.7 33843.3 35385.6 36718.3 41672.8 42108.4 42881.0 43451.0 43529.1 11209.4 11281.0 11329.8 11440.6 11446.6 11970.2 12204.4 12232.4 12294.2 12302.8 11688.5 11830.0 11962.7 12415.9 12456.9 11231.3 11509.7 11516.1 11705.4 11955.5 11560.3 11768.9 11953.1 12017.9 12145.1 10159.7 10181.8 10260.8 10490.5 10897.1 9360.7 9487.7 9768.8 10357.3 10466.4 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:11:52 INFO - 2015-12-17 19:11:52,661 DEBUG : BROWSER_OUTPUT: 19:11:53 INFO - 2015-12-17 19:11:53,278 INFO : Browser exited with error code: 0 19:11:53 INFO - 2015-12-17 19:11:53,297 INFO : Completed test dromaeo_css (00:18:33) 19:11:53 INFO - 2015-12-17 19:11:53,297 INFO : Starting test kraken 19:11:53 INFO - 2015-12-17 19:11:53,297 DEBUG : operating with platform_type : linux_ 19:11:53 INFO - 2015-12-17 19:11:53,297 INFO : Initialising browser for kraken test... 19:11:53 INFO - 2015-12-17 19:11:53,303 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH_gJGL/profile http://localhost:35892/getInfo.html 19:11:57 INFO - 2015-12-17 19:11:57,288 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:11:57 INFO - 2015-12-17 19:11:57,288 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:11:57 INFO - 2015-12-17 19:11:57,288 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:11:57 INFO - 2015-12-17 19:11:57,288 DEBUG : BROWSER_OUTPUT: __metrics 19:11:57 INFO - 2015-12-17 19:11:57,410 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] 19:11:57 INFO - 2015-12-17 19:11:57,466 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] 19:11:58 INFO - 2015-12-17 19:11:58,274 INFO : Browser initialized. 19:11:58 INFO - 2015-12-17 19:11:58,274 INFO : Running cycle 1/1 for kraken test... 19:11:58 INFO - 2015-12-17 19:11:58,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH_gJGL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:12:10 INFO - 2015-12-17 19:12:10,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 150245376 19:12:10 INFO - 2015-12-17 19:12:10,064 DEBUG : BROWSER_OUTPUT: 19:12:12 INFO - 2015-12-17 19:12:12,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35892/tests/kraken/driver.html?testName=audio-beat-detection) 19:12:13 INFO - 2015-12-17 19:12:13,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 185356288 19:12:13 INFO - 2015-12-17 19:12:13,121 DEBUG : BROWSER_OUTPUT: 19:12:15 INFO - 2015-12-17 19:12:15,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35892/tests/kraken/driver.html?testName=audio-dft) 19:12:16 INFO - 2015-12-17 19:12:16,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 176414720 19:12:16 INFO - 2015-12-17 19:12:16,316 DEBUG : BROWSER_OUTPUT: 19:12:19 INFO - 2015-12-17 19:12:19,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35892/tests/kraken/driver.html?testName=audio-fft) 19:12:19 INFO - 2015-12-17 19:12:19,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 160870400 19:12:19 INFO - 2015-12-17 19:12:19,808 DEBUG : BROWSER_OUTPUT: 19:12:21 INFO - 2015-12-17 19:12:21,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35892/tests/kraken/driver.html?testName=audio-oscillator) 19:12:22 INFO - 2015-12-17 19:12:22,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 164380672 19:12:22 INFO - 2015-12-17 19:12:22,347 DEBUG : BROWSER_OUTPUT: 19:12:24 INFO - 2015-12-17 19:12:24,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:12:25 INFO - 2015-12-17 19:12:25,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 163971072 19:12:25 INFO - 2015-12-17 19:12:25,122 DEBUG : BROWSER_OUTPUT: 19:12:28 INFO - 2015-12-17 19:12:28,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35892/tests/kraken/driver.html?testName=imaging-darkroom) 19:12:28 INFO - 2015-12-17 19:12:28,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 165732352 19:12:28 INFO - 2015-12-17 19:12:28,603 DEBUG : BROWSER_OUTPUT: 19:12:31 INFO - 2015-12-17 19:12:31,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35892/tests/kraken/driver.html?testName=imaging-desaturate) 19:12:32 INFO - 2015-12-17 19:12:32,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 165896192 19:12:32 INFO - 2015-12-17 19:12:32,533 DEBUG : BROWSER_OUTPUT: 19:12:35 INFO - 2015-12-17 19:12:35,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35892/tests/kraken/driver.html?testName=json-parse-financial) 19:12:35 INFO - 2015-12-17 19:12:35,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 165793792 19:12:35 INFO - 2015-12-17 19:12:35,841 DEBUG : BROWSER_OUTPUT: 19:12:37 INFO - 2015-12-17 19:12:37,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:12:37 INFO - 2015-12-17 19:12:37,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 176312320 19:12:37 INFO - 2015-12-17 19:12:37,971 DEBUG : BROWSER_OUTPUT: 19:12:39 INFO - 2015-12-17 19:12:39,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:12:40 INFO - 2015-12-17 19:12:40,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 173420544 19:12:40 INFO - 2015-12-17 19:12:40,367 DEBUG : BROWSER_OUTPUT: 19:12:42 INFO - 2015-12-17 19:12:42,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:12:42 INFO - 2015-12-17 19:12:42,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 187232256 19:12:42 INFO - 2015-12-17 19:12:42,974 DEBUG : BROWSER_OUTPUT: 19:12:45 INFO - 2015-12-17 19:12:45,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:12:45 INFO - 2015-12-17 19:12:45,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 190922752 19:12:45 INFO - 2015-12-17 19:12:45,936 DEBUG : BROWSER_OUTPUT: 19:12:48 INFO - 2015-12-17 19:12:48,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:12:49 INFO - 2015-12-17 19:12:49,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 191291392 19:12:49 INFO - 2015-12-17 19:12:49,091 DEBUG : BROWSER_OUTPUT: 19:12:50 INFO - 2015-12-17 19:12:50,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35892/tests/kraken/driver.html?testName=ai-astar) 19:12:51 INFO - 2015-12-17 19:12:51,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 249507840 19:12:51 INFO - 2015-12-17 19:12:51,003 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,006 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:12:51 INFO - 2015-12-17 19:12:51,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:12:51 INFO - 2015-12-17 19:12:51,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:12:51 INFO - 2015-12-17 19:12:51,007 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:12:51 INFO - 2015-12-17 19:12:51,007 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;107;109;110;110;99;108;111;110 19:12:51 INFO - 2015-12-17 19:12:51,008 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;131;156;168;130;151;146;132;171;125 19:12:51 INFO - 2015-12-17 19:12:51,008 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;161;160;159;160;161;162;160 19:12:51 INFO - 2015-12-17 19:12:51,008 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;82;93;71;77;72;99;95;72 19:12:51 INFO - 2015-12-17 19:12:51,008 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;140;93;93;92;136;93;93;140 19:12:51 INFO - 2015-12-17 19:12:51,008 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;109;110 19:12:51 INFO - 2015-12-17 19:12:51,009 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;146;146;146;145;146;145 19:12:51 INFO - 2015-12-17 19:12:51,009 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;95;95;96;96;96;96 19:12:51 INFO - 2015-12-17 19:12:51,009 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;57;57;58;59;58;66;56;56 19:12:51 INFO - 2015-12-17 19:12:51,009 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;69;71;68;70;69;69 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;82;83;91;84;84;84;84 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;114;116;114;120;116;122;122;120;120 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;152;149;150;151;144;164;151;149;146 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;67;67;66;66;68;66;66;66 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,958 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:12:51 INFO - 2015-12-17 19:12:51,010 DEBUG : BROWSER_OUTPUT: __startTimestamp1450408371004__endTimestamp 19:12:51 INFO - 2015-12-17 19:12:51,011 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,012 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:12:51 INFO - 2015-12-17 19:12:51,012 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:12:51 INFO - 2015-12-17 19:12:51,012 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,012 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.43 (3.1%) stddev-sans-first:3.62 19:12:51 INFO - 2015-12-17 19:12:51,013 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 107.0 109.0 110.0 110.0 99.0 108.0 111.0 110.0 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.50 Median:148.50 stddev:16.16 (10.9%) stddev-sans-first:17.14 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: Values: 145.0 131.0 156.0 168.0 130.0 151.0 146.0 132.0 171.0 125.0 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 161.0 160.0 159.0 160.0 161.0 162.0 160.0 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:79.50 stddev:11.25 (14.1%) stddev-sans-first:11.41 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 82.0 93.0 71.0 77.0 72.0 99.0 95.0 72.0 19:12:51 INFO - 2015-12-17 19:12:51,014 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,015 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:22.09 (23.8%) stddev-sans-first:22.95 19:12:51 INFO - 2015-12-17 19:12:51,015 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 140.0 93.0 93.0 92.0 136.0 93.0 93.0 140.0 19:12:51 INFO - 2015-12-17 19:12:51,015 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,015 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:12:51 INFO - 2015-12-17 19:12:51,015 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 19:12:51 INFO - 2015-12-17 19:12:51,015 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:2.88 (4.9%) stddev-sans-first:3.05 19:12:51 INFO - 2015-12-17 19:12:51,016 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 57.0 57.0 58.0 59.0 58.0 66.0 56.0 56.0 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 69.0 71.0 68.0 70.0 69.0 69.0 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.46 (2.9%) stddev-sans-first:2.55 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 82.0 83.0 91.0 84.0 84.0 84.0 84.0 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:120.00 stddev:3.21 (2.7%) stddev-sans-first:3.23 19:12:51 INFO - 2015-12-17 19:12:51,017 DEBUG : BROWSER_OUTPUT: Values: 115.0 114.0 116.0 114.0 120.0 116.0 122.0 122.0 120.0 120.0 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:150.50 stddev:5.96 (4.0%) stddev-sans-first:5.61 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: Values: 142.0 152.0 149.0 150.0 151.0 144.0 164.0 151.0 149.0 146.0 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.09 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 67.0 66.0 66.0 68.0 66.0 66.0 66.0 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:12:51 INFO - 2015-12-17 19:12:51,018 DEBUG : BROWSER_OUTPUT: 19:12:51 INFO - 2015-12-17 19:12:51,874 INFO : Browser exited with error code: 0 19:12:51 INFO - 2015-12-17 19:12:51,925 INFO : Completed test kraken (00:00:58) 19:12:51 INFO - 2015-12-17 19:12:51,925 INFO : Starting test v8_7 19:12:51 INFO - 2015-12-17 19:12:51,925 DEBUG : operating with platform_type : linux_ 19:12:51 INFO - 2015-12-17 19:12:51,925 INFO : Initialising browser for v8_7 test... 19:12:51 INFO - 2015-12-17 19:12:51,931 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLy5TD6/profile http://localhost:35892/getInfo.html 19:12:56 INFO - 2015-12-17 19:12:56,135 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:12:56 INFO - 2015-12-17 19:12:56,135 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:12:56 INFO - 2015-12-17 19:12:56,135 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:12:56 INFO - 2015-12-17 19:12:56,135 DEBUG : BROWSER_OUTPUT: __metrics 19:12:56 INFO - 2015-12-17 19:12:56,216 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] 19:12:56 INFO - 2015-12-17 19:12:56,272 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] 19:12:57 INFO - 2015-12-17 19:12:57,100 INFO : Browser initialized. 19:12:57 INFO - 2015-12-17 19:12:57,100 INFO : Running cycle 1/1 for v8_7 test... 19:12:57 INFO - 2015-12-17 19:12:57,101 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLy5TD6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:13:08 INFO - 2015-12-17 19:13:08,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 150241280 19:13:08 INFO - 2015-12-17 19:13:08,854 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35892/tests/v8_7/run.html (next: http://localhost:35892/tests/v8_7/run.html) 19:13:30 INFO - 2015-12-17 19:13:30,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 619687936 19:13:30 INFO - 2015-12-17 19:13:30,582 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,582 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:13:30 INFO - 2015-12-17 19:13:30,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:13:30 INFO - 2015-12-17 19:13:30,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:13:30 INFO - 2015-12-17 19:13:30,583 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:13:30 INFO - 2015-12-17 19:13:30,583 DEBUG : BROWSER_OUTPUT: |0;Richards;168.15200941651253 19:13:30 INFO - 2015-12-17 19:13:30,583 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.67924528301887 19:13:30 INFO - 2015-12-17 19:13:30,583 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8988764044944 19:13:30 INFO - 2015-12-17 19:13:30,583 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 19:13:30 INFO - 2015-12-17 19:13:30,583 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1108.6474501108648 19:13:30 INFO - 2015-12-17 19:13:30,584 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 19:13:30 INFO - 2015-12-17 19:13:30,584 DEBUG : BROWSER_OUTPUT: |6;Boyer;12525 19:13:30 INFO - 2015-12-17 19:13:30,584 DEBUG : BROWSER_OUTPUT: |7;RegExp;25275 19:13:30 INFO - 2015-12-17 19:13:30,584 DEBUG : BROWSER_OUTPUT: |8;Splay;644.6078431372549 19:13:30 INFO - 2015-12-17 19:13:30,584 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 19:13:30 INFO - 2015-12-17 19:13:30,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:13:30 INFO - 2015-12-17 19:13:30,584 DEBUG : BROWSER_OUTPUT: __startTimestamp1450408410576__endTimestamp 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.15 Median:168.15 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: Values: 168.2 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,585 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,586 DEBUG : BROWSER_OUTPUT: Values: 188.7 19:13:30 INFO - 2015-12-17 19:13:30,586 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,586 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,586 DEBUG : BROWSER_OUTPUT: Values: 280.9 19:13:30 INFO - 2015-12-17 19:13:30,586 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,586 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,586 DEBUG : BROWSER_OUTPUT: Values: 5128.2 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: Values: 1108.6 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: Values: 788.0 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,587 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,588 DEBUG : BROWSER_OUTPUT: Values: 12525.0 19:13:30 INFO - 2015-12-17 19:13:30,588 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,588 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25275.00 Median:25275.00 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,588 DEBUG : BROWSER_OUTPUT: Values: 25275.0 19:13:30 INFO - 2015-12-17 19:13:30,588 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,588 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:644.61 Median:644.61 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,588 DEBUG : BROWSER_OUTPUT: Values: 644.6 19:13:30 INFO - 2015-12-17 19:13:30,589 DEBUG : BROWSER_OUTPUT: 19:13:30 INFO - 2015-12-17 19:13:30,589 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:13:30 INFO - 2015-12-17 19:13:30,589 DEBUG : BROWSER_OUTPUT: Values: 4830.9 19:13:30 INFO - 2015-12-17 19:13:30,589 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:13:30 INFO - 2015-12-17 19:13:30,589 DEBUG : BROWSER_OUTPUT: 19:13:31 INFO - 2015-12-17 19:13:31,446 INFO : Browser exited with error code: 0 19:13:31 INFO - 2015-12-17 19:13:31,465 INFO : Completed test v8_7 (00:00:39) 19:13:31 INFO - 2015-12-17 19:13:31,534 INFO : Completed test suite (00:20:11) 19:13:31 INFO - 2015-12-17 19:13:31,534 DEBUG : Working with test: dromaeo_css 19:13:31 INFO - 2015-12-17 19:13:31,534 DEBUG : Generating results file: dromaeo_css 19:13:31 INFO - 2015-12-17 19:13:31,535 DEBUG : Working with test: kraken 19:13:31 INFO - 2015-12-17 19:13:31,535 DEBUG : Generating results file: kraken 19:13:31 INFO - 2015-12-17 19:13:31,536 INFO : javascript benchmark 19:13:31 INFO - 2015-12-17 19:13:31,536 DEBUG : Working with test: v8_7 19:13:31 INFO - 2015-12-17 19:13:31,536 DEBUG : Generating results file: v8_7 19:13:31 INFO - 2015-12-17 19:13:31,536 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:13:31 INFO - 2015-12-17 19:13:31,596 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 19:13:31 INFO - 2015-12-17 19:13:31,596 DEBUG : process_Request line: dromaeo_css 6901.38 graph.html#tests=[[72,1,35]] 19:13:31 INFO - 2015-12-17 19:13:31,596 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:13:31 INFO - 2015-12-17 19:13:31,626 DEBUG : process_Request line: kraken 1498.50 graph.html#tests=[[232,1,35]] 19:13:31 INFO - 2015-12-17 19:13:31,626 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:13:31 INFO - 2015-12-17 19:13:31,655 DEBUG : process_Request line: v8_7 20890.62 graph.html#tests=[[230,1,35]] 19:13:31 INFO - 2015-12-17 19:13:31,657 INFO : javascript benchmark 19:13:31 INFO - 2015-12-17 19:13:31,660 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3124.1564777510057, 3127.7185053345197, 3200.487921932491, 3200.583924089868, 3218.6459489456156, 5112.693238405698, 5217.530422261995, 5298.947010529893, 5338.199270109486, 5353.9196912046355, 5256.894862102756, 5298.655587386817, 5320.733963301829, 5342.946570534294, 5343.0, 4785.760711964388, 4807.663463557552, 4846.66073374863, 4948.2330238812865, 4973.900521989558, 4900.166971614816, 4912.263160525932, 4934.235193545006, 4974.403071631409, 5029.094762942669, 4740.194166991585, 4748.715077095368, 4845.079434907374, 4848.539388758062, 4884.242942343943, 4856.2958371036, 4860.270959356089, 4864.367632207825, 4866.635002374836, 4891.413030436335, 4789.688670236424, 4846.9515304846855, 4861.8784530386665, 4872.0, 4910.705357678551, 5072.695638261716, 5098.4646612105935, 5152.355955505562, 5181.844544663666, 5182.766775495112, 5730.627509211888, 5748.0, 5766.740496677659, 5768.625039372428, 5772.076467765138, 5680.914786278209, 5784.913226301609, 5798.188253644493, 5799.768009279624, 5802.4197580241635, 5296.549793267577, 5337.092694241988, 5367.1680889462195, 5376.354837419495, 5386.48828361305, 5802.47777700009, 5813.709314534256, 5820.330661973842, 5821.2141360916585, 5869.882602347929, 5510.1459273812625, 5642.322921249476, 5643.407442218508, 5644.604877658525, 5653.689047102366, 5653.123765816305, 5669.4047125051275, 5711.6001879868845, 5718.628289161191, 5759.884802303931, 5702.971485142631, 5722.399148089391, 5754.4533269339345, 5765.711714414262, 5771.192033115367, 5510.0, 5756.7121643917635, 5761.654300741969, 5762.193292938992, 5765.625234359753, 4344.066025804467, 4346.500152482505, 4391.451068616423, 4448.599626033672, 4466.196084704784, 3999.140184860211, 4002.139539998856, 4004.1190937993597, 4007.599240075969, 4041.151358214749, 5498.477644623755, 5500.4499550044675, 5506.394296627368, 5508.091164957817, 5538.833834984876, 5624.521915637217, 5654.547636189095, 5670.092785154356, 5726.226959360516, 5734.741936612779, 5385.084535628953, 5446.537044351196, 5465.098258787335, 5475.288212532345, 5480.177973304037, 5047.041062198171, 5066.797328106908, 5068.062408454448, 5070.619703522177, 5113.795448182031, 5689.345725241567, 5778.393268706809, 5782.335031471434, 5807.622504537276, 5945.64326140433, 5802.158686990447, 5817.040188368872, 5821.38875418075, 5821.621594596338, 5822.970885145547, 5852.678102704393, 5873.089671100986, 5876.382979787061, 5878.3239927408895, 5881.794137205177, 5435.83692489226, 5444.537214336668, 5500.972495137498, 5537.667739935617, 5655.971720141373, 5768.1636162757, 5779.942200577941, 5800.709964501673, 5805.767769289181, 5807.8548036299435, 5646.181303710857, 5668.319801623831, 5672.631278966854, 5674.517665998436, 5675.347335056521, 5358.651687640291, 5455.099908515051, 5457.890842183214, 5484.670919744828, 5603.74783134768, 5574.777008919597, 5599.132134519156, 5600.523955463831, 5605.411431799603, 5606.551475881838, 5677.574181936454, 5688.260526131577, 5689.857753556194, 5700.173474846041, 5706.258186435737, 5362.410134885237, 5390.0, 5412.729363531729, 5462.9726851365485, 5478.91781623268], "unit": "score", "name": "dojo.html", "value": 5280.772057038495}, {"lowerIsBetter": false, "replicates": [555.2579026837465, 587.8706684529404, 592.6888383598612, 596.2487266044787, 602.3163709190068, 30651.0, 31397.215069623242, 31538.0, 31541.369172616534, 31599.368012639792, 32305.353892922187, 40477.0, 40978.79510602443, 41175.0, 41184.794076029655, 8677.566121693922, 8794.428362156472, 8804.779880503007, 8812.030676625565, 8813.250873675714, 7679.424043196755, 7838.0, 8599.22606965373, 8722.520261385622, 8726.432781869189, 10431.73920651986, 10586.78826423471, 10624.15006799458, 10633.840492392621, 10652.840207396895, 10209.744756381113, 10273.126784223386, 10313.535890884928, 10318.690439286833, 10321.225908056851, 7737.806554836118, 7997.600119993977, 10142.543585538595, 10364.429956352398, 10619.30974486656, 40350.798246008584, 40520.392194117114, 40739.1852162958, 40851.591484085075, 40895.0, 3332.41682705528, 3565.6969157621634, 3794.487744154559, 3951.130751234724, 4059.5331536873045, 30591.0, 30930.690693093005, 30966.690333096605, 31180.53229201564, 31979.0, 3777.54669439669, 3788.9227047871955, 3795.886123416302, 3815.9427608585893, 3971.5631280559114, 275642.0, 276246.0, 277631.0, 278117.0, 278145.99999999796, 53304.466955330725, 53916.0, 58975.0, 59733.0, 60143.699281503315, 59209.70395148083, 59343.703281483315, 59713.71574563441, 59743.0, 59780.70109649424, 16175.757363639555, 16406.917965410095, 16416.507504774636, 16422.917885410734, 16423.753643695352, 12391.93804030992, 12452.81320780189, 12454.065945054157, 12477.5008999639, 12514.49942002328, 19788.0, 20005.099770510362, 20115.49711257201, 20141.09365078575, 20327.186912523335, 7868.84262314762, 8061.798455038554, 8065.596720163969, 8150.75547733569, 8209.302209312274, 989.1048601016092, 990.4305024610734, 1028.1928685981468, 1056.9048785609332, 1071.6035067025095, 25485.3628659285, 25518.390337263525, 25840.22479325623, 25993.22020339393, 26588.46823063528, 1048.764028093688, 1050.5325130316935, 1053.6786280184465, 1057.8413238014205, 1104.2932523185168, 13540.93229533846, 13548.932255338661, 13637.360009565191, 13656.453741850215, 13670.17978921268, 247968.0, 250496.0, 251485.0, 252811.0, 252845.0, 47661.042369703784, 47738.28392574114, 47765.5223447768, 47855.76072119617, 47869.0, 1362.3120324236395, 1376.1467889908322, 1376.291210026817, 1382.882454991337, 1399.3213291553589, 25948.0, 26624.334391640365, 26778.0, 26953.730462695123, 27010.864945675145, 44547.554524455634, 44597.331040035075, 44792.0, 44918.550814491435, 44922.32616510821, 299877.0, 300551.0, 301545.0, 301960.0, 302706.0, 28098.29754256078, 28458.57312140361, 30659.693403065685, 32471.512927306583, 32832.67167328296, 37428.0, 37664.43503347397, 37741.0, 38172.80913595414, 38396.232075358894, 34673.82663086769, 34951.0, 35198.64801351954, 35207.82396088003, 36116.819415902755, 29366.0, 34836.14085779609, 35065.824670876485, 35077.64922350744, 35117.473237900944, 35637.0, 36499.0, 36499.27001460009, 36599.0, 37507.24985500329, 28811.5678264822, 29947.70052299449, 30064.54903176498, 30098.699013010464, 30115.247118821328, 23210.1876434324, 25355.746442536078, 26651.866740666173, 27179.72820271772, 27180.456390872467], "unit": "score", "name": "ext.html", "value": 18285.037314414647}, {"lowerIsBetter": false, "replicates": [355.7723057243363, 361.0810487309796, 363.7671889990407, 365.20567765110883, 367.6470588235294, 13734.793978090336, 14048.578542643712, 16883.662326753456, 17336.30654773809, 18113.909430452844, 14882.925585372084, 17200.483985480423, 17573.472795816113, 17591.472255832312, 17695.203715832788, 4760.262159365304, 5383.43473935237, 5484.341878974508, 5496.148097044965, 5503.147012213093, 4087.9182416351655, 4189.581041895802, 4975.701457912519, 5908.291005079396, 6130.570860039799, 5963.254593175853, 6031.457168854802, 6044.788432404866, 6065.3934606539215, 6068.757249710006, 5270.472952704718, 5443.101888188484, 5456.181572764078, 5462.781488740426, 6095.817125486243, 5233.921491177635, 5240.161574148118, 5243.501867322637, 5251.08106081438, 5263.894722105537, 13548.593542193652, 13551.39018744159, 13554.118982266122, 15162.848371516255, 16523.83476165235, 2057.763357213925, 2133.4026472587702, 2147.8174355179826, 2169.2949791317883, 2182.9235976740897, 9959.75100622483, 10024.54889529973, 13263.336833158304, 13377.130486518443, 13401.860841828457, 1762.1453595006412, 1789.2395731813926, 1869.392447454569, 1872.419549939523, 1933.1397528100001, 57742.0, 60980.085298721, 61028.0, 61352.69323653353, 62067.0, 10348.327358721659, 10370.740731481774, 10385.0, 10391.636292729718, 10435.217358698128, 13611.523596674268, 13628.114172578751, 13628.182309061489, 13632.863671363359, 13635.0, 7747.922520774833, 7851.29338359539, 7854.2145785421, 7866.213378662203, 7915.406344524184, 7582.393408527415, 7641.69433222676, 7663.655135518915, 7667.424943129287, 7671.232876712284, 4482.350059241392, 4501.504834468205, 4505.754469321135, 4514.616257618073, 4524.0, 1722.6554689061986, 1749.545118269259, 1762.6739053275185, 1771.2206629083162, 1805.7359848106378, 388.46391979069267, 395.4720448201683, 397.66794726403197, 408.2243736899914, 852.9317654587618, 10370.377777333384, 10620.575176992988, 10742.462876856282, 11024.559017639205, 11221.382823944761, 858.6222062292571, 887.6981826179131, 919.1727445299284, 972.1979367022094, 999.0708640963974, 9305.232005918853, 9515.0, 9522.619095236252, 9554.092361225672, 9557.474338911426, 485063.0, 545384.0, 555142.0, 562240.0, 564511.0, 71477.0, 71783.6410817953, 73535.0, 75481.0, 80000.19999799927, 1163.7032556697989, 1165.1319766773809, 1173.9882601173879, 1192.358924981171, 1211.678905090134, 15575.221238937782, 15598.532044038697, 15878.60303492422, 16042.278097485874, 16061.518154455385, 32047.679523204468, 34007.4898876522, 34282.65717342795, 34412.0, 35819.82090089533, 38791.6120838788, 39551.2089758209, 40218.798906005286, 42847.0, 43093.784531077144, 9723.951380243054, 9802.50987450639, 10004.299699021, 10034.0, 10034.899651003396, 17415.738763918296, 17788.911055445158, 17837.821621783616, 17997.190126444602, 18120.27518899229, 14380.28098595087, 14495.057821241586, 14601.780973285197, 14777.0, 15067.034485491236, 14351.928240358731, 14597.197154156198, 14817.777733334224, 14828.481003164838, 14938.551843444715, 9477.431354118775, 10003.249756268455, 10330.121939635215, 10343.327683700536, 15335.76996345078, 14146.22195779242, 14370.0, 14397.0, 14754.926225368805, 15067.849321506645, 16427.0, 16458.0, 16525.504234872973, 16720.581985450463, 16942.745858811882], "unit": "score", "name": "jquery.html", "value": 8698.100081154264}, {"lowerIsBetter": false, "replicates": [1473.4474572035488, 1478.2756449339827, 1486.3311509820576, 1506.246876561719, 1508.818941726993, 6636.236832764233, 7223.711051557938, 7413.332800047994, 7432.0, 7438.107427108755, 7301.123865136191, 7449.068866391701, 7455.0, 7459.104907411118, 7462.850742985137, 2156.20220518408, 2178.5098352870555, 2187.453136715821, 2188.5622875424897, 2191.386411804697, 2179.8256139508803, 2212.0930418528405, 2236.798688118069, 2254.323702889135, 2254.842161048727, 2037.8879161646103, 2064.4941989212666, 2064.948376290597, 2098.2970704813906, 2220.378294077661, 2032.0550943811124, 2059.4233614588015, 2059.721937538428, 2061.0, 2061.5258490547108, 2183.3995651195887, 2235.3852690510075, 2236.6980457638174, 2237.2617036377956, 2239.955200895989, 7371.299726525972, 7457.962710186469, 7463.626818659045, 7464.104307483137, 7465.589392583406, 4397.2304846651705, 4414.117176564668, 4420.80106395213, 4450.421445212101, 4453.354263631755, 2923.181509177434, 2951.911442656724, 3032.105528868989, 3045.3909218156236, 3063.0198336532317, 991.1129539062499, 1000.4397537379091, 1003.894591067942, 1009.3540134314045, 1056.6935588679273, 10112.797744045152, 10151.543180556893, 10183.0, 10194.0, 10207.489625518769, 4033.4353190553347, 4057.9797101014306, 4100.0, 4101.671866250693, 4104.138130992465, 8756.4308319959, 8774.868376974351, 8777.605007774666, 8781.165789250012, 8785.033646298902, 4491.88770280739, 4495.865124046284, 4498.797554110073, 4515.0, 4517.11916176349, 3640.7997560133917, 3750.8124593770203, 4064.349704047338, 4142.896427589274, 4143.440635514227, 3468.1849765305133, 3477.5305333779615, 3479.2171761353493, 3489.2498112905846, 3525.065857547752, 1121.7980763462492, 1131.1742428027585, 1131.5077941095649, 1131.5530365505745, 1142.9942850285695, 1289.3488788162106, 1300.2263653126374, 1315.2700251360395, 1322.2529270961875, 1322.616441232051, 6821.590704557643, 6884.965575172092, 6894.827629309308, 6895.655217239118, 6903.482238832108, 492.5074925074925, 493.5582653525075, 494.7649866313544, 496.87329730918384, 513.6173550704749, 5576.776928922797, 5645.520130788929, 5648.661080335193, 5648.915266271009, 5656.462636049569, 8511.872321915176, 8567.27178189861, 8640.006399264164, 8726.694565690297, 8749.737507874774, 8523.190296921783, 8530.061693213742, 8628.050914399411, 8637.913620863837, 8640.222379985831, 7029.578225306498, 7046.189688185924, 7068.3285087916565, 7084.645767711594, 7103.751368702174, 6693.062971184136, 6726.159230096238, 6750.32496750321, 6753.527253092237, 6770.627615481196, 7563.281488258606, 7747.18654541265, 7829.0, 7831.138574756658, 7840.411969102226, 7790.688372465038, 7880.802979925547, 8036.557989310644, 8039.67841286342, 8044.517328960281, 6088.299845517822, 6141.938580614136, 6316.05259211122, 6364.490840732823, 6621.768238111643, 6971.930280697331, 7176.856462870818, 7208.747693830691, 7236.6019868905605, 7250.9637451812405, 6663.800085997428, 6799.558028728117, 6838.692258848264, 6899.241083480913, 6966.582005079711, 6752.426043786137, 6755.648870225876, 6829.69266383004, 6858.897116543156, 6901.137357830271, 6779.542747205238, 6807.047013418027, 6826.453883689393, 6843.589384636938, 6844.760433384808, 6235.781747638811, 6278.623282603058, 6284.937150628618, 6302.086197501429, 6309.148264984168, 6243.313235543996, 6282.842928926813, 6302.338254483213, 6307.558470907176, 6310.1796766420075], "unit": "score", "name": "mootools.html", "value": 4211.0106837995}, {"lowerIsBetter": false, "replicates": [335.832083958021, 341.4945880097454, 344.36464722586834, 345.57666858098816, 348.5503700226708, 5887.558433117512, 6021.729022194001, 6024.909626355608, 6037.818865434038, 6041.486473649734, 5796.362400135981, 5921.171036054956, 5929.407059294069, 5935.584509084366, 5947.583669143161, 4599.701019433743, 4601.286800545904, 4654.39492865927, 4657.556157591141, 4657.813687452498, 4424.491183513889, 4494.393256910308, 4566.84016059438, 4657.20827459331, 4659.813607455698, 4621.191291523986, 4627.490975992638, 4636.02643444877, 4637.258038713807, 4638.768061596924, 4613.284940834159, 4624.306354046903, 4625.306204069383, 4635.814567417299, 4635.8377456789185, 4089.407035979796, 4094.9181016379507, 4104.774237416971, 4106.178764247133, 4117.1765646870745, 5614.129809879475, 5718.857028574277, 5726.971365143189, 5733.741981610796, 5743.942560574383, 5391.73041347931, 5400.162974738922, 5403.189521571757, 5405.5135037846785, 5407.351117865842, 6032.939670603326, 6320.462760665303, 6321.146645202931, 6324.272708638519, 6325.304216536178, 4391.055922976543, 4446.244138496431, 4460.420145381112, 4461.955380446187, 4508.887277818048, 6457.83855403614, 6567.310432404576, 6571.539992200548, 6581.440577550914, 6585.275619681879, 4655.766221951186, 4659.138059459011, 4661.394018777537, 4661.5804577587505, 4665.113628410591, 4629.51390104041, 4723.126221649006, 4723.929141062887, 4732.0, 4762.595179409789, 5391.0, 5398.703071331036, 5400.91898621521, 5404.972975135099, 5407.702576358338, 6402.839929001719, 6411.5832470889245, 6413.711382987777, 6417.358264173638, 6419.325970773095, 1644.4408900973488, 1646.7200575901886, 1647.4316360855726, 1649.0682764238168, 1649.6205872649357, 1078.7464945737745, 1081.643057790927, 1125.7861006408757, 1126.2791813239533, 1184.8222766584909, 6013.609115407485, 6069.241344831896, 6070.817875463743, 6072.453479186895, 6073.058675905242, 6515.869682606416, 6516.087747715229, 6517.771877984248, 6520.804375868732, 6556.901646475307, 5926.970365148147, 6062.060380641008, 6066.7269972850445, 6067.362926892701, 6068.514518838482, 3491.6159222485508, 3535.7701749386206, 3536.398812201932, 3538.7345949053924, 3541.6281290464644, 6581.308962558958, 6619.50353723463, 6619.834504137435, 6623.20521537409, 6642.302558231316, 6438.517111216677, 6673.833154171185, 6677.432418244406, 6681.265060843303, 6691.197056353171, 6558.934410655832, 6569.704363303663, 6587.703553340111, 6589.505787065989, 6595.340465953463, 6347.301796802256, 6489.837754056186, 6509.674516274262, 6516.0, 6524.608523488606, 6577.0, 6591.681663667382, 6599.142111525471, 6601.702923368556, 6610.735570577123, 6752.459803215829, 6754.459643228432, 6754.5947243165565, 6755.121834161528, 6759.290274521104, 4413.536578659323, 4508.797104130256, 4514.706544074756, 4724.905501889874, 4730.148573256847, 6519.185101862267, 6534.934650653433, 6593.175853018372, 6597.703103360456, 6600.372964568358, 6426.807195784134, 6427.164468619237, 6429.839254018687, 6430.582012169194, 6434.227892652912, 6315.715792789428, 6395.968020159869, 6405.0, 6434.67826608677, 6456.225252969673, 6333.809985700436, 6339.334369891095, 6342.270638876588, 6356.618602883842, 6363.204599425072, 6497.415232629086, 6498.382653648085, 6505.772297969548, 6514.413702766774, 6518.934810651833, 6165.6570503208495, 6302.65335406557, 6330.778422755181, 6332.0818481320875, 6357.586756860789], "unit": "score", "name": "prototype.html", "value": 4825.670955219772}, {"lowerIsBetter": false, "replicates": [778.5056489129402, 830.7715378270979, 834.3283656656394, 850.9787255318619, 853.5561508015828, 13290.933545332271, 13923.721525569508, 13930.164190148598, 13947.651308717288, 13949.790753138699, 13183.538576149836, 13304.20174789511, 13331.333433328318, 13333.933330333335, 13351.399187036583, 670.6311528659243, 680.5610381304056, 818.643889907889, 819.7622689420061, 827.1976183102381, 840.2983508770184, 840.7141571865565, 840.7645859159445, 848.0120659431785, 848.6096395658004, 855.0, 865.6104752861206, 866.757307953774, 871.8692196170562, 878.0210065776645, 703.6587255181233, 709.1383968478298, 866.4065115395974, 873.9956300218522, 874.8993865705398, 637.579197729501, 638.1385130074362, 638.9009703495966, 642.0818229931197, 643.0129750832497, 13589.0, 13694.52069177584, 13699.45202191911, 13720.108192967526, 13738.862611373857, 11915.523379064914, 12335.0, 12702.0, 12907.870921290762, 12924.418401171875, 10665.84001239982, 10671.519781609768, 10795.946020269927, 10810.135189184924, 10852.782944341068, 3587.928241435183, 3615.493830863681, 3703.5000274962804, 3719.0702324418894, 3787.696984241282, 46950.0, 48456.27315590269, 48482.51517484815, 48635.51364486381, 48937.02125957496, 10083.0, 10109.544138965117, 10215.0, 10226.53980570876, 10454.52954617044, 17549.473515794547, 17582.208800604003, 17599.560010999572, 17603.11984400775, 17607.383741568985, 6964.756233531802, 6999.790006299819, 7024.859502809915, 7038.824029399204, 7212.783616491513, 4436.245838207448, 4439.311906654474, 4460.7323560586465, 4463.598276155161, 4469.754163521037, 2949.1889730324333, 2967.540031295153, 2977.8064425812254, 2982.030839977016, 2983.254186453387, 545.0704506048544, 545.1876703711441, 546.4044191830924, 555.9471850174227, 558.0958846668423, 532.6165161084014, 612.21024877907, 658.7496751234596, 681.1213534540486, 695.3359541637724, 8052.005025025457, 8633.223009929137, 8682.6092825823, 8873.689420870238, 8895.46627202357, 597.4205021129497, 666.7699643622942, 687.1994126842172, 694.135800927838, 731.4441024821068, 3863.4977452931503, 4074.0, 4116.300228961084, 4198.433211516467, 4217.683673724483, 52125.0, 53329.73335133377, 53533.73233133809, 53633.1955020675, 53711.0, 48314.5168548317, 48660.75669621629, 48759.0, 49657.255141172915, 50033.749831250614, 43211.783941080095, 43326.78336608297, 43880.56119438828, 44483.55516444859, 44819.87950301203, 8167.469114507538, 8415.116412776815, 8586.313094952264, 8714.433561818461, 9323.580438880132, 33651.0, 33714.662853371156, 33843.3231335367, 35385.64614353926, 36718.26563468769, 41672.791636042835, 42108.36837447502, 42881.0, 43451.0, 43529.12941741211, 11209.43952802373, 11281.0, 11329.81897752145, 11440.599579014695, 11446.599369022044, 11970.22193557416, 12204.389780511117, 12232.449539770554, 12294.20087694297, 12302.75394492123, 11688.47401866901, 11830.0, 11962.700932476757, 12415.93792031034, 12456.875431245933, 11231.26996745209, 11509.712257193638, 11516.136289778133, 11705.356205408785, 11955.521779128738, 11560.30638161713, 11768.941155294511, 11953.103517236415, 12017.879821201675, 12145.14983951115, 10159.695209143738, 10181.847272290774, 10260.794784104126, 10490.475476226005, 10897.073748731447, 9360.719178424659, 9487.66793162236, 9768.839620670164, 10357.274990750575, 10466.424346661006], "unit": "score", "name": "yui.html", "value": 6330.126810992747}], "name": "dromaeo_css", "value": 6901.376193450948}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 107.0, 109.0, 110.0, 110.0, 99.0, 108.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [145.0, 131.0, 156.0, 168.0, 130.0, 151.0, 146.0, 132.0, 171.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 161.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 82.0, 93.0, 71.0, 77.0, 72.0, 99.0, 95.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 140.0, 93.0, 93.0, 92.0, 136.0, 93.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 57.0, 57.0, 58.0, 59.0, 58.0, 66.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 69.0, 71.0, 68.0, 70.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 82.0, 83.0, 91.0, 84.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [115.0, 114.0, 116.0, 114.0, 120.0, 116.0, 122.0, 122.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [142.0, 152.0, 149.0, 150.0, 151.0, 144.0, 164.0, 151.0, 149.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1498.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.15200941651253], "unit": "score", "name": "Richards", "value": 209.94099399999996}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [25275.0], "unit": "score", "name": "RegExp", "value": 36.042927794263136}, {"lowerIsBetter": false, "replicates": [644.6078431372549], "unit": "score", "name": "Splay", "value": 126.41949809885934}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20890.619291731062}]} 19:13:31 INFO - RETURN: dromaeo_css: 6901.38 19:13:31 INFO - RETURN: kraken: 1498.50 19:13:31 INFO - RETURN: v8_7: 20890.62 19:13:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20890.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1498.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6901.38"}}} 19:13:31 INFO - Return code: 0 19:13:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:13:31 INFO - # TBPL SUCCESS # 19:13:31 INFO - Running post-action listener: _resource_record_post_action 19:13:31 INFO - Running post-run listener: _resource_record_post_run 19:13:32 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 24576; Write bytes: 560472064; Read time: 240; Write time: 460072 19:13:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249466880; Read time: 0; Write time: 221088 19:13:32 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 24576; Write bytes: 310730752; Read time: 240; Write time: 238952 19:13:32 INFO - Running post-run listener: _upload_blobber_files 19:13:32 INFO - Blob upload gear active. 19:13:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:13:32 INFO - Copying logs to upload dir... 19:13:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.849656 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-17 19:13:32.726378) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 19:13:32.729826) ========= 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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009779 build_url: 'https://queue.taskcluster.net/v1/task/tx4kQS6xSSmruzF-v6WbTQ/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-17 19:13:32.780362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:13:32.780701) ========= 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=b00de3c228505fac2445e70d000001bb-1450405459.944230-30720437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 19:13:32.830161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 19:13:32.830472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 19:13:32.830760) ========= ========= Total master_lag: 0.18 =========