builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1450537704.04 results: success (0) buildid: 20151219043002 builduid: 8a5e4fc4847441bbbd982c3dc26aca76 revision: 388bdc46ba51ee31da8b8abe977e0ca38d117434 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.040712) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.041237) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.041570) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006302 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.130139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.130479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.267537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.267789) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.031638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.344732) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.345040) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.345422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.345798) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-19 07:08:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-19 07:08:24 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.265427 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.640628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.640928) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.216177 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.866685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:24.866996) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 388bdc46ba51ee31da8b8abe977e0ca38d117434 --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 388bdc46ba51ee31da8b8abe977e0ca38d117434 --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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-19 07:08:24,922 truncating revision to first 12 chars 2015-12-19 07:08:24,922 Setting DEBUG logging. 2015-12-19 07:08:24,922 attempt 1/10 2015-12-19 07:08:24,922 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/388bdc46ba51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-19 07:08:25,204 unpacking tar archive at: mozilla-central-388bdc46ba51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.919597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:25.799020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:25.799412) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:25.811420) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:25.811849) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 07:08:25.812338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-19 07:08:25.812663) ========= /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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:26 INFO - MultiFileLogger online at 20151219 07:08:26 in /builds/slave/test-pgo 07:08:26 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 07:08:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:08:26 INFO - {'append_to_log': False, 07:08:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:08:26 INFO - 'blob_upload_branch': 'Firefox', 07:08:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:08:26 INFO - 'branch': 'Firefox', 07:08:26 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:26 INFO - 'config_files': ('talos/linux_config.py',), 07:08:26 INFO - 'default_actions': ('clobber', 07:08:26 INFO - 'read-buildbot-config', 07:08:26 INFO - 'download-and-extract', 07:08:26 INFO - 'populate-webroot', 07:08:26 INFO - 'create-virtualenv', 07:08:26 INFO - 'install', 07:08:26 INFO - 'run-tests'), 07:08:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:26 INFO - 'download_minidump_stackwalk': True, 07:08:26 INFO - 'download_symbols': 'ondemand', 07:08:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:26 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:26 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:26 INFO - 'installer_path': 'installer.exe', 07:08:26 INFO - 'log_level': 'info', 07:08:26 INFO - 'log_name': 'talos', 07:08:26 INFO - 'log_to_console': True, 07:08:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:26 INFO - 'opt_config_files': (), 07:08:26 INFO - 'pip_index': False, 07:08:26 INFO - 'sps_profile': False, 07:08:26 INFO - 'sps_profile_interval': 0, 07:08:26 INFO - 'suite': 'dromaeojs', 07:08:26 INFO - 'system_bits': '64', 07:08:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:26 INFO - 'title': 'talos-linux64-ix-010', 07:08:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:26 INFO - 'use_talos_json': True, 07:08:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:08:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:26 INFO - 'work_dir': 'build'} 07:08:26 INFO - ##### 07:08:26 INFO - ##### Running clobber step. 07:08:26 INFO - ##### 07:08:26 INFO - Running pre-action listener: _resource_record_pre_action 07:08:26 INFO - Running main action method: clobber 07:08:26 INFO - rmtree: /builds/slave/test-pgo/build 07:08:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:08:31 INFO - Running post-action listener: _resource_record_post_action 07:08:31 INFO - ##### 07:08:31 INFO - ##### Running read-buildbot-config step. 07:08:31 INFO - ##### 07:08:31 INFO - Running pre-action listener: _resource_record_pre_action 07:08:31 INFO - Running main action method: read_buildbot_config 07:08:31 INFO - Using buildbot properties: 07:08:31 INFO - { 07:08:31 INFO - "project": "", 07:08:31 INFO - "product": "firefox", 07:08:31 INFO - "script_repo_revision": "production", 07:08:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:08:31 INFO - "repository": "", 07:08:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:08:31 INFO - "buildid": "20151219043002", 07:08:31 INFO - "pgo_build": "True", 07:08:31 INFO - "basedir": "/builds/slave/test-pgo", 07:08:31 INFO - "buildnumber": 145, 07:08:31 INFO - "slavename": "talos-linux64-ix-010", 07:08:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:08:31 INFO - "platform": "ubuntu64_hw", 07:08:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:08:31 INFO - "branch": "mozilla-central", 07:08:31 INFO - "repo_path": "mozilla-central", 07:08:31 INFO - "revision": "388bdc46ba51ee31da8b8abe977e0ca38d117434", 07:08:31 INFO - "stage_platform": "linux64-pgo", 07:08:31 INFO - "builduid": "8a5e4fc4847441bbbd982c3dc26aca76", 07:08:31 INFO - "slavebuilddir": "test" 07:08:31 INFO - } 07:08:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:08:31 INFO - Running post-action listener: _resource_record_post_action 07:08:31 INFO - ##### 07:08:31 INFO - ##### Running download-and-extract step. 07:08:31 INFO - ##### 07:08:31 INFO - Running pre-action listener: _resource_record_pre_action 07:08:31 INFO - Running main action method: download_and_extract 07:08:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:08: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')]} 07:08:31 INFO - https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/test_packages.json 07:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/test_packages.json 07:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:08:36 INFO - Downloaded 1302 bytes. 07:08:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:08:36 INFO - Using the following test package requirements: 07:08:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:36 INFO - u'jsshell-linux-x86_64.zip'], 07:08:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:36 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')]} 07:08:36 INFO - https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:39 INFO - Downloaded 23121213 bytes. 07:08:39 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 07:08:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:39 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 07:08:40 INFO - Return code: 0 07:08:40 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 07:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:40 INFO - https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:45 INFO - Downloaded 23121213 bytes. 07:08:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:08:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:08:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:08:46 INFO - Return code: 0 07:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:46 INFO - https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:47 INFO - Downloaded 11132039 bytes. 07:08:47 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 07:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:47 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 07:08:48 INFO - Return code: 0 07:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:48 INFO - https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0o9dgflLQC2eoFuoB-kTFg/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 07:08:49 INFO - Downloaded 54646771 bytes. 07:08:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:49 INFO - mkdir: /builds/slave/test-pgo/properties 07:08:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:08:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:08:49 INFO - Contents: 07:08:49 INFO - build_url:https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:08:49 INFO - Running post-action listener: _resource_record_post_action 07:08:49 INFO - Running post-action listener: set_extra_try_arguments 07:08:49 INFO - ##### 07:08:49 INFO - ##### Running populate-webroot step. 07:08:49 INFO - ##### 07:08:49 INFO - Running pre-action listener: _resource_record_pre_action 07:08:49 INFO - Running main action method: populate_webroot 07:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:49 INFO - '--tppagecycles', 07:08:49 INFO - '7'], 07:08:49 INFO - 'tests': ['tsvgm']}}, 07:08:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:08:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:08:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'tests': ['damp', 'tps']}, 07:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['damp', 'tps']}, 07:08:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:49 INFO - 'other': {'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore']}, 07:08:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore']}, 07:08:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore']}, 07:08:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore']}, 07:08:49 INFO - 'other_l64': {'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore']}, 07:08:49 INFO - 'other_nol64': {'tests': ['a11yr', 07:08:49 INFO - 'ts_paint', 07:08:49 INFO - 'tpaint', 07:08:49 INFO - 'sessionrestore', 07:08:49 INFO - 'sessionrestore_no_auto_restore']}, 07:08:49 INFO - 'svgr': {'tests': ['tsvgx', 07:08:49 INFO - 'tsvgr_opacity', 07:08:49 INFO - 'tart', 07:08:49 INFO - 'tscrollx', 07:08:49 INFO - 'cart']}, 07:08:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['tsvgx', 07:08:49 INFO - 'tsvgr_opacity', 07:08:49 INFO - 'tart', 07:08:49 INFO - 'tscrollx', 07:08:49 INFO - 'cart']}, 07:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'tests': ['tp5o']}, 07:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--e10s'], 07:08:49 INFO - 'tests': ['tp5o']}, 07:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--xperf_path', 07:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:49 INFO - 'tests': ['tp5n']}, 07:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:49 INFO - 'talos_options': ['--e10s', 07:08:49 INFO - '--xperf_path', 07:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:49 INFO - 'tests': ['tp5n']}}, 07:08:49 INFO - 'talos.zip': {'path': '', 07:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:49 INFO - Running post-action listener: _resource_record_post_action 07:08:49 INFO - ##### 07:08:49 INFO - ##### Running create-virtualenv step. 07:08:49 INFO - ##### 07:08:49 INFO - Running pre-action listener: _resource_record_pre_action 07:08:49 INFO - Running main action method: create_virtualenv 07:08:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:08:49 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 07:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:08:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:50 INFO - Using real prefix '/usr' 07:08:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:08:51 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:53 INFO - Installing pip.................done. 07:08:53 INFO - Return code: 0 07:08:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:08: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')]} 07:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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', '--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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:08:53 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 07:08:53 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 07:08:53 INFO - Using env: {'DISPLAY': ':0', 07:08:53 INFO - 'HOME': '/home/cltbld', 07:08:53 INFO - 'LANG': 'en_US.UTF-8', 07:08:53 INFO - 'LANGUAGE': 'en_US:en', 07:08:53 INFO - 'LOGNAME': 'cltbld', 07:08:53 INFO - 'MAIL': '/var/mail/cltbld', 07:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:53 INFO - 'MOZ_NO_REMOTE': '1', 07:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:53 INFO - 'NO_EM_RESTART': '1', 07:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:53 INFO - 'SHELL': '/bin/bash', 07:08:53 INFO - 'SHLVL': '1', 07:08:53 INFO - 'TERM': 'linux', 07:08:53 INFO - 'TMOUT': '86400', 07:08:53 INFO - 'USER': 'cltbld', 07:08:53 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:53 INFO - '_': '/tools/buildbot/bin/python'} 07:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:53 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 07:08:53 INFO - Cleaning up... 07:08:53 INFO - Return code: 0 07:08:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:08: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')]} 07:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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', '--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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:08:53 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 07:08:53 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 07:08:53 INFO - Using env: {'DISPLAY': ':0', 07:08:53 INFO - 'HOME': '/home/cltbld', 07:08:53 INFO - 'LANG': 'en_US.UTF-8', 07:08:53 INFO - 'LANGUAGE': 'en_US:en', 07:08:53 INFO - 'LOGNAME': 'cltbld', 07:08:53 INFO - 'MAIL': '/var/mail/cltbld', 07:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:53 INFO - 'MOZ_NO_REMOTE': '1', 07:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:53 INFO - 'NO_EM_RESTART': '1', 07:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:53 INFO - 'SHELL': '/bin/bash', 07:08:53 INFO - 'SHLVL': '1', 07:08:53 INFO - 'TERM': 'linux', 07:08:53 INFO - 'TMOUT': '86400', 07:08:53 INFO - 'USER': 'cltbld', 07:08:53 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:53 INFO - '_': '/tools/buildbot/bin/python'} 07:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:54 INFO - Downloading/unpacking psutil>=0.7.1 07:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:08:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:08:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:55 INFO - Installing collected packages: psutil 07:08:55 INFO - Running setup.py install for psutil 07:08:56 INFO - building 'psutil._psutil_linux' extension 07:08:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:08:57 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 07:08:58 INFO - building 'psutil._psutil_posix' extension 07:08:58 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 07:08:58 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 07:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:58 INFO - Successfully installed psutil 07:08:58 INFO - Cleaning up... 07:08:58 INFO - Return code: 0 07:08:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:08:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:08:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:08:58 INFO - Using env: {'DISPLAY': ':0', 07:08:58 INFO - 'HOME': '/home/cltbld', 07:08:58 INFO - 'LANG': 'en_US.UTF-8', 07:08:58 INFO - 'LANGUAGE': 'en_US:en', 07:08:58 INFO - 'LOGNAME': 'cltbld', 07:08:58 INFO - 'MAIL': '/var/mail/cltbld', 07:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:58 INFO - 'MOZ_NO_REMOTE': '1', 07:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:58 INFO - 'NO_EM_RESTART': '1', 07:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:58 INFO - 'SHELL': '/bin/bash', 07:08:58 INFO - 'SHLVL': '1', 07:08:58 INFO - 'TERM': 'linux', 07:08:58 INFO - 'TMOUT': '86400', 07:08:58 INFO - 'USER': 'cltbld', 07:08:58 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:58 INFO - '_': '/tools/buildbot/bin/python'} 07:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:09:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:09:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:09:00 INFO - Installing collected packages: mozsystemmonitor 07:09:00 INFO - Running setup.py install for mozsystemmonitor 07:09:00 INFO - Successfully installed mozsystemmonitor 07:09:00 INFO - Cleaning up... 07:09:00 INFO - Return code: 0 07:09:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:09: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')]} 07:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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', '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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:09: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:09: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 blobuploader==1.2.4 07:09:00 INFO - Using env: {'DISPLAY': ':0', 07:09:00 INFO - 'HOME': '/home/cltbld', 07:09:00 INFO - 'LANG': 'en_US.UTF-8', 07:09:00 INFO - 'LANGUAGE': 'en_US:en', 07:09:00 INFO - 'LOGNAME': 'cltbld', 07:09:00 INFO - 'MAIL': '/var/mail/cltbld', 07:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:00 INFO - 'MOZ_NO_REMOTE': '1', 07:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:00 INFO - 'NO_EM_RESTART': '1', 07:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:00 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:00 INFO - 'SHELL': '/bin/bash', 07:09:00 INFO - 'SHLVL': '1', 07:09:00 INFO - 'TERM': 'linux', 07:09:00 INFO - 'TMOUT': '86400', 07:09:00 INFO - 'USER': 'cltbld', 07:09:00 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:00 INFO - '_': '/tools/buildbot/bin/python'} 07:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:09:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:09:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:09:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:03 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 07:09:03 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 07:09:03 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 07:09:03 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 07:09:03 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 07:09:03 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 07:09:03 INFO - Downloading docopt-0.6.1.tar.gz 07:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:09:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:03 INFO - Running setup.py install for blobuploader 07:09:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:09:03 INFO - Running setup.py install for requests 07:09:03 INFO - Running setup.py install for docopt 07:09:03 INFO - Successfully installed blobuploader requests docopt 07:09:03 INFO - Cleaning up... 07:09:03 INFO - Return code: 0 07:09:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:09:03 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')]} 07:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:03 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')]} 07:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:03 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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:09:03 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 07:09:03 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 07:09:03 INFO - Using env: {'DISPLAY': ':0', 07:09:03 INFO - 'HOME': '/home/cltbld', 07:09:03 INFO - 'LANG': 'en_US.UTF-8', 07:09:03 INFO - 'LANGUAGE': 'en_US:en', 07:09:03 INFO - 'LOGNAME': 'cltbld', 07:09:03 INFO - 'MAIL': '/var/mail/cltbld', 07:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:03 INFO - 'MOZ_NO_REMOTE': '1', 07:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:03 INFO - 'NO_EM_RESTART': '1', 07:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:03 INFO - 'SHELL': '/bin/bash', 07:09:03 INFO - 'SHLVL': '1', 07:09:03 INFO - 'TERM': 'linux', 07:09:03 INFO - 'TMOUT': '86400', 07:09:03 INFO - 'USER': 'cltbld', 07:09:03 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:03 INFO - '_': '/tools/buildbot/bin/python'} 07:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:09:04 INFO - Running setup.py (path:/tmp/pip-h49oOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:09:04 INFO - Running setup.py (path:/tmp/pip-AzGwoi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:09:04 INFO - Running setup.py (path:/tmp/pip-foEglX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:09:04 INFO - Running setup.py (path:/tmp/pip-fO1yUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:09:04 INFO - Running setup.py (path:/tmp/pip-BcuyzX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:09:04 INFO - Running setup.py (path:/tmp/pip-35AJ3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:09:04 INFO - Running setup.py (path:/tmp/pip-eLDGa1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:09:04 INFO - Running setup.py (path:/tmp/pip-pDeNAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:09:04 INFO - Running setup.py (path:/tmp/pip-povZse-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:09:04 INFO - Running setup.py (path:/tmp/pip-WJV9yT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:09:04 INFO - Running setup.py (path:/tmp/pip-akpsd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:09:04 INFO - Running setup.py (path:/tmp/pip-QqIso0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:09:04 INFO - Running setup.py (path:/tmp/pip-wtFJ6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:09:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:09:05 INFO - Running setup.py (path:/tmp/pip-2ZOoHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:09:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:09:05 INFO - Running setup.py (path:/tmp/pip-IEWtx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:09:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:09:05 INFO - Running setup.py (path:/tmp/pip-0yI5Ni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:09:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:09:05 INFO - Running setup.py (path:/tmp/pip-rCIdrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:09:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:05 INFO - Running setup.py install for manifestparser 07:09:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:09:05 INFO - Running setup.py install for mozcrash 07:09:05 INFO - Running setup.py install for mozdebug 07:09:05 INFO - Running setup.py install for mozdevice 07:09:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:09:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:09:05 INFO - Running setup.py install for mozfile 07:09:05 INFO - Running setup.py install for mozhttpd 07:09:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:09:05 INFO - Running setup.py install for mozinfo 07:09:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Running setup.py install for mozInstall 07:09:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Running setup.py install for mozleak 07:09:06 INFO - Running setup.py install for mozlog 07:09:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Running setup.py install for moznetwork 07:09:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Running setup.py install for mozprocess 07:09:06 INFO - Running setup.py install for mozprofile 07:09:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Running setup.py install for mozrunner 07:09:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:09:06 INFO - Running setup.py install for mozscreenshot 07:09:06 INFO - Running setup.py install for moztest 07:09:06 INFO - Running setup.py install for mozversion 07:09:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:09:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:07 INFO - Cleaning up... 07:09:07 INFO - Return code: 0 07:09:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:09:07 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')]} 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:07 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')]} 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:07 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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:09:07 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 07:09:07 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 07:09:07 INFO - Using env: {'DISPLAY': ':0', 07:09:07 INFO - 'HOME': '/home/cltbld', 07:09:07 INFO - 'LANG': 'en_US.UTF-8', 07:09:07 INFO - 'LANGUAGE': 'en_US:en', 07:09:07 INFO - 'LOGNAME': 'cltbld', 07:09:07 INFO - 'MAIL': '/var/mail/cltbld', 07:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:07 INFO - 'MOZ_NO_REMOTE': '1', 07:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:07 INFO - 'NO_EM_RESTART': '1', 07:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:07 INFO - 'SHELL': '/bin/bash', 07:09:07 INFO - 'SHLVL': '1', 07:09:07 INFO - 'TERM': 'linux', 07:09:07 INFO - 'TMOUT': '86400', 07:09:07 INFO - 'USER': 'cltbld', 07:09:07 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:07 INFO - '_': '/tools/buildbot/bin/python'} 07:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:09:07 INFO - Running setup.py (path:/tmp/pip-0dOxnN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:09:07 INFO - Running setup.py (path:/tmp/pip-w67FLY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:09:07 INFO - Running setup.py (path:/tmp/pip-7wNDyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:09:07 INFO - Running setup.py (path:/tmp/pip-iiVIkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:09:07 INFO - Running setup.py (path:/tmp/pip-mZbWbf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:09:07 INFO - Running setup.py (path:/tmp/pip-Po3wgW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:09:07 INFO - Running setup.py (path:/tmp/pip-MU8LMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:09:07 INFO - Running setup.py (path:/tmp/pip-CZF1DT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:09:07 INFO - Running setup.py (path:/tmp/pip-RQq3iA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:09:07 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)) 07:09:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:09:07 INFO - Running setup.py (path:/tmp/pip-jBGlJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:09:08 INFO - Running setup.py (path:/tmp/pip-aWGzI1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:09:08 INFO - Running setup.py (path:/tmp/pip-w82Qwx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:09:08 INFO - Running setup.py (path:/tmp/pip-pcYb5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:09:08 INFO - Running setup.py (path:/tmp/pip-ZMvJ94-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:09:08 INFO - Running setup.py (path:/tmp/pip-4MovlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:09:08 INFO - Running setup.py (path:/tmp/pip-aJM8CH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:09:08 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)) 07:09:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:09:08 INFO - Running setup.py (path:/tmp/pip-Nm_9ce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:09:08 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)) 07:09:08 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)) 07:09:08 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)) 07:09:08 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)) 07:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:08 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)) 07:09:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:08 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 07:09:08 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 07:09:08 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 07:09:08 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 07:09:08 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 07:09:08 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 07:09:10 INFO - Downloading blessings-1.5.1.tar.gz 07:09:10 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 07:09:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:10 INFO - Installing collected packages: blessings 07:09:10 INFO - Running setup.py install for blessings 07:09:10 INFO - Successfully installed blessings 07:09:10 INFO - Cleaning up... 07:09:10 INFO - Return code: 0 07:09:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:09:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:09:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:09:10 INFO - Reading from file tmpfile_stdout 07:09:10 INFO - Current package versions: 07:09:10 INFO - argparse == 1.2.1 07:09:10 INFO - blessings == 1.5.1 07:09:10 INFO - blobuploader == 1.2.4 07:09:10 INFO - docopt == 0.6.1 07:09:10 INFO - manifestparser == 1.1 07:09:10 INFO - mozInstall == 1.12 07:09:10 INFO - mozcrash == 0.16 07:09:10 INFO - mozdebug == 0.1 07:09:10 INFO - mozdevice == 0.47 07:09:10 INFO - mozfile == 1.2 07:09:10 INFO - mozhttpd == 0.7 07:09:10 INFO - mozinfo == 0.9 07:09:10 INFO - mozleak == 0.1 07:09:10 INFO - mozlog == 3.1 07:09:10 INFO - moznetwork == 0.27 07:09:10 INFO - mozprocess == 0.22 07:09:10 INFO - mozprofile == 0.27 07:09:10 INFO - mozrunner == 6.11 07:09:10 INFO - mozscreenshot == 0.1 07:09:10 INFO - mozsystemmonitor == 0.0 07:09:10 INFO - moztest == 0.7 07:09:10 INFO - mozversion == 1.4 07:09:10 INFO - psutil == 3.1.1 07:09:10 INFO - requests == 1.2.3 07:09:10 INFO - wsgiref == 0.1.2 07:09:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:09:10 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')]} 07:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:10 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')]} 07:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:10 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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:09:10 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 07:09:10 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 07:09:10 INFO - Using env: {'DISPLAY': ':0', 07:09:10 INFO - 'HOME': '/home/cltbld', 07:09:10 INFO - 'LANG': 'en_US.UTF-8', 07:09:10 INFO - 'LANGUAGE': 'en_US:en', 07:09:10 INFO - 'LOGNAME': 'cltbld', 07:09:10 INFO - 'MAIL': '/var/mail/cltbld', 07:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:10 INFO - 'MOZ_NO_REMOTE': '1', 07:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:10 INFO - 'NO_EM_RESTART': '1', 07:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:10 INFO - 'SHELL': '/bin/bash', 07:09:10 INFO - 'SHLVL': '1', 07:09:10 INFO - 'TERM': 'linux', 07:09:10 INFO - 'TMOUT': '86400', 07:09:10 INFO - 'USER': 'cltbld', 07:09:10 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:10 INFO - '_': '/tools/buildbot/bin/python'} 07:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:10 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)) 07:09:10 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)) 07:09:10 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)) 07:09:10 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)) 07:09:10 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)) 07:09:10 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)) 07:09:10 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)) 07:09:10 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)) 07:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:09:10 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)) 07:09:10 INFO - Cleaning up... 07:09:10 INFO - Return code: 0 07:09:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:09:10 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')]} 07:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:10 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')]} 07:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:10 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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:09:10 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 07:09:10 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 07:09:10 INFO - Using env: {'DISPLAY': ':0', 07:09:10 INFO - 'HOME': '/home/cltbld', 07:09:10 INFO - 'LANG': 'en_US.UTF-8', 07:09:10 INFO - 'LANGUAGE': 'en_US:en', 07:09:10 INFO - 'LOGNAME': 'cltbld', 07:09:10 INFO - 'MAIL': '/var/mail/cltbld', 07:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:10 INFO - 'MOZ_NO_REMOTE': '1', 07:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:10 INFO - 'NO_EM_RESTART': '1', 07:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:10 INFO - 'SHELL': '/bin/bash', 07:09:10 INFO - 'SHLVL': '1', 07:09:10 INFO - 'TERM': 'linux', 07:09:10 INFO - 'TMOUT': '86400', 07:09:10 INFO - 'USER': 'cltbld', 07:09:10 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:10 INFO - '_': '/tools/buildbot/bin/python'} 07:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:11 INFO - Downloading/unpacking jsonschema 07:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:12 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 07:09:12 INFO - Downloading/unpacking functools32 (from jsonschema) 07:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:12 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:09:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:13 INFO - warning: no files found matching '*.txt' 07:09:13 INFO - no previously-included directories found matching 'build' 07:09:13 INFO - no previously-included directories found matching 'dist' 07:09:13 INFO - no previously-included directories found matching '.git*' 07:09:13 INFO - Installing collected packages: jsonschema, functools32 07:09:13 INFO - Running setup.py install for functools32 07:09:13 INFO - warning: no files found matching '*.txt' 07:09:13 INFO - no previously-included directories found matching 'build' 07:09:13 INFO - no previously-included directories found matching 'dist' 07:09:13 INFO - no previously-included directories found matching '.git*' 07:09:13 INFO - Successfully installed jsonschema functools32 07:09:13 INFO - Cleaning up... 07:09:13 INFO - Return code: 0 07:09:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:09:13 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')]} 07:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:13 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')]} 07:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:13 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 0x7f7780915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', '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 07:09:13 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 07:09:13 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 07:09:13 INFO - Using env: {'DISPLAY': ':0', 07:09:13 INFO - 'HOME': '/home/cltbld', 07:09:13 INFO - 'LANG': 'en_US.UTF-8', 07:09:13 INFO - 'LANGUAGE': 'en_US:en', 07:09:13 INFO - 'LOGNAME': 'cltbld', 07:09:13 INFO - 'MAIL': '/var/mail/cltbld', 07:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:13 INFO - 'MOZ_NO_REMOTE': '1', 07:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:13 INFO - 'NO_EM_RESTART': '1', 07:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:13 INFO - 'SHELL': '/bin/bash', 07:09:13 INFO - 'SHLVL': '1', 07:09:13 INFO - 'TERM': 'linux', 07:09:13 INFO - 'TMOUT': '86400', 07:09:13 INFO - 'USER': 'cltbld', 07:09:13 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:13 INFO - '_': '/tools/buildbot/bin/python'} 07:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:13 INFO - Downloading/unpacking flake8 07:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:15 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 07:09:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:09:15 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 07:09:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:15 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 07:09:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:09:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:09:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:15 INFO - no previously-included directories found matching 'docs/_build' 07:09:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:09:15 INFO - Running setup.py install for pep8 07:09:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:15 INFO - no previously-included directories found matching 'docs/_build' 07:09:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:09:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:09:15 INFO - Cleaning up... 07:09:16 INFO - Return code: 0 07:09:16 INFO - Running post-action listener: _resource_record_post_action 07:09:16 INFO - Running post-action listener: _start_resource_monitoring 07:09:16 INFO - Starting resource monitoring. 07:09:16 INFO - ##### 07:09:16 INFO - ##### Running install step. 07:09:16 INFO - ##### 07:09:16 INFO - Running pre-action listener: _resource_record_pre_action 07:09:16 INFO - Running main action method: install 07:09:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:09:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:09:16 INFO - Reading from file tmpfile_stdout 07:09:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:09:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:09:16 INFO - Reading from file tmpfile_stdout 07:09:16 INFO - Output received: 07:09:16 INFO - Usage: mozinstall [options] installer 07:09:16 INFO - Options: 07:09:16 INFO - -h, --help show this help message and exit 07:09:16 INFO - -d DEST, --destination=DEST 07:09:16 INFO - Directory to install application into. [default: 07:09:16 INFO - "/builds/slave/test-pgo"] 07:09:16 INFO - --app=APP Application being installed. [default: firefox] 07:09:16 INFO - mkdir: /builds/slave/test-pgo/build/application 07:09:16 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'] 07:09:16 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 07:09:32 INFO - Reading from file tmpfile_stdout 07:09:32 INFO - Output received: 07:09:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:09:32 INFO - Running post-action listener: _resource_record_post_action 07:09:32 INFO - ##### 07:09:32 INFO - ##### Running run-tests step. 07:09:32 INFO - ##### 07:09:32 INFO - Running pre-action listener: _resource_record_pre_action 07:09:32 INFO - Running main action method: run_tests 07:09:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:09:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:09:32 INFO - Python 2.7.3 07:09:32 INFO - Return code: 0 07:09:32 INFO - grabbing minidump binary from tooltool 07:09: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')]} 07:09:32 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 0x2153350>, '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 0x2154250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21546e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:09:32 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 07:09:32 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 07:09:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:32 INFO - Return code: 0 07:09:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:09:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:09:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:09:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:09:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:09:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:09:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:09:33 INFO - Return code: 0 07:09:33 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/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:09:33 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/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 07:09:33 INFO - Using env: {'DISPLAY': ':0', 07:09:33 INFO - 'HOME': '/home/cltbld', 07:09:33 INFO - 'LANG': 'en_US.UTF-8', 07:09:33 INFO - 'LANGUAGE': 'en_US:en', 07:09:33 INFO - 'LOGNAME': 'cltbld', 07:09:33 INFO - 'MAIL': '/var/mail/cltbld', 07:09:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:09:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:33 INFO - 'MOZ_NO_REMOTE': '1', 07:09:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:33 INFO - 'NO_EM_RESTART': '1', 07:09:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:09:33 INFO - 'PWD': '/builds/slave/test-pgo', 07:09:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:09:33 INFO - 'SHELL': '/bin/bash', 07:09:33 INFO - 'SHLVL': '1', 07:09:33 INFO - 'TERM': 'linux', 07:09:33 INFO - 'TMOUT': '86400', 07:09:33 INFO - 'USER': 'cltbld', 07:09:33 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242', 07:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:33 INFO - '_': '/tools/buildbot/bin/python'} 07:09:33 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/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 07:09:33 INFO - mozversion INFO | application_buildid: 20151219043002 07:09:33 INFO - mozversion INFO | application_changeset: 388bdc46ba51ee31da8b8abe977e0ca38d117434 07:09:33 INFO - mozversion INFO | application_display_name: Nightly 07:09:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:33 INFO - mozversion INFO | application_name: Firefox 07:09:33 INFO - mozversion INFO | application_remotingname: firefox 07:09:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:09:33 INFO - mozversion INFO | application_vendor: Mozilla 07:09:33 INFO - mozversion INFO | application_version: 46.0a1 07:09:33 INFO - mozversion INFO | platform_buildid: 20151219043002 07:09:33 INFO - mozversion INFO | platform_changeset: 388bdc46ba51ee31da8b8abe977e0ca38d117434 07:09:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:09:33 INFO - mozversion INFO | platform_version: 46.0a1 07:09:33 INFO - 2015-12-19 07:09:33,774 DEBUG : using testdate: 1450537773 07:09:33 INFO - 2015-12-19 07:09:33,774 DEBUG : actual date: 1450537773 07:09:33 INFO - 2015-12-19 07:09:33,865 INFO : starting webserver on 'localhost:58835' 07:09:33 INFO - 2015-12-19 07:09:33,866 INFO : Starting test suite talos-linux64-ix-010 07:09:33 INFO - 2015-12-19 07:09:33,867 INFO : Starting test dromaeo_css 07:09:33 INFO - 2015-12-19 07:09:33,867 DEBUG : operating with platform_type : linux_ 07:09:33 INFO - 2015-12-19 07:09:33,867 INFO : Initialising browser for dromaeo_css test... 07:09:33 INFO - 2015-12-19 07:09:33,882 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptos_0M/profile http://localhost:58835/getInfo.html 07:09:40 INFO - 2015-12-19 07:09:40,831 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:09:40 INFO - 2015-12-19 07:09:40,831 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:09:40 INFO - 2015-12-19 07:09:40,831 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:09:40 INFO - 2015-12-19 07:09:40,832 DEBUG : BROWSER_OUTPUT: __metrics 07:09:41 INFO - 2015-12-19 07:09:41,015 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:41 INFO - 2015-12-19 07:09:41,077 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:42 INFO - 2015-12-19 07:09:42,102 INFO : Browser initialized. 07:09:42 INFO - 2015-12-19 07:09:42,102 INFO : Running cycle 1/1 for dromaeo_css test... 07:09:42 INFO - 2015-12-19 07:09:42,102 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptos_0M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:09:53 INFO - 2015-12-19 07:09:53,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 149635072 07:09:53 INFO - 2015-12-19 07:09:53,868 DEBUG : BROWSER_OUTPUT: 07:10:45 INFO - 2015-12-19 07:10:45,453 DEBUG : BROWSER_OUTPUT: 1450537845449 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] 07:12:54 INFO - 2015-12-19 07:12:54,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58835/tests/dromaeo/cssquery-ext.html) 07:12:55 INFO - 2015-12-19 07:12:55,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 236728320 07:12:55 INFO - 2015-12-19 07:12:55,834 DEBUG : BROWSER_OUTPUT: 07:15:58 INFO - 2015-12-19 07:15:58,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/dromaeo/cssquery-ext.html (next: http://localhost:58835/tests/dromaeo/cssquery-jquery.html) 07:15:58 INFO - 2015-12-19 07:15:58,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 236916736 07:15:58 INFO - 2015-12-19 07:15:58,714 DEBUG : BROWSER_OUTPUT: 07:19:00 INFO - 2015-12-19 07:19:00,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58835/tests/dromaeo/cssquery-mootools.html) 07:19:01 INFO - 2015-12-19 07:19:01,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 235057152 07:19:01 INFO - 2015-12-19 07:19:01,320 DEBUG : BROWSER_OUTPUT: 07:22:03 INFO - 2015-12-19 07:22:03,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58835/tests/dromaeo/cssquery-prototype.html) 07:22:03 INFO - 2015-12-19 07:22:03,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 214564864 07:22:03 INFO - 2015-12-19 07:22:03,762 DEBUG : BROWSER_OUTPUT: 07:25:06 INFO - 2015-12-19 07:25:06,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58835/tests/dromaeo/cssquery-yui.html) 07:25:06 INFO - 2015-12-19 07:25:06,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 195764224 07:25:06 INFO - 2015-12-19 07:25:06,891 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/dromaeo/cssquery-yui.html (next: http://localhost:58835/tests/dromaeo/cssquery-dojo.html) 07:28:09 INFO - 2015-12-19 07:28:09,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 301707264 07:28:09 INFO - 2015-12-19 07:28:09,769 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,770 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:28:09 INFO - 2015-12-19 07:28:09,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:28:09 INFO - 2015-12-19 07:28:09,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:28:09 INFO - 2015-12-19 07:28:09,770 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:28:09 INFO - 2015-12-19 07:28:09,770 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3137.1372872460074;3155.526670999351;3208.149840292323;3208.855601497932;3230.3539292141572;5078.492150784919;5182.611304152185;5254.658447200929;5288.180332048534;5321.521063104325;5243.947560524393;5304.734763261841;5349.956758432098;5353.0899747042995;5377.435369286227;4692.906141877161;4748.691335063209;4772.618190544766;4793.832215872445;4815.855524334275;4858.757062146896;4921.286413470062;4975.9004819903585;4983.700977941335;5025.874353141164;4710.26990816424;4792.544708252711;4913.434954980187;4919.803207871699;4960.032793605248;4831.710097394168;4834.661573689843;4838.806447742086;4843.24929635907;4844.442889067767;4854.393200849894;4867.002264535797;4868.805247790084;4872.269159626049;4875.195592727196;5065.138926382524;5178.0679477694;5178.508041736067;5184.326037615086;5186.0665080285535;5749.6550206987295;5758.078707406837;5759.510441612468;5774;5775.913361299584;5742.310922689262;5776;5783.21926539916;5803.767849286023;5806.187133801272;5260.184671375943;5284.07528682479;5351.304330437058;5367.114426119686;5441.727913604304;5803.5357171426185;5837.912431313449;5884.676342801187;5891.970540147272;5944.910826337608;5703.74333155009;5711.114777209539;5728.198052272685;5733.02538568436;5740.655560666373;5489.533389661923;5579.38626751057;5591.52472039873;5659.179418984307;5751.971240143773;5589.329280486287;5593.916091258634;5603.271574695345;5623.803166889139;5739.8852022960145;5580.469855363734;5587.3015873015875;5589.105743081169;5598.776048958078;5601.467860553241;4339.262325404688;4360.847370342023;4447.555244475527;4456.264716321771;4459.2865141577195;3960.980195099006;3965.78188199646;3975.960240397617;4003.8598649047144;4021.135455876942;5485.232067510552;5495.587830912697;5498.0653288940175;5509.614326997072;5511.696856672841;5457.099578569571;5559;5601.159826026129;5609.1305847593685;5612.186232996192;5305.549028332558;5320.441353657888;5356.7857285708915;5361.088614935392;5431.34823821144;4898.853034408973;4923.359963204761;4927.211646136601;5009.173486374707;5021.096202683552;5826.563007774434;5837.47268030992;5849.941500585025;5850.414958504116;5877.5591830612875;5327.627066105335;5502.477264659851;5657.745401456862;5669.234653321913;5735.340435849931;5785.82642520725;5886.293644762656;5937.851553711192;5969.7313620888035;6017.909731353946;5612.971935140298;5615.606907516598;5620.971895140498;5626.2967129108865;5638.2670252866865;5441.21102440136;5553.972230138824;5698.914516282176;5710.714464276686;5729.541636668973;5430.619856609999;5460.645058071213;5552.666839989613;5575.944240557705;5602.1036634138345;5529.612927095226;5544.445555444423;5545.421379058757;5550.47270509301;5553.6390134641115;5499.092649712753;5501.422350653123;5508.889822203453;5511.586631002771;5539.916901246565;5392;5486.835394938158;5495.835124946258;5530.5022547970875;5691.2032315475035;5466.72666366688;5510.834674959758;5518;5519.199716041232;5559.138333558305 07:28:09 INFO - 2015-12-19 07:28:09,770 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.0784974416573;567.9574031947604;568.5252813900391;590.2592246730353;608.902575587906;29873.85063074684;38572.61427385725;39338.8033059835;39439.40840887389;39564.80217598915;41950;42654.786726066406;42683.573164268346;42701;42731;7518.699252029912;7620.161782203953;8500.14998500148;8670.52312122833;8672.696455624055;10193.490325483734;10416.42709650969;10442.164626829874;10446.634367797129;10499.790004199911;10164.288499805016;10212;10256.128229100535;10265;10272.07551320381;7739.419543534257;7917.722879699183;7929.484583502054;10105.090541851232;10208.48957552127;10026.849597256047;10201.132903703194;10207.081362677394;10207.489625518694;10209;38891.416628750594;39250.41124383137;39262.80368598167;39298.214035719124;39383.21233575312;3050.42042012017;3147.9055628330957;3191.515722179561;3218.7103160715415;3901.6878649707955;29802;29862.40275194484;29901.252468688457;30233.697663023308;30417.543736843745;3613.1711363557297;3754.6057663945166;3776.527934008249;3829.8276577554075;3855.3445914194654;267193;268259;268945;269098;269195.999999998;54010;56032;56301.71849140728;56377.154342684895;56514.15228771572;49100;65780.34219657838;67204;67222.66388668025;67252.32747672558;13160.802587961189;13326.600201993955;13333;13340.599782006555;13352.065355425028;10512.684619461428;10521.105706015074;10548.314359566604;10578.788424231472;10602.098821600097;18754.34359797428;18813.529661758566;18819.811801881806;18841.528961776065;18844.623107537773;7627.330434347934;7669.194734552903;7739.419543534144;7887.881681774778;7893.644785984645;934.6868798952427;982.8574856645746;1104.7735214281054;1121.9046381057701;1135.8750537440874;27631.447371052465;27840.32446580026;27891.302717432227;28173.295667608472;28215.43569128606;1008.1581879130861;1054.1914053564913;1067.5783065689009;1068.2095249515303;1140.406988366045;13402.865971340161;13440.9568307975;13590.38843252056;13633.318334083455;13654;301257;304043;305234;305531;306151;48391.274130888065;48487;48533.75733121312;48688.51311486911;48743.5125648746;1269.2321145706899;1279.3539262672477;1280.7438512297579;1292.6057552446407;1327.681356474439;24638.13766518163;25560.360990975376;25732.61401079023;25817.354566135997;25959.740402596486;40578;40850.387244190766;40931.38602920899;40946.79526602348;40947.7952610235;285497;287202;288051;289492;289623;26042.21873343803;26612.467750644493;29181.562276565444;29677;29720.554191687574;35125;35156.824215878754;35900.28199436049;35928.82035589805;35932.4610130843;32486;32713.34573308568;32931.34137317288;33277.33445331128;33487.33025339528;26561.60157597676;30564.541531877483;32675.67324326726;33184.834075829465;35038.47442288419;32790.672093278765;32855.561207695995;32977;33233.51646978222;33284.66715332912;28591.857040715495;29931.700682993764;30474.23814404569;30603.971828311147;30609;22962;23314.562024913062;23508.41228969221;23659.64510532309;23684.88157559201 07:28:09 INFO - 2015-12-19 07:28:09,774 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.75681509313284;345.19741600778195;346.5737143313724;353.6640191817773;355.60705420510334;14109.506167284148;14488.927555362236;16533.421330253444;16969.406070787525;17958.371456999008;16485;16873.66252674949;17039;17417.21622526986;17426.128693565304;5188.792448302072;5349.839504814842;5351.545118664899;5355.116405793039;5357.116075847481;4013.177298653769;4127.649149822254;5299.390570084451;5805.680687562182;5967.6121052131475;5875.177475153482;5883.558733095035;5884.087966365199;5903.763849446039;5907.995640741063;5787.160861675055;5956.880862382772;5962.25471816023;5964.970175149118;5969.224000879858;5174.896502069975;5175.404828444739;5177.58579313654;5185.507376799235;5215;20442.795572044237;21062.157513699432;21225.893870530548;21432.14271429141;22065.33803985883;2265.275111964172;2303.37808791627;2330.6154484510034;2344.765523447659;2414.7635294996708;13888.23614701191;14039.859601403958;14300.427982880672;14392.71214575713;14629.41482340705;1945.4941715154162;1964.4204959536971;1980.692992586137;2018.1725492548132;2118.3433135727973;69013.65493172553;69330.65334673345;70352;70445.64777176133;70727.11000894949;15334.386624534895;15452.150131742637;15460.226988650522;15524.611884702972;15556.922215388851;24279.39301517441;24378.75621243765;24433.633495497583;24522.386940326276;24529.63205551918;8882.333824963154;8922.107789221025;8925.241354484811;8925.375223734407;8985.640574377083;7417.332440080419;7426.331630153312;7473.252674732484;7479.70081196746;7484.363829074481;7652.885206721904;7754.457187996786;7758.612069396508;7774.455788094892;7977.60111994398;1711.6833385823663;1826.4703236061393;1826.8995205263839;1829.0854572713642;2211.9889400552893;405.46478648184114;808.0988359410568;903.1014140929817;921.1433366968649;928.9024652411534;9635.421874687401;10062.849057264148;10252.743681408025;10422.21833362501;10500.527476263587;421.46263514019256;427.9079997800488;444.7153821554208;446.88157638225897;455.84045584045316;5891.116332550152;5957.344692083867;5974.820755377345;6011.09833524966;6044.184035155197;521846;523350;527116;546112;554432;82695.58652206701;83886.58056709677;83956.58021709853;84141;84892;489.66213312814045;495.5341978540161;496.0302608400568;497.39069639691087;497.52237851662085;10175.643852465128;10216.744581385228;10228.64199753005;10267.178625710074;10328.690139295833;31731.365372691955;32856;33540.32919341648;33682.663173368936;34008.65991340154;40228.59771402366;43732.34401484044;46140.30789538092;46326.76836615795;46693.53306467028;9219.170274675043;9266.44401335922;9490.905090949278;9571.234301255743;9595.184409325286;11234.157438192331;11256.549738010388;11365.204435689422;14831.92584037073;17573;13746.518871839438;13880.305984700926;14156.150630962175;14498.710025799635;15284.15937123469;14538.709225815635;14705.191214482878;14761.630959225675;14975.925120374328;15045.47340843109;14429.92785036068;14767.335469904096;14812.629684257548;15283.694326113193;15452.5364239073;8337.458065225741;8577;14144.858551414354;14720.484783032542;15356.07863528192;14950.775738363716;15303.158326292161;15412.460563880659;15431.922840385727;15824.129672868103 07:28:09 INFO - 2015-12-19 07:28:09,775 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1305.9673508162289;1606.5822886049627;1659.0709202846406;1683.7474378843172;1723.3106757297087;6320.652364119972;6843.589384636925;7029.297070292968;7084.114485689282;7092;7080.752173673923;7213.2786721327975;7237.7466788662405;7244.456665750064;7259.564426134436;1942.766867975845;1961.0390908454826;2058.217877206663;2081.687746837979;2096.8951552422395;2004.1181879972764;2006.799320067989;2010.3566858605252;2012.6880333548324;2013.1242909334412;1990.7412036435317;2051.3128102085743;2135.2846796323174;2137.8396620253466;2138.550904310097;2105.7473103227635;2110.8627939183903;2134.157007981846;2137.9786202137934;2154.385999990011;2162.76209616942;2173.7500187478486;2187.6062308784412;2188.2231807708195;2190.496185877257;6847.281035491252;6948.895766563455;6959.921212212115;6969.2682268362105;6978.581285122909;4316.072044510445;4422.778861056934;4427.845025424127;4428.822847086113;4430.313301438282;2822.520171570838;2910.985445072782;2923.5468502382164;2942.970570294291;2946.6758656547763;999.9500024998721;1004.6232662751469;1018.1498448795265;1022.5194158745378;1067.2635881241918;9537.237021038369;9555.522223888778;9565.521723913846;9573.952130239304;9576.090271424135;3868.7678739275734;3914.8629797956933;3945.11234972129;3960.7623542587535;3982.4225487304757;8306.626201820933;8310.792230194293;8312.792180195422;8317.584120793936;8319.084900660922;4306.633936115402;4308.375285583573;4340.587644173798;4340.739555626609;4341.522432532419;3981.5421226558738;3983.1635356575443;3986.980065099656;3987.182627561343;3989.202159568098;3050.481418158918;3084.306031142975;3210.06907996683;3234.045956442855;3476.28736109097;1096.2983690438125;1097.2812807611028;1102.6195962392962;1127.087059481806;1127.3799410324289;943.8018016216671;963.7012526116927;1057.5188289328337;1172.783035138502;1172.8475298211179;6740.460763139035;6779.220389655155;6869.278725733726;6891.586504809728;6901.896471552931;1079.83262594298;1081.5133190064346;1085.9837102443469;1097.5884043483693;1104.86741591008;5485.232067510552;5543.390227075019;5557.666540007613;5572.247746554163;5578.721063946787;8409.621567029499;8495.065542790288;8497.74506764798;8502.06477287498;8797.956010220036;8443.408961372645;8544.871826922601;8554.914450855536;8566.48601083937;8575.656973720981;6707.832304192337;6886.793396198122;6917.446604271646;6947.201071876698;6963.79108626742;6919.238883722887;6953.304669533006;6958.652067396712;6977.511574189758;6985.231624521401;7648;7733.419993500397;7839.059312882263;7972.6412311444965;7979.9202007979175;8056.073551541648;8064.798380040546;8113.472624279403;8176.591170441335;8248.381371397048;6420.101185834081;6440.484761219185;6483.059956306403;6502.837429064311;6743.022261772114;6237.750489980532;6389.329120442287;6394.2646595640235;6396.104545363746;7152.070230870162;6549.279579246374;6617.602943823386;6698.464227743788;6749.763758268437;6761.797146085625;6514.250861151028;6602.3397660233595;6614.470842332698;6630.9668451657435;6736.225334086643;6316.147320111726;6562.442192413699;6570.5729127606555;6580.868382632416;6589.374009469093;6051.122587224916;6071.028635418312;6081.878362432815;6091.086337049478;6092.964196086765;6051.606645568024;6124.448799608057;6131.080337949344;6176.135341052346;6219.689015549295 07:28:09 INFO - 2015-12-19 07:28:09,779 DEBUG : BROWSER_OUTPUT: |4;prototype.html;334.95310656508093;335.5989592437038;336.725568661541;342.9897103086905;344.7827868442881;5857.09215071664;5929.169916211734;5954.732037058332;5962.344142144366;5962.433568810967;5632.831015069544;5728.25532680752;5753.683547404901;5864.970675146629;5872.060470324749;4527;4535.206338890697;4543.591076803087;4545.999999999992;4559.384483094789;4329.480462344523;4535.546445355471;4537.568930951555;4537.931931021021;4538.092381523692;4348.239058164824;4424;4525.185466616008;4531.161735079021;4542.386777785006;4500.279955207151;4523.525029871849;4528.252838281696;4534.727916325031;4540.568645978643;4001.3997900314894;4013.177298653769;4015.156817068419;4022.275990321741;4026.375911733686;5508.889822203573;5617.747201375948;5618.943810561883;5621.831345059655;5632.493075623172;5247.580193584504;5249.973750131263;5252.054630166568;5254.0805359062015;5254.211868219798;6219.689015549205;6232.968835155795;6233.252009758858;6234.438900498977;6238.376162383771;4386.166628340637;4389.385486031958;4390.363397307405;4399.934000989988;4401.031773009932;6306.1171435998995;6457.096006559085;6471.9029214561815;6483.157189565373;6489.123968264318;4551.681382303207;4552.635789136861;4554.453465584151;4556.70381425213;4561.429821272341;4615.423072115986;4618.422697162855;4619.538046195421;4619.676622636451;4624.907501850012;5262.1317482615705;5268.1834315681135;5274.235235890775;5276.92084618731;5283.788648454019;6040.637561746309;6239.750409983641;6265.467435267962;6280.05799130125;6282.560220784501;1577.4873166220796;1593.80874295083;1594.1949315595782;1594.673092016134;1596.4093285484214;1050.2595670052594;1053.9209559283083;1059.7244716373798;1065.1478816946412;1075.9193060520493;6112.602680825821;6114.11345354921;6130.724117414727;6142.170806941006;6144.631322120687;6486.578372405778;6502.219733631994;6507.446867016357;6509.1863517060365;6523.151990241238;5876.471117599436;5971.134185543159;6088.360722124202;6096.207493025879;6105.694715264219;3443.5695538057744;3479.234568394949;3524.665156810099;3537.1157210697324;3537.681608655182;6795.93204067953;6820.6930688119155;6821.658917054127;6825.044493770876;6828.965855170792;6721.563098398588;6723.193216813916;6725.39471447572;6725.814110414135;6732.192136943598;6571.769988050491;6733.293004234582;6753.898691519631;6835.7949261521235;6836.965815170893;6558.081868538313;6558.1802274715665;6562.573432726857;6569.37590928861;6570.967145164243;6287.905681414691;6451.000094985285;6453.386928241809;6457.225132984072;6461.709223085067;6745.9662701686175;6780.118584583973;6790.796276111724;6791.0832037676255;6797.864042719217;4467.195904737178;4499.66252531068;4502.909941801211;4505.752183629932;4509.932351014803;6501.544891857525;6529.608223506605;6530.902036469552;6532.640704761094;6557.672116394257;6231.2522497300615;6301.275353334242;6352;6358.745650173942;6362.522810789302;6302.590331628429;6304.306526282197;6317.399847014526;6344.809655710336;6349.49204063683;6229.906551401642;6232.937670623236;6236.251649802053;6238.75044998195;6239.0953311770445;6092.8781424372155;6233.625982441068;6233.937660623517;6360.968195158995;6381.712822923072;6026.909596356146;6178.104174894705;6179.16581261524;6200.534959877937;6212.502999760099 07:28:09 INFO - 2015-12-19 07:28:09,779 DEBUG : BROWSER_OUTPUT: |5;yui.html;710.2471380336842;846.3561045790541;855.6491838346276;856.4775486952959;859.8710193470979;13690.11014284071;13984.160950342986;13985.790213146785;13994.580162595114;14003.509877154302;12948.546800861972;12948.546800861972;12992.740145197115;13000.804987925188;13028.283444410554;651.9348065193478;660.465023331101;786.0488808541671;788.3850596534684;790.9881351779728;775.1047540091204;775.9340456061242;777.1451403456209;780.1457404142454;781.5232708048086;682.4642655515421;816.4570560577209;819.2749416766145;819.5533434278333;819.9057108432518;682.0553533356288;814.2997022560593;814.5519964019795;814.8859159717645;819.397742659148;593.8070127208674;596.859737961583;597.4294548705975;597.6354423801478;598.299989012856;13015.154014988995;13192.538261160813;13202.141860779115;13208.273544955024;13223.140495867738;11410.144239182095;11941.164118511708;12519.624411267676;12628.558000469939;12635;9442;9445.716628501155;9552.570134343901;9658.951705241428;9687.17658998986;3591.6228795976567;3634.7819130852236;3673.8163091845568;3716.646918542734;3746.4380342948502;43073.138537229395;43304;43422.13155736899;43445.34831977523;43445.56554434478;9631.759206019906;9954.45250511229;10041.849372259421;10133.543990520444;10261.640842570474;18273.63452730938;18280.63438731218;18301.816981830278;18307.908460457613;18309.81690183081;7215.96392018047;7426.368758655467;7532.736354227685;7644.579548124795;7649.770506884803;4118.691098167649;4136.73111247768;4179.017930786263;4207.389928460356;4257.723247988871;2933.5453004784295;2994.2215024093894;2997.4005198960294;3000.0549826804922;3000.399920015962;492.3279723177908;500.31956539106784;502.0912149010303;514.951079647433;525.0365579162203;559.963602365845;595.1756816808664;598.9281286245591;611.6880391000622;641.5861769158867;7862.606869656609;7981.441299109007;8004.6167087046;8194;8206.548639824867;582.6445868020504;691.4675699711195;694.6561452081252;699.6361891816227;700.9684564194623;3930.6855451563806;4249.745015299092;4309.719868208556;4312.805923733439;4318;54963;59666.70166649139;60070.39929600735;60461.69769151126;60885.391146088856;49952.50047499551;50021;50099.24851127236;50541;50753.238701419505;44314.77842610766;44671.55328446739;45050.54949450464;45411.77294113574;45963;8202.712905048533;8317.83364332722;8730.257928076184;8752.256058235122;8926.955365223132;32951.057341398984;33401.33197335991;33640.3271934555;33763.83118084394;34340.48489272613;38253.61746382501;40879.386809198484;42759.358609620256;43279.567204327555;43447.348289775044;10270.589176432859;10326.225533085199;10591.258611897094;10613.628523001658;10628.734281643021;11707.239029463057;11971.341576213392;12002.939985300018;12027.27836329823;12110.455029523517;10299.588016479556;10772.515236814206;10913.672589822318;10923;11244.325340479598;10333.74165645865;10838.458077096271;11059.557617695202;11164.441777911234;11297.887021129683;11288.94355528217;11397.886021139682;11653.941730291293;11680.123990700562;11772.587959421378;9414.2468602513;9707.320487565803;9744.707658770249;9848.11366976947;10081.092701656886;8985.415947963362;9127.589258483516;9342.346035777431;9444.95277523608;9656.517174141405 07:28:09 INFO - 2015-12-19 07:28:09,779 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:28:09 INFO - 2015-12-19 07:28:09,779 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:28:09 INFO - 2015-12-19 07:28:09,779 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1011 07:28:09 INFO - 2015-12-19 07:28:09,779 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:28:09 INFO - 2015-12-19 07:28:09,780 DEBUG : BROWSER_OUTPUT: __startTimestamp1450538889767__endTimestamp 07:28:09 INFO - 2015-12-19 07:28:09,780 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,780 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:28:09 INFO - 2015-12-19 07:28:09,780 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:28:09 INFO - 2015-12-19 07:28:09,780 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,780 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5287.49 Median:5498.07 stddev:574.21 (10.4%) stddev-sans-first:550.63 07:28:09 INFO - 2015-12-19 07:28:09,782 DEBUG : BROWSER_OUTPUT: Values: 3137.1 3155.5 3208.1 3208.9 3230.4 5078.5 5182.6 5254.7 5288.2 5321.5 5243.9 5304.7 5350.0 5353.1 5377.4 4692.9 4748.7 4772.6 4793.8 4815.9 4858.8 4921.3 4975.9 4983.7 5025.9 4710.3 4792.5 4913.4 4919.8 4960.0 4831.7 4834.7 4838.8 4843.2 4844.4 4854.4 4867.0 4868.8 4872.3 4875.2 5065.1 5178.1 5178.5 5184.3 5186.1 5749.7 5758.1 5759.5 5774.0 5775.9 5742.3 5776.0 5783.2 5803.8 5806.2 5260.2 5284.1 5351.3 5367.1 5441.7 5803.5 5837.9 5884.7 5892.0 5944.9 5703.7 5711.1 5728.2 5733.0 5740.7 5489.5 5579.4 5591.5 5659.2 5752.0 5589.3 5593.9 5603.3 5623.8 5739.9 5580.5 5587.3 5589.1 5598.8 5601.5 4339.3 4360.8 4447.6 4456.3 4459.3 3961.0 3965.8 3976.0 4003.9 4021.1 5485.2 5495.6 5498.1 5509.6 5511.7 5457.1 5559.0 5601.2 5609.1 5612.2 5305.5 5320.4 5356.8 5361.1 5431.3 4898.9 4923.4 4927.2 5009.2 5021.1 5826.6 5837.5 5849.9 5850.4 5877.6 5327.6 5502.5 5657.7 5669.2 5735.3 5785.8 5886.3 5937.9 5969.7 6017.9 5613.0 5615.6 5621.0 5626.3 5638.3 5441.2 5554.0 5698.9 5710.7 5729.5 5430.6 5460.6 5552.7 5575.9 5602.1 5529.6 5544.4 5545.4 5550.5 5553.6 5499.1 5501.4 5508.9 5511.6 5539.9 5392.0 5486.8 5495.8 5530.5 5691.2 5466.7 5510.8 5518.0 5519.2 5559.1 07:28:09 INFO - 2015-12-19 07:28:09,782 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,782 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44720.66 Median:30445.89 stddev:75138.65 (246.8%) stddev-sans-first:75276.29 07:28:09 INFO - 2015-12-19 07:28:09,782 DEBUG : BROWSER_OUTPUT: Values: 567.1 568.0 568.5 590.3 608.9 29873.9 38572.6 39338.8 39439.4 39564.8 41950.0 42654.8 42683.6 42701.0 42731.0 7518.7 7620.2 8500.1 8670.5 8672.7 10193.5 10416.4 10442.2 10446.6 10499.8 10164.3 10212.0 10256.1 10265.0 10272.1 7739.4 7917.7 7929.5 10105.1 10208.5 10026.8 10201.1 10207.1 10207.5 10209.0 38891.4 39250.4 39262.8 39298.2 39383.2 3050.4 3147.9 3191.5 3218.7 3901.7 29802.0 29862.4 29901.3 30233.7 30417.5 3613.2 3754.6 3776.5 3829.8 3855.3 267193.0 268259.0 268945.0 269098.0 269196.0 54010.0 56032.0 56301.7 56377.2 56514.2 49100.0 65780.3 67204.0 67222.7 67252.3 13160.8 13326.6 13333.0 13340.6 13352.1 10512.7 10521.1 10548.3 10578.8 10602.1 18754.3 18813.5 18819.8 18841.5 18844.6 7627.3 7669.2 7739.4 7887.9 7893.6 934.7 982.9 1104.8 1121.9 1135.9 27631.4 27840.3 27891.3 28173.3 28215.4 1008.2 1054.2 1067.6 1068.2 1140.4 13402.9 13441.0 13590.4 13633.3 13654.0 301257.0 304043.0 305234.0 305531.0 306151.0 48391.3 48487.0 48533.8 48688.5 48743.5 1269.2 1279.4 1280.7 1292.6 1327.7 24638.1 25560.4 25732.6 25817.4 25959.7 40578.0 40850.4 40931.4 40946.8 40947.8 285497.0 287202.0 288051.0 289492.0 289623.0 26042.2 26612.5 29181.6 29677.0 29720.6 35125.0 35156.8 35900.3 35928.8 35932.5 32486.0 32713.3 32931.3 33277.3 33487.3 26561.6 30564.5 32675.7 33184.8 35038.5 32790.7 32855.6 32977.0 33233.5 33284.7 28591.9 29931.7 30474.2 30604.0 30609.0 22962.0 23314.6 23508.4 23659.6 23684.9 07:28:09 INFO - 2015-12-19 07:28:09,782 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,782 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29313.38 Median:354.64 stddev:87485.68 (24669.2%) stddev-sans-first:87704.04 07:28:09 INFO - 2015-12-19 07:28:09,783 DEBUG : BROWSER_OUTPUT: Values: 337.8 345.2 346.6 353.7 355.6 14109.5 14488.9 16533.4 16969.4 17958.4 16485.0 16873.7 17039.0 17417.2 17426.1 5188.8 5349.8 5351.5 5355.1 5357.1 4013.2 4127.6 5299.4 5805.7 5967.6 5875.2 5883.6 5884.1 5903.8 5908.0 5787.2 5956.9 5962.3 5965.0 5969.2 5174.9 5175.4 5177.6 5185.5 5215.0 20442.8 21062.2 21225.9 21432.1 22065.3 2265.3 2303.4 2330.6 2344.8 2414.8 13888.2 14039.9 14300.4 14392.7 14629.4 1945.5 1964.4 1980.7 2018.2 2118.3 69013.7 69330.7 70352.0 70445.6 70727.1 15334.4 15452.2 15460.2 15524.6 15556.9 24279.4 24378.8 24433.6 24522.4 24529.6 8882.3 8922.1 8925.2 8925.4 8985.6 7417.3 7426.3 7473.3 7479.7 7484.4 7652.9 7754.5 7758.6 7774.5 7977.6 1711.7 1826.5 1826.9 1829.1 2212.0 405.5 808.1 903.1 921.1 928.9 9635.4 10062.8 10252.7 10422.2 10500.5 421.5 427.9 444.7 446.9 455.8 5891.1 5957.3 5974.8 6011.1 6044.2 521846.0 523350.0 527116.0 546112.0 554432.0 82695.6 83886.6 83956.6 84141.0 84892.0 489.7 495.5 496.0 497.4 497.5 10175.6 10216.7 10228.6 10267.2 10328.7 31731.4 32856.0 33540.3 33682.7 34008.7 40228.6 43732.3 46140.3 46326.8 46693.5 9219.2 9266.4 9490.9 9571.2 9595.2 11234.2 11256.5 11365.2 14831.9 17573.0 13746.5 13880.3 14156.2 14498.7 15284.2 14538.7 14705.2 14761.6 14975.9 15045.5 14429.9 14767.3 14812.6 15283.7 15452.5 8337.5 8577.0 14144.9 14720.5 15356.1 14950.8 15303.2 15412.5 15431.9 15824.1 07:28:09 INFO - 2015-12-19 07:28:09,783 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,783 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5064.67 Median:6197.91 stddev:2584.98 (41.7%) stddev-sans-first:2576.79 07:28:09 INFO - 2015-12-19 07:28:09,784 DEBUG : BROWSER_OUTPUT: Values: 1306.0 1606.6 1659.1 1683.7 1723.3 6320.7 6843.6 7029.3 7084.1 7092.0 7080.8 7213.3 7237.7 7244.5 7259.6 1942.8 1961.0 2058.2 2081.7 2096.9 2004.1 2006.8 2010.4 2012.7 2013.1 1990.7 2051.3 2135.3 2137.8 2138.6 2105.7 2110.9 2134.2 2138.0 2154.4 2162.8 2173.8 2187.6 2188.2 2190.5 6847.3 6948.9 6959.9 6969.3 6978.6 4316.1 4422.8 4427.8 4428.8 4430.3 2822.5 2911.0 2923.5 2943.0 2946.7 1000.0 1004.6 1018.1 1022.5 1067.3 9537.2 9555.5 9565.5 9574.0 9576.1 3868.8 3914.9 3945.1 3960.8 3982.4 8306.6 8310.8 8312.8 8317.6 8319.1 4306.6 4308.4 4340.6 4340.7 4341.5 3981.5 3983.2 3987.0 3987.2 3989.2 3050.5 3084.3 3210.1 3234.0 3476.3 1096.3 1097.3 1102.6 1127.1 1127.4 943.8 963.7 1057.5 1172.8 1172.8 6740.5 6779.2 6869.3 6891.6 6901.9 1079.8 1081.5 1086.0 1097.6 1104.9 5485.2 5543.4 5557.7 5572.2 5578.7 8409.6 8495.1 8497.7 8502.1 8798.0 8443.4 8544.9 8554.9 8566.5 8575.7 6707.8 6886.8 6917.4 6947.2 6963.8 6919.2 6953.3 6958.7 6977.5 6985.2 7648.0 7733.4 7839.1 7972.6 7979.9 8056.1 8064.8 8113.5 8176.6 8248.4 6420.1 6440.5 6483.1 6502.8 6743.0 6237.8 6389.3 6394.3 6396.1 7152.1 6549.3 6617.6 6698.5 6749.8 6761.8 6514.3 6602.3 6614.5 6631.0 6736.2 6316.1 6562.4 6570.6 6580.9 6589.4 6051.1 6071.0 6081.9 6091.1 6093.0 6051.6 6124.4 6131.1 6176.1 6219.7 07:28:09 INFO - 2015-12-19 07:28:09,784 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,784 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5274.67 Median:5966.78 stddev:1588.03 (26.6%) stddev-sans-first:1548.59 07:28:09 INFO - 2015-12-19 07:28:09,785 DEBUG : BROWSER_OUTPUT: Values: 335.0 335.6 336.7 343.0 344.8 5857.1 5929.2 5954.7 5962.3 5962.4 5632.8 5728.3 5753.7 5865.0 5872.1 4527.0 4535.2 4543.6 4546.0 4559.4 4329.5 4535.5 4537.6 4537.9 4538.1 4348.2 4424.0 4525.2 4531.2 4542.4 4500.3 4523.5 4528.3 4534.7 4540.6 4001.4 4013.2 4015.2 4022.3 4026.4 5508.9 5617.7 5618.9 5621.8 5632.5 5247.6 5250.0 5252.1 5254.1 5254.2 6219.7 6233.0 6233.3 6234.4 6238.4 4386.2 4389.4 4390.4 4399.9 4401.0 6306.1 6457.1 6471.9 6483.2 6489.1 4551.7 4552.6 4554.5 4556.7 4561.4 4615.4 4618.4 4619.5 4619.7 4624.9 5262.1 5268.2 5274.2 5276.9 5283.8 6040.6 6239.8 6265.5 6280.1 6282.6 1577.5 1593.8 1594.2 1594.7 1596.4 1050.3 1053.9 1059.7 1065.1 1075.9 6112.6 6114.1 6130.7 6142.2 6144.6 6486.6 6502.2 6507.4 6509.2 6523.2 5876.5 5971.1 6088.4 6096.2 6105.7 3443.6 3479.2 3524.7 3537.1 3537.7 6795.9 6820.7 6821.7 6825.0 6829.0 6721.6 6723.2 6725.4 6725.8 6732.2 6571.8 6733.3 6753.9 6835.8 6837.0 6558.1 6558.2 6562.6 6569.4 6571.0 6287.9 6451.0 6453.4 6457.2 6461.7 6746.0 6780.1 6790.8 6791.1 6797.9 4467.2 4499.7 4502.9 4505.8 4509.9 6501.5 6529.6 6530.9 6532.6 6557.7 6231.3 6301.3 6352.0 6358.7 6362.5 6302.6 6304.3 6317.4 6344.8 6349.5 6229.9 6232.9 6236.3 6238.8 6239.1 6092.9 6233.6 6233.9 6361.0 6381.7 6026.9 6178.1 6179.2 6200.5 6212.5 07:28:09 INFO - 2015-12-19 07:28:09,785 DEBUG : BROWSER_OUTPUT: 07:28:09 INFO - 2015-12-19 07:28:09,785 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13437.58 Median:44861.05 stddev:15497.96 (34.5%) stddev-sans-first:15511.96 07:28:09 INFO - 2015-12-19 07:28:09,785 DEBUG : BROWSER_OUTPUT: Values: 710.2 846.4 855.6 856.5 859.9 13690.1 13984.2 13985.8 13994.6 14003.5 12948.5 12948.5 12992.7 13000.8 13028.3 651.9 660.5 786.0 788.4 791.0 775.1 775.9 777.1 780.1 781.5 682.5 816.5 819.3 819.6 819.9 682.1 814.3 814.6 814.9 819.4 593.8 596.9 597.4 597.6 598.3 13015.2 13192.5 13202.1 13208.3 13223.1 11410.1 11941.2 12519.6 12628.6 12635.0 9442.0 9445.7 9552.6 9659.0 9687.2 3591.6 3634.8 3673.8 3716.6 3746.4 43073.1 43304.0 43422.1 43445.3 43445.6 9631.8 9954.5 10041.8 10133.5 10261.6 18273.6 18280.6 18301.8 18307.9 18309.8 7216.0 7426.4 7532.7 7644.6 7649.8 4118.7 4136.7 4179.0 4207.4 4257.7 2933.5 2994.2 2997.4 3000.1 3000.4 492.3 500.3 502.1 515.0 525.0 560.0 595.2 598.9 611.7 641.6 7862.6 7981.4 8004.6 8194.0 8206.5 582.6 691.5 694.7 699.6 701.0 3930.7 4249.7 4309.7 4312.8 4318.0 54963.0 59666.7 60070.4 60461.7 60885.4 49952.5 50021.0 50099.2 50541.0 50753.2 44314.8 44671.6 45050.5 45411.8 45963.0 8202.7 8317.8 8730.3 8752.3 8927.0 32951.1 33401.3 33640.3 33763.8 34340.5 38253.6 40879.4 42759.4 43279.6 43447.3 10270.6 10326.2 10591.3 10613.6 10628.7 11707.2 11971.3 12002.9 12027.3 12110.5 10299.6 10772.5 10913.7 10923.0 11244.3 10333.7 10838.5 11059.6 11164.4 11297.9 11288.9 11397.9 11653.9 11680.1 11772.6 9414.2 9707.3 9744.7 9848.1 10081.1 8985.4 9127.6 9342.3 9445.0 9656.5 07:28:09 INFO - 2015-12-19 07:28:09,785 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:28:09 INFO - 2015-12-19 07:28:09,785 DEBUG : BROWSER_OUTPUT: 07:28:10 INFO - 2015-12-19 07:28:10,425 INFO : Browser exited with error code: 0 07:28:10 INFO - 2015-12-19 07:28:10,446 INFO : Completed test dromaeo_css (00:18:36) 07:28:10 INFO - 2015-12-19 07:28:10,446 INFO : Starting test kraken 07:28:10 INFO - 2015-12-19 07:28:10,446 DEBUG : operating with platform_type : linux_ 07:28:10 INFO - 2015-12-19 07:28:10,446 INFO : Initialising browser for kraken test... 07:28:10 INFO - 2015-12-19 07:28:10,452 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqFFq8R/profile http://localhost:58835/getInfo.html 07:28:14 INFO - 2015-12-19 07:28:14,356 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:28:14 INFO - 2015-12-19 07:28:14,356 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:28:14 INFO - 2015-12-19 07:28:14,357 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:28:14 INFO - 2015-12-19 07:28:14,357 DEBUG : BROWSER_OUTPUT: __metrics 07:28:14 INFO - 2015-12-19 07:28:14,458 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:28:14 INFO - 2015-12-19 07:28:14,514 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:15 INFO - 2015-12-19 07:28:15,621 INFO : Browser initialized. 07:28:15 INFO - 2015-12-19 07:28:15,621 INFO : Running cycle 1/1 for kraken test... 07:28:15 INFO - 2015-12-19 07:28:15,622 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqFFq8R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:28:27 INFO - 2015-12-19 07:28:27,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 150577152 07:28:27 INFO - 2015-12-19 07:28:27,377 DEBUG : BROWSER_OUTPUT: 07:28:29 INFO - 2015-12-19 07:28:29,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58835/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:30 INFO - 2015-12-19 07:28:30,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 183418880 07:28:30 INFO - 2015-12-19 07:28:30,442 DEBUG : BROWSER_OUTPUT: 07:28:33 INFO - 2015-12-19 07:28:33,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58835/tests/kraken/driver.html?testName=audio-dft) 07:28:33 INFO - 2015-12-19 07:28:33,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 174497792 07:28:33 INFO - 2015-12-19 07:28:33,616 DEBUG : BROWSER_OUTPUT: 07:28:36 INFO - 2015-12-19 07:28:36,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58835/tests/kraken/driver.html?testName=audio-fft) 07:28:37 INFO - 2015-12-19 07:28:37,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 160702464 07:28:37 INFO - 2015-12-19 07:28:37,130 DEBUG : BROWSER_OUTPUT: 07:28:39 INFO - 2015-12-19 07:28:39,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58835/tests/kraken/driver.html?testName=audio-oscillator) 07:28:39 INFO - 2015-12-19 07:28:39,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 163500032 07:28:39 INFO - 2015-12-19 07:28:39,692 DEBUG : BROWSER_OUTPUT: 07:28:41 INFO - 2015-12-19 07:28:41,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58835/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:42 INFO - 2015-12-19 07:28:42,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 162902016 07:28:42 INFO - 2015-12-19 07:28:42,432 DEBUG : BROWSER_OUTPUT: 07:28:45 INFO - 2015-12-19 07:28:45,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58835/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:45 INFO - 2015-12-19 07:28:45,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 163508224 07:28:45 INFO - 2015-12-19 07:28:45,912 DEBUG : BROWSER_OUTPUT: 07:28:49 INFO - 2015-12-19 07:28:49,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58835/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:49 INFO - 2015-12-19 07:28:49,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 165642240 07:28:49 INFO - 2015-12-19 07:28:49,903 DEBUG : BROWSER_OUTPUT: 07:28:52 INFO - 2015-12-19 07:28:52,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58835/tests/kraken/driver.html?testName=json-parse-financial) 07:28:53 INFO - 2015-12-19 07:28:53,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 165199872 07:28:53 INFO - 2015-12-19 07:28:53,242 DEBUG : BROWSER_OUTPUT: 07:28:54 INFO - 2015-12-19 07:28:54,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58835/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:55 INFO - 2015-12-19 07:28:55,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 176537600 07:28:55 INFO - 2015-12-19 07:28:55,368 DEBUG : BROWSER_OUTPUT: 07:28:57 INFO - 2015-12-19 07:28:57,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:57 INFO - 2015-12-19 07:28:57,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 174338048 07:28:57 INFO - 2015-12-19 07:28:57,760 DEBUG : BROWSER_OUTPUT: 07:28:59 INFO - 2015-12-19 07:28:59,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:00 INFO - 2015-12-19 07:29:00,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 183074816 07:29:00 INFO - 2015-12-19 07:29:00,402 DEBUG : BROWSER_OUTPUT: 07:29:02 INFO - 2015-12-19 07:29:02,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:03 INFO - 2015-12-19 07:29:03,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 189517824 07:29:03 INFO - 2015-12-19 07:29:03,551 DEBUG : BROWSER_OUTPUT: 07:29:06 INFO - 2015-12-19 07:29:06,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:06 INFO - 2015-12-19 07:29:06,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 187658240 07:29:06 INFO - 2015-12-19 07:29:06,696 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58835/tests/kraken/driver.html?testName=ai-astar) 07:29:08 INFO - 2015-12-19 07:29:08,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 246251520 07:29:08 INFO - 2015-12-19 07:29:08,631 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,633 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:29:08 INFO - 2015-12-19 07:29:08,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:29:08 INFO - 2015-12-19 07:29:08,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:29:08 INFO - 2015-12-19 07:29:08,633 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:29:08 INFO - 2015-12-19 07:29:08,633 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;110;111;113;102;112;110;101 07:29:08 INFO - 2015-12-19 07:29:08,634 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;124;158;161;123;157;144;124;166;126 07:29:08 INFO - 2015-12-19 07:29:08,634 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;163;160;161;163;161;161;162;160;162 07:29:08 INFO - 2015-12-19 07:29:08,634 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;82;99;71;72;72;122;98;70 07:29:08 INFO - 2015-12-19 07:29:08,634 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;139;93;95;93;141;94;94;136 07:29:08 INFO - 2015-12-19 07:29:08,635 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;109;109;109;109;109 07:29:08 INFO - 2015-12-19 07:29:08,635 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;147;147;147;148;146;147;147;145 07:29:08 INFO - 2015-12-19 07:29:08,635 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;96;97;96;95;96 07:29:08 INFO - 2015-12-19 07:29:08,635 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;59;59;59;59;58;70;56;58 07:29:08 INFO - 2015-12-19 07:29:08,635 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;67;66;67;67;67;67;68;68 07:29:08 INFO - 2015-12-19 07:29:08,635 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;93;85;85;84;85;86;85;94 07:29:08 INFO - 2015-12-19 07:29:08,635 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;121;118;113;122;118;130;118;120;124 07:29:08 INFO - 2015-12-19 07:29:08,636 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;155;153;155;152;142;154;152;150;142 07:29:08 INFO - 2015-12-19 07:29:08,636 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;69;66;66;68;67;67;67;66 07:29:08 INFO - 2015-12-19 07:29:08,636 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:29:08 INFO - 2015-12-19 07:29:08,637 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:29:08 INFO - 2015-12-19 07:29:08,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 07:29:08 INFO - 2015-12-19 07:29:08,637 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:29:08 INFO - 2015-12-19 07:29:08,638 DEBUG : BROWSER_OUTPUT: __startTimestamp1450538948632__endTimestamp 07:29:08 INFO - 2015-12-19 07:29:08,638 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,639 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:29:08 INFO - 2015-12-19 07:29:08,639 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:29:08 INFO - 2015-12-19 07:29:08,639 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,639 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:4.22 (3.8%) stddev-sans-first:4.47 07:29:08 INFO - 2015-12-19 07:29:08,639 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 110.0 111.0 113.0 102.0 112.0 110.0 101.0 07:29:08 INFO - 2015-12-19 07:29:08,640 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,640 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.70 Median:150.50 stddev:17.28 (11.5%) stddev-sans-first:18.32 07:29:08 INFO - 2015-12-19 07:29:08,640 DEBUG : BROWSER_OUTPUT: Values: 144.0 124.0 158.0 161.0 123.0 157.0 144.0 124.0 166.0 126.0 07:29:08 INFO - 2015-12-19 07:29:08,640 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,640 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.13 07:29:08 INFO - 2015-12-19 07:29:08,640 DEBUG : BROWSER_OUTPUT: Values: 160.0 163.0 160.0 161.0 163.0 161.0 161.0 162.0 160.0 162.0 07:29:08 INFO - 2015-12-19 07:29:08,641 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,641 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.80 Median:72.00 stddev:17.78 (24.7%) stddev-sans-first:18.34 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 82.0 99.0 71.0 72.0 72.0 122.0 98.0 70.0 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.68 (23.1%) stddev-sans-first:22.46 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 139.0 93.0 95.0 93.0 141.0 94.0 94.0 136.0 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 147.0 147.0 147.0 148.0 146.0 147.0 147.0 145.0 07:29:08 INFO - 2015-12-19 07:29:08,642 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 96.0 97.0 96.0 95.0 96.0 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.00 stddev:3.89 (6.6%) stddev-sans-first:4.10 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 59.0 59.0 59.0 59.0 58.0 70.0 56.0 58.0 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 66.0 67.0 67.0 67.0 67.0 68.0 68.0 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.00 stddev:3.84 (4.5%) stddev-sans-first:3.87 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 93.0 85.0 85.0 84.0 85.0 86.0 85.0 94.0 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:120.50 stddev:5.21 (4.3%) stddev-sans-first:4.75 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: Values: 112.0 121.0 118.0 113.0 122.0 118.0 130.0 118.0 120.0 124.0 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,643 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:152.50 stddev:5.24 (3.4%) stddev-sans-first:5.10 07:29:08 INFO - 2015-12-19 07:29:08,644 DEBUG : BROWSER_OUTPUT: Values: 144.0 155.0 153.0 155.0 152.0 142.0 154.0 152.0 150.0 142.0 07:29:08 INFO - 2015-12-19 07:29:08,644 DEBUG : BROWSER_OUTPUT: 07:29:08 INFO - 2015-12-19 07:29:08,644 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 07:29:08 INFO - 2015-12-19 07:29:08,644 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 69.0 66.0 66.0 68.0 67.0 67.0 67.0 66.0 07:29:08 INFO - 2015-12-19 07:29:08,644 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:29:08 INFO - 2015-12-19 07:29:08,644 DEBUG : BROWSER_OUTPUT: 07:29:09 INFO - 2015-12-19 07:29:09,433 INFO : Browser exited with error code: 0 07:29:09 INFO - 2015-12-19 07:29:09,482 INFO : Completed test kraken (00:00:59) 07:29:09 INFO - 2015-12-19 07:29:09,482 INFO : Starting test v8_7 07:29:09 INFO - 2015-12-19 07:29:09,482 DEBUG : operating with platform_type : linux_ 07:29:09 INFO - 2015-12-19 07:29:09,483 INFO : Initialising browser for v8_7 test... 07:29:09 INFO - 2015-12-19 07:29:09,489 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnVTlOx/profile http://localhost:58835/getInfo.html 07:29:13 INFO - 2015-12-19 07:29:13,585 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:29:13 INFO - 2015-12-19 07:29:13,585 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:29:13 INFO - 2015-12-19 07:29:13,585 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:29:13 INFO - 2015-12-19 07:29:13,585 DEBUG : BROWSER_OUTPUT: __metrics 07:29:13 INFO - 2015-12-19 07:29:13,666 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:29:13 INFO - 2015-12-19 07:29:13,714 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:13 ERROR - 2015-12-19 07:29:13,721 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 07:29:14 INFO - 2015-12-19 07:29:14,460 INFO : Browser initialized. 07:29:14 INFO - 2015-12-19 07:29:14,461 INFO : Running cycle 1/1 for v8_7 test... 07:29:14 INFO - 2015-12-19 07:29:14,461 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnVTlOx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:29:26 INFO - 2015-12-19 07:29:26,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 150040576 07:29:26 INFO - 2015-12-19 07:29:26,237 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58835/tests/v8_7/run.html (next: http://localhost:58835/tests/v8_7/run.html) 07:29:47 INFO - 2015-12-19 07:29:47,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 554491904 07:29:47 INFO - 2015-12-19 07:29:47,861 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,861 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:29:47 INFO - 2015-12-19 07:29:47,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:29:47 INFO - 2015-12-19 07:29:47,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:29:47 INFO - 2015-12-19 07:29:47,862 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:29:47 INFO - 2015-12-19 07:29:47,862 DEBUG : BROWSER_OUTPUT: |0;Richards;166.55562958027983 07:29:47 INFO - 2015-12-19 07:29:47,862 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.6080724254998 07:29:47 INFO - 2015-12-19 07:29:47,862 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 07:29:47 INFO - 2015-12-19 07:29:47,862 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 07:29:47 INFO - 2015-12-19 07:29:47,862 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 07:29:47 INFO - 2015-12-19 07:29:47,862 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 07:29:47 INFO - 2015-12-19 07:29:47,863 DEBUG : BROWSER_OUTPUT: |6;Boyer;12550 07:29:47 INFO - 2015-12-19 07:29:47,863 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 07:29:47 INFO - 2015-12-19 07:29:47,863 DEBUG : BROWSER_OUTPUT: |8;Splay;589.622641509434 07:29:47 INFO - 2015-12-19 07:29:47,863 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 07:29:47 INFO - 2015-12-19 07:29:47,863 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:29:47 INFO - 2015-12-19 07:29:47,864 DEBUG : BROWSER_OUTPUT: __startTimestamp1450538987860__endTimestamp 07:29:47 INFO - 2015-12-19 07:29:47,864 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,864 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:29:47 INFO - 2015-12-19 07:29:47,864 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:29:47 INFO - 2015-12-19 07:29:47,864 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,866 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,866 DEBUG : BROWSER_OUTPUT: Values: 166.6 07:29:47 INFO - 2015-12-19 07:29:47,866 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,866 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.61 Median:188.61 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,866 DEBUG : BROWSER_OUTPUT: Values: 188.6 07:29:47 INFO - 2015-12-19 07:29:47,866 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,867 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,867 DEBUG : BROWSER_OUTPUT: Values: 279.1 07:29:47 INFO - 2015-12-19 07:29:47,867 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,867 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,867 DEBUG : BROWSER_OUTPUT: Values: 5138.5 07:29:47 INFO - 2015-12-19 07:29:47,867 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,868 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,868 DEBUG : BROWSER_OUTPUT: Values: 1978.3 07:29:47 INFO - 2015-12-19 07:29:47,868 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,868 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,868 DEBUG : BROWSER_OUTPUT: Values: 792.4 07:29:47 INFO - 2015-12-19 07:29:47,868 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,868 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: Values: 12550.0 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: Values: 25923.1 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:589.62 Median:589.62 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: Values: 589.6 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: Values: 4845.4 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:29:47 INFO - 2015-12-19 07:29:47,869 DEBUG : BROWSER_OUTPUT: 07:29:48 INFO - 2015-12-19 07:29:48,729 INFO : Browser exited with error code: 0 07:29:48 INFO - 2015-12-19 07:29:48,746 INFO : Completed test v8_7 (00:00:39) 07:29:48 INFO - 2015-12-19 07:29:48,915 INFO : Completed test suite (00:20:15) 07:29:48 INFO - 2015-12-19 07:29:48,916 DEBUG : Working with test: dromaeo_css 07:29:48 INFO - 2015-12-19 07:29:48,916 DEBUG : Generating results file: dromaeo_css 07:29:48 INFO - 2015-12-19 07:29:48,917 DEBUG : Working with test: kraken 07:29:48 INFO - 2015-12-19 07:29:48,917 DEBUG : Generating results file: kraken 07:29:48 INFO - 2015-12-19 07:29:48,917 INFO : javascript benchmark 07:29:48 INFO - 2015-12-19 07:29:48,917 DEBUG : Working with test: v8_7 07:29:48 INFO - 2015-12-19 07:29:48,918 DEBUG : Generating results file: v8_7 07:29:48 INFO - 2015-12-19 07:29:48,918 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:29:48 INFO - 2015-12-19 07:29:48,967 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:29:48 INFO - 2015-12-19 07:29:48,967 DEBUG : process_Request line: dromaeo_css 6822.36 graph.html#tests=[[72,1,35]] 07:29:48 INFO - 2015-12-19 07:29:48,967 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:29:49 INFO - 2015-12-19 07:29:49,005 DEBUG : process_Request line: kraken 1502.90 graph.html#tests=[[232,1,35]] 07:29:49 INFO - 2015-12-19 07:29:49,005 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:29:49 INFO - 2015-12-19 07:29:49,035 DEBUG : process_Request line: v8_7 19846.61 graph.html#tests=[[230,1,35]] 07:29:49 INFO - 2015-12-19 07:29:49,036 INFO : javascript benchmark 07:29:49 INFO - 2015-12-19 07:29:49,040 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.1372872460074, 3155.526670999351, 3208.149840292323, 3208.855601497932, 3230.3539292141572, 5078.492150784919, 5182.611304152185, 5254.658447200929, 5288.180332048534, 5321.521063104325, 5243.947560524393, 5304.734763261841, 5349.956758432098, 5353.0899747042995, 5377.435369286227, 4692.906141877161, 4748.691335063209, 4772.618190544766, 4793.832215872445, 4815.855524334275, 4858.757062146896, 4921.286413470062, 4975.9004819903585, 4983.700977941335, 5025.874353141164, 4710.26990816424, 4792.544708252711, 4913.434954980187, 4919.803207871699, 4960.032793605248, 4831.710097394168, 4834.661573689843, 4838.806447742086, 4843.24929635907, 4844.442889067767, 4854.393200849894, 4867.002264535797, 4868.805247790084, 4872.269159626049, 4875.195592727196, 5065.138926382524, 5178.0679477694, 5178.508041736067, 5184.326037615086, 5186.0665080285535, 5749.6550206987295, 5758.078707406837, 5759.510441612468, 5774.0, 5775.913361299584, 5742.310922689262, 5776.0, 5783.21926539916, 5803.767849286023, 5806.187133801272, 5260.184671375943, 5284.07528682479, 5351.304330437058, 5367.114426119686, 5441.727913604304, 5803.5357171426185, 5837.912431313449, 5884.676342801187, 5891.970540147272, 5944.910826337608, 5703.74333155009, 5711.114777209539, 5728.198052272685, 5733.02538568436, 5740.655560666373, 5489.533389661923, 5579.38626751057, 5591.52472039873, 5659.179418984307, 5751.971240143773, 5589.329280486287, 5593.916091258634, 5603.271574695345, 5623.803166889139, 5739.8852022960145, 5580.469855363734, 5587.3015873015875, 5589.105743081169, 5598.776048958078, 5601.467860553241, 4339.262325404688, 4360.847370342023, 4447.555244475527, 4456.264716321771, 4459.2865141577195, 3960.980195099006, 3965.78188199646, 3975.960240397617, 4003.8598649047144, 4021.135455876942, 5485.232067510552, 5495.587830912697, 5498.0653288940175, 5509.614326997072, 5511.696856672841, 5457.099578569571, 5559.0, 5601.159826026129, 5609.1305847593685, 5612.186232996192, 5305.549028332558, 5320.441353657888, 5356.7857285708915, 5361.088614935392, 5431.34823821144, 4898.853034408973, 4923.359963204761, 4927.211646136601, 5009.173486374707, 5021.096202683552, 5826.563007774434, 5837.47268030992, 5849.941500585025, 5850.414958504116, 5877.5591830612875, 5327.627066105335, 5502.477264659851, 5657.745401456862, 5669.234653321913, 5735.340435849931, 5785.82642520725, 5886.293644762656, 5937.851553711192, 5969.7313620888035, 6017.909731353946, 5612.971935140298, 5615.606907516598, 5620.971895140498, 5626.2967129108865, 5638.2670252866865, 5441.21102440136, 5553.972230138824, 5698.914516282176, 5710.714464276686, 5729.541636668973, 5430.619856609999, 5460.645058071213, 5552.666839989613, 5575.944240557705, 5602.1036634138345, 5529.612927095226, 5544.445555444423, 5545.421379058757, 5550.47270509301, 5553.6390134641115, 5499.092649712753, 5501.422350653123, 5508.889822203453, 5511.586631002771, 5539.916901246565, 5392.0, 5486.835394938158, 5495.835124946258, 5530.5022547970875, 5691.2032315475035, 5466.72666366688, 5510.834674959758, 5518.0, 5519.199716041232, 5559.138333558305], "unit": "score", "name": "dojo.html", "value": 5251.128043026873}, {"lowerIsBetter": false, "replicates": [567.0784974416573, 567.9574031947604, 568.5252813900391, 590.2592246730353, 608.902575587906, 29873.85063074684, 38572.61427385725, 39338.8033059835, 39439.40840887389, 39564.80217598915, 41950.0, 42654.786726066406, 42683.573164268346, 42701.0, 42731.0, 7518.699252029912, 7620.161782203953, 8500.14998500148, 8670.52312122833, 8672.696455624055, 10193.490325483734, 10416.42709650969, 10442.164626829874, 10446.634367797129, 10499.790004199911, 10164.288499805016, 10212.0, 10256.128229100535, 10265.0, 10272.07551320381, 7739.419543534257, 7917.722879699183, 7929.484583502054, 10105.090541851232, 10208.48957552127, 10026.849597256047, 10201.132903703194, 10207.081362677394, 10207.489625518694, 10209.0, 38891.416628750594, 39250.41124383137, 39262.80368598167, 39298.214035719124, 39383.21233575312, 3050.42042012017, 3147.9055628330957, 3191.515722179561, 3218.7103160715415, 3901.6878649707955, 29802.0, 29862.40275194484, 29901.252468688457, 30233.697663023308, 30417.543736843745, 3613.1711363557297, 3754.6057663945166, 3776.527934008249, 3829.8276577554075, 3855.3445914194654, 267193.0, 268259.0, 268945.0, 269098.0, 269195.999999998, 54010.0, 56032.0, 56301.71849140728, 56377.154342684895, 56514.15228771572, 49100.0, 65780.34219657838, 67204.0, 67222.66388668025, 67252.32747672558, 13160.802587961189, 13326.600201993955, 13333.0, 13340.599782006555, 13352.065355425028, 10512.684619461428, 10521.105706015074, 10548.314359566604, 10578.788424231472, 10602.098821600097, 18754.34359797428, 18813.529661758566, 18819.811801881806, 18841.528961776065, 18844.623107537773, 7627.330434347934, 7669.194734552903, 7739.419543534144, 7887.881681774778, 7893.644785984645, 934.6868798952427, 982.8574856645746, 1104.7735214281054, 1121.9046381057701, 1135.8750537440874, 27631.447371052465, 27840.32446580026, 27891.302717432227, 28173.295667608472, 28215.43569128606, 1008.1581879130861, 1054.1914053564913, 1067.5783065689009, 1068.2095249515303, 1140.406988366045, 13402.865971340161, 13440.9568307975, 13590.38843252056, 13633.318334083455, 13654.0, 301257.0, 304043.0, 305234.0, 305531.0, 306151.0, 48391.274130888065, 48487.0, 48533.75733121312, 48688.51311486911, 48743.5125648746, 1269.2321145706899, 1279.3539262672477, 1280.7438512297579, 1292.6057552446407, 1327.681356474439, 24638.13766518163, 25560.360990975376, 25732.61401079023, 25817.354566135997, 25959.740402596486, 40578.0, 40850.387244190766, 40931.38602920899, 40946.79526602348, 40947.7952610235, 285497.0, 287202.0, 288051.0, 289492.0, 289623.0, 26042.21873343803, 26612.467750644493, 29181.562276565444, 29677.0, 29720.554191687574, 35125.0, 35156.824215878754, 35900.28199436049, 35928.82035589805, 35932.4610130843, 32486.0, 32713.34573308568, 32931.34137317288, 33277.33445331128, 33487.33025339528, 26561.60157597676, 30564.541531877483, 32675.67324326726, 33184.834075829465, 35038.47442288419, 32790.672093278765, 32855.561207695995, 32977.0, 33233.51646978222, 33284.66715332912, 28591.857040715495, 29931.700682993764, 30474.23814404569, 30603.971828311147, 30609.0, 22962.0, 23314.562024913062, 23508.41228969221, 23659.64510532309, 23684.88157559201], "unit": "score", "name": "ext.html", "value": 17884.351150494458}, {"lowerIsBetter": false, "replicates": [337.75681509313284, 345.19741600778195, 346.5737143313724, 353.6640191817773, 355.60705420510334, 14109.506167284148, 14488.927555362236, 16533.421330253444, 16969.406070787525, 17958.371456999008, 16485.0, 16873.66252674949, 17039.0, 17417.21622526986, 17426.128693565304, 5188.792448302072, 5349.839504814842, 5351.545118664899, 5355.116405793039, 5357.116075847481, 4013.177298653769, 4127.649149822254, 5299.390570084451, 5805.680687562182, 5967.6121052131475, 5875.177475153482, 5883.558733095035, 5884.087966365199, 5903.763849446039, 5907.995640741063, 5787.160861675055, 5956.880862382772, 5962.25471816023, 5964.970175149118, 5969.224000879858, 5174.896502069975, 5175.404828444739, 5177.58579313654, 5185.507376799235, 5215.0, 20442.795572044237, 21062.157513699432, 21225.893870530548, 21432.14271429141, 22065.33803985883, 2265.275111964172, 2303.37808791627, 2330.6154484510034, 2344.765523447659, 2414.7635294996708, 13888.23614701191, 14039.859601403958, 14300.427982880672, 14392.71214575713, 14629.41482340705, 1945.4941715154162, 1964.4204959536971, 1980.692992586137, 2018.1725492548132, 2118.3433135727973, 69013.65493172553, 69330.65334673345, 70352.0, 70445.64777176133, 70727.11000894949, 15334.386624534895, 15452.150131742637, 15460.226988650522, 15524.611884702972, 15556.922215388851, 24279.39301517441, 24378.75621243765, 24433.633495497583, 24522.386940326276, 24529.63205551918, 8882.333824963154, 8922.107789221025, 8925.241354484811, 8925.375223734407, 8985.640574377083, 7417.332440080419, 7426.331630153312, 7473.252674732484, 7479.70081196746, 7484.363829074481, 7652.885206721904, 7754.457187996786, 7758.612069396508, 7774.455788094892, 7977.60111994398, 1711.6833385823663, 1826.4703236061393, 1826.8995205263839, 1829.0854572713642, 2211.9889400552893, 405.46478648184114, 808.0988359410568, 903.1014140929817, 921.1433366968649, 928.9024652411534, 9635.421874687401, 10062.849057264148, 10252.743681408025, 10422.21833362501, 10500.527476263587, 421.46263514019256, 427.9079997800488, 444.7153821554208, 446.88157638225897, 455.84045584045316, 5891.116332550152, 5957.344692083867, 5974.820755377345, 6011.09833524966, 6044.184035155197, 521846.0, 523350.0, 527116.0, 546112.0, 554432.0, 82695.58652206701, 83886.58056709677, 83956.58021709853, 84141.0, 84892.0, 489.66213312814045, 495.5341978540161, 496.0302608400568, 497.39069639691087, 497.52237851662085, 10175.643852465128, 10216.744581385228, 10228.64199753005, 10267.178625710074, 10328.690139295833, 31731.365372691955, 32856.0, 33540.32919341648, 33682.663173368936, 34008.65991340154, 40228.59771402366, 43732.34401484044, 46140.30789538092, 46326.76836615795, 46693.53306467028, 9219.170274675043, 9266.44401335922, 9490.905090949278, 9571.234301255743, 9595.184409325286, 11234.157438192331, 11256.549738010388, 11365.204435689422, 14831.92584037073, 17573.0, 13746.518871839438, 13880.305984700926, 14156.150630962175, 14498.710025799635, 15284.15937123469, 14538.709225815635, 14705.191214482878, 14761.630959225675, 14975.925120374328, 15045.47340843109, 14429.92785036068, 14767.335469904096, 14812.629684257548, 15283.694326113193, 15452.5364239073, 8337.458065225741, 8577.0, 14144.858551414354, 14720.484783032542, 15356.07863528192, 14950.775738363716, 15303.158326292161, 15412.460563880659, 15431.922840385727, 15824.129672868103], "unit": "score", "name": "jquery.html", "value": 8773.984616767539}, {"lowerIsBetter": false, "replicates": [1305.9673508162289, 1606.5822886049627, 1659.0709202846406, 1683.7474378843172, 1723.3106757297087, 6320.652364119972, 6843.589384636925, 7029.297070292968, 7084.114485689282, 7092.0, 7080.752173673923, 7213.2786721327975, 7237.7466788662405, 7244.456665750064, 7259.564426134436, 1942.766867975845, 1961.0390908454826, 2058.217877206663, 2081.687746837979, 2096.8951552422395, 2004.1181879972764, 2006.799320067989, 2010.3566858605252, 2012.6880333548324, 2013.1242909334412, 1990.7412036435317, 2051.3128102085743, 2135.2846796323174, 2137.8396620253466, 2138.550904310097, 2105.7473103227635, 2110.8627939183903, 2134.157007981846, 2137.9786202137934, 2154.385999990011, 2162.76209616942, 2173.7500187478486, 2187.6062308784412, 2188.2231807708195, 2190.496185877257, 6847.281035491252, 6948.895766563455, 6959.921212212115, 6969.2682268362105, 6978.581285122909, 4316.072044510445, 4422.778861056934, 4427.845025424127, 4428.822847086113, 4430.313301438282, 2822.520171570838, 2910.985445072782, 2923.5468502382164, 2942.970570294291, 2946.6758656547763, 999.9500024998721, 1004.6232662751469, 1018.1498448795265, 1022.5194158745378, 1067.2635881241918, 9537.237021038369, 9555.522223888778, 9565.521723913846, 9573.952130239304, 9576.090271424135, 3868.7678739275734, 3914.8629797956933, 3945.11234972129, 3960.7623542587535, 3982.4225487304757, 8306.626201820933, 8310.792230194293, 8312.792180195422, 8317.584120793936, 8319.084900660922, 4306.633936115402, 4308.375285583573, 4340.587644173798, 4340.739555626609, 4341.522432532419, 3981.5421226558738, 3983.1635356575443, 3986.980065099656, 3987.182627561343, 3989.202159568098, 3050.481418158918, 3084.306031142975, 3210.06907996683, 3234.045956442855, 3476.28736109097, 1096.2983690438125, 1097.2812807611028, 1102.6195962392962, 1127.087059481806, 1127.3799410324289, 943.8018016216671, 963.7012526116927, 1057.5188289328337, 1172.783035138502, 1172.8475298211179, 6740.460763139035, 6779.220389655155, 6869.278725733726, 6891.586504809728, 6901.896471552931, 1079.83262594298, 1081.5133190064346, 1085.9837102443469, 1097.5884043483693, 1104.86741591008, 5485.232067510552, 5543.390227075019, 5557.666540007613, 5572.247746554163, 5578.721063946787, 8409.621567029499, 8495.065542790288, 8497.74506764798, 8502.06477287498, 8797.956010220036, 8443.408961372645, 8544.871826922601, 8554.914450855536, 8566.48601083937, 8575.656973720981, 6707.832304192337, 6886.793396198122, 6917.446604271646, 6947.201071876698, 6963.79108626742, 6919.238883722887, 6953.304669533006, 6958.652067396712, 6977.511574189758, 6985.231624521401, 7648.0, 7733.419993500397, 7839.059312882263, 7972.6412311444965, 7979.9202007979175, 8056.073551541648, 8064.798380040546, 8113.472624279403, 8176.591170441335, 8248.381371397048, 6420.101185834081, 6440.484761219185, 6483.059956306403, 6502.837429064311, 6743.022261772114, 6237.750489980532, 6389.329120442287, 6394.2646595640235, 6396.104545363746, 7152.070230870162, 6549.279579246374, 6617.602943823386, 6698.464227743788, 6749.763758268437, 6761.797146085625, 6514.250861151028, 6602.3397660233595, 6614.470842332698, 6630.9668451657435, 6736.225334086643, 6316.147320111726, 6562.442192413699, 6570.5729127606555, 6580.868382632416, 6589.374009469093, 6051.122587224916, 6071.028635418312, 6081.878362432815, 6091.086337049478, 6092.964196086765, 6051.606645568024, 6124.448799608057, 6131.080337949344, 6176.135341052346, 6219.689015549295], "unit": "score", "name": "mootools.html", "value": 4187.029430744054}, {"lowerIsBetter": false, "replicates": [334.95310656508093, 335.5989592437038, 336.725568661541, 342.9897103086905, 344.7827868442881, 5857.09215071664, 5929.169916211734, 5954.732037058332, 5962.344142144366, 5962.433568810967, 5632.831015069544, 5728.25532680752, 5753.683547404901, 5864.970675146629, 5872.060470324749, 4527.0, 4535.206338890697, 4543.591076803087, 4545.999999999992, 4559.384483094789, 4329.480462344523, 4535.546445355471, 4537.568930951555, 4537.931931021021, 4538.092381523692, 4348.239058164824, 4424.0, 4525.185466616008, 4531.161735079021, 4542.386777785006, 4500.279955207151, 4523.525029871849, 4528.252838281696, 4534.727916325031, 4540.568645978643, 4001.3997900314894, 4013.177298653769, 4015.156817068419, 4022.275990321741, 4026.375911733686, 5508.889822203573, 5617.747201375948, 5618.943810561883, 5621.831345059655, 5632.493075623172, 5247.580193584504, 5249.973750131263, 5252.054630166568, 5254.0805359062015, 5254.211868219798, 6219.689015549205, 6232.968835155795, 6233.252009758858, 6234.438900498977, 6238.376162383771, 4386.166628340637, 4389.385486031958, 4390.363397307405, 4399.934000989988, 4401.031773009932, 6306.1171435998995, 6457.096006559085, 6471.9029214561815, 6483.157189565373, 6489.123968264318, 4551.681382303207, 4552.635789136861, 4554.453465584151, 4556.70381425213, 4561.429821272341, 4615.423072115986, 4618.422697162855, 4619.538046195421, 4619.676622636451, 4624.907501850012, 5262.1317482615705, 5268.1834315681135, 5274.235235890775, 5276.92084618731, 5283.788648454019, 6040.637561746309, 6239.750409983641, 6265.467435267962, 6280.05799130125, 6282.560220784501, 1577.4873166220796, 1593.80874295083, 1594.1949315595782, 1594.673092016134, 1596.4093285484214, 1050.2595670052594, 1053.9209559283083, 1059.7244716373798, 1065.1478816946412, 1075.9193060520493, 6112.602680825821, 6114.11345354921, 6130.724117414727, 6142.170806941006, 6144.631322120687, 6486.578372405778, 6502.219733631994, 6507.446867016357, 6509.1863517060365, 6523.151990241238, 5876.471117599436, 5971.134185543159, 6088.360722124202, 6096.207493025879, 6105.694715264219, 3443.5695538057744, 3479.234568394949, 3524.665156810099, 3537.1157210697324, 3537.681608655182, 6795.93204067953, 6820.6930688119155, 6821.658917054127, 6825.044493770876, 6828.965855170792, 6721.563098398588, 6723.193216813916, 6725.39471447572, 6725.814110414135, 6732.192136943598, 6571.769988050491, 6733.293004234582, 6753.898691519631, 6835.7949261521235, 6836.965815170893, 6558.081868538313, 6558.1802274715665, 6562.573432726857, 6569.37590928861, 6570.967145164243, 6287.905681414691, 6451.000094985285, 6453.386928241809, 6457.225132984072, 6461.709223085067, 6745.9662701686175, 6780.118584583973, 6790.796276111724, 6791.0832037676255, 6797.864042719217, 4467.195904737178, 4499.66252531068, 4502.909941801211, 4505.752183629932, 4509.932351014803, 6501.544891857525, 6529.608223506605, 6530.902036469552, 6532.640704761094, 6557.672116394257, 6231.2522497300615, 6301.275353334242, 6352.0, 6358.745650173942, 6362.522810789302, 6302.590331628429, 6304.306526282197, 6317.399847014526, 6344.809655710336, 6349.49204063683, 6229.906551401642, 6232.937670623236, 6236.251649802053, 6238.75044998195, 6239.0953311770445, 6092.8781424372155, 6233.625982441068, 6233.937660623517, 6360.968195158995, 6381.712822923072, 6026.909596356146, 6178.104174894705, 6179.16581261524, 6200.534959877937, 6212.502999760099], "unit": "score", "name": "prototype.html", "value": 4758.942976153385}, {"lowerIsBetter": false, "replicates": [710.2471380336842, 846.3561045790541, 855.6491838346276, 856.4775486952959, 859.8710193470979, 13690.11014284071, 13984.160950342986, 13985.790213146785, 13994.580162595114, 14003.509877154302, 12948.546800861972, 12948.546800861972, 12992.740145197115, 13000.804987925188, 13028.283444410554, 651.9348065193478, 660.465023331101, 786.0488808541671, 788.3850596534684, 790.9881351779728, 775.1047540091204, 775.9340456061242, 777.1451403456209, 780.1457404142454, 781.5232708048086, 682.4642655515421, 816.4570560577209, 819.2749416766145, 819.5533434278333, 819.9057108432518, 682.0553533356288, 814.2997022560593, 814.5519964019795, 814.8859159717645, 819.397742659148, 593.8070127208674, 596.859737961583, 597.4294548705975, 597.6354423801478, 598.299989012856, 13015.154014988995, 13192.538261160813, 13202.141860779115, 13208.273544955024, 13223.140495867738, 11410.144239182095, 11941.164118511708, 12519.624411267676, 12628.558000469939, 12635.0, 9442.0, 9445.716628501155, 9552.570134343901, 9658.951705241428, 9687.17658998986, 3591.6228795976567, 3634.7819130852236, 3673.8163091845568, 3716.646918542734, 3746.4380342948502, 43073.138537229395, 43304.0, 43422.13155736899, 43445.34831977523, 43445.56554434478, 9631.759206019906, 9954.45250511229, 10041.849372259421, 10133.543990520444, 10261.640842570474, 18273.63452730938, 18280.63438731218, 18301.816981830278, 18307.908460457613, 18309.81690183081, 7215.96392018047, 7426.368758655467, 7532.736354227685, 7644.579548124795, 7649.770506884803, 4118.691098167649, 4136.73111247768, 4179.017930786263, 4207.389928460356, 4257.723247988871, 2933.5453004784295, 2994.2215024093894, 2997.4005198960294, 3000.0549826804922, 3000.399920015962, 492.3279723177908, 500.31956539106784, 502.0912149010303, 514.951079647433, 525.0365579162203, 559.963602365845, 595.1756816808664, 598.9281286245591, 611.6880391000622, 641.5861769158867, 7862.606869656609, 7981.441299109007, 8004.6167087046, 8194.0, 8206.548639824867, 582.6445868020504, 691.4675699711195, 694.6561452081252, 699.6361891816227, 700.9684564194623, 3930.6855451563806, 4249.745015299092, 4309.719868208556, 4312.805923733439, 4318.0, 54963.0, 59666.70166649139, 60070.39929600735, 60461.69769151126, 60885.391146088856, 49952.50047499551, 50021.0, 50099.24851127236, 50541.0, 50753.238701419505, 44314.77842610766, 44671.55328446739, 45050.54949450464, 45411.77294113574, 45963.0, 8202.712905048533, 8317.83364332722, 8730.257928076184, 8752.256058235122, 8926.955365223132, 32951.057341398984, 33401.33197335991, 33640.3271934555, 33763.83118084394, 34340.48489272613, 38253.61746382501, 40879.386809198484, 42759.358609620256, 43279.567204327555, 43447.348289775044, 10270.589176432859, 10326.225533085199, 10591.258611897094, 10613.628523001658, 10628.734281643021, 11707.239029463057, 11971.341576213392, 12002.939985300018, 12027.27836329823, 12110.455029523517, 10299.588016479556, 10772.515236814206, 10913.672589822318, 10923.0, 11244.325340479598, 10333.74165645865, 10838.458077096271, 11059.557617695202, 11164.441777911234, 11297.887021129683, 11288.94355528217, 11397.886021139682, 11653.941730291293, 11680.123990700562, 11772.587959421378, 9414.2468602513, 9707.320487565803, 9744.707658770249, 9848.11366976947, 10081.092701656886, 8985.415947963362, 9127.589258483516, 9342.346035777431, 9444.95277523608, 9656.517174141405], "unit": "score", "name": "yui.html", "value": 6140.854266086227}], "name": "dromaeo_css", "value": 6822.36107663149}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 111.0, 113.0, 102.0, 112.0, 110.0, 101.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [144.0, 124.0, 158.0, 161.0, 123.0, 157.0, 144.0, 124.0, 166.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 160.0, 161.0, 163.0, 161.0, 161.0, 162.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 82.0, 99.0, 71.0, 72.0, 72.0, 122.0, 98.0, 70.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 139.0, 93.0, 95.0, 93.0, 141.0, 94.0, 94.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 59.0, 59.0, 59.0, 59.0, 58.0, 70.0, 56.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 93.0, 85.0, 85.0, 84.0, 85.0, 86.0, 85.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [112.0, 121.0, 118.0, 113.0, 122.0, 118.0, 130.0, 118.0, 120.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [144.0, 155.0, 153.0, 155.0, 152.0, 142.0, 154.0, 152.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 66.0, 66.0, 68.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1502.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [188.6080724254998], "unit": "score", "name": "DeltaBlue", "value": 350.5576359999999}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [589.622641509434], "unit": "score", "name": "Splay", "value": 138.208736}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19846.607791598362}]} 07:29:49 INFO - RETURN: dromaeo_css: 6822.36 07:29:49 INFO - RETURN: kraken: 1502.90 07:29:49 INFO - RETURN: v8_7: 19846.61 07:29:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19846.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1502.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6822.36"}}} 07:29:49 INFO - Return code: 0 07:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:29:49 ERROR - # TBPL SUCCESS # 07:29:49 INFO - Running post-action listener: _resource_record_post_action 07:29:49 INFO - Running post-run listener: _resource_record_post_run 07:29:50 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 10616832; Write bytes: 460541952; Read time: 4364; Write time: 550008 07:29:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 16764928; Read time: 0; Write time: 28368 07:29:50 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 10616832; Write bytes: 403968000; Read time: 4364; Write time: 483320 07:29:50 INFO - Running post-run listener: _upload_blobber_files 07:29:50 INFO - Blob upload gear active. 07:29:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:29:50 INFO - Copying logs to upload dir... 07:29:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.470578 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-19 07:29:50.301163) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-19 07:29:50.305014) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009062 build_url: 'https://queue.taskcluster.net/v1/task/0o9dgflLQC2eoFuoB-kTFg/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-19 07:29:50.355601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:29:50.355959) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1450535899.233050-1984526242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:29:50.405184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 07:29:50.405505) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 07:29:50.405784) ========= ========= Total master_lag: 0.28 =========