builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1452865020.15 results: success (0) buildid: 20160115023009 builduid: a0b6f25fc0104e6197addf7c0e647069 revision: 84a69d2731e261ee599d8ae2f83e2763b21d0827 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.150574) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.151040) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.151327) ========= 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=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006018 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.173891) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.174197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.187495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.187891) ========= 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=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.237479) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.237794) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.238175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.238461) ========= 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=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 05:37:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-15 05:37:00 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.374055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.374375) ========= 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=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.423499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:00.423871) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 84a69d2731e261ee599d8ae2f83e2763b21d0827 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 84a69d2731e261ee599d8ae2f83e2763b21d0827 --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=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 05:37:00,533 truncating revision to first 12 chars 2016-01-15 05:37:00,533 Setting DEBUG logging. 2016-01-15 05:37:00,533 attempt 1/10 2016-01-15 05:37:00,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/84a69d2731e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 05:37:00,794 unpacking tar archive at: b2g-inbound-84a69d2731e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600844 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:01.037664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:01.037988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:01.048043) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:01.048469) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 05:37:01.048922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-15 05:37:01.049205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:37:01 INFO - MultiFileLogger online at 20160115 05:37:01 in /builds/slave/test-pgo 05:37:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 05:37:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:37:01 INFO - {'append_to_log': False, 05:37:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:37:01 INFO - 'blob_upload_branch': 'B2G-Inbound', 05:37:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:37:01 INFO - 'branch': 'B2G-Inbound', 05:37:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:01 INFO - 'config_files': ('talos/linux_config.py',), 05:37:01 INFO - 'default_actions': ('clobber', 05:37:01 INFO - 'read-buildbot-config', 05:37:01 INFO - 'download-and-extract', 05:37:01 INFO - 'populate-webroot', 05:37:01 INFO - 'create-virtualenv', 05:37:01 INFO - 'install', 05:37:01 INFO - 'run-tests'), 05:37:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:01 INFO - 'download_minidump_stackwalk': True, 05:37:01 INFO - 'download_symbols': 'ondemand', 05:37:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:01 INFO - 'installer_path': 'installer.exe', 05:37:01 INFO - 'log_level': 'info', 05:37:01 INFO - 'log_name': 'talos', 05:37:01 INFO - 'log_to_console': True, 05:37:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:37:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:37:01 INFO - 'opt_config_files': (), 05:37:01 INFO - 'pip_index': False, 05:37:01 INFO - 'sps_profile': False, 05:37:01 INFO - 'sps_profile_interval': 0, 05:37:01 INFO - 'suite': 'dromaeojs', 05:37:01 INFO - 'system_bits': '32', 05:37:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:01 INFO - 'title': 'talos-linux64-ix-009', 05:37:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:01 INFO - 'use_talos_json': True, 05:37:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:37:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:01 INFO - 'work_dir': 'build'} 05:37:01 INFO - ##### 05:37:01 INFO - ##### Running clobber step. 05:37:01 INFO - ##### 05:37:01 INFO - Running pre-action listener: _resource_record_pre_action 05:37:01 INFO - Running main action method: clobber 05:37:01 INFO - rmtree: /builds/slave/test-pgo/build 05:37:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:37:01 INFO - Running post-action listener: _resource_record_post_action 05:37:01 INFO - ##### 05:37:01 INFO - ##### Running read-buildbot-config step. 05:37:01 INFO - ##### 05:37:01 INFO - Running pre-action listener: _resource_record_pre_action 05:37:01 INFO - Running main action method: read_buildbot_config 05:37:01 INFO - Using buildbot properties: 05:37:01 INFO - { 05:37:01 INFO - "project": "", 05:37:01 INFO - "product": "firefox", 05:37:01 INFO - "script_repo_revision": "production", 05:37:01 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:37:01 INFO - "repository": "", 05:37:01 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 05:37:01 INFO - "buildid": "20160115023009", 05:37:01 INFO - "pgo_build": "True", 05:37:01 INFO - "basedir": "/builds/slave/test-pgo", 05:37:01 INFO - "buildnumber": 16, 05:37:01 INFO - "slavename": "talos-linux64-ix-009", 05:37:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:37:01 INFO - "platform": "ubuntu64_hw", 05:37:01 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 05:37:01 INFO - "branch": "b2g-inbound", 05:37:01 INFO - "repo_path": "integration/b2g-inbound", 05:37:01 INFO - "revision": "84a69d2731e261ee599d8ae2f83e2763b21d0827", 05:37:01 INFO - "stage_platform": "linux64-pgo", 05:37:01 INFO - "builduid": "a0b6f25fc0104e6197addf7c0e647069", 05:37:01 INFO - "slavebuilddir": "test" 05:37:01 INFO - } 05:37:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:37:01 INFO - Running post-action listener: _resource_record_post_action 05:37:01 INFO - ##### 05:37:01 INFO - ##### Running download-and-extract step. 05:37:01 INFO - ##### 05:37:01 INFO - Running pre-action listener: _resource_record_pre_action 05:37:01 INFO - Running main action method: download_and_extract 05:37:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:37:01 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')]} 05:37:01 INFO - https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:37:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/test_packages.json 05:37:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/test_packages.json 05:37:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:37:02 INFO - Downloaded 1448 bytes. 05:37:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:37:02 INFO - Using the following test package requirements: 05:37:02 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:02 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:02 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:37:02 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'jsshell-linux-x86_64.zip'], 05:37:02 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:02 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:02 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:02 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:02 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:02 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:02 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:02 INFO - https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:04 INFO - Downloaded 24030227 bytes. 05:37:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:37:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:37:06 INFO - Return code: 0 05:37:06 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 05:37:06 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')]} 05:37:06 INFO - https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:09 INFO - Downloaded 24030227 bytes. 05:37:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:37:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:37:10 INFO - Return code: 0 05:37: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')]} 05:37:10 INFO - https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:37:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:12 INFO - Downloaded 11132144 bytes. 05:37:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:37:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:37:12 INFO - Return code: 0 05:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:12 INFO - https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:37:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MLJAJoQkQGmJCWpCluwYeA/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 05:37:16 INFO - Downloaded 55874647 bytes. 05:37:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:16 INFO - mkdir: /builds/slave/test-pgo/properties 05:37:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:37:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:37:16 INFO - Contents: 05:37:16 INFO - build_url:https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:16 INFO - Running post-action listener: _resource_record_post_action 05:37:16 INFO - Running post-action listener: set_extra_try_arguments 05:37:16 INFO - ##### 05:37:16 INFO - ##### Running populate-webroot step. 05:37:16 INFO - ##### 05:37:16 INFO - Running pre-action listener: _resource_record_pre_action 05:37:16 INFO - Running main action method: populate_webroot 05:37:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:16 INFO - '--tppagecycles', 05:37:16 INFO - '7'], 05:37:16 INFO - 'tests': ['tsvgm']}}, 05:37:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:37:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'tests': ['damp', 'tps']}, 05:37:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['damp', 'tps']}, 05:37:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:37:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:16 INFO - 'other': {'tests': ['a11yr', 05:37:16 INFO - 'ts_paint', 05:37:16 INFO - 'tpaint', 05:37:16 INFO - 'sessionrestore', 05:37:16 INFO - 'sessionrestore_no_auto_restore']}, 05:37:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['a11yr', 05:37:16 INFO - 'ts_paint', 05:37:16 INFO - 'tpaint', 05:37:16 INFO - 'sessionrestore', 05:37:16 INFO - 'sessionrestore_no_auto_restore']}, 05:37:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['a11yr', 05:37:16 INFO - 'ts_paint', 05:37:16 INFO - 'tpaint', 05:37:16 INFO - 'sessionrestore', 05:37:16 INFO - 'sessionrestore_no_auto_restore']}, 05:37:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['a11yr', 05:37:16 INFO - 'ts_paint', 05:37:16 INFO - 'tpaint', 05:37:16 INFO - 'sessionrestore', 05:37:16 INFO - 'sessionrestore_no_auto_restore']}, 05:37:16 INFO - 'other_l64': {'tests': ['a11yr', 05:37:16 INFO - 'ts_paint', 05:37:16 INFO - 'tpaint', 05:37:16 INFO - 'sessionrestore', 05:37:16 INFO - 'sessionrestore_no_auto_restore']}, 05:37:16 INFO - 'other_nol64': {'tests': ['a11yr', 05:37:16 INFO - 'ts_paint', 05:37:16 INFO - 'tpaint', 05:37:16 INFO - 'sessionrestore', 05:37:16 INFO - 'sessionrestore_no_auto_restore']}, 05:37:16 INFO - 'svgr': {'tests': ['tsvgx', 05:37:16 INFO - 'tsvgr_opacity', 05:37:16 INFO - 'tart', 05:37:16 INFO - 'tscrollx', 05:37:16 INFO - 'cart']}, 05:37:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['tsvgx', 05:37:16 INFO - 'tsvgr_opacity', 05:37:16 INFO - 'tart', 05:37:16 INFO - 'tscrollx', 05:37:16 INFO - 'cart']}, 05:37:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'tests': ['tp5o']}, 05:37:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'talos_options': ['--e10s'], 05:37:16 INFO - 'tests': ['tp5o']}, 05:37:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'talos_options': ['--xperf_path', 05:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:16 INFO - 'tests': ['tp5n']}, 05:37:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:16 INFO - 'talos_options': ['--e10s', 05:37:16 INFO - '--xperf_path', 05:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:16 INFO - 'tests': ['tp5n']}}, 05:37:16 INFO - 'talos.zip': {'path': '', 05:37:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:16 INFO - Running post-action listener: _resource_record_post_action 05:37:16 INFO - ##### 05:37:16 INFO - ##### Running create-virtualenv step. 05:37:16 INFO - ##### 05:37:16 INFO - Running pre-action listener: _resource_record_pre_action 05:37:16 INFO - Running main action method: create_virtualenv 05:37:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:37:16 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 05:37:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:37:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:16 INFO - Using real prefix '/usr' 05:37:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:37:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:18 INFO - Installing pip.................done. 05:37:18 INFO - Return code: 0 05:37:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:18 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:18 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 05:37:18 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 05:37:18 INFO - Using env: {'DISPLAY': ':0', 05:37:18 INFO - 'HOME': '/home/cltbld', 05:37:18 INFO - 'LANG': 'en_US.UTF-8', 05:37:18 INFO - 'LANGUAGE': 'en_US:en', 05:37:18 INFO - 'LOGNAME': 'cltbld', 05:37:18 INFO - 'MAIL': '/var/mail/cltbld', 05:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:18 INFO - 'MOZ_NO_REMOTE': '1', 05:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:18 INFO - 'NO_EM_RESTART': '1', 05:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:18 INFO - 'SHELL': '/bin/bash', 05:37:18 INFO - 'SHLVL': '1', 05:37:18 INFO - 'TERM': 'linux', 05:37:18 INFO - 'TMOUT': '86400', 05:37:18 INFO - 'USER': 'cltbld', 05:37:18 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:18 INFO - '_': '/tools/buildbot/bin/python'} 05:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:18 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 05:37:18 INFO - Cleaning up... 05:37:18 INFO - Return code: 0 05:37:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:18 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:18 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 05:37:18 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 05:37:18 INFO - Using env: {'DISPLAY': ':0', 05:37:18 INFO - 'HOME': '/home/cltbld', 05:37:18 INFO - 'LANG': 'en_US.UTF-8', 05:37:18 INFO - 'LANGUAGE': 'en_US:en', 05:37:18 INFO - 'LOGNAME': 'cltbld', 05:37:18 INFO - 'MAIL': '/var/mail/cltbld', 05:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:18 INFO - 'MOZ_NO_REMOTE': '1', 05:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:18 INFO - 'NO_EM_RESTART': '1', 05:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:18 INFO - 'SHELL': '/bin/bash', 05:37:18 INFO - 'SHLVL': '1', 05:37:18 INFO - 'TERM': 'linux', 05:37:18 INFO - 'TMOUT': '86400', 05:37:18 INFO - 'USER': 'cltbld', 05:37:18 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:18 INFO - '_': '/tools/buildbot/bin/python'} 05:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:19 INFO - Downloading/unpacking psutil>=0.7.1 05:37:19 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 05:37:19 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 05:37:19 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 05:37:19 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 05:37:19 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 05:37:19 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 05:37:20 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:37:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:37:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:20 INFO - Installing collected packages: psutil 05:37:20 INFO - Running setup.py install for psutil 05:37:21 INFO - building 'psutil._psutil_linux' extension 05:37:21 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 05:37:21 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 05:37:21 INFO - building 'psutil._psutil_posix' extension 05:37:21 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 05:37:21 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 05:37:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:21 INFO - Successfully installed psutil 05:37:21 INFO - Cleaning up... 05:37:21 INFO - Return code: 0 05:37:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:21 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:21 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 05:37:21 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 05:37:21 INFO - Using env: {'DISPLAY': ':0', 05:37:21 INFO - 'HOME': '/home/cltbld', 05:37:21 INFO - 'LANG': 'en_US.UTF-8', 05:37:21 INFO - 'LANGUAGE': 'en_US:en', 05:37:21 INFO - 'LOGNAME': 'cltbld', 05:37:21 INFO - 'MAIL': '/var/mail/cltbld', 05:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:21 INFO - 'MOZ_NO_REMOTE': '1', 05:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:21 INFO - 'NO_EM_RESTART': '1', 05:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:21 INFO - 'SHELL': '/bin/bash', 05:37:21 INFO - 'SHLVL': '1', 05:37:21 INFO - 'TERM': 'linux', 05:37:21 INFO - 'TMOUT': '86400', 05:37:21 INFO - 'USER': 'cltbld', 05:37:21 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:21 INFO - '_': '/tools/buildbot/bin/python'} 05:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:37:21 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 05:37:21 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 05:37:21 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 05:37:21 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 05:37:21 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 05:37:21 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 05:37:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:37:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:37:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:37:23 INFO - Installing collected packages: mozsystemmonitor 05:37:23 INFO - Running setup.py install for mozsystemmonitor 05:37:23 INFO - Successfully installed mozsystemmonitor 05:37:23 INFO - Cleaning up... 05:37:23 INFO - Return code: 0 05:37:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:37:23 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')]} 05:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:23 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')]} 05:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:23 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:23 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 05:37:23 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 05:37:23 INFO - Using env: {'DISPLAY': ':0', 05:37:23 INFO - 'HOME': '/home/cltbld', 05:37:23 INFO - 'LANG': 'en_US.UTF-8', 05:37:23 INFO - 'LANGUAGE': 'en_US:en', 05:37:23 INFO - 'LOGNAME': 'cltbld', 05:37:23 INFO - 'MAIL': '/var/mail/cltbld', 05:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:23 INFO - 'MOZ_NO_REMOTE': '1', 05:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:23 INFO - 'NO_EM_RESTART': '1', 05:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:23 INFO - 'SHELL': '/bin/bash', 05:37:23 INFO - 'SHLVL': '1', 05:37:23 INFO - 'TERM': 'linux', 05:37:23 INFO - 'TMOUT': '86400', 05:37:23 INFO - 'USER': 'cltbld', 05:37:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:23 INFO - '_': '/tools/buildbot/bin/python'} 05:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:23 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:23 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 05:37:23 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 05:37:23 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 05:37:23 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 05:37:23 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 05:37:23 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 05:37:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:37:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:25 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 05:37:25 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 05:37:25 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 05:37:25 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 05:37:25 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 05:37:25 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 05:37:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:37:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:37:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:25 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 05:37:25 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 05:37:25 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 05:37:25 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 05:37:25 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 05:37:25 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 05:37:26 INFO - Downloading docopt-0.6.1.tar.gz 05:37:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:37:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:26 INFO - Running setup.py install for blobuploader 05:37:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:37:26 INFO - Running setup.py install for requests 05:37:26 INFO - Running setup.py install for docopt 05:37:26 INFO - Successfully installed blobuploader requests docopt 05:37:26 INFO - Cleaning up... 05:37:26 INFO - Return code: 0 05:37:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37:26 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')]} 05:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 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')]} 05:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:26 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:26 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 05:37:26 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 05:37:26 INFO - Using env: {'DISPLAY': ':0', 05:37:26 INFO - 'HOME': '/home/cltbld', 05:37:26 INFO - 'LANG': 'en_US.UTF-8', 05:37:26 INFO - 'LANGUAGE': 'en_US:en', 05:37:26 INFO - 'LOGNAME': 'cltbld', 05:37:26 INFO - 'MAIL': '/var/mail/cltbld', 05:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:26 INFO - 'MOZ_NO_REMOTE': '1', 05:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:26 INFO - 'NO_EM_RESTART': '1', 05:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:26 INFO - 'SHELL': '/bin/bash', 05:37:26 INFO - 'SHLVL': '1', 05:37:26 INFO - 'TERM': 'linux', 05:37:26 INFO - 'TMOUT': '86400', 05:37:26 INFO - 'USER': 'cltbld', 05:37:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:26 INFO - '_': '/tools/buildbot/bin/python'} 05:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:27 INFO - Running setup.py (path:/tmp/pip-w3jqhb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:27 INFO - Running setup.py (path:/tmp/pip-DFWBYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:27 INFO - Running setup.py (path:/tmp/pip-ipP_uQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:27 INFO - Running setup.py (path:/tmp/pip-WSjpHs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:27 INFO - Running setup.py (path:/tmp/pip-JP7kzl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:27 INFO - Running setup.py (path:/tmp/pip-FVGwsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:27 INFO - Running setup.py (path:/tmp/pip-jwNxqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:27 INFO - Running setup.py (path:/tmp/pip-7pHEQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:27 INFO - Running setup.py (path:/tmp/pip-59slsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:27 INFO - Running setup.py (path:/tmp/pip-5z7432-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:27 INFO - Running setup.py (path:/tmp/pip-2ELAiw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:27 INFO - Running setup.py (path:/tmp/pip-PCcQOk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:27 INFO - Running setup.py (path:/tmp/pip-1SCUFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:28 INFO - Running setup.py (path:/tmp/pip-oGLf_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:28 INFO - Running setup.py (path:/tmp/pip-N0MYzo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:28 INFO - Running setup.py (path:/tmp/pip-O3HW8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:28 INFO - Running setup.py (path:/tmp/pip-1kgjHc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:28 INFO - Running setup.py install for manifestparser 05:37:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:37:28 INFO - Running setup.py install for mozcrash 05:37:28 INFO - Running setup.py install for mozdebug 05:37:28 INFO - Running setup.py install for mozdevice 05:37:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:37:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:37:28 INFO - Running setup.py install for mozfile 05:37:28 INFO - Running setup.py install for mozhttpd 05:37:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:37:28 INFO - Running setup.py install for mozinfo 05:37:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Running setup.py install for mozInstall 05:37:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Running setup.py install for mozleak 05:37:29 INFO - Running setup.py install for mozlog 05:37:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Running setup.py install for moznetwork 05:37:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Running setup.py install for mozprocess 05:37:29 INFO - Running setup.py install for mozprofile 05:37:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Running setup.py install for mozrunner 05:37:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:37:29 INFO - Running setup.py install for mozscreenshot 05:37:29 INFO - Running setup.py install for moztest 05:37:29 INFO - Running setup.py install for mozversion 05:37:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:37:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:30 INFO - Cleaning up... 05:37:30 INFO - Return code: 0 05:37:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:30 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:30 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 05:37:30 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 05:37:30 INFO - Using env: {'DISPLAY': ':0', 05:37:30 INFO - 'HOME': '/home/cltbld', 05:37:30 INFO - 'LANG': 'en_US.UTF-8', 05:37:30 INFO - 'LANGUAGE': 'en_US:en', 05:37:30 INFO - 'LOGNAME': 'cltbld', 05:37:30 INFO - 'MAIL': '/var/mail/cltbld', 05:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:30 INFO - 'MOZ_NO_REMOTE': '1', 05:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:30 INFO - 'NO_EM_RESTART': '1', 05:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:30 INFO - 'SHELL': '/bin/bash', 05:37:30 INFO - 'SHLVL': '1', 05:37:30 INFO - 'TERM': 'linux', 05:37:30 INFO - 'TMOUT': '86400', 05:37:30 INFO - 'USER': 'cltbld', 05:37:30 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:30 INFO - '_': '/tools/buildbot/bin/python'} 05:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:30 INFO - Running setup.py (path:/tmp/pip-KzKIuJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:30 INFO - Running setup.py (path:/tmp/pip-bL9_GY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:30 INFO - Running setup.py (path:/tmp/pip-3H_5wM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:30 INFO - Running setup.py (path:/tmp/pip-stOkEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:30 INFO - Running setup.py (path:/tmp/pip-pBF37E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:30 INFO - Running setup.py (path:/tmp/pip-HXw4SM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:30 INFO - Running setup.py (path:/tmp/pip-EtLwcp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:30 INFO - Running setup.py (path:/tmp/pip-uDg531-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:30 INFO - Running setup.py (path:/tmp/pip-_V_nt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:37:30 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)) 05:37:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:30 INFO - Running setup.py (path:/tmp/pip-scUGap-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:37:31 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)) 05:37:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:31 INFO - Running setup.py (path:/tmp/pip-4wQxzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:37:31 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)) 05:37:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:31 INFO - Running setup.py (path:/tmp/pip-onPNY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:37:31 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)) 05:37:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:31 INFO - Running setup.py (path:/tmp/pip-HN8mfl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:37:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:31 INFO - Running setup.py (path:/tmp/pip-P5Jmaa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:37:31 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)) 05:37:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:31 INFO - Running setup.py (path:/tmp/pip-lsRD13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:37:31 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)) 05:37:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:31 INFO - Running setup.py (path:/tmp/pip-muGYxy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:37:31 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)) 05:37:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:31 INFO - Running setup.py (path:/tmp/pip-qX16Fk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:37:31 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)) 05:37:31 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)) 05:37:31 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)) 05:37:31 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)) 05:37:31 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:31 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:31 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 05:37:31 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 05:37:31 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 05:37:31 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 05:37:31 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 05:37:31 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 05:37:33 INFO - Downloading blessings-1.5.1.tar.gz 05:37:33 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 05:37:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:33 INFO - Installing collected packages: blessings 05:37:33 INFO - Running setup.py install for blessings 05:37:33 INFO - Successfully installed blessings 05:37:33 INFO - Cleaning up... 05:37:33 INFO - Return code: 0 05:37:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:37:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:37:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:37:33 INFO - Reading from file tmpfile_stdout 05:37:33 INFO - Current package versions: 05:37:33 INFO - argparse == 1.2.1 05:37:33 INFO - blessings == 1.5.1 05:37:33 INFO - blobuploader == 1.2.4 05:37:33 INFO - docopt == 0.6.1 05:37:33 INFO - manifestparser == 1.1 05:37:33 INFO - mozInstall == 1.12 05:37:33 INFO - mozcrash == 0.16 05:37:33 INFO - mozdebug == 0.1 05:37:33 INFO - mozdevice == 0.48 05:37:33 INFO - mozfile == 1.2 05:37:33 INFO - mozhttpd == 0.7 05:37:33 INFO - mozinfo == 0.9 05:37:33 INFO - mozleak == 0.1 05:37:33 INFO - mozlog == 3.1 05:37:33 INFO - moznetwork == 0.27 05:37:33 INFO - mozprocess == 0.22 05:37:33 INFO - mozprofile == 0.28 05:37:33 INFO - mozrunner == 6.11 05:37:33 INFO - mozscreenshot == 0.1 05:37:33 INFO - mozsystemmonitor == 0.0 05:37:33 INFO - moztest == 0.7 05:37:33 INFO - mozversion == 1.4 05:37:33 INFO - psutil == 3.1.1 05:37:33 INFO - requests == 1.2.3 05:37:33 INFO - wsgiref == 0.1.2 05:37:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:33 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 05:37:33 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 05:37:33 INFO - Using env: {'DISPLAY': ':0', 05:37:33 INFO - 'HOME': '/home/cltbld', 05:37:33 INFO - 'LANG': 'en_US.UTF-8', 05:37:33 INFO - 'LANGUAGE': 'en_US:en', 05:37:33 INFO - 'LOGNAME': 'cltbld', 05:37:33 INFO - 'MAIL': '/var/mail/cltbld', 05:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:33 INFO - 'MOZ_NO_REMOTE': '1', 05:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:33 INFO - 'NO_EM_RESTART': '1', 05:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:33 INFO - 'SHELL': '/bin/bash', 05:37:33 INFO - 'SHLVL': '1', 05:37:33 INFO - 'TERM': 'linux', 05:37:33 INFO - 'TMOUT': '86400', 05:37:33 INFO - 'USER': 'cltbld', 05:37:33 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:33 INFO - '_': '/tools/buildbot/bin/python'} 05:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:37:33 INFO - Cleaning up... 05:37:33 INFO - Return code: 0 05:37:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:33 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:33 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 05:37:33 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 05:37:33 INFO - Using env: {'DISPLAY': ':0', 05:37:33 INFO - 'HOME': '/home/cltbld', 05:37:33 INFO - 'LANG': 'en_US.UTF-8', 05:37:33 INFO - 'LANGUAGE': 'en_US:en', 05:37:33 INFO - 'LOGNAME': 'cltbld', 05:37:33 INFO - 'MAIL': '/var/mail/cltbld', 05:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:33 INFO - 'MOZ_NO_REMOTE': '1', 05:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:33 INFO - 'NO_EM_RESTART': '1', 05:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:33 INFO - 'SHELL': '/bin/bash', 05:37:33 INFO - 'SHLVL': '1', 05:37:33 INFO - 'TERM': 'linux', 05:37:33 INFO - 'TMOUT': '86400', 05:37:33 INFO - 'USER': 'cltbld', 05:37:33 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:33 INFO - '_': '/tools/buildbot/bin/python'} 05:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:34 INFO - Downloading/unpacking jsonschema 05:37:34 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 05:37:34 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 05:37:34 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 05:37:34 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 05:37:34 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 05:37:34 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 05:37:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:35 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 05:37:35 INFO - Downloading/unpacking functools32 (from jsonschema) 05:37:35 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 05:37:35 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 05:37:35 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 05:37:35 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 05:37:35 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 05:37:35 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 05:37:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:37:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:36 INFO - warning: no files found matching '*.txt' 05:37:36 INFO - no previously-included directories found matching 'build' 05:37:36 INFO - no previously-included directories found matching 'dist' 05:37:36 INFO - no previously-included directories found matching '.git*' 05:37:36 INFO - Installing collected packages: jsonschema, functools32 05:37:36 INFO - Running setup.py install for functools32 05:37:36 INFO - warning: no files found matching '*.txt' 05:37:36 INFO - no previously-included directories found matching 'build' 05:37:36 INFO - no previously-included directories found matching 'dist' 05:37:36 INFO - no previously-included directories found matching '.git*' 05:37:36 INFO - Successfully installed jsonschema functools32 05:37:36 INFO - Cleaning up... 05:37:36 INFO - Return code: 0 05:37:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:37: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')]} 05:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:36 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 0x7f12b694ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', '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 05:37:36 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 05:37:36 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 05:37:36 INFO - Using env: {'DISPLAY': ':0', 05:37:36 INFO - 'HOME': '/home/cltbld', 05:37:36 INFO - 'LANG': 'en_US.UTF-8', 05:37:36 INFO - 'LANGUAGE': 'en_US:en', 05:37:36 INFO - 'LOGNAME': 'cltbld', 05:37:36 INFO - 'MAIL': '/var/mail/cltbld', 05:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:36 INFO - 'MOZ_NO_REMOTE': '1', 05:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:36 INFO - 'NO_EM_RESTART': '1', 05:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:36 INFO - 'SHELL': '/bin/bash', 05:37:36 INFO - 'SHLVL': '1', 05:37:36 INFO - 'TERM': 'linux', 05:37:36 INFO - 'TMOUT': '86400', 05:37:36 INFO - 'USER': 'cltbld', 05:37:36 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:36 INFO - '_': '/tools/buildbot/bin/python'} 05:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:36 INFO - Downloading/unpacking flake8 05:37:36 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 05:37:36 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 05:37:36 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 05:37:36 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 05:37:36 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 05:37:36 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 05:37:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:37:38 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 05:37:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:37:38 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 05:37:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 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 05:37:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:37:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:37:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:38 INFO - no previously-included directories found matching 'docs/_build' 05:37:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:37:39 INFO - Running setup.py install for pep8 05:37:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:39 INFO - no previously-included directories found matching 'docs/_build' 05:37:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:37:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:37:39 INFO - Cleaning up... 05:37:39 INFO - Return code: 0 05:37:39 INFO - Running post-action listener: _resource_record_post_action 05:37:39 INFO - Running post-action listener: _start_resource_monitoring 05:37:39 INFO - Starting resource monitoring. 05:37:39 INFO - ##### 05:37:39 INFO - ##### Running install step. 05:37:39 INFO - ##### 05:37:39 INFO - Running pre-action listener: _resource_record_pre_action 05:37:39 INFO - Running main action method: install 05:37:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:37:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:37:39 INFO - Reading from file tmpfile_stdout 05:37:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:37:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:37:39 INFO - Reading from file tmpfile_stdout 05:37:39 INFO - Output received: 05:37:39 INFO - Usage: mozinstall [options] installer 05:37:39 INFO - Options: 05:37:39 INFO - -h, --help show this help message and exit 05:37:39 INFO - -d DEST, --destination=DEST 05:37:39 INFO - Directory to install application into. [default: 05:37:39 INFO - "/builds/slave/test-pgo"] 05:37:39 INFO - --app=APP Application being installed. [default: firefox] 05:37:39 INFO - mkdir: /builds/slave/test-pgo/build/application 05:37:39 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'] 05:37:39 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 05:37:55 INFO - Reading from file tmpfile_stdout 05:37:55 INFO - Output received: 05:37:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:37:55 INFO - Running post-action listener: _resource_record_post_action 05:37:55 INFO - ##### 05:37:55 INFO - ##### Running run-tests step. 05:37:55 INFO - ##### 05:37:55 INFO - Running pre-action listener: _resource_record_pre_action 05:37:55 INFO - Running main action method: run_tests 05:37:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:37:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:37:55 INFO - Python 2.7.3 05:37:55 INFO - Return code: 0 05:37:55 INFO - grabbing minidump binary from tooltool 05:37:55 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')]} 05:37:55 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 0x2d24840>, '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 0x2c916b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c91b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:37:55 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 05:37:55 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 05:37:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:55 INFO - Return code: 0 05:37:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:37:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:37:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:37:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:37:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:37:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:37:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:37:56 INFO - Return code: 0 05:37:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:37:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:37:56 INFO - Using env: {'DISPLAY': ':0', 05:37:56 INFO - 'HOME': '/home/cltbld', 05:37:56 INFO - 'LANG': 'en_US.UTF-8', 05:37:56 INFO - 'LANGUAGE': 'en_US:en', 05:37:56 INFO - 'LOGNAME': 'cltbld', 05:37:56 INFO - 'MAIL': '/var/mail/cltbld', 05:37:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:37:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:56 INFO - 'MOZ_NO_REMOTE': '1', 05:37:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:56 INFO - 'NO_EM_RESTART': '1', 05:37:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:37:56 INFO - 'SHELL': '/bin/bash', 05:37:56 INFO - 'SHLVL': '1', 05:37:56 INFO - 'TERM': 'linux', 05:37:56 INFO - 'TMOUT': '86400', 05:37:56 INFO - 'USER': 'cltbld', 05:37:56 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846', 05:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:56 INFO - '_': '/tools/buildbot/bin/python'} 05:37:56 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:37:56 INFO - mozversion application_buildid: 20160115023009 05:37:56 INFO - mozversion application_changeset: 84a69d2731e261ee599d8ae2f83e2763b21d0827 05:37:56 INFO - mozversion application_display_name: Nightly 05:37:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:56 INFO - mozversion application_name: Firefox 05:37:56 INFO - mozversion application_remotingname: firefox 05:37:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:37:56 INFO - mozversion application_vendor: Mozilla 05:37:56 INFO - mozversion application_version: 46.0a1 05:37:56 INFO - mozversion platform_buildid: 20160115023009 05:37:56 INFO - mozversion platform_changeset: 84a69d2731e261ee599d8ae2f83e2763b21d0827 05:37:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:37:56 INFO - mozversion platform_version: 46.0a1 05:37:56 INFO - using testdate: 1452865076 05:37:56 INFO - actual date: 1452865076 05:37:56 INFO - starting webserver on 'localhost:35181' 05:37:56 INFO - SUITE-START | Running 3 tests 05:37:56 INFO - TEST-START | dromaeo_css 05:37:56 INFO - operating with platform_type : linux_ 05:37:56 INFO - Initialising browser for dromaeo_css test... 05:37:56 INFO - TEST-INFO | started process 621 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKY4uIy/profile http://localhost:35181/getInfo.html) 05:38:01 INFO - PROCESS | 621 | __metrics Screen width/height:1600/1200 05:38:01 INFO - PROCESS | 621 | colorDepth:24 05:38:01 INFO - PROCESS | 621 | Browser inner width/height: 1024/697 05:38:01 INFO - PROCESS | 621 | __metrics 05:38:01 INFO - PROCESS | 621 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:38:01 INFO - PROCESS | 621 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:02 INFO - TEST-INFO | 621: exit 0 05:38:02 INFO - Browser initialized. 05:38:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:02 INFO - TEST-INFO | started process 716 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKY4uIy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:14 INFO - PROCESS | 716 | RSS: Main: 150204416 05:38:14 INFO - PROCESS | 716 | 05:39:05 INFO - PROCESS | 716 | 1452865145790 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] 05:41:14 INFO - PROCESS | 716 | Cycle 1(1): loaded http://localhost:35181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35181/tests/dromaeo/cssquery-ext.html) 05:41:15 INFO - PROCESS | 716 | RSS: Main: 260169728 05:41:15 INFO - PROCESS | 716 | 05:44:17 INFO - PROCESS | 716 | Cycle 1(1): loaded http://localhost:35181/tests/dromaeo/cssquery-ext.html (next: http://localhost:35181/tests/dromaeo/cssquery-jquery.html) 05:44:18 INFO - PROCESS | 716 | RSS: Main: 225382400 05:44:18 INFO - PROCESS | 716 | 05:47:20 INFO - PROCESS | 716 | Cycle 1(1): loaded http://localhost:35181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35181/tests/dromaeo/cssquery-mootools.html) 05:47:20 INFO - PROCESS | 716 | RSS: Main: 220057600 05:47:20 INFO - PROCESS | 716 | 05:50:22 INFO - PROCESS | 716 | Cycle 1(1): loaded http://localhost:35181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35181/tests/dromaeo/cssquery-prototype.html) 05:50:23 INFO - PROCESS | 716 | RSS: Main: 205225984 05:50:23 INFO - PROCESS | 716 | 05:53:25 INFO - PROCESS | 716 | Cycle 1(1): loaded http://localhost:35181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35181/tests/dromaeo/cssquery-yui.html) 05:53:26 INFO - PROCESS | 716 | RSS: Main: 211124224 05:53:26 INFO - PROCESS | 716 | 05:56:28 INFO - PROCESS | 716 | Cycle 1(1): loaded http://localhost:35181/tests/dromaeo/cssquery-yui.html (next: http://localhost:35181/tests/dromaeo/cssquery-dojo.html) 05:56:29 INFO - PROCESS | 716 | RSS: Main: 268087296 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | __start_tp_report 05:56:29 INFO - PROCESS | 716 | _x_x_mozilla_page_load 05:56:29 INFO - PROCESS | 716 | _x_x_mozilla_page_load_details 05:56:29 INFO - PROCESS | 716 | |i|pagename|runs| 05:56:29 INFO - PROCESS | 716 | |0;dojo.html;3061.005173318672;3064.279894224857;3109.5491153782687;3114.112477943785;3130.358276553306;4898.877528061791;4949.52979466951;5034.446210916796;5049.772760225785;5088.821891233808;4975.8258460953875;5029.446760856312;5055.191169412895;5057.797688092472;5080.517350851673;4413.44831896013;4548.772561371935;4576.290674945389;4593.081383723269;4654.185517534418;4557.430321209848;4602.516735742749;4638.512956139607;4646.558576935203;4743.928841067387;4538;4561.064981678748;4563.315502674593;4614.9077018459775;4617.353570500132;4659.277811939155;4671.929921051187;4680.461746899116;4684.5549672781035;4688.765561721901;4549.681522293407;4657.04530571232;4658.697184682985;4674.228752255874;4678.625709943196;4866.7079975201605;4895.681780684244;5014.2979982802435;5044.117279476113;5050.3434553507805;5442.510174084351;5452.482014208644;5457.972710136463;5463;5476.7535460904355;5458.863528411782;5460.453954604547;5460.535854452376;5461.808836690697;5471.933141770984;5003.799848006075;5074.238864170367;5142.5628821549835;5171.069207542679;5218.478152184789;5548.72256387179;5571.637843540157;5579.6931168785295;5580.302462192226;5585.413531579207;5303.655262407931;5374.785008599612;5380.085385484399;5396.406395296514;5401.5948803839865;5347.973260133675;5380.596455265871;5398.73006349681;5401.864953376118;5442.0204363215;5444.972775136099;5455.481729235717;5462.781488740406;5463.863403414946;5486.753096110685;5290.735463226823;5371.060064488699;5437.673739575638;5488.1767734839295;5516.862078448071;4226.725262857904;4273.316269396882;4273.850415235514;4283.635890949242;4291.420658211102;3841.2893614681375;3858.884233473;3865.806709664562;3869.7484663496784;3885.417187421909;4899.559039686445;4906.215005599087;5091.516305950929;5133.9743301284;5178.3785945686;5488;5501.119820828648;5522.144067669517;5529.391766905637;5562.694051827108;5058.797648094109;5141;5141.25451809493;5144.588432925357;5190.714510701872;4568.132054909556;4615.353850460938;4680.742559159279;4683.484816670163;4702.95297047032;5692.9146062809095;5693.886122277614;5705.144228365778;5711.514521265656;5715.342735585461;5517.089680202722;5527.53015993645;5530.723463826873;5533.059379905345;5535.972320138373;5439.238506609157;5592.356878958972;5594;5598.244237027949;5689.203511508475;5372.650777699593;5433.619646624698;5465.398806131243;5479.945200547943;5490.505854473116;5431.511163995259;5449.427810080043;5471.671699698031;5478.972605136949;5486.067368547437;5173.22401639742;5347;5367.570594352521;5370.087085195604;5411.78352865881;5246.475352464723;5290.788368465218;5300.867478313073;5330.760115794721;5332.093544097435;5293.761780719799;5324.094903866275;5324.121519949165;5331.120365139708;5371.328583927009;5293.232481290268;5327.174287985368;5407.83776486706;5424.918626220531;5439.4288599696465;5234.921476177937;5248.501392367719;5282.260483532232;5285.154375299933;5326.387465441524 05:56:29 INFO - PROCESS | 716 | |1;ext.html;554.5258803722814;570.8858228354329;586.1676419484331;586.996236435695;594.8661551150991;28292.57561136582;35770.46344304834;36431.81784091082;36449.81775091121;36511.63488365115;40237.7988110059;40832;40900.59099409005;41049;41049.38425923613;8488.44825086369;8675.045744968049;8683.13168683133;8687.348448866329;8689.348298877578;8425.452345597547;8573.185547373021;8576;8577.485350878937;8774.385792994493;8757.211850933414;8845.646174153026;8847.159519845605;8847.424917380382;8847.601857916377;8654.394192406535;8786.341024423195;8793.736187914374;8823.205911467998;8823.823523529494;8660.17728315809;8784.12158784123;8794.34042446819;8802.339824513187;8806.64773409063;39393.60606393928;40297.59702402968;40303.798481007405;40355.59644403548;40373.394399084034;3368.2708882328525;3368.511565822942;3375.6455572164814;3379.4086034943784;3439.4840773883866;29660.110196694135;30270.394592108256;30402.239944001354;30419;30899.691003089905;4018.276710192164;4035.959640403588;4086.6117718816663;4122.361034039729;4145.958540414587;259898;260987;261005;261467;261528;51400.48599514032;52412.737936310834;58468.415315847145;58720.11919821206;58806;63749.36250637527;64907.35092649013;65286.34713652897;65369.67315163489;65427.34572654308;14382.712345753027;14553.708925821637;14612;14640.19478928648;14658.413663453555;10584.417857017785;10873.401962892116;10934.125269978542;10995.670129896116;11117.444127793578;19324.71012934807;19433.708494372597;19483.902580487007;19491.902540487208;19591.31430399929;7119.323664251888;7466.775996720107;7480.8877866832045;7486.737964171337;7502.212267711811;962.2398305338704;972.1687956796837;1051.4742628685658;1069.6363236499628;1110.3892858927718;28282.43435131286;29565.85217073901;29626.851865740533;29970.85014574957;30185.245368865955;1041.4480325427535;1112.2158877990996;1137.6985098948785;1145.5818626201376;1181.1436708386352;14330.49843255502;14624.488142914946;14776.522347765138;14985.32566034531;15035.323410446337;321659;324828;325843;326026;326080;52254;53239.20141197808;53267.46732532702;53281.733591331795;53305.46694533005;1340.8323959505062;1346.4008516210192;1346.5421756602607;1359.8980076494302;1372.4510195921512;27616;28066.579001315404;28758.424831502834;28862.567061493675;28947;42089.158216836106;42100.36849447322;42244;46962.530374695816;47060.7646961763;248015;249138;249234;249715;249834;28519.144425667262;32430.351392971537;32574.51138232881;32747;33167.83416082904;39641.60358396495;41261;41577;41611.58388416077;42219.7889010553;35293.29413411666;35313.47029794606;35358.292834143685;35579.822100890364;35859.64140358563;28621.02852923947;33872.66127338695;34985.30029399347;35617.64382356247;36385.27229455449;32672.34655306928;33219.833900831305;33521;33548.329033419686;33614;28470;29704.702952970194;30029.849850750605;30179.18924864515;30232.84883575568;24317.635235471127;24791.87604061968;24884.04418028849;24906.377340566632;25177 05:56:29 INFO - PROCESS | 716 | |2;jquery.html;359.98920032399036;362.3929917388374;362.52871267352435;362.75876542099496;363.9217568222832;13221.272829994346;13439.462421503153;16229.350825966962;16673.583160420996;17653.38213162541;14811.629709257273;16130.596735081628;16523.33906643733;16524.75212871808;16898.155092245368;5363.812266570661;5532.806351777688;5540.50135487806;5541.473560011793;5541.612087153901;4004.279229738646;4146.025683964266;5396.5952553558445;5467.753951072212;5895.764169433218;5929.229200203968;6070.6357618543025;6111.388861113897;6123.479504242145;6126.142340072393;5880.823575292727;5986.461218490357;5989.55078369124;5990.670513121777;5991.011483105282;5051.469595692436;5215.426303106655;5219.530242278175;5274.367075950872;5294.68231906083;12841.35793210345;12994.610161695164;13835.654108647264;20024.59950800976;20167.991600420068;2161.718976533041;2221.48905751678;2221.8111460525874;2235.8770267635273;2263.0608297556496;9831.31180817336;9856.65501707444;10802.243842930999;10855.348679079281;13209.537666181734;1766.1610734900949;1804.0799192411832;1846.8614853886013;1867.3464287499403;1874.062968515742;54344.456555434335;56742.148867766606;57849;58532.70733646347;58943.70528147332;9947.452890091114;10126.949365253127;10142.340747851365;10152.766391393881;10202.897971020344;13224.73550528984;13315.866841331657;13385.531506397228;13431.932840335736;13439.596812095653;7367.5211111277595;7417.406607471389;7428.888566671504;7488.9625551871895;7498.775036748906;7113.64431778409;7138.9286107139305;7203.243659415791;7211.242819503981;7216.530925489827;4392.890177745582;4427.203103441347;4429.933550996673;4434.979954610458;4506.076254367847;1730.6365663210615;1789.2753434858903;1804.2061492943062;1811.1759149586906;1820.4811628686025;891.4250308551078;938.6996161228342;983.3362480325751;1005.7636455432968;1027.2655051638114;13547.59357219285;15112;15801.683966320608;15905;16765.664686706197;939.1125386509683;970.5147426286857;980.7155924781733;983.6213057972732;984.7341217871135;9322.487263200454;9910.702678919644;9988.300818942604;9997.700068997941;9998.152743176377;368131;373010;589764;589874;590633;70783;71589;72770;73762.26237737553;75870;1087.3530249501534;1099.4777480696605;1112.5660992212881;1166.4634268236537;1167.445463404893;14752;15066;15121.621959451102;15191.392344306547;15197.848021519643;33760;33781.49327760036;33849;34295.31409371849;34533.13667158341;43043.78478107715;43174;43212.567874322114;43801.12397751964;44237.33643995407;6938.548994315353;7222.530535515385;7248.238934911758;7255.673494692646;7445.702171913063;9029.77425564366;10226.590936362461;10592.841107383549;10823.56705731762;11126.276792008493;8916.910830891607;9226.077392260988;9226.400283981788;9320.254379649747;9417;9172.403793753385;9488.525573721425;9625.614975400906;9796.9020309796;10227;9060.139286767746;9357.625694972125;9411.341206115507;9459.668911588062;9470.57382417779;7391.6304184791625;7619.390448764197;7636.08366995964;7670.8849367260655;7680.116786569392;8717.65129394817;9448.338616296793;9587.664431744855;9665.178459830993;9715.125638692552 05:56:29 INFO - PROCESS | 716 | |3;mootools.html;1307.8822905938464;1429.892758043147;1438.7050654615805;1611.927463264153;1820.9620516305704;6946.583205007703;7565.697372105116;7677.462577619569;7685.193054729257;7694.923050769491;7525.096988361404;7735.72924947627;7745.109312429072;7753.922460775405;7758.49569777964;2011.668074767669;2037.5415531505441;2045.31481953545;2287.1651847075823;2310.0875154314035;2322.907083716649;2362.6574146748712;2363.7872591466767;2367.6566897799894;2369.2655276864143;2259.8418110732255;2296.494771150353;2296.609576372021;2297.0467256088787;2297.264875239924;2286.977130228693;2304.665823455598;2309.041747674713;2315.69895913531;2317.501737126509;2301.838871279011;2305.262316058862;2312.410335364488;2313.4332088638225;2314.2825724025606;7719.536827790294;7752.728654497066;7757.146713861471;7760.379169666413;7763.378929685611;4726.149293127236;4830.879228019293;4838.080764654705;4841.104395686809;4863.732494712789;3187.139472342478;3195.888143914975;3215.26049008727;3233.7711669565415;3277.19708671377;1005.4319309590059;1008.9293749437543;1010.7372083258332;1040.1107053469327;1051.0435503691604;10911.181661375429;10915.836262456069;10927.398993055378;10957.616483423042;10965.890341096567;4268.125034367947;4347.891302717458;4411.250087485135;4413.337999300131;4420.734755914591;9456.33805633599;9464.574094165779;9466.337356385126;9475.336726429085;9480.857787133198;4835.202191638411;4838.080764654775;4867.659263851568;4870.95129048705;4872.634552408584;4382.780860956939;4394.912101758011;4434.689571730012;4437.866863994085;4442.444694413199;3387.3902697514686;3445.6037555680914;3645.3802853514435;3692.4276737105793;3705.184859330997;1149.1840793037038;1189.1378750405886;1197.5389475052168;1200.4177973682756;1212.9332886691316;1324.2253281830237;1345.6030471011074;1348.5886804524519;1364.6179069860455;1366.1666383506054;7275.199728029913;7429.591372474566;7436;7441.851162976818;7447.44144189188;1073.2004656530778;1080.5461706083463;1086.1202426034938;1091.9344839309667;1111.2110401614782;5730.656160630376;5822.417758224144;5831.037878750044;5832.212651292106;5837.824865253964;9513.571889265;9554.808903821884;9670.323077384515;9826.213902887752;9840.901590984142;9488.478133702713;9599.952000239955;9627.374220675634;9640.75898102539;9645.614175433044;7416.295451932057;7484.700611975569;7594.886076708854;7661.578613176217;7670.501417407851;7271.054762880792;7301.4158867289425;7305.452091093295;7306.671199796128;7322.743703970335;8021.598920054091;8114.350851931949;8234.053083895189;8240;8388.161183881562;8246.134155913782;8250.752477425687;8369.414141010071;8389.790255243668;8395.832083358177;6773.593584384756;6943.409810166192;6946.2011868635755;6960.79117626472;6963;6804.183497980076;6925.238223795479;7278.163011253562;7512.173660897188;7516.774496765106;6875.0718652983205;6978.860422791618;7000.824979375557;7054.753083642253;7094.255103214295;6827.453803695593;6830.59016459014;6897.068895699217;6908.758193463204;6969.8257543559785;7009;7052.118485189351;7054.082969214174;7056.188538318159;7056.364927156581;6374.872502550016;6489.675516224264;6512.967435162794;6532.510061745483;6549.050387693853;6290;6402.263739669997;6411.134496842867;6417.71120299597;6427.260865000585 05:56:29 INFO - PROCESS | 716 | |4;prototype.html;340.456971131046;348.3816226198498;348.55559162068374;348.5851836314785;350.58980992239077;5708.828735137942;5803.100519419486;5840.386759390261;5910.2612173478365;5927.081302398135;5673.205751194836;5807.941920580793;5832.56255780816;5832.6792026438525;5850.327212370578;4563.612092972101;4575.26795712686;4575.725456472605;4579.793909274074;4583.862484125481;4374.868753937387;4474.485434175062;4516.525764794698;4538.273876179812;4572.948221908963;4503.211937910869;4507.504174540798;4509.301058335963;4524.864254072383;4545.977270113644;4519.683622146451;4521.389612402317;4526.615237704799;4546.47715512717;4555.954440455586;4036.7577945323374;4040;4044.797760111983;4045;4057.5536690963972;5434.103372943459;5608.775648974036;5614.438556144394;5623.606347555673;5625.80309689163;5244.763985620656;5253.290805741214;5254.395744489356;5256.1852912798195;5263.34208223972;5901.881962360729;6220.066989951498;6244;6246.781362652286;6248.750049997994;4233.661307095425;4271.8718438446895;4350.086481838817;4392.802323895432;4397.384366188736;6392.137061496732;6436.131122298477;6440.645764482952;6465;6466.902996455057;4434.312681534368;4446.799894004713;4448.310511870665;4455.376247325377;4469.910601787946;4433.091216300651;4473.932891006638;4503.41455610775;4514.32285157229;4527.683062185615;5195.090859099642;5204.5576126028955;5207.010667973073;5208.906129712803;5209.4009188943755;6234.2830574483605;6235.282942461584;6240.5319601030105;6288.685565721696;6303.054541818764;1572.6147093962052;1604.638956234838;1604.9438269660507;1605.1733357320988;1606.9919650401673;1070.8286674132257;1079.3146352066337;1080.7028067281403;1095.884932082136;1103.6137351926761;5855.092460668603;5888.852778680482;5902.232709747791;5907.2911250650195;5924.881502369928;6404.615723056631;6406.583572067801;6412.454941330039;6413.29453760086;6413.807585772434;5838.591298609142;5877.353491115974;5891.440313170242;5902.704864756745;5907.822765317047;3345.180430794471;3437.656234376542;3440.673136052071;3442.277121804399;3443.9311213775586;6593.901091483632;6659.600423974577;6704.061431399608;6707.128073350531;6713.4964877634375;6577.6053436793945;6585.308542603054;6590.373914478117;6590.637514936724;6592.934070659232;6521.836954076186;6642.003699445026;6690.29751876046;6694.330566943267;6697.966510167418;6126.23422072241;6282.120503129474;6398.168238129014;6439.581427207217;6448.484121270381;6167;6334.746610135543;6371.076193951758;6377.17096777416;6415.262244841903;6700.564463309869;6705.497087718538;6706.396424321834;6709.597424154566;6720.630365329758;4429.867103986886;4466.5086840446875;4485.125400546862;4517.073999830092;4530.478994915627;6436.259830119409;6437.742490300336;6448.645324507197;6454.935450645621;6455.354464553507;6259.217597800275;6266.154069200599;6267.655278959701;6276.184096067482;6279.058141278662;6104.938950610437;6203.65879876593;6219.906701399573;6227.532935029982;6297.748090076529;6162.476189523762;6173.783917562864;6174.197354343906;6178.320384757763;6184.845378865564;6309.842253943688;6316.494680425647;6316.873662526816;6316.936830631635;6322.272938612118;6048.183495228088;6167;6168.444839964424;6171.074338849208;6182.474489668429 05:56:29 INFO - PROCESS | 716 | |5;yui.html;782.9344143392252;795.7016118955391;842.3976856547567;852.1521086518912;870.9651613935442;13308.201507909533;13518.797218041713;13544.187348759082;13545.322733863317;13557.864421355784;12869.871301286985;12920.935395323011;12943.352832358392;12959.870401295984;12965.416556254968;815.3925325632412;824.3487644760631;831.9584020798966;832.5837081459271;833.9332853371716;680.918289805224;690.76513985245;827.5655280977505;828.7845160258316;829.3613917283687;851.5061264466594;857.5626430520417;863.4646519158131;864.567716141929;865.0786911938796;856.5845564901018;857.8756080368374;858.3262139220744;859.4585411190941;867.8784970104191;522.1202274168039;530.4774796825125;624.9656268905209;634.1312402009231;637.1366797988751;13321.533746318832;13347.933260333733;13357.599272021855;13376.264305463195;13404.86595134046;11749.94125029378;12083.74203648108;12087;12124.333161676104;12408.255504669658;9990.250731195118;10057.89942100577;10149.847752283722;10327.58689652413;10488.160947124212;3514.7715398499017;3596.478510615946;3607.4408466687705;3609.693176080036;3615.6565126312958;49749.999999999636;50038;50364.74817625889;50368.24447633288;50421.49578504205;8936.32977526688;9101.362904596615;9742.46416447088;9829.705108846745;9835.901640983499;17436.564085897953;17648.823511764975;17682.292708291523;17704.114794260237;17711.645767084585;7245.9275407246305;7342.853142937218;7345.816354591071;7407.740729074564;7452.664630091659;4323.589259020388;4362.847300344472;4373.693841431133;4390.758508282075;4464.1071785643;2931.8240905545736;3014.201236672284;3018.5773991641186;3020.879164833426;3022.032949456197;570.520762559452;574.3968832725621;577.206341280739;625.8842114208886;637.2735082006516;556.7800718716165;560.2996254681648;587.415521556046;689.9241083480813;720.3881761081224;8164.918350816534;8213;8487.193716597038;8526.31789456842;8854.24738897201;498.7905079866465;630.6878095342743;684.1516519515765;699;723.4827098624509;3639.1448009717697;3777.2823163598828;3957.2876882161486;3967.6429121378637;4006.09862780872;53536.46463535393;57050;57119.42880571141;57400;58476;49440.752796235785;49832.252516212284;50985.49014509882;51517.96964060773;51943.480565193866;45805.08389832251;46154;46256.768716156876;47192.820179495786;47364.763176184584;8560.743177704679;8728.258098061737;8861.379703420957;9170.724878253663;9421.434713917188;31352;31524.684753152174;31625.20936976594;31733.841330794123;31986;43612.34581481344;43704.56295437132;44154.337684935395;44395.77802110969;45244.77377613223;10820.67537973862;11169.609063683058;11297.096232301561;11416;11755.471003804678;12582.18215815969;12755.426005829946;12824.871751282368;12989.155704879153;13021.283829389096;11571.363575003119;11832.585859494877;11981.880181198425;12227.755444890874;12288.815667764811;11730.354830484406;12136.150469467053;12211.87788122143;12242.877571224173;12482.812757808459;7227.517692410915;11220.943895280798;11725.941370293094;11812.055035596959;12096.032317414762;9182.494962777111;9542.379745316532;10004.349717268355;10160.199004975124;10433.686989390331;8250;8820.514871681862;8991.730248092568;9398.95300523493;9712.75718107053 05:56:29 INFO - PROCESS | 716 | __end_tp_report 05:56:29 INFO - PROCESS | 716 | __start_cc_report 05:56:29 INFO - PROCESS | 716 | _x_x_mozilla_cycle_collect,945 05:56:29 INFO - PROCESS | 716 | __end_cc_report 05:56:29 INFO - PROCESS | 716 | __startTimestamp1452866189130__endTimestamp 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | ------- Summary: start ------- 05:56:29 INFO - PROCESS | 716 | Number of tests: 6 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | [#0] dojo.html Cycles:165 Average:5069.71 Median:5290.79 stddev:553.11 (10.5%) stddev-sans-first:531.89 05:56:29 INFO - PROCESS | 716 | Values: 3061.0 3064.3 3109.5 3114.1 3130.4 4898.9 4949.5 5034.4 5049.8 5088.8 4975.8 5029.4 5055.2 5057.8 5080.5 4413.4 4548.8 4576.3 4593.1 4654.2 4557.4 4602.5 4638.5 4646.6 4743.9 4538.0 4561.1 4563.3 4614.9 4617.4 4659.3 4671.9 4680.5 4684.6 4688.8 4549.7 4657.0 4658.7 4674.2 4678.6 4866.7 4895.7 5014.3 5044.1 5050.3 5442.5 5452.5 5458.0 5463.0 5476.8 5458.9 5460.5 5460.5 5461.8 5471.9 5003.8 5074.2 5142.6 5171.1 5218.5 5548.7 5571.6 5579.7 5580.3 5585.4 5303.7 5374.8 5380.1 5396.4 5401.6 5348.0 5380.6 5398.7 5401.9 5442.0 5445.0 5455.5 5462.8 5463.9 5486.8 5290.7 5371.1 5437.7 5488.2 5516.9 4226.7 4273.3 4273.9 4283.6 4291.4 3841.3 3858.9 3865.8 3869.7 3885.4 4899.6 4906.2 5091.5 5134.0 5178.4 5488.0 5501.1 5522.1 5529.4 5562.7 5058.8 5141.0 5141.3 5144.6 5190.7 4568.1 4615.4 4680.7 4683.5 4703.0 5692.9 5693.9 5705.1 5711.5 5715.3 5517.1 5527.5 5530.7 5533.1 5536.0 5439.2 5592.4 5594.0 5598.2 5689.2 5372.7 5433.6 5465.4 5479.9 5490.5 5431.5 5449.4 5471.7 5479.0 5486.1 5173.2 5347.0 5367.6 5370.1 5411.8 5246.5 5290.8 5300.9 5330.8 5332.1 5293.8 5324.1 5324.1 5331.1 5371.3 5293.2 5327.2 5407.8 5424.9 5439.4 5234.9 5248.5 5282.3 5285.2 5326.4 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | [#1] ext.html Cycles:180 Average:44714.39 Median:19212.39 stddev:73261.23 (381.3%) stddev-sans-first:73391.71 05:56:29 INFO - PROCESS | 716 | Values: 554.5 570.9 586.2 587.0 594.9 28292.6 35770.5 36431.8 36449.8 36511.6 40237.8 40832.0 40900.6 41049.0 41049.4 8488.4 8675.0 8683.1 8687.3 8689.3 8425.5 8573.2 8576.0 8577.5 8774.4 8757.2 8845.6 8847.2 8847.4 8847.6 8654.4 8786.3 8793.7 8823.2 8823.8 8660.2 8784.1 8794.3 8802.3 8806.6 39393.6 40297.6 40303.8 40355.6 40373.4 3368.3 3368.5 3375.6 3379.4 3439.5 29660.1 30270.4 30402.2 30419.0 30899.7 4018.3 4036.0 4086.6 4122.4 4146.0 259898.0 260987.0 261005.0 261467.0 261528.0 51400.5 52412.7 58468.4 58720.1 58806.0 63749.4 64907.4 65286.3 65369.7 65427.3 14382.7 14553.7 14612.0 14640.2 14658.4 10584.4 10873.4 10934.1 10995.7 11117.4 19324.7 19433.7 19483.9 19491.9 19591.3 7119.3 7466.8 7480.9 7486.7 7502.2 962.2 972.2 1051.5 1069.6 1110.4 28282.4 29565.9 29626.9 29970.9 30185.2 1041.4 1112.2 1137.7 1145.6 1181.1 14330.5 14624.5 14776.5 14985.3 15035.3 321659.0 324828.0 325843.0 326026.0 326080.0 52254.0 53239.2 53267.5 53281.7 53305.5 1340.8 1346.4 1346.5 1359.9 1372.5 27616.0 28066.6 28758.4 28862.6 28947.0 42089.2 42100.4 42244.0 46962.5 47060.8 248015.0 249138.0 249234.0 249715.0 249834.0 28519.1 32430.4 32574.5 32747.0 33167.8 39641.6 41261.0 41577.0 41611.6 42219.8 35293.3 35313.5 35358.3 35579.8 35859.6 28621.0 33872.7 34985.3 35617.6 36385.3 32672.3 33219.8 33521.0 33548.3 33614.0 28470.0 29704.7 30029.8 30179.2 30232.8 24317.6 24791.9 24884.0 24906.4 25177.0 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | [#2] jquery.html Cycles:180 Average:26424.49 Median:5246.95 stddev:84062.92 (1602.1%) stddev-sans-first:84275.95 05:56:29 INFO - PROCESS | 716 | Values: 360.0 362.4 362.5 362.8 363.9 13221.3 13439.5 16229.4 16673.6 17653.4 14811.6 16130.6 16523.3 16524.8 16898.2 5363.8 5532.8 5540.5 5541.5 5541.6 4004.3 4146.0 5396.6 5467.8 5895.8 5929.2 6070.6 6111.4 6123.5 6126.1 5880.8 5986.5 5989.6 5990.7 5991.0 5051.5 5215.4 5219.5 5274.4 5294.7 12841.4 12994.6 13835.7 20024.6 20168.0 2161.7 2221.5 2221.8 2235.9 2263.1 9831.3 9856.7 10802.2 10855.3 13209.5 1766.2 1804.1 1846.9 1867.3 1874.1 54344.5 56742.1 57849.0 58532.7 58943.7 9947.5 10126.9 10142.3 10152.8 10202.9 13224.7 13315.9 13385.5 13431.9 13439.6 7367.5 7417.4 7428.9 7489.0 7498.8 7113.6 7138.9 7203.2 7211.2 7216.5 4392.9 4427.2 4429.9 4435.0 4506.1 1730.6 1789.3 1804.2 1811.2 1820.5 891.4 938.7 983.3 1005.8 1027.3 13547.6 15112.0 15801.7 15905.0 16765.7 939.1 970.5 980.7 983.6 984.7 9322.5 9910.7 9988.3 9997.7 9998.2 368131.0 373010.0 589764.0 589874.0 590633.0 70783.0 71589.0 72770.0 73762.3 75870.0 1087.4 1099.5 1112.6 1166.5 1167.4 14752.0 15066.0 15121.6 15191.4 15197.8 33760.0 33781.5 33849.0 34295.3 34533.1 43043.8 43174.0 43212.6 43801.1 44237.3 6938.5 7222.5 7248.2 7255.7 7445.7 9029.8 10226.6 10592.8 10823.6 11126.3 8916.9 9226.1 9226.4 9320.3 9417.0 9172.4 9488.5 9625.6 9796.9 10227.0 9060.1 9357.6 9411.3 9459.7 9470.6 7391.6 7619.4 7636.1 7670.9 7680.1 8717.7 9448.3 9587.7 9665.2 9715.1 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | [#3] mootools.html Cycles:180 Average:5501.30 Median:6332.44 stddev:2840.78 (44.9%) stddev-sans-first:2831.26 05:56:29 INFO - PROCESS | 716 | Values: 1307.9 1429.9 1438.7 1611.9 1821.0 6946.6 7565.7 7677.5 7685.2 7694.9 7525.1 7735.7 7745.1 7753.9 7758.5 2011.7 2037.5 2045.3 2287.2 2310.1 2322.9 2362.7 2363.8 2367.7 2369.3 2259.8 2296.5 2296.6 2297.0 2297.3 2287.0 2304.7 2309.0 2315.7 2317.5 2301.8 2305.3 2312.4 2313.4 2314.3 7719.5 7752.7 7757.1 7760.4 7763.4 4726.1 4830.9 4838.1 4841.1 4863.7 3187.1 3195.9 3215.3 3233.8 3277.2 1005.4 1008.9 1010.7 1040.1 1051.0 10911.2 10915.8 10927.4 10957.6 10965.9 4268.1 4347.9 4411.3 4413.3 4420.7 9456.3 9464.6 9466.3 9475.3 9480.9 4835.2 4838.1 4867.7 4871.0 4872.6 4382.8 4394.9 4434.7 4437.9 4442.4 3387.4 3445.6 3645.4 3692.4 3705.2 1149.2 1189.1 1197.5 1200.4 1212.9 1324.2 1345.6 1348.6 1364.6 1366.2 7275.2 7429.6 7436.0 7441.9 7447.4 1073.2 1080.5 1086.1 1091.9 1111.2 5730.7 5822.4 5831.0 5832.2 5837.8 9513.6 9554.8 9670.3 9826.2 9840.9 9488.5 9600.0 9627.4 9640.8 9645.6 7416.3 7484.7 7594.9 7661.6 7670.5 7271.1 7301.4 7305.5 7306.7 7322.7 8021.6 8114.4 8234.1 8240.0 8388.2 8246.1 8250.8 8369.4 8389.8 8395.8 6773.6 6943.4 6946.2 6960.8 6963.0 6804.2 6925.2 7278.2 7512.2 7516.8 6875.1 6978.9 7000.8 7054.8 7094.3 6827.5 6830.6 6897.1 6908.8 6969.8 7009.0 7052.1 7054.1 7056.2 7056.4 6374.9 6489.7 6513.0 6532.5 6549.1 6290.0 6402.3 6411.1 6417.7 6427.3 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | [#4] prototype.html Cycles:180 Average:5221.59 Median:5883.10 stddev:1558.41 (26.5%) stddev-sans-first:1519.11 05:56:29 INFO - PROCESS | 716 | Values: 340.5 348.4 348.6 348.6 350.6 5708.8 5803.1 5840.4 5910.3 5927.1 5673.2 5807.9 5832.6 5832.7 5850.3 4563.6 4575.3 4575.7 4579.8 4583.9 4374.9 4474.5 4516.5 4538.3 4572.9 4503.2 4507.5 4509.3 4524.9 4546.0 4519.7 4521.4 4526.6 4546.5 4556.0 4036.8 4040.0 4044.8 4045.0 4057.6 5434.1 5608.8 5614.4 5623.6 5625.8 5244.8 5253.3 5254.4 5256.2 5263.3 5901.9 6220.1 6244.0 6246.8 6248.8 4233.7 4271.9 4350.1 4392.8 4397.4 6392.1 6436.1 6440.6 6465.0 6466.9 4434.3 4446.8 4448.3 4455.4 4469.9 4433.1 4473.9 4503.4 4514.3 4527.7 5195.1 5204.6 5207.0 5208.9 5209.4 6234.3 6235.3 6240.5 6288.7 6303.1 1572.6 1604.6 1604.9 1605.2 1607.0 1070.8 1079.3 1080.7 1095.9 1103.6 5855.1 5888.9 5902.2 5907.3 5924.9 6404.6 6406.6 6412.5 6413.3 6413.8 5838.6 5877.4 5891.4 5902.7 5907.8 3345.2 3437.7 3440.7 3442.3 3443.9 6593.9 6659.6 6704.1 6707.1 6713.5 6577.6 6585.3 6590.4 6590.6 6592.9 6521.8 6642.0 6690.3 6694.3 6698.0 6126.2 6282.1 6398.2 6439.6 6448.5 6167.0 6334.7 6371.1 6377.2 6415.3 6700.6 6705.5 6706.4 6709.6 6720.6 4429.9 4466.5 4485.1 4517.1 4530.5 6436.3 6437.7 6448.6 6454.9 6455.4 6259.2 6266.2 6267.7 6276.2 6279.1 6104.9 6203.7 6219.9 6227.5 6297.7 6162.5 6173.8 6174.2 6178.3 6184.8 6309.8 6316.5 6316.9 6316.9 6322.3 6048.2 6167.0 6168.4 6171.1 6182.5 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - PROCESS | 716 | [#5] yui.html Cycles:180 Average:13707.40 Median:48402.76 stddev:15860.12 (32.8%) stddev-sans-first:15874.92 05:56:29 INFO - PROCESS | 716 | Values: 782.9 795.7 842.4 852.2 871.0 13308.2 13518.8 13544.2 13545.3 13557.9 12869.9 12920.9 12943.4 12959.9 12965.4 815.4 824.3 832.0 832.6 833.9 680.9 690.8 827.6 828.8 829.4 851.5 857.6 863.5 864.6 865.1 856.6 857.9 858.3 859.5 867.9 522.1 530.5 625.0 634.1 637.1 13321.5 13347.9 13357.6 13376.3 13404.9 11749.9 12083.7 12087.0 12124.3 12408.3 9990.3 10057.9 10149.8 10327.6 10488.2 3514.8 3596.5 3607.4 3609.7 3615.7 49750.0 50038.0 50364.7 50368.2 50421.5 8936.3 9101.4 9742.5 9829.7 9835.9 17436.6 17648.8 17682.3 17704.1 17711.6 7245.9 7342.9 7345.8 7407.7 7452.7 4323.6 4362.8 4373.7 4390.8 4464.1 2931.8 3014.2 3018.6 3020.9 3022.0 570.5 574.4 577.2 625.9 637.3 556.8 560.3 587.4 689.9 720.4 8164.9 8213.0 8487.2 8526.3 8854.2 498.8 630.7 684.2 699.0 723.5 3639.1 3777.3 3957.3 3967.6 4006.1 53536.5 57050.0 57119.4 57400.0 58476.0 49440.8 49832.3 50985.5 51518.0 51943.5 45805.1 46154.0 46256.8 47192.8 47364.8 8560.7 8728.3 8861.4 9170.7 9421.4 31352.0 31524.7 31625.2 31733.8 31986.0 43612.3 43704.6 44154.3 44395.8 45244.8 10820.7 11169.6 11297.1 11416.0 11755.5 12582.2 12755.4 12824.9 12989.2 13021.3 11571.4 11832.6 11981.9 12227.8 12288.8 11730.4 12136.2 12211.9 12242.9 12482.8 7227.5 11220.9 11725.9 11812.1 12096.0 9182.5 9542.4 10004.3 10160.2 10433.7 8250.0 8820.5 8991.7 9399.0 9712.8 05:56:29 INFO - PROCESS | 716 | -------- Summary: end -------- 05:56:29 INFO - PROCESS | 716 | 05:56:29 INFO - TEST-INFO | 716: exit 0 05:56:29 INFO - TEST-OK | dromaeo_css | took 1113020ms 05:56:29 INFO - TEST-START | kraken 05:56:29 INFO - operating with platform_type : linux_ 05:56:29 INFO - Initialising browser for kraken test... 05:56:29 INFO - TEST-INFO | started process 917 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC4rCQ8/profile http://localhost:35181/getInfo.html) 05:56:34 INFO - PROCESS | 917 | __metrics Screen width/height:1600/1200 05:56:34 INFO - PROCESS | 917 | colorDepth:24 05:56:34 INFO - PROCESS | 917 | Browser inner width/height: 1024/697 05:56:34 INFO - PROCESS | 917 | __metrics 05:56:34 INFO - PROCESS | 917 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:56:34 INFO - PROCESS | 917 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:35 INFO - TEST-INFO | 917: exit 0 05:56:35 INFO - Browser initialized. 05:56:35 INFO - Running cycle 1/1 for kraken test... 05:56:35 INFO - TEST-INFO | started process 1002 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC4rCQ8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:47 INFO - PROCESS | 1002 | RSS: Main: 150519808 05:56:47 INFO - PROCESS | 1002 | 05:56:49 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35181/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:50 INFO - PROCESS | 1002 | RSS: Main: 186658816 05:56:50 INFO - PROCESS | 1002 | 05:56:52 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35181/tests/kraken/driver.html?testName=audio-dft) 05:56:53 INFO - PROCESS | 1002 | RSS: Main: 177139712 05:56:53 INFO - PROCESS | 1002 | 05:56:56 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35181/tests/kraken/driver.html?testName=audio-fft) 05:56:56 INFO - PROCESS | 1002 | RSS: Main: 162242560 05:56:56 INFO - PROCESS | 1002 | 05:56:58 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35181/tests/kraken/driver.html?testName=audio-oscillator) 05:56:59 INFO - PROCESS | 1002 | RSS: Main: 163729408 05:56:59 INFO - PROCESS | 1002 | 05:57:01 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:02 INFO - PROCESS | 1002 | RSS: Main: 165793792 05:57:02 INFO - PROCESS | 1002 | 05:57:05 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35181/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:05 INFO - PROCESS | 1002 | RSS: Main: 165789696 05:57:05 INFO - PROCESS | 1002 | 05:57:09 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35181/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:09 INFO - PROCESS | 1002 | RSS: Main: 167292928 05:57:09 INFO - PROCESS | 1002 | 05:57:12 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35181/tests/kraken/driver.html?testName=json-parse-financial) 05:57:12 INFO - PROCESS | 1002 | RSS: Main: 166617088 05:57:12 INFO - PROCESS | 1002 | 05:57:14 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:15 INFO - PROCESS | 1002 | RSS: Main: 176181248 05:57:15 INFO - PROCESS | 1002 | 05:57:16 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:17 INFO - PROCESS | 1002 | RSS: Main: 175042560 05:57:17 INFO - PROCESS | 1002 | 05:57:19 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:20 INFO - PROCESS | 1002 | RSS: Main: 184168448 05:57:20 INFO - PROCESS | 1002 | 05:57:22 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:23 INFO - PROCESS | 1002 | RSS: Main: 189554688 05:57:23 INFO - PROCESS | 1002 | 05:57:25 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:26 INFO - PROCESS | 1002 | RSS: Main: 189530112 05:57:26 INFO - PROCESS | 1002 | 05:57:27 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:35181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35181/tests/kraken/driver.html?testName=ai-astar) 05:57:28 INFO - PROCESS | 1002 | RSS: Main: 246525952 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | __start_tp_report 05:57:28 INFO - PROCESS | 1002 | _x_x_mozilla_page_load 05:57:28 INFO - PROCESS | 1002 | _x_x_mozilla_page_load_details 05:57:28 INFO - PROCESS | 1002 | |i|pagename|runs| 05:57:28 INFO - PROCESS | 1002 | |0;ai-astar;111;113;106;111;111;111;101;109;110;111 05:57:28 INFO - PROCESS | 1002 | |1;audio-beat-detection;153;128;157;167;128;147;157;128;165;132 05:57:28 INFO - PROCESS | 1002 | |2;audio-dft;164;161;161;162;163;163;160;163;163;162 05:57:28 INFO - PROCESS | 1002 | |3;audio-fft;72;73;129;90;74;72;71;105;111;70 05:57:28 INFO - PROCESS | 1002 | |4;audio-oscillator;95;95;147;95;96;95;144;96;95;132 05:57:28 INFO - PROCESS | 1002 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;109;110 05:57:28 INFO - PROCESS | 1002 | |6;imaging-darkroom;146;145;146;145;145;145;146;145;145;145 05:57:28 INFO - PROCESS | 1002 | |7;imaging-desaturate;95;96;96;96;97;97;96;95;96;95 05:57:28 INFO - PROCESS | 1002 | |8;json-parse-financial;58;58;56;56;55;57;58;70;52;54 05:57:28 INFO - PROCESS | 1002 | |9;json-stringify-tinderbox;66;67;66;66;68;68;66;67;66;67 05:57:28 INFO - PROCESS | 1002 | |10;stanford-crypto-aes;81;83;83;84;90;82;84;82;91;90 05:57:28 INFO - PROCESS | 1002 | |11;stanford-crypto-ccm;119;114;125;120;121;118;113;117;119;117 05:57:28 INFO - PROCESS | 1002 | |12;stanford-crypto-pbkdf2;145;139;135;146;142;131;141;141;143;144 05:57:28 INFO - PROCESS | 1002 | |13;stanford-crypto-sha256-iterative;69;67;68;67;66;66;67;67;66;67 05:57:28 INFO - PROCESS | 1002 | __end_tp_report 05:57:28 INFO - PROCESS | 1002 | __start_cc_report 05:57:28 INFO - PROCESS | 1002 | _x_x_mozilla_cycle_collect,973 05:57:28 INFO - PROCESS | 1002 | __end_cc_report 05:57:28 INFO - PROCESS | 1002 | __startTimestamp1452866248171__endTimestamp 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | ------- Summary: start ------- 05:57:28 INFO - PROCESS | 1002 | Number of tests: 14 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:3.63 05:57:28 INFO - PROCESS | 1002 | Values: 111.0 113.0 106.0 111.0 111.0 111.0 101.0 109.0 110.0 111.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.00 stddev:15.85 (10.2%) stddev-sans-first:16.62 05:57:28 INFO - PROCESS | 1002 | Values: 153.0 128.0 157.0 167.0 128.0 147.0 157.0 128.0 165.0 132.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.23 (0.8%) stddev-sans-first:1.12 05:57:28 INFO - PROCESS | 1002 | Values: 164.0 161.0 161.0 162.0 163.0 163.0 160.0 163.0 163.0 162.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#3] audio-fft Cycles:10 Average:86.70 Median:72.00 stddev:21.17 (29.4%) stddev-sans-first:21.77 05:57:28 INFO - PROCESS | 1002 | Values: 72.0 73.0 129.0 90.0 74.0 72.0 71.0 105.0 111.0 70.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.40 (23.6%) stddev-sans-first:23.18 05:57:28 INFO - PROCESS | 1002 | Values: 95.0 95.0 147.0 95.0 96.0 95.0 144.0 96.0 95.0 132.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:57:28 INFO - PROCESS | 1002 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 05:57:28 INFO - PROCESS | 1002 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 05:57:28 INFO - PROCESS | 1002 | Values: 95.0 96.0 96.0 96.0 97.0 97.0 96.0 95.0 96.0 95.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:4.84 (8.4%) stddev-sans-first:5.12 05:57:28 INFO - PROCESS | 1002 | Values: 58.0 58.0 56.0 56.0 55.0 57.0 58.0 70.0 52.0 54.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 05:57:28 INFO - PROCESS | 1002 | Values: 66.0 67.0 66.0 66.0 68.0 68.0 66.0 67.0 66.0 67.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.80 (4.5%) stddev-sans-first:3.75 05:57:28 INFO - PROCESS | 1002 | Values: 81.0 83.0 83.0 84.0 90.0 82.0 84.0 82.0 91.0 90.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:119.00 stddev:3.43 (2.9%) stddev-sans-first:3.63 05:57:28 INFO - PROCESS | 1002 | Values: 119.0 114.0 125.0 120.0 121.0 118.0 113.0 117.0 119.0 117.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:142.50 stddev:4.64 (3.3%) stddev-sans-first:4.66 05:57:28 INFO - PROCESS | 1002 | Values: 145.0 139.0 135.0 146.0 142.0 131.0 141.0 141.0 143.0 144.0 05:57:28 INFO - PROCESS | 1002 | 05:57:28 INFO - PROCESS | 1002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:0.67 05:57:28 INFO - PROCESS | 1002 | Values: 69.0 67.0 68.0 67.0 66.0 66.0 67.0 67.0 66.0 67.0 05:57:28 INFO - PROCESS | 1002 | -------- Summary: end -------- 05:57:28 INFO - PROCESS | 1002 | 05:57:29 INFO - TEST-INFO | 1002: exit 0 05:57:29 INFO - TEST-OK | kraken | took 59218ms 05:57:29 INFO - TEST-START | v8_7 05:57:29 INFO - operating with platform_type : linux_ 05:57:29 INFO - Initialising browser for v8_7 test... 05:57:29 INFO - TEST-INFO | started process 1334 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXbd1Ic/profile http://localhost:35181/getInfo.html) 05:57:33 INFO - PROCESS | 1334 | __metrics Screen width/height:1600/1200 05:57:33 INFO - PROCESS | 1334 | colorDepth:24 05:57:33 INFO - PROCESS | 1334 | Browser inner width/height: 1024/697 05:57:33 INFO - PROCESS | 1334 | __metrics 05:57:33 INFO - PROCESS | 1334 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:57:33 INFO - PROCESS | 1334 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:34 INFO - TEST-INFO | 1334: exit 0 05:57:34 INFO - Browser initialized. 05:57:34 INFO - Running cycle 1/1 for v8_7 test... 05:57:34 INFO - TEST-INFO | started process 1421 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXbd1Ic/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:46 INFO - PROCESS | 1421 | RSS: Main: 149999616 05:57:46 INFO - PROCESS | 1421 | 05:58:08 INFO - PROCESS | 1421 | Cycle 1(1): loaded http://localhost:35181/tests/v8_7/run.html (next: http://localhost:35181/tests/v8_7/run.html) 05:58:09 INFO - PROCESS | 1421 | RSS: Main: 550858752 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | __start_tp_report 05:58:09 INFO - PROCESS | 1421 | _x_x_mozilla_page_load 05:58:09 INFO - PROCESS | 1421 | _x_x_mozilla_page_load_details 05:58:09 INFO - PROCESS | 1421 | |i|pagename|runs| 05:58:09 INFO - PROCESS | 1421 | |0;Richards;166.14055490945339 05:58:09 INFO - PROCESS | 1421 | |1;DeltaBlue;188.78610534264678 05:58:09 INFO - PROCESS | 1421 | |2;Encrypt;280.42624789680315 05:58:09 INFO - PROCESS | 1421 | |3;Decrypt;5251.308900523561 05:58:09 INFO - PROCESS | 1421 | |4;RayTrace;1109.8779134295228 05:58:09 INFO - PROCESS | 1421 | |5;Earley;786.7820613690008 05:58:09 INFO - PROCESS | 1421 | |6;Boyer;12168.674698795181 05:58:09 INFO - PROCESS | 1421 | |7;RegExp;43255.31914893617 05:58:09 INFO - PROCESS | 1421 | |8;Splay;579.1284403669724 05:58:09 INFO - PROCESS | 1421 | |9;NavierStokes;4840.579710144928 05:58:09 INFO - PROCESS | 1421 | __end_tp_report 05:58:09 INFO - PROCESS | 1421 | __startTimestamp1452866289028__endTimestamp 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | ------- Summary: start ------- 05:58:09 INFO - PROCESS | 1421 | Number of tests: 10 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 166.1 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 188.8 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 280.4 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 5251.3 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 1109.9 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 786.8 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 12168.7 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#7] RegExp Cycles:1 Average:43255.32 Median:43255.32 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 43255.3 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#8] Splay Cycles:1 Average:579.13 Median:579.13 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 579.1 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - PROCESS | 1421 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:58:09 INFO - PROCESS | 1421 | Values: 4840.6 05:58:09 INFO - PROCESS | 1421 | -------- Summary: end -------- 05:58:09 INFO - PROCESS | 1421 | 05:58:09 INFO - TEST-INFO | 1421: exit 0 05:58:09 INFO - TEST-OK | v8_7 | took 40798ms 05:58:09 INFO - SUITE-END | took 1213s 05:58:10 INFO - Completed test suite (00:20:13) 05:58:10 INFO - Working with test: dromaeo_css 05:58:10 INFO - Generating results file: dromaeo_css 05:58:10 INFO - Working with test: kraken 05:58:10 INFO - Generating results file: kraken 05:58:10 INFO - javascript benchmark 05:58:10 INFO - Working with test: v8_7 05:58:10 INFO - Generating results file: v8_7 05:58:10 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:58:10 INFO - process_Request line: dromaeo_css 6816.18 graph.html#tests=[[72,201,35]] 05:58:10 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:10 INFO - process_Request line: kraken 1499.00 graph.html#tests=[[232,201,35]] 05:58:10 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:10 INFO - process_Request line: v8_7 20077.00 graph.html#tests=[[230,201,35]] 05:58:10 INFO - RETURN: dromaeo_css: 6816.18 05:58:10 INFO - RETURN: kraken: 1499.00 05:58:10 INFO - RETURN: v8_7: 20077.00 05:58:10 INFO - javascript benchmark 05:58:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3061.005173318672, 3064.279894224857, 3109.5491153782687, 3114.112477943785, 3130.358276553306, 4898.877528061791, 4949.52979466951, 5034.446210916796, 5049.772760225785, 5088.821891233808, 4975.8258460953875, 5029.446760856312, 5055.191169412895, 5057.797688092472, 5080.517350851673, 4413.44831896013, 4548.772561371935, 4576.290674945389, 4593.081383723269, 4654.185517534418, 4557.430321209848, 4602.516735742749, 4638.512956139607, 4646.558576935203, 4743.928841067387, 4538.0, 4561.064981678748, 4563.315502674593, 4614.9077018459775, 4617.353570500132, 4659.277811939155, 4671.929921051187, 4680.461746899116, 4684.5549672781035, 4688.765561721901, 4549.681522293407, 4657.04530571232, 4658.697184682985, 4674.228752255874, 4678.625709943196, 4866.7079975201605, 4895.681780684244, 5014.2979982802435, 5044.117279476113, 5050.3434553507805, 5442.510174084351, 5452.482014208644, 5457.972710136463, 5463.0, 5476.7535460904355, 5458.863528411782, 5460.453954604547, 5460.535854452376, 5461.808836690697, 5471.933141770984, 5003.799848006075, 5074.238864170367, 5142.5628821549835, 5171.069207542679, 5218.478152184789, 5548.72256387179, 5571.637843540157, 5579.6931168785295, 5580.302462192226, 5585.413531579207, 5303.655262407931, 5374.785008599612, 5380.085385484399, 5396.406395296514, 5401.5948803839865, 5347.973260133675, 5380.596455265871, 5398.73006349681, 5401.864953376118, 5442.0204363215, 5444.972775136099, 5455.481729235717, 5462.781488740406, 5463.863403414946, 5486.753096110685, 5290.735463226823, 5371.060064488699, 5437.673739575638, 5488.1767734839295, 5516.862078448071, 4226.725262857904, 4273.316269396882, 4273.850415235514, 4283.635890949242, 4291.420658211102, 3841.2893614681375, 3858.884233473, 3865.806709664562, 3869.7484663496784, 3885.417187421909, 4899.559039686445, 4906.215005599087, 5091.516305950929, 5133.9743301284, 5178.3785945686, 5488.0, 5501.119820828648, 5522.144067669517, 5529.391766905637, 5562.694051827108, 5058.797648094109, 5141.0, 5141.25451809493, 5144.588432925357, 5190.714510701872, 4568.132054909556, 4615.353850460938, 4680.742559159279, 4683.484816670163, 4702.95297047032, 5692.9146062809095, 5693.886122277614, 5705.144228365778, 5711.514521265656, 5715.342735585461, 5517.089680202722, 5527.53015993645, 5530.723463826873, 5533.059379905345, 5535.972320138373, 5439.238506609157, 5592.356878958972, 5594.0, 5598.244237027949, 5689.203511508475, 5372.650777699593, 5433.619646624698, 5465.398806131243, 5479.945200547943, 5490.505854473116, 5431.511163995259, 5449.427810080043, 5471.671699698031, 5478.972605136949, 5486.067368547437, 5173.22401639742, 5347.0, 5367.570594352521, 5370.087085195604, 5411.78352865881, 5246.475352464723, 5290.788368465218, 5300.867478313073, 5330.760115794721, 5332.093544097435, 5293.761780719799, 5324.094903866275, 5324.121519949165, 5331.120365139708, 5371.328583927009, 5293.232481290268, 5327.174287985368, 5407.83776486706, 5424.918626220531, 5439.4288599696465, 5234.921476177937, 5248.501392367719, 5282.260483532232, 5285.154375299933, 5326.387465441524], "unit": "score", "name": "dojo.html", "value": 5034.923736967206}, {"lowerIsBetter": false, "replicates": [554.5258803722814, 570.8858228354329, 586.1676419484331, 586.996236435695, 594.8661551150991, 28292.57561136582, 35770.46344304834, 36431.81784091082, 36449.81775091121, 36511.63488365115, 40237.7988110059, 40832.0, 40900.59099409005, 41049.0, 41049.38425923613, 8488.44825086369, 8675.045744968049, 8683.13168683133, 8687.348448866329, 8689.348298877578, 8425.452345597547, 8573.185547373021, 8576.0, 8577.485350878937, 8774.385792994493, 8757.211850933414, 8845.646174153026, 8847.159519845605, 8847.424917380382, 8847.601857916377, 8654.394192406535, 8786.341024423195, 8793.736187914374, 8823.205911467998, 8823.823523529494, 8660.17728315809, 8784.12158784123, 8794.34042446819, 8802.339824513187, 8806.64773409063, 39393.60606393928, 40297.59702402968, 40303.798481007405, 40355.59644403548, 40373.394399084034, 3368.2708882328525, 3368.511565822942, 3375.6455572164814, 3379.4086034943784, 3439.4840773883866, 29660.110196694135, 30270.394592108256, 30402.239944001354, 30419.0, 30899.691003089905, 4018.276710192164, 4035.959640403588, 4086.6117718816663, 4122.361034039729, 4145.958540414587, 259898.0, 260987.0, 261005.0, 261467.0, 261528.0, 51400.48599514032, 52412.737936310834, 58468.415315847145, 58720.11919821206, 58806.0, 63749.36250637527, 64907.35092649013, 65286.34713652897, 65369.67315163489, 65427.34572654308, 14382.712345753027, 14553.708925821637, 14612.0, 14640.19478928648, 14658.413663453555, 10584.417857017785, 10873.401962892116, 10934.125269978542, 10995.670129896116, 11117.444127793578, 19324.71012934807, 19433.708494372597, 19483.902580487007, 19491.902540487208, 19591.31430399929, 7119.323664251888, 7466.775996720107, 7480.8877866832045, 7486.737964171337, 7502.212267711811, 962.2398305338704, 972.1687956796837, 1051.4742628685658, 1069.6363236499628, 1110.3892858927718, 28282.43435131286, 29565.85217073901, 29626.851865740533, 29970.85014574957, 30185.245368865955, 1041.4480325427535, 1112.2158877990996, 1137.6985098948785, 1145.5818626201376, 1181.1436708386352, 14330.49843255502, 14624.488142914946, 14776.522347765138, 14985.32566034531, 15035.323410446337, 321659.0, 324828.0, 325843.0, 326026.0, 326080.0, 52254.0, 53239.20141197808, 53267.46732532702, 53281.733591331795, 53305.46694533005, 1340.8323959505062, 1346.4008516210192, 1346.5421756602607, 1359.8980076494302, 1372.4510195921512, 27616.0, 28066.579001315404, 28758.424831502834, 28862.567061493675, 28947.0, 42089.158216836106, 42100.36849447322, 42244.0, 46962.530374695816, 47060.7646961763, 248015.0, 249138.0, 249234.0, 249715.0, 249834.0, 28519.144425667262, 32430.351392971537, 32574.51138232881, 32747.0, 33167.83416082904, 39641.60358396495, 41261.0, 41577.0, 41611.58388416077, 42219.7889010553, 35293.29413411666, 35313.47029794606, 35358.292834143685, 35579.822100890364, 35859.64140358563, 28621.02852923947, 33872.66127338695, 34985.30029399347, 35617.64382356247, 36385.27229455449, 32672.34655306928, 33219.833900831305, 33521.0, 33548.329033419686, 33614.0, 28470.0, 29704.702952970194, 30029.849850750605, 30179.18924864515, 30232.84883575568, 24317.635235471127, 24791.87604061968, 24884.04418028849, 24906.377340566632, 25177.0], "unit": "score", "name": "ext.html", "value": 18171.143737690498}, {"lowerIsBetter": false, "replicates": [359.98920032399036, 362.3929917388374, 362.52871267352435, 362.75876542099496, 363.9217568222832, 13221.272829994346, 13439.462421503153, 16229.350825966962, 16673.583160420996, 17653.38213162541, 14811.629709257273, 16130.596735081628, 16523.33906643733, 16524.75212871808, 16898.155092245368, 5363.812266570661, 5532.806351777688, 5540.50135487806, 5541.473560011793, 5541.612087153901, 4004.279229738646, 4146.025683964266, 5396.5952553558445, 5467.753951072212, 5895.764169433218, 5929.229200203968, 6070.6357618543025, 6111.388861113897, 6123.479504242145, 6126.142340072393, 5880.823575292727, 5986.461218490357, 5989.55078369124, 5990.670513121777, 5991.011483105282, 5051.469595692436, 5215.426303106655, 5219.530242278175, 5274.367075950872, 5294.68231906083, 12841.35793210345, 12994.610161695164, 13835.654108647264, 20024.59950800976, 20167.991600420068, 2161.718976533041, 2221.48905751678, 2221.8111460525874, 2235.8770267635273, 2263.0608297556496, 9831.31180817336, 9856.65501707444, 10802.243842930999, 10855.348679079281, 13209.537666181734, 1766.1610734900949, 1804.0799192411832, 1846.8614853886013, 1867.3464287499403, 1874.062968515742, 54344.456555434335, 56742.148867766606, 57849.0, 58532.70733646347, 58943.70528147332, 9947.452890091114, 10126.949365253127, 10142.340747851365, 10152.766391393881, 10202.897971020344, 13224.73550528984, 13315.866841331657, 13385.531506397228, 13431.932840335736, 13439.596812095653, 7367.5211111277595, 7417.406607471389, 7428.888566671504, 7488.9625551871895, 7498.775036748906, 7113.64431778409, 7138.9286107139305, 7203.243659415791, 7211.242819503981, 7216.530925489827, 4392.890177745582, 4427.203103441347, 4429.933550996673, 4434.979954610458, 4506.076254367847, 1730.6365663210615, 1789.2753434858903, 1804.2061492943062, 1811.1759149586906, 1820.4811628686025, 891.4250308551078, 938.6996161228342, 983.3362480325751, 1005.7636455432968, 1027.2655051638114, 13547.59357219285, 15112.0, 15801.683966320608, 15905.0, 16765.664686706197, 939.1125386509683, 970.5147426286857, 980.7155924781733, 983.6213057972732, 984.7341217871135, 9322.487263200454, 9910.702678919644, 9988.300818942604, 9997.700068997941, 9998.152743176377, 368131.0, 373010.0, 589764.0, 589874.0, 590633.0, 70783.0, 71589.0, 72770.0, 73762.26237737553, 75870.0, 1087.3530249501534, 1099.4777480696605, 1112.5660992212881, 1166.4634268236537, 1167.445463404893, 14752.0, 15066.0, 15121.621959451102, 15191.392344306547, 15197.848021519643, 33760.0, 33781.49327760036, 33849.0, 34295.31409371849, 34533.13667158341, 43043.78478107715, 43174.0, 43212.567874322114, 43801.12397751964, 44237.33643995407, 6938.548994315353, 7222.530535515385, 7248.238934911758, 7255.673494692646, 7445.702171913063, 9029.77425564366, 10226.590936362461, 10592.841107383549, 10823.56705731762, 11126.276792008493, 8916.910830891607, 9226.077392260988, 9226.400283981788, 9320.254379649747, 9417.0, 9172.403793753385, 9488.525573721425, 9625.614975400906, 9796.9020309796, 10227.0, 9060.139286767746, 9357.625694972125, 9411.341206115507, 9459.668911588062, 9470.57382417779, 7391.6304184791625, 7619.390448764197, 7636.08366995964, 7670.8849367260655, 7680.116786569392, 8717.65129394817, 9448.338616296793, 9587.664431744855, 9665.178459830993, 9715.125638692552], "unit": "score", "name": "jquery.html", "value": 8154.4876829032855}, {"lowerIsBetter": false, "replicates": [1307.8822905938464, 1429.892758043147, 1438.7050654615805, 1611.927463264153, 1820.9620516305704, 6946.583205007703, 7565.697372105116, 7677.462577619569, 7685.193054729257, 7694.923050769491, 7525.096988361404, 7735.72924947627, 7745.109312429072, 7753.922460775405, 7758.49569777964, 2011.668074767669, 2037.5415531505441, 2045.31481953545, 2287.1651847075823, 2310.0875154314035, 2322.907083716649, 2362.6574146748712, 2363.7872591466767, 2367.6566897799894, 2369.2655276864143, 2259.8418110732255, 2296.494771150353, 2296.609576372021, 2297.0467256088787, 2297.264875239924, 2286.977130228693, 2304.665823455598, 2309.041747674713, 2315.69895913531, 2317.501737126509, 2301.838871279011, 2305.262316058862, 2312.410335364488, 2313.4332088638225, 2314.2825724025606, 7719.536827790294, 7752.728654497066, 7757.146713861471, 7760.379169666413, 7763.378929685611, 4726.149293127236, 4830.879228019293, 4838.080764654705, 4841.104395686809, 4863.732494712789, 3187.139472342478, 3195.888143914975, 3215.26049008727, 3233.7711669565415, 3277.19708671377, 1005.4319309590059, 1008.9293749437543, 1010.7372083258332, 1040.1107053469327, 1051.0435503691604, 10911.181661375429, 10915.836262456069, 10927.398993055378, 10957.616483423042, 10965.890341096567, 4268.125034367947, 4347.891302717458, 4411.250087485135, 4413.337999300131, 4420.734755914591, 9456.33805633599, 9464.574094165779, 9466.337356385126, 9475.336726429085, 9480.857787133198, 4835.202191638411, 4838.080764654775, 4867.659263851568, 4870.95129048705, 4872.634552408584, 4382.780860956939, 4394.912101758011, 4434.689571730012, 4437.866863994085, 4442.444694413199, 3387.3902697514686, 3445.6037555680914, 3645.3802853514435, 3692.4276737105793, 3705.184859330997, 1149.1840793037038, 1189.1378750405886, 1197.5389475052168, 1200.4177973682756, 1212.9332886691316, 1324.2253281830237, 1345.6030471011074, 1348.5886804524519, 1364.6179069860455, 1366.1666383506054, 7275.199728029913, 7429.591372474566, 7436.0, 7441.851162976818, 7447.44144189188, 1073.2004656530778, 1080.5461706083463, 1086.1202426034938, 1091.9344839309667, 1111.2110401614782, 5730.656160630376, 5822.417758224144, 5831.037878750044, 5832.212651292106, 5837.824865253964, 9513.571889265, 9554.808903821884, 9670.323077384515, 9826.213902887752, 9840.901590984142, 9488.478133702713, 9599.952000239955, 9627.374220675634, 9640.75898102539, 9645.614175433044, 7416.295451932057, 7484.700611975569, 7594.886076708854, 7661.578613176217, 7670.501417407851, 7271.054762880792, 7301.4158867289425, 7305.452091093295, 7306.671199796128, 7322.743703970335, 8021.598920054091, 8114.350851931949, 8234.053083895189, 8240.0, 8388.161183881562, 8246.134155913782, 8250.752477425687, 8369.414141010071, 8389.790255243668, 8395.832083358177, 6773.593584384756, 6943.409810166192, 6946.2011868635755, 6960.79117626472, 6963.0, 6804.183497980076, 6925.238223795479, 7278.163011253562, 7512.173660897188, 7516.774496765106, 6875.0718652983205, 6978.860422791618, 7000.824979375557, 7054.753083642253, 7094.255103214295, 6827.453803695593, 6830.59016459014, 6897.068895699217, 6908.758193463204, 6969.8257543559785, 7009.0, 7052.118485189351, 7054.082969214174, 7056.188538318159, 7056.364927156581, 6374.872502550016, 6489.675516224264, 6512.967435162794, 6532.510061745483, 6549.050387693853, 6290.0, 6402.263739669997, 6411.134496842867, 6417.71120299597, 6427.260865000585], "unit": "score", "name": "mootools.html", "value": 4534.20263113867}, {"lowerIsBetter": false, "replicates": [340.456971131046, 348.3816226198498, 348.55559162068374, 348.5851836314785, 350.58980992239077, 5708.828735137942, 5803.100519419486, 5840.386759390261, 5910.2612173478365, 5927.081302398135, 5673.205751194836, 5807.941920580793, 5832.56255780816, 5832.6792026438525, 5850.327212370578, 4563.612092972101, 4575.26795712686, 4575.725456472605, 4579.793909274074, 4583.862484125481, 4374.868753937387, 4474.485434175062, 4516.525764794698, 4538.273876179812, 4572.948221908963, 4503.211937910869, 4507.504174540798, 4509.301058335963, 4524.864254072383, 4545.977270113644, 4519.683622146451, 4521.389612402317, 4526.615237704799, 4546.47715512717, 4555.954440455586, 4036.7577945323374, 4040.0, 4044.797760111983, 4045.0, 4057.5536690963972, 5434.103372943459, 5608.775648974036, 5614.438556144394, 5623.606347555673, 5625.80309689163, 5244.763985620656, 5253.290805741214, 5254.395744489356, 5256.1852912798195, 5263.34208223972, 5901.881962360729, 6220.066989951498, 6244.0, 6246.781362652286, 6248.750049997994, 4233.661307095425, 4271.8718438446895, 4350.086481838817, 4392.802323895432, 4397.384366188736, 6392.137061496732, 6436.131122298477, 6440.645764482952, 6465.0, 6466.902996455057, 4434.312681534368, 4446.799894004713, 4448.310511870665, 4455.376247325377, 4469.910601787946, 4433.091216300651, 4473.932891006638, 4503.41455610775, 4514.32285157229, 4527.683062185615, 5195.090859099642, 5204.5576126028955, 5207.010667973073, 5208.906129712803, 5209.4009188943755, 6234.2830574483605, 6235.282942461584, 6240.5319601030105, 6288.685565721696, 6303.054541818764, 1572.6147093962052, 1604.638956234838, 1604.9438269660507, 1605.1733357320988, 1606.9919650401673, 1070.8286674132257, 1079.3146352066337, 1080.7028067281403, 1095.884932082136, 1103.6137351926761, 5855.092460668603, 5888.852778680482, 5902.232709747791, 5907.2911250650195, 5924.881502369928, 6404.615723056631, 6406.583572067801, 6412.454941330039, 6413.29453760086, 6413.807585772434, 5838.591298609142, 5877.353491115974, 5891.440313170242, 5902.704864756745, 5907.822765317047, 3345.180430794471, 3437.656234376542, 3440.673136052071, 3442.277121804399, 3443.9311213775586, 6593.901091483632, 6659.600423974577, 6704.061431399608, 6707.128073350531, 6713.4964877634375, 6577.6053436793945, 6585.308542603054, 6590.373914478117, 6590.637514936724, 6592.934070659232, 6521.836954076186, 6642.003699445026, 6690.29751876046, 6694.330566943267, 6697.966510167418, 6126.23422072241, 6282.120503129474, 6398.168238129014, 6439.581427207217, 6448.484121270381, 6167.0, 6334.746610135543, 6371.076193951758, 6377.17096777416, 6415.262244841903, 6700.564463309869, 6705.497087718538, 6706.396424321834, 6709.597424154566, 6720.630365329758, 4429.867103986886, 4466.5086840446875, 4485.125400546862, 4517.073999830092, 4530.478994915627, 6436.259830119409, 6437.742490300336, 6448.645324507197, 6454.935450645621, 6455.354464553507, 6259.217597800275, 6266.154069200599, 6267.655278959701, 6276.184096067482, 6279.058141278662, 6104.938950610437, 6203.65879876593, 6219.906701399573, 6227.532935029982, 6297.748090076529, 6162.476189523762, 6173.783917562864, 6174.197354343906, 6178.320384757763, 6184.845378865564, 6309.842253943688, 6316.494680425647, 6316.873662526816, 6316.936830631635, 6322.272938612118, 6048.183495228088, 6167.0, 6168.444839964424, 6171.074338849208, 6182.474489668429], "unit": "score", "name": "prototype.html", "value": 4721.995720333318}, {"lowerIsBetter": false, "replicates": [782.9344143392252, 795.7016118955391, 842.3976856547567, 852.1521086518912, 870.9651613935442, 13308.201507909533, 13518.797218041713, 13544.187348759082, 13545.322733863317, 13557.864421355784, 12869.871301286985, 12920.935395323011, 12943.352832358392, 12959.870401295984, 12965.416556254968, 815.3925325632412, 824.3487644760631, 831.9584020798966, 832.5837081459271, 833.9332853371716, 680.918289805224, 690.76513985245, 827.5655280977505, 828.7845160258316, 829.3613917283687, 851.5061264466594, 857.5626430520417, 863.4646519158131, 864.567716141929, 865.0786911938796, 856.5845564901018, 857.8756080368374, 858.3262139220744, 859.4585411190941, 867.8784970104191, 522.1202274168039, 530.4774796825125, 624.9656268905209, 634.1312402009231, 637.1366797988751, 13321.533746318832, 13347.933260333733, 13357.599272021855, 13376.264305463195, 13404.86595134046, 11749.94125029378, 12083.74203648108, 12087.0, 12124.333161676104, 12408.255504669658, 9990.250731195118, 10057.89942100577, 10149.847752283722, 10327.58689652413, 10488.160947124212, 3514.7715398499017, 3596.478510615946, 3607.4408466687705, 3609.693176080036, 3615.6565126312958, 49749.999999999636, 50038.0, 50364.74817625889, 50368.24447633288, 50421.49578504205, 8936.32977526688, 9101.362904596615, 9742.46416447088, 9829.705108846745, 9835.901640983499, 17436.564085897953, 17648.823511764975, 17682.292708291523, 17704.114794260237, 17711.645767084585, 7245.9275407246305, 7342.853142937218, 7345.816354591071, 7407.740729074564, 7452.664630091659, 4323.589259020388, 4362.847300344472, 4373.693841431133, 4390.758508282075, 4464.1071785643, 2931.8240905545736, 3014.201236672284, 3018.5773991641186, 3020.879164833426, 3022.032949456197, 570.520762559452, 574.3968832725621, 577.206341280739, 625.8842114208886, 637.2735082006516, 556.7800718716165, 560.2996254681648, 587.415521556046, 689.9241083480813, 720.3881761081224, 8164.918350816534, 8213.0, 8487.193716597038, 8526.31789456842, 8854.24738897201, 498.7905079866465, 630.6878095342743, 684.1516519515765, 699.0, 723.4827098624509, 3639.1448009717697, 3777.2823163598828, 3957.2876882161486, 3967.6429121378637, 4006.09862780872, 53536.46463535393, 57050.0, 57119.42880571141, 57400.0, 58476.0, 49440.752796235785, 49832.252516212284, 50985.49014509882, 51517.96964060773, 51943.480565193866, 45805.08389832251, 46154.0, 46256.768716156876, 47192.820179495786, 47364.763176184584, 8560.743177704679, 8728.258098061737, 8861.379703420957, 9170.724878253663, 9421.434713917188, 31352.0, 31524.684753152174, 31625.20936976594, 31733.841330794123, 31986.0, 43612.34581481344, 43704.56295437132, 44154.337684935395, 44395.77802110969, 45244.77377613223, 10820.67537973862, 11169.609063683058, 11297.096232301561, 11416.0, 11755.471003804678, 12582.18215815969, 12755.426005829946, 12824.871751282368, 12989.155704879153, 13021.283829389096, 11571.363575003119, 11832.585859494877, 11981.880181198425, 12227.755444890874, 12288.815667764811, 11730.354830484406, 12136.150469467053, 12211.87788122143, 12242.877571224173, 12482.812757808459, 7227.517692410915, 11220.943895280798, 11725.941370293094, 11812.055035596959, 12096.032317414762, 9182.494962777111, 9542.379745316532, 10004.349717268355, 10160.199004975124, 10433.686989390331, 8250.0, 8820.514871681862, 8991.730248092568, 9398.95300523493, 9712.75718107053], "unit": "score", "name": "yui.html", "value": 6277.817084864919}], "name": "dromaeo_css", "value": 6816.1767458927725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 111.0, 111.0, 111.0, 101.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 157.0, 167.0, 128.0, 147.0, 157.0, 128.0, 165.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 162.0, 163.0, 163.0, 160.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 129.0, 90.0, 74.0, 72.0, 71.0, 105.0, 111.0, 70.0], "unit": "score", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 147.0, 95.0, 96.0, 95.0, 144.0, 96.0, 95.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 56.0, 56.0, 55.0, 57.0, 58.0, 70.0, 52.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 68.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 84.0, 90.0, 82.0, 84.0, 82.0, 91.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 125.0, 120.0, 121.0, 118.0, 113.0, 117.0, 119.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [145.0, 139.0, 135.0, 146.0, 142.0, 131.0, 141.0, 141.0, 143.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1499.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [43255.31914893617], "unit": "score", "name": "RegExp", "value": 21.060646827348737}, {"lowerIsBetter": false, "replicates": [579.1284403669724], "unit": "score", "name": "Splay", "value": 140.71317227722767}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20076.997692355722}]} 05:58:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20077.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1499.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6816.18"}}} 05:58:10 INFO - Return code: 0 05:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:10 INFO - # TBPL SUCCESS # 05:58:10 INFO - Running post-action listener: _resource_record_post_action 05:58:10 INFO - Running post-run listener: _resource_record_post_run 05:58:11 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 561246208; Read time: 0; Write time: 896676 05:58:11 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 237019136; Read time: 0; Write time: 546548 05:58:11 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 314413056; Read time: 0; Write time: 348352 05:58:11 INFO - Running post-run listener: _upload_blobber_files 05:58:11 INFO - Blob upload gear active. 05:58:11 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:58:11 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:58:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:58:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:58:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:12 INFO - (blobuploader) - INFO - Done attempting. 05:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:13 INFO - (blobuploader) - INFO - Done attempting. 05:58:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:13 INFO - Return code: 0 05:58:13 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:58:13 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a4811c716bbdeea11bf792b15fc44e7068bf594de2502c140463d62442bee7e681acbc2f710730de7853bd1901906a708b3b067ef821791386b02d2df693bfaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6f9988a3c1daa5d89f0627bd7af029eefd54f6623a271856a86a9ba2ce871ae639d41d05ca8172ccffa5e71801156e2759348992ec640b855643ba69432de141"} 05:58:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:58:13 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:58:13 INFO - Contents: 05:58:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a4811c716bbdeea11bf792b15fc44e7068bf594de2502c140463d62442bee7e681acbc2f710730de7853bd1901906a708b3b067ef821791386b02d2df693bfaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6f9988a3c1daa5d89f0627bd7af029eefd54f6623a271856a86a9ba2ce871ae639d41d05ca8172ccffa5e71801156e2759348992ec640b855643ba69432de141"} 05:58:13 INFO - Copying logs to upload dir... 05:58:13 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.553967 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-15 05:58:13.621231) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 05:58:13.625019) ========= 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=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a4811c716bbdeea11bf792b15fc44e7068bf594de2502c140463d62442bee7e681acbc2f710730de7853bd1901906a708b3b067ef821791386b02d2df693bfaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6f9988a3c1daa5d89f0627bd7af029eefd54f6623a271856a86a9ba2ce871ae639d41d05ca8172ccffa5e71801156e2759348992ec640b855643ba69432de141"} build_url:https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/MLJAJoQkQGmJCWpCluwYeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a4811c716bbdeea11bf792b15fc44e7068bf594de2502c140463d62442bee7e681acbc2f710730de7853bd1901906a708b3b067ef821791386b02d2df693bfaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6f9988a3c1daa5d89f0627bd7af029eefd54f6623a271856a86a9ba2ce871ae639d41d05ca8172ccffa5e71801156e2759348992ec640b855643ba69432de141"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 05:58:13.649115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:58:13.649418) ========= 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=aa52b8aba932b19cc50b5275000001de-1452865019.441822-800596846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:58:13.731500) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 05:58:13.731820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 05:58:13.732104) ========= ========= Total master_lag: 0.22 =========