builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1451742444.54 results: success (0) buildid: 20160102030217 builduid: e5e6a042e2de46619877fa9470acca63 revision: ce643acfab14d95bea2fb6c4f56477413514b686 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.539160) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.539562) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.539848) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.564842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.565154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.580761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.581050) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004683 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.629379) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.629645) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.629976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.630266) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-02 05:47:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-01-02 05:47:25 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.799258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.799547) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022453 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:24.848507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-02 05:47:24.848812) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ce643acfab14d95bea2fb6c4f56477413514b686 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ce643acfab14d95bea2fb6c4f56477413514b686 --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=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-02 05:47:25,874 truncating revision to first 12 chars 2016-01-02 05:47:25,874 Setting DEBUG logging. 2016-01-02 05:47:25,874 attempt 1/10 2016-01-02 05:47:25,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ce643acfab14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-02 05:47:26,955 unpacking tar archive at: mozilla-central-ce643acfab14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.343154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-02 05:47:26.205947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:26.206313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:26.216487) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:26.216810) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:26.217304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-02 05:47:26.217635) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:27 INFO - MultiFileLogger online at 20160102 05:47:27 in /builds/slave/test-pgo 05:47:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:47:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:47:27 INFO - {'append_to_log': False, 05:47:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:47:27 INFO - 'blob_upload_branch': 'Firefox', 05:47:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:47:27 INFO - 'branch': 'Firefox', 05:47:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:27 INFO - 'config_files': ('talos/linux_config.py',), 05:47:27 INFO - 'default_actions': ('clobber', 05:47:27 INFO - 'read-buildbot-config', 05:47:27 INFO - 'download-and-extract', 05:47:27 INFO - 'populate-webroot', 05:47:27 INFO - 'create-virtualenv', 05:47:27 INFO - 'install', 05:47:27 INFO - 'run-tests'), 05:47:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:27 INFO - 'download_minidump_stackwalk': True, 05:47:27 INFO - 'download_symbols': 'ondemand', 05:47:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:27 INFO - 'installer_path': 'installer.exe', 05:47:27 INFO - 'log_level': 'info', 05:47:27 INFO - 'log_name': 'talos', 05:47:27 INFO - 'log_to_console': True, 05:47:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:27 INFO - 'opt_config_files': (), 05:47:27 INFO - 'pip_index': False, 05:47:27 INFO - 'sps_profile': False, 05:47:27 INFO - 'sps_profile_interval': 0, 05:47:27 INFO - 'suite': 'dromaeojs', 05:47:27 INFO - 'system_bits': '32', 05:47:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:27 INFO - 'title': 'talos-linux64-ix-001', 05:47:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:27 INFO - 'use_talos_json': True, 05:47:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:47:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:27 INFO - 'work_dir': 'build'} 05:47:27 INFO - ##### 05:47:27 INFO - ##### Running clobber step. 05:47:27 INFO - ##### 05:47:27 INFO - Running pre-action listener: _resource_record_pre_action 05:47:27 INFO - Running main action method: clobber 05:47:27 INFO - rmtree: /builds/slave/test-pgo/build 05:47:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:47:28 INFO - Running post-action listener: _resource_record_post_action 05:47:28 INFO - ##### 05:47:28 INFO - ##### Running read-buildbot-config step. 05:47:28 INFO - ##### 05:47:28 INFO - Running pre-action listener: _resource_record_pre_action 05:47:28 INFO - Running main action method: read_buildbot_config 05:47:28 INFO - Using buildbot properties: 05:47:28 INFO - { 05:47:28 INFO - "project": "", 05:47:28 INFO - "product": "firefox", 05:47:28 INFO - "script_repo_revision": "production", 05:47:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:47:28 INFO - "repository": "", 05:47:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:47:28 INFO - "buildid": "20160102030217", 05:47:28 INFO - "stage_platform": "linux64-pgo", 05:47:28 INFO - "basedir": "/builds/slave/test-pgo", 05:47:28 INFO - "nightly_build": "True", 05:47:28 INFO - "buildnumber": 628, 05:47:28 INFO - "slavename": "talos-linux64-ix-001", 05:47:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:47:28 INFO - "platform": "ubuntu64_hw", 05:47:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:47:28 INFO - "branch": "mozilla-central", 05:47:28 INFO - "repo_path": "mozilla-central", 05:47:28 INFO - "revision": "ce643acfab14d95bea2fb6c4f56477413514b686", 05:47:28 INFO - "pgo_build": "True", 05:47:28 INFO - "builduid": "e5e6a042e2de46619877fa9470acca63", 05:47:28 INFO - "slavebuilddir": "test" 05:47:28 INFO - } 05:47:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:47:28 INFO - Running post-action listener: _resource_record_post_action 05:47:28 INFO - ##### 05:47:28 INFO - ##### Running download-and-extract step. 05:47:28 INFO - ##### 05:47:28 INFO - Running pre-action listener: _resource_record_pre_action 05:47:28 INFO - Running main action method: download_and_extract 05:47:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:47:28 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:47:28 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:47:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json 05:47:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json 05:47:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:47:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:47:30 INFO - Downloaded 1302 bytes. 05:47:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:47:30 INFO - Using the following test package requirements: 05:47:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:30 INFO - u'jsshell-linux-x86_64.zip'], 05:47:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47: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:47:30 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:32 INFO - Downloaded 23199205 bytes. 05:47:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:47:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:47:33 INFO - Return code: 0 05:47:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:47: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:47:33 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:36 INFO - Downloaded 23199205 bytes. 05:47:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:47:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:47:37 INFO - Return code: 0 05:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:37 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:38 INFO - Downloaded 11132285 bytes. 05:47:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:47:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:47:38 INFO - Return code: 0 05:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:38 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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:47:40 INFO - Downloaded 54989007 bytes. 05:47:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:40 INFO - mkdir: /builds/slave/test-pgo/properties 05:47:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:47:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:47:40 INFO - Contents: 05:47:40 INFO - build_url:https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:40 INFO - Running post-action listener: _resource_record_post_action 05:47:40 INFO - Running post-action listener: set_extra_try_arguments 05:47:40 INFO - ##### 05:47:40 INFO - ##### Running populate-webroot step. 05:47:40 INFO - ##### 05:47:40 INFO - Running pre-action listener: _resource_record_pre_action 05:47:40 INFO - Running main action method: populate_webroot 05:47:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:40 INFO - '--tppagecycles', 05:47:40 INFO - '7'], 05:47:40 INFO - 'tests': ['tsvgm']}}, 05:47:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:47:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:47:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:47:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'tests': ['damp', 'tps']}, 05:47:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['damp', 'tps']}, 05:47:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:47:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:40 INFO - 'other': {'tests': ['a11yr', 05:47:40 INFO - 'ts_paint', 05:47:40 INFO - 'tpaint', 05:47:40 INFO - 'sessionrestore', 05:47:40 INFO - 'sessionrestore_no_auto_restore']}, 05:47:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['a11yr', 05:47:40 INFO - 'ts_paint', 05:47:40 INFO - 'tpaint', 05:47:40 INFO - 'sessionrestore', 05:47:40 INFO - 'sessionrestore_no_auto_restore']}, 05:47:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['a11yr', 05:47:40 INFO - 'ts_paint', 05:47:40 INFO - 'tpaint', 05:47:40 INFO - 'sessionrestore', 05:47:40 INFO - 'sessionrestore_no_auto_restore']}, 05:47:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['a11yr', 05:47:40 INFO - 'ts_paint', 05:47:40 INFO - 'tpaint', 05:47:40 INFO - 'sessionrestore', 05:47:40 INFO - 'sessionrestore_no_auto_restore']}, 05:47:40 INFO - 'other_l64': {'tests': ['a11yr', 05:47:40 INFO - 'ts_paint', 05:47:40 INFO - 'tpaint', 05:47:40 INFO - 'sessionrestore', 05:47:40 INFO - 'sessionrestore_no_auto_restore']}, 05:47:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:47:40 INFO - 'ts_paint', 05:47:40 INFO - 'tpaint', 05:47:40 INFO - 'sessionrestore', 05:47:40 INFO - 'sessionrestore_no_auto_restore']}, 05:47:40 INFO - 'svgr': {'tests': ['tsvgx', 05:47:40 INFO - 'tsvgr_opacity', 05:47:40 INFO - 'tart', 05:47:40 INFO - 'tscrollx', 05:47:40 INFO - 'cart']}, 05:47:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['tsvgx', 05:47:40 INFO - 'tsvgr_opacity', 05:47:40 INFO - 'tart', 05:47:40 INFO - 'tscrollx', 05:47:40 INFO - 'cart']}, 05:47:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'tests': ['tp5o']}, 05:47:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'talos_options': ['--e10s'], 05:47:40 INFO - 'tests': ['tp5o']}, 05:47:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'talos_options': ['--xperf_path', 05:47:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:40 INFO - 'tests': ['tp5n']}, 05:47:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:40 INFO - 'talos_options': ['--e10s', 05:47:40 INFO - '--xperf_path', 05:47:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:40 INFO - 'tests': ['tp5n']}}, 05:47:40 INFO - 'talos.zip': {'path': '', 05:47:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:40 INFO - Running post-action listener: _resource_record_post_action 05:47:40 INFO - ##### 05:47:40 INFO - ##### Running create-virtualenv step. 05:47:40 INFO - ##### 05:47:40 INFO - Running pre-action listener: _resource_record_pre_action 05:47:40 INFO - Running main action method: create_virtualenv 05:47:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:47:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:47:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:47:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:40 INFO - Using real prefix '/usr' 05:47:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:47:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:43 INFO - Installing pip.................done. 05:47:43 INFO - Return code: 0 05:47:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:47:43 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:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:43 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:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:43 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 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:43 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:47:43 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:47:43 INFO - Using env: {'DISPLAY': ':0', 05:47:43 INFO - 'HOME': '/home/cltbld', 05:47:43 INFO - 'LANG': 'en_US.UTF-8', 05:47:43 INFO - 'LANGUAGE': 'en_US:en', 05:47:43 INFO - 'LOGNAME': 'cltbld', 05:47:43 INFO - 'MAIL': '/var/mail/cltbld', 05:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:43 INFO - 'MOZ_NO_REMOTE': '1', 05:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:43 INFO - 'NO_EM_RESTART': '1', 05:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:43 INFO - 'SHELL': '/bin/bash', 05:47:43 INFO - 'SHLVL': '1', 05:47:43 INFO - 'TERM': 'linux', 05:47:43 INFO - 'TMOUT': '86400', 05:47:43 INFO - 'USER': 'cltbld', 05:47:43 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:43 INFO - '_': '/tools/buildbot/bin/python'} 05:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:43 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:47:43 INFO - Cleaning up... 05:47:43 INFO - Return code: 0 05:47:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:47:43 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:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:43 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:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:43 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 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:43 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:47:43 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:47:43 INFO - Using env: {'DISPLAY': ':0', 05:47:43 INFO - 'HOME': '/home/cltbld', 05:47:43 INFO - 'LANG': 'en_US.UTF-8', 05:47:43 INFO - 'LANGUAGE': 'en_US:en', 05:47:43 INFO - 'LOGNAME': 'cltbld', 05:47:43 INFO - 'MAIL': '/var/mail/cltbld', 05:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:43 INFO - 'MOZ_NO_REMOTE': '1', 05:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:43 INFO - 'NO_EM_RESTART': '1', 05:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:43 INFO - 'SHELL': '/bin/bash', 05:47:43 INFO - 'SHLVL': '1', 05:47:43 INFO - 'TERM': 'linux', 05:47:43 INFO - 'TMOUT': '86400', 05:47:43 INFO - 'USER': 'cltbld', 05:47:43 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:43 INFO - '_': '/tools/buildbot/bin/python'} 05:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:43 INFO - Downloading/unpacking psutil>=0.7.1 05:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:47:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:47:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:45 INFO - Installing collected packages: psutil 05:47:45 INFO - Running setup.py install for psutil 05:47:45 INFO - building 'psutil._psutil_linux' extension 05:47:45 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:47:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:47:45 INFO - building 'psutil._psutil_posix' extension 05:47:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:47:46 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:47:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:46 INFO - Successfully installed psutil 05:47:46 INFO - Cleaning up... 05:47:46 INFO - Return code: 0 05:47:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:46 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 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:46 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:47:46 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:47:46 INFO - Using env: {'DISPLAY': ':0', 05:47:46 INFO - 'HOME': '/home/cltbld', 05:47:46 INFO - 'LANG': 'en_US.UTF-8', 05:47:46 INFO - 'LANGUAGE': 'en_US:en', 05:47:46 INFO - 'LOGNAME': 'cltbld', 05:47:46 INFO - 'MAIL': '/var/mail/cltbld', 05:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:46 INFO - 'MOZ_NO_REMOTE': '1', 05:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:46 INFO - 'NO_EM_RESTART': '1', 05:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:46 INFO - 'SHELL': '/bin/bash', 05:47:46 INFO - 'SHLVL': '1', 05:47:46 INFO - 'TERM': 'linux', 05:47:46 INFO - 'TMOUT': '86400', 05:47:46 INFO - 'USER': 'cltbld', 05:47:46 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:46 INFO - '_': '/tools/buildbot/bin/python'} 05:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:47:46 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:47:46 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:47:46 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:47:46 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:47:46 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:47:46 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:47:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:47:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:47:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:48 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:47:48 INFO - Installing collected packages: mozsystemmonitor 05:47:48 INFO - Running setup.py install for mozsystemmonitor 05:47:48 INFO - Successfully installed mozsystemmonitor 05:47:48 INFO - Cleaning up... 05:47:48 INFO - Return code: 0 05:47:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:48 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 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:48 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:47:48 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:47:48 INFO - Using env: {'DISPLAY': ':0', 05:47:48 INFO - 'HOME': '/home/cltbld', 05:47:48 INFO - 'LANG': 'en_US.UTF-8', 05:47:48 INFO - 'LANGUAGE': 'en_US:en', 05:47:48 INFO - 'LOGNAME': 'cltbld', 05:47:48 INFO - 'MAIL': '/var/mail/cltbld', 05:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:48 INFO - 'MOZ_NO_REMOTE': '1', 05:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:48 INFO - 'NO_EM_RESTART': '1', 05:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:48 INFO - 'SHELL': '/bin/bash', 05:47:48 INFO - 'SHLVL': '1', 05:47:48 INFO - 'TERM': 'linux', 05:47:48 INFO - 'TMOUT': '86400', 05:47:48 INFO - 'USER': 'cltbld', 05:47:48 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:48 INFO - '_': '/tools/buildbot/bin/python'} 05:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:50 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:47:50 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:47:50 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:47:50 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:47:50 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:47:50 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:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:47:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:50 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:47:50 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:47:50 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:47:50 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:47:50 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:47:50 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:47:50 INFO - Downloading docopt-0.6.1.tar.gz 05:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:50 INFO - Running setup.py install for blobuploader 05:47:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:47:51 INFO - Running setup.py install for requests 05:47:51 INFO - Running setup.py install for docopt 05:47:51 INFO - Successfully installed blobuploader requests docopt 05:47:51 INFO - Cleaning up... 05:47:51 INFO - Return code: 0 05:47:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:47:51 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:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:51 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:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:51 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 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:51 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:47:51 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:47:51 INFO - Using env: {'DISPLAY': ':0', 05:47:51 INFO - 'HOME': '/home/cltbld', 05:47:51 INFO - 'LANG': 'en_US.UTF-8', 05:47:51 INFO - 'LANGUAGE': 'en_US:en', 05:47:51 INFO - 'LOGNAME': 'cltbld', 05:47:51 INFO - 'MAIL': '/var/mail/cltbld', 05:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:51 INFO - 'MOZ_NO_REMOTE': '1', 05:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:51 INFO - 'NO_EM_RESTART': '1', 05:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:51 INFO - 'SHELL': '/bin/bash', 05:47:51 INFO - 'SHLVL': '1', 05:47:51 INFO - 'TERM': 'linux', 05:47:51 INFO - 'TMOUT': '86400', 05:47:51 INFO - 'USER': 'cltbld', 05:47:51 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:51 INFO - '_': '/tools/buildbot/bin/python'} 05:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:47:51 INFO - Running setup.py (path:/tmp/pip-fIDkcb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:47:51 INFO - Running setup.py (path:/tmp/pip-8ayWf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:47:51 INFO - Running setup.py (path:/tmp/pip-r1xpJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:47:51 INFO - Running setup.py (path:/tmp/pip-2f9SBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:47:52 INFO - Running setup.py (path:/tmp/pip-opqEtc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:47:52 INFO - Running setup.py (path:/tmp/pip-E6hcGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:47:52 INFO - Running setup.py (path:/tmp/pip-aABU2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:47:52 INFO - Running setup.py (path:/tmp/pip-R4IHDD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:47:52 INFO - Running setup.py (path:/tmp/pip-Ih0GpK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:47:52 INFO - Running setup.py (path:/tmp/pip-N2mRAb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:47:52 INFO - Running setup.py (path:/tmp/pip-Wzi3i0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:47:52 INFO - Running setup.py (path:/tmp/pip-m4bQOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:47:52 INFO - Running setup.py (path:/tmp/pip-jeznEd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:47:52 INFO - Running setup.py (path:/tmp/pip-WKMq2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:47:52 INFO - Running setup.py (path:/tmp/pip-vnk8Gb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:47:52 INFO - Running setup.py (path:/tmp/pip-Ux92Zw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:47:52 INFO - Running setup.py (path:/tmp/pip-X36wg6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:47:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:52 INFO - Running setup.py install for manifestparser 05:47:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Running setup.py install for mozcrash 05:47:53 INFO - Running setup.py install for mozdebug 05:47:53 INFO - Running setup.py install for mozdevice 05:47:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Running setup.py install for mozfile 05:47:53 INFO - Running setup.py install for mozhttpd 05:47:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Running setup.py install for mozinfo 05:47:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Running setup.py install for mozInstall 05:47:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Running setup.py install for mozleak 05:47:53 INFO - Running setup.py install for mozlog 05:47:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:47:53 INFO - Running setup.py install for moznetwork 05:47:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:47:54 INFO - Running setup.py install for mozprocess 05:47:54 INFO - Running setup.py install for mozprofile 05:47:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:47:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:47:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:47:54 INFO - Running setup.py install for mozrunner 05:47:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:47:54 INFO - Running setup.py install for mozscreenshot 05:47:54 INFO - Running setup.py install for moztest 05:47:54 INFO - Running setup.py install for mozversion 05:47:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:47:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:54 INFO - Cleaning up... 05:47:54 INFO - Return code: 0 05:47:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:54 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:47:54 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:47:54 INFO - Using env: {'DISPLAY': ':0', 05:47:54 INFO - 'HOME': '/home/cltbld', 05:47:54 INFO - 'LANG': 'en_US.UTF-8', 05:47:54 INFO - 'LANGUAGE': 'en_US:en', 05:47:54 INFO - 'LOGNAME': 'cltbld', 05:47:54 INFO - 'MAIL': '/var/mail/cltbld', 05:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:54 INFO - 'MOZ_NO_REMOTE': '1', 05:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:54 INFO - 'NO_EM_RESTART': '1', 05:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:54 INFO - 'SHELL': '/bin/bash', 05:47:54 INFO - 'SHLVL': '1', 05:47:54 INFO - 'TERM': 'linux', 05:47:54 INFO - 'TMOUT': '86400', 05:47:54 INFO - 'USER': 'cltbld', 05:47:54 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:54 INFO - '_': '/tools/buildbot/bin/python'} 05:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:47:54 INFO - Running setup.py (path:/tmp/pip-whSJG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:47:55 INFO - Running setup.py (path:/tmp/pip-x3FAJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:47:55 INFO - Running setup.py (path:/tmp/pip-IRKCZZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:47:55 INFO - Running setup.py (path:/tmp/pip-hITDgK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:47:55 INFO - Running setup.py (path:/tmp/pip-0brFYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:47:55 INFO - Running setup.py (path:/tmp/pip-Jjvn0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:47:55 INFO - Running setup.py (path:/tmp/pip-HAd7Ql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:47:55 INFO - Running setup.py (path:/tmp/pip-USU4nc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:47:55 INFO - Running setup.py (path:/tmp/pip-Vuh4SJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:47:55 INFO - Running setup.py (path:/tmp/pip-l1pXb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:47:55 INFO - Running setup.py (path:/tmp/pip-TtG14B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:47:55 INFO - Running setup.py (path:/tmp/pip-rZtppU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:47:55 INFO - Running setup.py (path:/tmp/pip-rt29Zw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:47:55 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:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:47:55 INFO - Running setup.py (path:/tmp/pip-mmjbDr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:47:55 INFO - Running setup.py (path:/tmp/pip-3KAItV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:47:56 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:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:47:56 INFO - Running setup.py (path:/tmp/pip-ZZt5UZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:47:56 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:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:47:56 INFO - Running setup.py (path:/tmp/pip-zvp2pn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:47:56 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:47:56 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:47:56 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:47:56 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:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:47:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:56 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:47:56 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:47:56 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:47:56 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:47:56 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:47:56 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:47:57 INFO - Downloading blessings-1.5.1.tar.gz 05:47:57 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:47:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:57 INFO - Installing collected packages: blessings 05:47:57 INFO - Running setup.py install for blessings 05:47:58 INFO - Successfully installed blessings 05:47:58 INFO - Cleaning up... 05:47:58 INFO - Return code: 0 05:47:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:47:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:47:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:47:58 INFO - Reading from file tmpfile_stdout 05:47:58 INFO - Current package versions: 05:47:58 INFO - argparse == 1.2.1 05:47:58 INFO - blessings == 1.5.1 05:47:58 INFO - blobuploader == 1.2.4 05:47:58 INFO - docopt == 0.6.1 05:47:58 INFO - manifestparser == 1.1 05:47:58 INFO - mozInstall == 1.12 05:47:58 INFO - mozcrash == 0.16 05:47:58 INFO - mozdebug == 0.1 05:47:58 INFO - mozdevice == 0.47 05:47:58 INFO - mozfile == 1.2 05:47:58 INFO - mozhttpd == 0.7 05:47:58 INFO - mozinfo == 0.9 05:47:58 INFO - mozleak == 0.1 05:47:58 INFO - mozlog == 3.1 05:47:58 INFO - moznetwork == 0.27 05:47:58 INFO - mozprocess == 0.22 05:47:58 INFO - mozprofile == 0.28 05:47:58 INFO - mozrunner == 6.11 05:47:58 INFO - mozscreenshot == 0.1 05:47:58 INFO - mozsystemmonitor == 0.0 05:47:58 INFO - moztest == 0.7 05:47:58 INFO - mozversion == 1.4 05:47:58 INFO - psutil == 3.1.1 05:47:58 INFO - requests == 1.2.3 05:47:58 INFO - wsgiref == 0.1.2 05:47:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:58 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:47:58 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:47:58 INFO - Using env: {'DISPLAY': ':0', 05:47:58 INFO - 'HOME': '/home/cltbld', 05:47:58 INFO - 'LANG': 'en_US.UTF-8', 05:47:58 INFO - 'LANGUAGE': 'en_US:en', 05:47:58 INFO - 'LOGNAME': 'cltbld', 05:47:58 INFO - 'MAIL': '/var/mail/cltbld', 05:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:58 INFO - 'MOZ_NO_REMOTE': '1', 05:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:58 INFO - 'NO_EM_RESTART': '1', 05:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:58 INFO - 'SHELL': '/bin/bash', 05:47:58 INFO - 'SHLVL': '1', 05:47:58 INFO - 'TERM': 'linux', 05:47:58 INFO - 'TMOUT': '86400', 05:47:58 INFO - 'USER': 'cltbld', 05:47:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:58 INFO - '_': '/tools/buildbot/bin/python'} 05:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:58 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:47:58 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:47:58 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:47:58 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:47:58 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:47:58 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:47:58 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:47:58 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:47:58 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:47:58 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:47:58 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:47:58 INFO - Cleaning up... 05:47:58 INFO - Return code: 0 05:47:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:47:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:47:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:47:58 INFO - Using env: {'DISPLAY': ':0', 05:47:58 INFO - 'HOME': '/home/cltbld', 05:47:58 INFO - 'LANG': 'en_US.UTF-8', 05:47:58 INFO - 'LANGUAGE': 'en_US:en', 05:47:58 INFO - 'LOGNAME': 'cltbld', 05:47:58 INFO - 'MAIL': '/var/mail/cltbld', 05:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:58 INFO - 'MOZ_NO_REMOTE': '1', 05:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:58 INFO - 'NO_EM_RESTART': '1', 05:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:58 INFO - 'SHELL': '/bin/bash', 05:47:58 INFO - 'SHLVL': '1', 05:47:58 INFO - 'TERM': 'linux', 05:47:58 INFO - 'TMOUT': '86400', 05:47:58 INFO - 'USER': 'cltbld', 05:47:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:58 INFO - '_': '/tools/buildbot/bin/python'} 05:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:58 INFO - Downloading/unpacking jsonschema 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:00 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:48:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:00 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:48:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:00 INFO - warning: no files found matching '*.txt' 05:48:00 INFO - no previously-included directories found matching 'build' 05:48:00 INFO - no previously-included directories found matching 'dist' 05:48:00 INFO - no previously-included directories found matching '.git*' 05:48:00 INFO - Installing collected packages: jsonschema, functools32 05:48:00 INFO - Running setup.py install for functools32 05:48:00 INFO - warning: no files found matching '*.txt' 05:48:00 INFO - no previously-included directories found matching 'build' 05:48:00 INFO - no previously-included directories found matching 'dist' 05:48:00 INFO - no previously-included directories found matching '.git*' 05:48:00 INFO - Successfully installed jsonschema functools32 05:48:00 INFO - Cleaning up... 05:48:00 INFO - Return code: 0 05:48:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7522b25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11aa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', '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:48:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:48:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:48:00 INFO - Using env: {'DISPLAY': ':0', 05:48:00 INFO - 'HOME': '/home/cltbld', 05:48:00 INFO - 'LANG': 'en_US.UTF-8', 05:48:00 INFO - 'LANGUAGE': 'en_US:en', 05:48:00 INFO - 'LOGNAME': 'cltbld', 05:48:00 INFO - 'MAIL': '/var/mail/cltbld', 05:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:00 INFO - 'MOZ_NO_REMOTE': '1', 05:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:00 INFO - 'NO_EM_RESTART': '1', 05:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:00 INFO - 'SHELL': '/bin/bash', 05:48:00 INFO - 'SHLVL': '1', 05:48:00 INFO - 'TERM': 'linux', 05:48:00 INFO - 'TMOUT': '86400', 05:48:00 INFO - 'USER': 'cltbld', 05:48:00 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:00 INFO - '_': '/tools/buildbot/bin/python'} 05:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:01 INFO - Downloading/unpacking flake8 05:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:48:02 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:48:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:48:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:48:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:03 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:48:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:48:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:03 INFO - no previously-included directories found matching 'docs/_build' 05:48:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:48:03 INFO - Running setup.py install for pep8 05:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:03 INFO - no previously-included directories found matching 'docs/_build' 05:48:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:48:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:48:03 INFO - Cleaning up... 05:48:03 INFO - Return code: 0 05:48:03 INFO - Running post-action listener: _resource_record_post_action 05:48:03 INFO - Running post-action listener: _start_resource_monitoring 05:48:03 INFO - Starting resource monitoring. 05:48:03 INFO - ##### 05:48:03 INFO - ##### Running install step. 05:48:03 INFO - ##### 05:48:03 INFO - Running pre-action listener: _resource_record_pre_action 05:48:03 INFO - Running main action method: install 05:48:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:48:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:48:03 INFO - Reading from file tmpfile_stdout 05:48:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:48:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:48:03 INFO - Reading from file tmpfile_stdout 05:48:03 INFO - Output received: 05:48:03 INFO - Usage: mozinstall [options] installer 05:48:03 INFO - Options: 05:48:03 INFO - -h, --help show this help message and exit 05:48:03 INFO - -d DEST, --destination=DEST 05:48:03 INFO - Directory to install application into. [default: 05:48:03 INFO - "/builds/slave/test-pgo"] 05:48:03 INFO - --app=APP Application being installed. [default: firefox] 05:48:03 INFO - mkdir: /builds/slave/test-pgo/build/application 05:48:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:48:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:48:19 INFO - Reading from file tmpfile_stdout 05:48:19 INFO - Output received: 05:48:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:48:19 INFO - Running post-action listener: _resource_record_post_action 05:48:19 INFO - ##### 05:48:19 INFO - ##### Running run-tests step. 05:48:19 INFO - ##### 05:48:19 INFO - Running pre-action listener: _resource_record_pre_action 05:48:19 INFO - Running main action method: run_tests 05:48:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:48:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:48:19 INFO - Python 2.7.3 05:48:19 INFO - Return code: 0 05:48:19 INFO - grabbing minidump binary from tooltool 05:48:19 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:48:19 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 0x123b840>, '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 0x11a86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:48:19 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:48:19 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:48:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:19 INFO - Return code: 0 05:48:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:48:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:48:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:48:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:48:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:48:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:48:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:48:20 INFO - Return code: 0 05:48:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:48:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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:48:20 INFO - Using env: {'DISPLAY': ':0', 05:48:20 INFO - 'HOME': '/home/cltbld', 05:48:20 INFO - 'LANG': 'en_US.UTF-8', 05:48:20 INFO - 'LANGUAGE': 'en_US:en', 05:48:20 INFO - 'LOGNAME': 'cltbld', 05:48:20 INFO - 'MAIL': '/var/mail/cltbld', 05:48:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:48:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:20 INFO - 'MOZ_NO_REMOTE': '1', 05:48:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:20 INFO - 'NO_EM_RESTART': '1', 05:48:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:48:20 INFO - 'SHELL': '/bin/bash', 05:48:20 INFO - 'SHLVL': '1', 05:48:20 INFO - 'TERM': 'linux', 05:48:20 INFO - 'TMOUT': '86400', 05:48:20 INFO - 'USER': 'cltbld', 05:48:20 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410', 05:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:20 INFO - '_': '/tools/buildbot/bin/python'} 05:48:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:48:21 INFO - mozversion application_buildid: 20160102030217 05:48:21 INFO - mozversion application_changeset: ce643acfab14d95bea2fb6c4f56477413514b686 05:48:21 INFO - mozversion application_display_name: Nightly 05:48:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:21 INFO - mozversion application_name: Firefox 05:48:21 INFO - mozversion application_remotingname: firefox 05:48:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:21 INFO - mozversion application_vendor: Mozilla 05:48:21 INFO - mozversion application_version: 46.0a1 05:48:21 INFO - mozversion platform_buildid: 20160102030217 05:48:21 INFO - mozversion platform_changeset: ce643acfab14d95bea2fb6c4f56477413514b686 05:48:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:21 INFO - mozversion platform_version: 46.0a1 05:48:21 INFO - using testdate: 1451742501 05:48:21 INFO - actual date: 1451742501 05:48:21 INFO - starting webserver on 'localhost:38754' 05:48:21 INFO - SUITE-START | Running 3 tests 05:48:21 INFO - TEST-START | dromaeo_css 05:48:21 INFO - operating with platform_type : linux_ 05:48:21 INFO - Initialising browser for dromaeo_css test... 05:48:21 INFO - TEST-INFO | started process 12001 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgtnxdd/profile http://localhost:38754/getInfo.html) 05:48:25 INFO - PROCESS | 12001 | __metrics Screen width/height:1600/1200 05:48:25 INFO - PROCESS | 12001 | colorDepth:24 05:48:25 INFO - PROCESS | 12001 | Browser inner width/height: 1024/697 05:48:25 INFO - PROCESS | 12001 | __metrics 05:48:25 INFO - PROCESS | 12001 | 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:48:25 INFO - PROCESS | 12001 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:26 INFO - TEST-INFO | 12001: exit 0 05:48:26 INFO - Browser initialized. 05:48:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:26 INFO - TEST-INFO | started process 12097 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgtnxdd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:38 INFO - PROCESS | 12097 | RSS: Main: 149676032 05:48:38 INFO - PROCESS | 12097 | 05:49:30 INFO - PROCESS | 12097 | 1451742570031 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:51:38 INFO - PROCESS | 12097 | Cycle 1(1): loaded http://localhost:38754/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38754/tests/dromaeo/cssquery-ext.html) 05:51:39 INFO - PROCESS | 12097 | RSS: Main: 264982528 05:51:39 INFO - PROCESS | 12097 | 05:54:42 INFO - PROCESS | 12097 | Cycle 1(1): loaded http://localhost:38754/tests/dromaeo/cssquery-ext.html (next: http://localhost:38754/tests/dromaeo/cssquery-jquery.html) 05:54:42 INFO - PROCESS | 12097 | RSS: Main: 232136704 05:54:42 INFO - PROCESS | 12097 | 05:57:44 INFO - PROCESS | 12097 | Cycle 1(1): loaded http://localhost:38754/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38754/tests/dromaeo/cssquery-mootools.html) 05:57:45 INFO - PROCESS | 12097 | RSS: Main: 233029632 05:57:45 INFO - PROCESS | 12097 | 06:00:47 INFO - PROCESS | 12097 | Cycle 1(1): loaded http://localhost:38754/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38754/tests/dromaeo/cssquery-prototype.html) 06:00:47 INFO - PROCESS | 12097 | RSS: Main: 217165824 06:00:47 INFO - PROCESS | 12097 | 06:03:50 INFO - PROCESS | 12097 | Cycle 1(1): loaded http://localhost:38754/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38754/tests/dromaeo/cssquery-yui.html) 06:03:50 INFO - PROCESS | 12097 | RSS: Main: 219926528 06:03:50 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | Cycle 1(1): loaded http://localhost:38754/tests/dromaeo/cssquery-yui.html (next: http://localhost:38754/tests/dromaeo/cssquery-dojo.html) 06:06:53 INFO - PROCESS | 12097 | RSS: Main: 272134144 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | __start_tp_report 06:06:53 INFO - PROCESS | 12097 | _x_x_mozilla_page_load 06:06:53 INFO - PROCESS | 12097 | _x_x_mozilla_page_load_details 06:06:53 INFO - PROCESS | 12097 | |i|pagename|runs| 06:06:53 INFO - PROCESS | 12097 | |0;dojo.html;3128.3117714102896;3184.5541624172606;3223.339215460829;3224.516322551617;3255.26756479792;5091.490850914916;5192.480751924815;5240.685558866466;5250.7112108834;5302.072137375953;5140.331756871611;5167.147420675584;5224.63427560071;5257.631965762398;5260.289860868782;4740.241561350184;4763.3569468121705;4767.5709186173235;4826.855194344158;4862.610991120702;4812.7352995585225;4825.372701548794;4870.220764677652;4875.8537243882565;4885.560299573038;4651.069786042805;4696.788644511005;4756.90486190276;4785.545373189541;4804.975975120137;4742.715437073786;4756.857294281177;4757.048590281957;4776.713397196145;4790.856274311776;4635.351050852883;4741.525847415265;4743.7628118594275;4758.191107511731;4775.116603428342;4976.129177393942;5014.824481143142;5031.622628302892;5058.696478211319;5093.006863661588;5543.029969755276;5546.306711661043;5548.72256387179;5549.278593782823;5559.777608895639;5504.6421982571;5607.495325420732;5607.57943154261;5647.124695672177;5649.830505084854;5177.508136727005;5184.040952423814;5258.158694608883;5276.92084618731;5288.127458969266;5739.053056245672;5744.827655170351;5750.281214848144;5775.537956963432;5796.449337312949;5524.392316845224;5524.4199359066715;5537.944620553823;5550.722463876871;5557.055300598908;5481.808136715196;5531.612787104864;5578.972105139448;5591.720413979285;5618.719064046782;5566.081596536607;5591.692456914909;5592.888142237214;5595.188697638901;5619.381867994517;5530.10111899695;5575.219469274305;5577;5582.553395728332;5582.7766889324785;4276.273033584298;4283.400323954649;4379.4087798147475;4387.824487020547;4431.0251744616135;3927.2145570885937;3929.7838618876235;3951.5258169019903;3952.2490726761825;3961.9405708914387;5117.104506711311;5118.948810511922;5121.0526052679625;5163;5209;5424.077906755861;5557.388687244481;5569.805056823073;5571.192177134293;5624.803131890446;5133.974330128325;5137.33214682089;5160.40655324635;5161.019406312788;5185.377754669464;4772.308015337826;4789.95210047902;4791.712497250176;4797.520247975174;4818.95181048185;5666.829995100154;5714.771409143587;5774.0761478163295;5774.2782152230975;5789.710514474344;5522.972385138049;5544.168374743821;5647.040003199384;5656.066748986371;5679.403662615531;5806.274215723035;5811.128330750421;5811.854703632443;5813.593048486566;5820.534357251325;5440.619156658996;5525.917111243415;5532.585056120887;5542.418046105262;5544.251526043932;5628.409017053151;5687.20379146928;5692.914606280992;5697.316322041382;5741.339745929272;5468.671879687232;5500.092484740133;5527.39198688152;5529.336479622471;5530.391656917655;5346.893062138814;5388.380336261223;5411.648242864201;5483.616146869681;5507.449255074461;5326.121190003761;5336.599755018467;5342.171963345688;5369.731513424391;5374.677519348852;5408.567314614743;5408.5673146149;5411.83764487066;5414.593905457185;5433.266509021231;5246.685198887926;5305.389880163676;5318.228856815817;5376.354837419534;5387 06:06:53 INFO - PROCESS | 12097 | |1;ext.html;516.891452794913;519.1589624807812;523.4033202149548;544.0506316477747;554.5037191713419;27889.721102788964;28492.572611410844;35481.645183548186;36388.45417318743;36455.27089458209;39127.413088803616;39635.20729585407;39719;39725.60274397255;39726.60273397265;8196.91803081969;8347.83304333913;8354.331653467738;8355.248027677508;8357.665693372257;8278.089410164877;8468.872966905501;8513.361497887652;8518.063013068557;8520;8690.782730431727;8798.51608161551;8817.73546793594;8819.95590022049;8823.250023747989;8562.700305489308;8631.913680863237;8659.696910608098;8678.609462574137;8683.739487815345;8270.131636178176;8470.491770493729;8479.940007499063;8507.319414446829;8515.74452766418;38854.80572597147;39426;39650.801745991375;39748.40377394341;39789.602103978876;3302.339532093567;3307.7849939753837;3452.5684289463816;3647.361711700442;4055.776932268724;29080.41839163226;29374.41251174986;29581.112566623036;30237.941672041372;30645.01614790063;3415.316936612687;3477.9130521736906;3500.264944361687;3562.447820587813;3575.6245594212755;260355;260380;261104;261458;261826;55193.724031379585;55232.72383638056;55602.16596751052;55629.165562516595;55672.721636392365;53520;54172.729136354064;60405.697971509864;61279;61403;14244.07413518118;14377.712445751236;14409.495667651581;14427.711445771236;14516.274186290642;10250.179985601135;10497.685069447929;10964.890351096386;11104.333739975627;11113.777724445466;15277.312520936584;15402.383904643688;15443.382264709286;15480.84519154794;15985.120818355103;7388.926110738824;7422.183559808417;7506.13679426862;7631.732889348847;7664.271894170045;901.9458832470073;982.1946004276567;1088.9094031347008;1115.5482029777952;1141.8305220081745;27815;27927.720722792918;28236.43527129487;28241.43517129646;28243.293917652223;968.1867231525553;998.336106489191;1011.5852500474917;1089.727568107973;1120.5685810962675;13758.380872860746;14114.153150810984;14233;14266.144031358152;14636.268186590627;317967;319118;321450;321794;322222;49740;50015.49984500181;50022.24966625503;50063.24905126426;50119.24821127686;1279.5329704657734;1286.3825363825417;1295.0416691648113;1308.6793735534854;1323.0804590809487;23729.58980485876;24343;24640.753592463847;24798.504029919663;24810.875945620155;43176.35235471408;43477;43852.780736096116;43876;43890.12219755523;285180;286601;288724;288980;289026;23468.76531234666;23676.88161559181;23699.289021329387;28864.42271154523;29251;34621.13447163841;35080.47379289262;35108.82445587858;35303.470447943815;35465.82267088648;25635.472699873015;25684.871575642002;26665;28900.132996010154;29037;32853;33646.66353336435;33761;33792.3241535163;33832.83083584566;26405;26630;35110.64889351074;35214.647853521135;35391.46912796362;25492;28580.42839143247;29121;29135.417291654474;29138;21925.671114933608;23036.769632304135;23869.641955370334;24181;24254 06:06:53 INFO - PROCESS | 12097 | |2;jquery.html;361.39466393790394;363.96906262967644;365.3515010855731;366.14505130520234;367.8675676756368;13620.182789032666;13829.585112446643;16315.673686526277;16482.42311519097;16938.237779299914;14341.56975290743;14410.92794536026;14807.33366998485;14807.55577332679;14819.629509262273;5065.138926382524;5149.510796474338;5220.190870415092;5237.711925844077;5237.973810130944;3932.351162058257;4036.697247706419;5218.1650935850275;5229.294045303874;5824.184614154022;5833.474987251147;5852.590318677694;5887.35239123696;5891.204687367215;5909.172715819789;5733.569982251327;5865.648061116325;5902.32123305821;5911.586188966774;5916.91124633133;5222.32109825724;5228.4510126436935;5229.189475631283;5229.241759944786;5231.110711179071;18563.16465759044;19631.90184049085;19885.701714474293;20040.298589549297;20045.498862528406;2053.722747429108;2111.134434881691;2129.4676330917273;2154.005931754862;2165.621016322137;12981.026423018311;13031.86968130316;13117.803232951514;13337.599872003855;13414.26221557814;1797.4607617714764;1816.9182386792627;1823.6597694280495;1828.4057681253646;1891.8581106417073;58377.416225838046;58671;58932.705336473475;63305.68347158281;63448.2827366564;9101.81796364069;9125.77185570366;9142.908570914205;9234.122758337948;9699;11669.124815638861;11669.708257293636;11672.766544669228;11697.941510292394;11750.823737643943;7326.487145899842;7332.1934587195365;7369.189389167187;7384.2246564111065;7638.923610763933;7323.780286591411;7388.630568471663;7389.8152546186775;7433;7472.850542989218;5642.435756424325;5650.208970744099;5674.319081710221;5688.77244910199;5803.187553742479;1541.3372249932636;1639.213177674699;1671.7993840739189;1695.711729006072;1790.7822680577333;880.8986966498807;922.216116301152;967.2552134856262;968.5883499512679;1047.3401756893109;14081.225532595601;16325.755113673304;16660.50018499447;16694.165291735364;16962.49112526626;897.555709923579;934.1919239857474;947.6446332625266;964.064857088623;1013.533774463755;7697.923020769721;8376.288015518627;8865.778355541162;8909.866352004725;9439;564472;568258;572250.5878902094;580243;585294;76679.2332076672;77147;78756.6062169697;80103.59948200222;80377;1132.116948779953;1136.108155098244;1144.1418935798151;1147.6212849759559;1156.9132315076404;14704.705905881608;14942;15159.696806063597;15226.162561059247;15494.612634683772;18890.811091889456;19264.90367548153;31815;34265.972020839414;36583.26833463369;44576.777116114215;45054.77472612747;45107.32339014983;45383.54616453925;49588.752056239486;9008.729738107868;9075.54622268897;9222.584983675884;9245.815083698153;9356.251499880129;11165.934302154128;11240.213185077293;11349.48927298257;11367.033802126913;12412.317322547347;11062.668119956414;11134.665960021212;11388;11653.883461165618;12881.742365152832;11776;13037.674058148623;13212.471501139848;13542.458301667823;14034.157950523002;12646.494140234656;12882.806757898452;13101.934490327869;13144.0799144059;13160.078794484294;9056.909430905607;9078.228350590274;9484.762880927756;9516.19112375456;9524.14282714559;9579.616815327308;13455.46178152863;13645.727085458433;14205.573832785032;14280.857191427953 06:06:53 INFO - PROCESS | 12097 | |3;mootools.html;1244.5270797097103;1295.9546415875445;1296.4490091711023;1317.4335035934544;1816.2553353125222;6850.143732033496;7400.185979542252;7568.281013303741;7572.772816815491;7578.355839753627;7398.778036658895;7585.013948186728;7589.051368578927;7589.127250366196;7597.202293759145;1927.286903845579;1960.872543284682;2190.7371115466085;2224.655178447335;2262.2195342606774;2276;2280.5096904165603;2280.5894938910988;2283.0867652938873;2284.983182483795;2086.374087773662;2167.4147980045377;2169.934901952944;2170.2838063439026;2170.2838063439026;2209.701690271817;2227.365200917731;2243.663450482424;2285.234446460421;2287.553926984239;2242.798148166673;2265.3770213191337;2286.2912497125944;2288.3592594073684;2312.9653055204185;7535.321821036078;7608.771736847848;7616.809579760495;7617.885731714029;7620.199879012679;4463.531329210418;4542.04617030424;4570.360149579062;4572.337011133401;4579.244424669925;2878.453093912171;3000.699930007004;3077.461444247248;3093.257618171645;3107.782455228135;960.5149399553251;967.2213867836389;968.2786324188525;987.4766373821886;998.1465846701038;9806.313558050939;10076.09315161639;10105.848412273821;10112.747181320452;10135.341202821794;4030.4760381150263;4050.9797451012555;4098.918021639551;4184.476940382391;4187.748735075906;8944.68693595721;8947.507887066144;8960.193582577469;8961.23829474489;8961.865572016424;4516.616087632522;4529.705569138061;4544.613707834871;4620.768961551909;4632.119897219518;4207.97896010518;4228.85199018039;4234.089670720809;4238.109996900624;4241.384999175164;3343.4650455926935;3375.9493607595905;3381.966180338214;3631.5279013728573;3674.6692797647806;1147.0594112827569;1150.424787606197;1155.653304008794;1158.5076342554548;1161.848959635259;966.8888077870994;967.6564819489121;1044.1594516414207;1090.6455401994224;1359.9592012239648;7111.893321600181;7157.498975071695;7176.82057948545;7183.245759195209;7192.928070719226;1162.7616338650557;1165.8484397028333;1177.611388241878;1198.7422704118655;1201.8677945425995;5551.72241387929;5595.0208713475795;5643.463870932255;5644.661320320712;5647.971760141255;8597.957010215034;8832.823343533222;8835.33734969867;8844.778880528038;8929.10708929102;8831.514266715263;9005.819883602291;9033.367664263438;9040.231580315747;9047.050059743764;6843.623600702009;7174.426045916314;7187.31720486553;7189.604571748604;7208.24313447091;6770.2891196425635;6817.181938167451;6828.180618325634;6830.521863469509;6830.726770929107;7651.88522172179;8086.7169649062;8095.190480951857;8109.635066421907;8301.501909885426;8386.203310685476;8520.61657225414;8521.573921304034;8547.74356769298;8558.486490810572;6507.869842603216;6626.204855417381;6631.204255489372;6631.63526006055;6632;6413.647249401328;6527;6939.236683964861;7099.290070992859;7179.533330333512;6562.475001999924;6575.80272591823;6618.900716489353;6706.83232919181;6842.04211410393;6609.735610575715;6611.272759996493;6624.536282460182;6712.295209002984;6757.93242067573;6577.671116444254;6600.504962127956;6649.63427011519;6656.534042617164;6664.400203981665;6085.726142323518;6116.17431646722;6126.724297406717;6137.84655383619;6146.846328841814;6159.692015399301;6288.905666415099;6289.842753931005;6338.207724034496;6353.237611486651 06:06:53 INFO - PROCESS | 12097 | |4;prototype.html;343.6151510308454;344.67944811325486;345.3266131044464;348.65657327532375;350.48526820066036;5798.275215598051;5852.707364631773;5854.297484301885;5889.2049573307595;5932.228810254672;5522.254495643087;5580.525655319303;5713.771449142029;5779.393163717812;5801.854953626162;4505.5719706627815;4507.053518761048;4507.760365899388;4509.909801803954;4517.073999830027;4289.463817022872;4509.1883460977015;4517.322401639747;4518.70628409154;4522.3216517522305;4344.500382456011;4369.541198174194;4456.844010459635;4472.3515090311885;4475.060237350161;4424.823007079713;4433.889152771174;4437.933430998538;4440.844570440036;4445.844395446144;3907.472491213678;3908.4137379393032;3909.6872250219913;3911.1395492991783;3918.5101862267215;5449.182622606601;5539.944600554023;5545.972270138664;5546.362168350611;5552.167174923794;5178.430372659004;5188.948110518884;5190.351206099238;5197.948020519784;5209.869753256161;6111.449969502766;6118.755249790003;6125.264968203799;6126.387361263838;6127.417895299939;4363.280058790296;4375.2124617568825;4375.7593332366705;4376.124775044972;4381.627561657263;6290.779822706183;6388.425041746265;6415.26224484181;6415.262244841856;6415.903761443582;4506.864794056183;4507.414036175342;4508.842190523316;4521.570450807168;4525.456945166536;4524.660650451229;4562.703424277412;4565.315202719618;4570.81716731327;4575.473820510617;5181.5595674368105;5195.038917800219;5204.323437953042;5217.34783152106;5219.217117432339;5989.940100598938;6165.938340616626;6179.258488981351;6187.84530386735;6189.133521307021;1559.5165498695214;1568.0826716370823;1570.8272090070084;1570.874330053593;1572.1667516216196;1041.0740130758038;1048.1457612046158;1049.0401282826128;1049.821530339844;1064.7497838008062;5796.956547821348;5798.246227990334;5806.361300256968;5808.3901190375245;5811.0411782056335;6300.59046161998;6310.873782524323;6312.905306420407;6318.210223722035;6320.62076275425;5611.859703507445;5678.432156784371;5727.398623144593;5728.684922329312;5731.971340143356;3369.5451114099774;3419.760616756853;3423.8972830815114;3425.1094715374184;3425.5033020212427;6559.672016399257;6592;6596.60420374779;6602.73589056442;6619.834504137435;6360.9045864312075;6520.869582608321;6538.313477084837;6555.246146693096;6556.967215163893;6600.1089852869245;6619.338066193439;6620.337966203341;6620.933790662032;6621.86756264872;6338.334474880256;6358.395952384516;6361.173047503795;6361.664050549436;6363.077353783583;6156.09858123881;6297.653629050446;6299.118123462627;6304.905426418699;6312.715927783169;6610.768623098168;6614.735410583523;6622.443725724547;6624.205095388392;6626.83432914181;4433.490148632948;4435.82256709728;4438.733675979452;4442.222611043119;4442.600165985077;6218.19163508741;6362.363763623785;6363.681815909279;6371;6431.903521447276;6226.003839385677;6227.221597300338;6228.065790131516;6228.532860035606;6235.407636274546;6215.254169499689;6227.719752611053;6229.034499652561;6236.345183755821;6245.750169993149;5999.370066143167;6038.547108966933;6090.756369745338;6129.785457508966;6134.7852825152695;6199.163112979871;6201.224846894138;6208.565400421927;6219.160413344141;6226.470749986302;6122.632642041492;6122.938770612237;6129.877402451837;6130.356312587292;6131.724072416841 06:06:53 INFO - PROCESS | 12097 | |5;yui.html;739.223814994256;783.8589053970285;806.6047636658031;868.3487384461654;895.9686410975618;13092.279924604143;13317.667058323546;13319.001074919384;13401.731965360712;13408.798868016987;12902.22586644802;13248.867511324885;13269.601911942656;13272.933635331834;13297;675.395521008697;686.5743239191684;832.063928080909;832.5629044751508;849.1466076593015;820.1962077164383;833.3916241143969;837.5979529825687;840.4201101240155;841.1504380575601;874.6632546469591;890.7684002159452;893.4148132972913;893.7944272817256;896.7713233125544;699.2552931128357;710.9431245500348;711.4841739738699;855.3584811391456;870.9782255443602;645.686841881687;646.3084499585445;646.3310473659786;646.5894157210205;649.8505343770959;13390.598282051555;13492.325383730775;13494.662633434145;13495.527656532073;13512.932435337858;12197.512099516009;12837.935810320982;12875.420606072748;12903.516095649027;13003.869961300456;9948.10467057961;9975.401475911469;9999.200063994864;10232;10262.7434314142;3587.515685382466;3620.8008559529217;3681.37416639172;3749;3753.6246375362243;46259.768701156616;46456.7677161612;46461.767691161665;46498.76750616225;48998.265026024994;9827.017298270259;9980.850287245697;10081.445520496443;10178.949105254427;10336.638217662347;18145.183466744027;18157.909210453865;18172.63654726898;18174.545636358933;18181;7615.5430674159725;7649.847003059907;7699.615019249015;7727.111382191008;7782.143964164051;4308;4308.439902812677;4330.198913201005;4358.171947329997;4400.4939431965095;3102.953455698166;3115.5482455043893;3123.6720144384967;3144.2925341797913;3153.858076386568;571.0549041336594;574.2448679985805;582.3972188784587;588.2382314902212;588.7409539802474;625.2153547298112;653.9869202615921;665.5241502325861;687.5840116729406;712.7113519024804;8560.272376847914;8763.737087887373;8769.824603508021;8909;9115.407498512575;575.8253163546402;580.8780156167252;629.7921685843661;638.3616383616384;641.2913730328014;3818.9236215275537;3883.2815929053218;3911.413288006822;4110.77390743512;4229.154169166179;53102.46897531053;57853.42146578564;58606;58632.41367586269;58788.11817822736;52221.21668174981;52275;52496.73751631294;52893.471065289625;53054.73472632612;46239.76880115645;47022.76488617535;47038.76480617575;47512.52487475081;48399.75800120977;8094.83810323802;8331.875021874797;8583;8613.956930215309;8735;34186.829065855505;34328.14179645529;35044.64955350516;35164.82417587896;35165.64834351726;40791.7960410196;42710.78644606757;45129.323060154784;47175.76412117918;48883;10813.025598489088;11202.83195752048;11300.378479183724;11431.199816012799;11596.768064638829;11707.88292117068;11738.589149380072;11740.236884602473;12329.568465103679;12618.621441356774;10911.945440272748;11213.60752373663;11284.21010529255;11568.826467602825;11671.241369310968;11536.711582210512;11564.537418503165;11667.474963626488;11792.469338879599;12161.148719589544;10952.835707464554;11050.668479945614;11157.776844463227;11263.605773798206;11324.011393850968;9598.712038638852;9819.803603927738;9825.213982881496;10292.639757608447;10294.691159265234;8782.673043590505;8953.462792232487;9328.766780830534;9512.476813775309;9784.902150978683 06:06:53 INFO - PROCESS | 12097 | __end_tp_report 06:06:53 INFO - PROCESS | 12097 | __start_cc_report 06:06:53 INFO - PROCESS | 12097 | _x_x_mozilla_cycle_collect,899 06:06:53 INFO - PROCESS | 12097 | __end_cc_report 06:06:53 INFO - PROCESS | 12097 | __startTimestamp1451743613506__endTimestamp 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | ------- Summary: start ------- 06:06:53 INFO - PROCESS | 12097 | Number of tests: 6 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | [#0] dojo.html Cycles:165 Average:5190.98 Median:5369.73 stddev:555.27 (10.3%) stddev-sans-first:532.87 06:06:53 INFO - PROCESS | 12097 | Values: 3128.3 3184.6 3223.3 3224.5 3255.3 5091.5 5192.5 5240.7 5250.7 5302.1 5140.3 5167.1 5224.6 5257.6 5260.3 4740.2 4763.4 4767.6 4826.9 4862.6 4812.7 4825.4 4870.2 4875.9 4885.6 4651.1 4696.8 4756.9 4785.5 4805.0 4742.7 4756.9 4757.0 4776.7 4790.9 4635.4 4741.5 4743.8 4758.2 4775.1 4976.1 5014.8 5031.6 5058.7 5093.0 5543.0 5546.3 5548.7 5549.3 5559.8 5504.6 5607.5 5607.6 5647.1 5649.8 5177.5 5184.0 5258.2 5276.9 5288.1 5739.1 5744.8 5750.3 5775.5 5796.4 5524.4 5524.4 5537.9 5550.7 5557.1 5481.8 5531.6 5579.0 5591.7 5618.7 5566.1 5591.7 5592.9 5595.2 5619.4 5530.1 5575.2 5577.0 5582.6 5582.8 4276.3 4283.4 4379.4 4387.8 4431.0 3927.2 3929.8 3951.5 3952.2 3961.9 5117.1 5118.9 5121.1 5163.0 5209.0 5424.1 5557.4 5569.8 5571.2 5624.8 5134.0 5137.3 5160.4 5161.0 5185.4 4772.3 4790.0 4791.7 4797.5 4819.0 5666.8 5714.8 5774.1 5774.3 5789.7 5523.0 5544.2 5647.0 5656.1 5679.4 5806.3 5811.1 5811.9 5813.6 5820.5 5440.6 5525.9 5532.6 5542.4 5544.3 5628.4 5687.2 5692.9 5697.3 5741.3 5468.7 5500.1 5527.4 5529.3 5530.4 5346.9 5388.4 5411.6 5483.6 5507.4 5326.1 5336.6 5342.2 5369.7 5374.7 5408.6 5408.6 5411.8 5414.6 5433.3 5246.7 5305.4 5318.2 5376.4 5387.0 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | [#1] ext.html Cycles:180 Average:44224.91 Median:33812.58 stddev:76219.63 (225.4%) stddev-sans-first:76362.80 06:06:53 INFO - PROCESS | 12097 | Values: 516.9 519.2 523.4 544.1 554.5 27889.7 28492.6 35481.6 36388.5 36455.3 39127.4 39635.2 39719.0 39725.6 39726.6 8196.9 8347.8 8354.3 8355.2 8357.7 8278.1 8468.9 8513.4 8518.1 8520.0 8690.8 8798.5 8817.7 8820.0 8823.3 8562.7 8631.9 8659.7 8678.6 8683.7 8270.1 8470.5 8479.9 8507.3 8515.7 38854.8 39426.0 39650.8 39748.4 39789.6 3302.3 3307.8 3452.6 3647.4 4055.8 29080.4 29374.4 29581.1 30237.9 30645.0 3415.3 3477.9 3500.3 3562.4 3575.6 260355.0 260380.0 261104.0 261458.0 261826.0 55193.7 55232.7 55602.2 55629.2 55672.7 53520.0 54172.7 60405.7 61279.0 61403.0 14244.1 14377.7 14409.5 14427.7 14516.3 10250.2 10497.7 10964.9 11104.3 11113.8 15277.3 15402.4 15443.4 15480.8 15985.1 7388.9 7422.2 7506.1 7631.7 7664.3 901.9 982.2 1088.9 1115.5 1141.8 27815.0 27927.7 28236.4 28241.4 28243.3 968.2 998.3 1011.6 1089.7 1120.6 13758.4 14114.2 14233.0 14266.1 14636.3 317967.0 319118.0 321450.0 321794.0 322222.0 49740.0 50015.5 50022.2 50063.2 50119.2 1279.5 1286.4 1295.0 1308.7 1323.1 23729.6 24343.0 24640.8 24798.5 24810.9 43176.4 43477.0 43852.8 43876.0 43890.1 285180.0 286601.0 288724.0 288980.0 289026.0 23468.8 23676.9 23699.3 28864.4 29251.0 34621.1 35080.5 35108.8 35303.5 35465.8 25635.5 25684.9 26665.0 28900.1 29037.0 32853.0 33646.7 33761.0 33792.3 33832.8 26405.0 26630.0 35110.6 35214.6 35391.5 25492.0 28580.4 29121.0 29135.4 29138.0 21925.7 23036.8 23869.6 24181.0 24254.0 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | [#2] jquery.html Cycles:180 Average:29123.41 Median:2150.11 stddev:93801.84 (4362.7%) stddev-sans-first:94040.11 06:06:53 INFO - PROCESS | 12097 | Values: 361.4 364.0 365.4 366.1 367.9 13620.2 13829.6 16315.7 16482.4 16938.2 14341.6 14410.9 14807.3 14807.6 14819.6 5065.1 5149.5 5220.2 5237.7 5238.0 3932.4 4036.7 5218.2 5229.3 5824.2 5833.5 5852.6 5887.4 5891.2 5909.2 5733.6 5865.6 5902.3 5911.6 5916.9 5222.3 5228.5 5229.2 5229.2 5231.1 18563.2 19631.9 19885.7 20040.3 20045.5 2053.7 2111.1 2129.5 2154.0 2165.6 12981.0 13031.9 13117.8 13337.6 13414.3 1797.5 1816.9 1823.7 1828.4 1891.9 58377.4 58671.0 58932.7 63305.7 63448.3 9101.8 9125.8 9142.9 9234.1 9699.0 11669.1 11669.7 11672.8 11697.9 11750.8 7326.5 7332.2 7369.2 7384.2 7638.9 7323.8 7388.6 7389.8 7433.0 7472.9 5642.4 5650.2 5674.3 5688.8 5803.2 1541.3 1639.2 1671.8 1695.7 1790.8 880.9 922.2 967.3 968.6 1047.3 14081.2 16325.8 16660.5 16694.2 16962.5 897.6 934.2 947.6 964.1 1013.5 7697.9 8376.3 8865.8 8909.9 9439.0 564472.0 568258.0 572250.6 580243.0 585294.0 76679.2 77147.0 78756.6 80103.6 80377.0 1132.1 1136.1 1144.1 1147.6 1156.9 14704.7 14942.0 15159.7 15226.2 15494.6 18890.8 19264.9 31815.0 34266.0 36583.3 44576.8 45054.8 45107.3 45383.5 49588.8 9008.7 9075.5 9222.6 9245.8 9356.3 11165.9 11240.2 11349.5 11367.0 12412.3 11062.7 11134.7 11388.0 11653.9 12881.7 11776.0 13037.7 13212.5 13542.5 14034.2 12646.5 12882.8 13101.9 13144.1 13160.1 9056.9 9078.2 9484.8 9516.2 9524.1 9579.6 13455.5 13645.7 14205.6 14280.9 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | [#3] mootools.html Cycles:180 Average:5257.17 Median:6345.72 stddev:2698.65 (42.5%) stddev-sans-first:2689.36 06:06:53 INFO - PROCESS | 12097 | Values: 1244.5 1296.0 1296.4 1317.4 1816.3 6850.1 7400.2 7568.3 7572.8 7578.4 7398.8 7585.0 7589.1 7589.1 7597.2 1927.3 1960.9 2190.7 2224.7 2262.2 2276.0 2280.5 2280.6 2283.1 2285.0 2086.4 2167.4 2169.9 2170.3 2170.3 2209.7 2227.4 2243.7 2285.2 2287.6 2242.8 2265.4 2286.3 2288.4 2313.0 7535.3 7608.8 7616.8 7617.9 7620.2 4463.5 4542.0 4570.4 4572.3 4579.2 2878.5 3000.7 3077.5 3093.3 3107.8 960.5 967.2 968.3 987.5 998.1 9806.3 10076.1 10105.8 10112.7 10135.3 4030.5 4051.0 4098.9 4184.5 4187.7 8944.7 8947.5 8960.2 8961.2 8961.9 4516.6 4529.7 4544.6 4620.8 4632.1 4208.0 4228.9 4234.1 4238.1 4241.4 3343.5 3375.9 3382.0 3631.5 3674.7 1147.1 1150.4 1155.7 1158.5 1161.8 966.9 967.7 1044.2 1090.6 1360.0 7111.9 7157.5 7176.8 7183.2 7192.9 1162.8 1165.8 1177.6 1198.7 1201.9 5551.7 5595.0 5643.5 5644.7 5648.0 8598.0 8832.8 8835.3 8844.8 8929.1 8831.5 9005.8 9033.4 9040.2 9047.1 6843.6 7174.4 7187.3 7189.6 7208.2 6770.3 6817.2 6828.2 6830.5 6830.7 7651.9 8086.7 8095.2 8109.6 8301.5 8386.2 8520.6 8521.6 8547.7 8558.5 6507.9 6626.2 6631.2 6631.6 6632.0 6413.6 6527.0 6939.2 7099.3 7179.5 6562.5 6575.8 6618.9 6706.8 6842.0 6609.7 6611.3 6624.5 6712.3 6757.9 6577.7 6600.5 6649.6 6656.5 6664.4 6085.7 6116.2 6126.7 6137.8 6146.8 6159.7 6288.9 6289.8 6338.2 6353.2 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | [#4] prototype.html Cycles:180 Average:5170.59 Median:5798.26 stddev:1542.78 (26.6%) stddev-sans-first:1503.97 06:06:53 INFO - PROCESS | 12097 | Values: 343.6 344.7 345.3 348.7 350.5 5798.3 5852.7 5854.3 5889.2 5932.2 5522.3 5580.5 5713.8 5779.4 5801.9 4505.6 4507.1 4507.8 4509.9 4517.1 4289.5 4509.2 4517.3 4518.7 4522.3 4344.5 4369.5 4456.8 4472.4 4475.1 4424.8 4433.9 4437.9 4440.8 4445.8 3907.5 3908.4 3909.7 3911.1 3918.5 5449.2 5539.9 5546.0 5546.4 5552.2 5178.4 5188.9 5190.4 5197.9 5209.9 6111.4 6118.8 6125.3 6126.4 6127.4 4363.3 4375.2 4375.8 4376.1 4381.6 6290.8 6388.4 6415.3 6415.3 6415.9 4506.9 4507.4 4508.8 4521.6 4525.5 4524.7 4562.7 4565.3 4570.8 4575.5 5181.6 5195.0 5204.3 5217.3 5219.2 5989.9 6165.9 6179.3 6187.8 6189.1 1559.5 1568.1 1570.8 1570.9 1572.2 1041.1 1048.1 1049.0 1049.8 1064.7 5797.0 5798.2 5806.4 5808.4 5811.0 6300.6 6310.9 6312.9 6318.2 6320.6 5611.9 5678.4 5727.4 5728.7 5732.0 3369.5 3419.8 3423.9 3425.1 3425.5 6559.7 6592.0 6596.6 6602.7 6619.8 6360.9 6520.9 6538.3 6555.2 6557.0 6600.1 6619.3 6620.3 6620.9 6621.9 6338.3 6358.4 6361.2 6361.7 6363.1 6156.1 6297.7 6299.1 6304.9 6312.7 6610.8 6614.7 6622.4 6624.2 6626.8 4433.5 4435.8 4438.7 4442.2 4442.6 6218.2 6362.4 6363.7 6371.0 6431.9 6226.0 6227.2 6228.1 6228.5 6235.4 6215.3 6227.7 6229.0 6236.3 6245.8 5999.4 6038.5 6090.8 6129.8 6134.8 6199.2 6201.2 6208.6 6219.2 6226.5 6122.6 6122.9 6129.9 6130.4 6131.7 06:06:53 INFO - PROCESS | 12097 | 06:06:53 INFO - PROCESS | 12097 | [#5] yui.html Cycles:180 Average:13845.60 Median:47030.76 stddev:16019.32 (34.1%) stddev-sans-first:16034.02 06:06:53 INFO - PROCESS | 12097 | Values: 739.2 783.9 806.6 868.3 896.0 13092.3 13317.7 13319.0 13401.7 13408.8 12902.2 13248.9 13269.6 13272.9 13297.0 675.4 686.6 832.1 832.6 849.1 820.2 833.4 837.6 840.4 841.2 874.7 890.8 893.4 893.8 896.8 699.3 710.9 711.5 855.4 871.0 645.7 646.3 646.3 646.6 649.9 13390.6 13492.3 13494.7 13495.5 13512.9 12197.5 12837.9 12875.4 12903.5 13003.9 9948.1 9975.4 9999.2 10232.0 10262.7 3587.5 3620.8 3681.4 3749.0 3753.6 46259.8 46456.8 46461.8 46498.8 48998.3 9827.0 9980.9 10081.4 10178.9 10336.6 18145.2 18157.9 18172.6 18174.5 18181.0 7615.5 7649.8 7699.6 7727.1 7782.1 4308.0 4308.4 4330.2 4358.2 4400.5 3103.0 3115.5 3123.7 3144.3 3153.9 571.1 574.2 582.4 588.2 588.7 625.2 654.0 665.5 687.6 712.7 8560.3 8763.7 8769.8 8909.0 9115.4 575.8 580.9 629.8 638.4 641.3 3818.9 3883.3 3911.4 4110.8 4229.2 53102.5 57853.4 58606.0 58632.4 58788.1 52221.2 52275.0 52496.7 52893.5 53054.7 46239.8 47022.8 47038.8 47512.5 48399.8 8094.8 8331.9 8583.0 8614.0 8735.0 34186.8 34328.1 35044.6 35164.8 35165.6 40791.8 42710.8 45129.3 47175.8 48883.0 10813.0 11202.8 11300.4 11431.2 11596.8 11707.9 11738.6 11740.2 12329.6 12618.6 10911.9 11213.6 11284.2 11568.8 11671.2 11536.7 11564.5 11667.5 11792.5 12161.1 10952.8 11050.7 11157.8 11263.6 11324.0 9598.7 9819.8 9825.2 10292.6 10294.7 8782.7 8953.5 9328.8 9512.5 9784.9 06:06:53 INFO - PROCESS | 12097 | -------- Summary: end -------- 06:06:53 INFO - PROCESS | 12097 | 06:06:54 INFO - TEST-INFO | 12097: exit 0 06:06:54 INFO - TEST-OK | dromaeo_css | took 1113202ms 06:06:54 INFO - TEST-START | kraken 06:06:54 INFO - operating with platform_type : linux_ 06:06:54 INFO - Initialising browser for kraken test... 06:06:54 INFO - TEST-INFO | started process 12293 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3xnUtO/profile http://localhost:38754/getInfo.html) 06:06:58 INFO - PROCESS | 12293 | __metrics Screen width/height:1600/1200 06:06:58 INFO - PROCESS | 12293 | colorDepth:24 06:06:58 INFO - PROCESS | 12293 | Browser inner width/height: 1024/697 06:06:58 INFO - PROCESS | 12293 | __metrics 06:06:58 INFO - PROCESS | 12293 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:06:58 INFO - PROCESS | 12293 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:59 INFO - TEST-INFO | 12293: exit 0 06:06:59 INFO - Browser initialized. 06:06:59 INFO - Running cycle 1/1 for kraken test... 06:06:59 INFO - TEST-INFO | started process 12375 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3xnUtO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:11 INFO - PROCESS | 12375 | RSS: Main: 150249472 06:07:11 INFO - PROCESS | 12375 | 06:07:13 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38754/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:14 INFO - PROCESS | 12375 | RSS: Main: 184020992 06:07:14 INFO - PROCESS | 12375 | 06:07:17 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38754/tests/kraken/driver.html?testName=audio-dft) 06:07:17 INFO - PROCESS | 12375 | RSS: Main: 175222784 06:07:17 INFO - PROCESS | 12375 | 06:07:20 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38754/tests/kraken/driver.html?testName=audio-fft) 06:07:21 INFO - PROCESS | 12375 | RSS: Main: 159309824 06:07:21 INFO - PROCESS | 12375 | 06:07:23 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38754/tests/kraken/driver.html?testName=audio-oscillator) 06:07:23 INFO - PROCESS | 12375 | RSS: Main: 162013184 06:07:23 INFO - PROCESS | 12375 | 06:07:25 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38754/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:26 INFO - PROCESS | 12375 | RSS: Main: 163885056 06:07:26 INFO - PROCESS | 12375 | 06:07:29 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38754/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:30 INFO - PROCESS | 12375 | RSS: Main: 163577856 06:07:30 INFO - PROCESS | 12375 | 06:07:33 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38754/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:33 INFO - PROCESS | 12375 | RSS: Main: 165433344 06:07:33 INFO - PROCESS | 12375 | 06:07:36 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38754/tests/kraken/driver.html?testName=json-parse-financial) 06:07:37 INFO - PROCESS | 12375 | RSS: Main: 166092800 06:07:37 INFO - PROCESS | 12375 | 06:07:38 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38754/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:39 INFO - PROCESS | 12375 | RSS: Main: 174583808 06:07:39 INFO - PROCESS | 12375 | 06:07:41 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:41 INFO - PROCESS | 12375 | RSS: Main: 173600768 06:07:41 INFO - PROCESS | 12375 | 06:07:43 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:44 INFO - PROCESS | 12375 | RSS: Main: 179109888 06:07:44 INFO - PROCESS | 12375 | 06:07:46 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:47 INFO - PROCESS | 12375 | RSS: Main: 186994688 06:07:47 INFO - PROCESS | 12375 | 06:07:49 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:50 INFO - PROCESS | 12375 | RSS: Main: 184553472 06:07:50 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | Cycle 1(1): loaded http://localhost:38754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38754/tests/kraken/driver.html?testName=ai-astar) 06:07:52 INFO - PROCESS | 12375 | RSS: Main: 243404800 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | __start_tp_report 06:07:52 INFO - PROCESS | 12375 | _x_x_mozilla_page_load 06:07:52 INFO - PROCESS | 12375 | _x_x_mozilla_page_load_details 06:07:52 INFO - PROCESS | 12375 | |i|pagename|runs| 06:07:52 INFO - PROCESS | 12375 | |0;ai-astar;108;110;104;111;110;112;100;109;111;108 06:07:52 INFO - PROCESS | 12375 | |1;audio-beat-detection;149;126;155;166;125;160;150;126;165;128 06:07:52 INFO - PROCESS | 12375 | |2;audio-dft;161;162;161;162;161;162;159;163;163;162 06:07:52 INFO - PROCESS | 12375 | |3;audio-fft;73;73;90;99;77;73;73;102;89;75 06:07:52 INFO - PROCESS | 12375 | |4;audio-oscillator;96;98;149;97;96;96;142;97;98;138 06:07:52 INFO - PROCESS | 12375 | |5;imaging-gaussian-blur;110;109;109;109;109;109;110;109;110;109 06:07:52 INFO - PROCESS | 12375 | |6;imaging-darkroom;146;145;145;145;145;146;145;147;145;146 06:07:52 INFO - PROCESS | 12375 | |7;imaging-desaturate;96;96;96;95;96;96;95;96;95;96 06:07:52 INFO - PROCESS | 12375 | |8;json-parse-financial;59;56;57;58;56;57;56;64;54;54 06:07:52 INFO - PROCESS | 12375 | |9;json-stringify-tinderbox;67;67;67;68;67;69;68;67;67;68 06:07:52 INFO - PROCESS | 12375 | |10;stanford-crypto-aes;84;87;85;86;85;86;85;86;86;88 06:07:52 INFO - PROCESS | 12375 | |11;stanford-crypto-ccm;124;131;117;120;115;117;126;123;122;115 06:07:52 INFO - PROCESS | 12375 | |12;stanford-crypto-pbkdf2;141;142;150;150;152;141;154;151;142;140 06:07:52 INFO - PROCESS | 12375 | |13;stanford-crypto-sha256-iterative;72;68;68;68;68;69;67;68;67;73 06:07:52 INFO - PROCESS | 12375 | __end_tp_report 06:07:52 INFO - PROCESS | 12375 | __start_cc_report 06:07:52 INFO - PROCESS | 12375 | _x_x_mozilla_cycle_collect,939 06:07:52 INFO - PROCESS | 12375 | __end_cc_report 06:07:52 INFO - PROCESS | 12375 | __startTimestamp1451743672385__endTimestamp 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | ------- Summary: start ------- 06:07:52 INFO - PROCESS | 12375 | Number of tests: 14 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.68 (3.3%) stddev-sans-first:3.91 06:07:52 INFO - PROCESS | 12375 | Values: 108.0 110.0 104.0 111.0 110.0 112.0 100.0 109.0 111.0 108.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.50 stddev:17.06 (11.2%) stddev-sans-first:18.03 06:07:52 INFO - PROCESS | 12375 | Values: 149.0 126.0 155.0 166.0 125.0 160.0 150.0 126.0 165.0 128.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 06:07:52 INFO - PROCESS | 12375 | Values: 161.0 162.0 161.0 162.0 161.0 162.0 159.0 163.0 163.0 162.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:11.54 (15.2%) stddev-sans-first:11.73 06:07:52 INFO - PROCESS | 12375 | Values: 73.0 73.0 90.0 99.0 77.0 73.0 73.0 102.0 89.0 75.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.50 stddev:22.46 (23.3%) stddev-sans-first:23.18 06:07:52 INFO - PROCESS | 12375 | Values: 96.0 98.0 149.0 97.0 96.0 96.0 142.0 97.0 98.0 138.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:07:52 INFO - PROCESS | 12375 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:07:52 INFO - PROCESS | 12375 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 145.0 147.0 145.0 146.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:07:52 INFO - PROCESS | 12375 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.88 (5.1%) stddev-sans-first:2.98 06:07:52 INFO - PROCESS | 12375 | Values: 59.0 56.0 57.0 58.0 56.0 57.0 56.0 64.0 54.0 54.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 06:07:52 INFO - PROCESS | 12375 | Values: 67.0 67.0 67.0 68.0 67.0 69.0 68.0 67.0 67.0 68.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.00 06:07:52 INFO - PROCESS | 12375 | Values: 84.0 87.0 85.0 86.0 85.0 86.0 85.0 86.0 86.0 88.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:122.50 stddev:5.21 (4.3%) stddev-sans-first:5.41 06:07:52 INFO - PROCESS | 12375 | Values: 124.0 131.0 117.0 120.0 115.0 117.0 126.0 123.0 122.0 115.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:150.00 stddev:5.52 (3.7%) stddev-sans-first:5.51 06:07:52 INFO - PROCESS | 12375 | Values: 141.0 142.0 150.0 150.0 152.0 141.0 154.0 151.0 142.0 140.0 06:07:52 INFO - PROCESS | 12375 | 06:07:52 INFO - PROCESS | 12375 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:2.04 (3.0%) stddev-sans-first:1.81 06:07:52 INFO - PROCESS | 12375 | Values: 72.0 68.0 68.0 68.0 68.0 69.0 67.0 68.0 67.0 73.0 06:07:52 INFO - PROCESS | 12375 | -------- Summary: end -------- 06:07:52 INFO - PROCESS | 12375 | 06:07:53 INFO - TEST-INFO | 12375: exit 0 06:07:53 INFO - TEST-OK | kraken | took 59214ms 06:07:53 INFO - TEST-START | v8_7 06:07:53 INFO - operating with platform_type : linux_ 06:07:53 INFO - Initialising browser for v8_7 test... 06:07:53 INFO - TEST-INFO | started process 12623 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAvh1yR/profile http://localhost:38754/getInfo.html) 06:07:57 INFO - PROCESS | 12623 | __metrics Screen width/height:1600/1200 06:07:57 INFO - PROCESS | 12623 | colorDepth:24 06:07:57 INFO - PROCESS | 12623 | Browser inner width/height: 1024/697 06:07:57 INFO - PROCESS | 12623 | __metrics 06:07:57 INFO - PROCESS | 12623 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:07:57 INFO - PROCESS | 12623 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:07:58 INFO - TEST-INFO | 12623: exit 0 06:07:58 INFO - Browser initialized. 06:07:58 INFO - Running cycle 1/1 for v8_7 test... 06:07:58 INFO - TEST-INFO | started process 12705 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAvh1yR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:10 INFO - PROCESS | 12705 | RSS: Main: 150061056 06:08:10 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | Cycle 1(1): loaded http://localhost:38754/tests/v8_7/run.html (next: http://localhost:38754/tests/v8_7/run.html) 06:08:32 INFO - PROCESS | 12705 | RSS: Main: 629751808 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | __start_tp_report 06:08:32 INFO - PROCESS | 12705 | _x_x_mozilla_page_load 06:08:32 INFO - PROCESS | 12705 | _x_x_mozilla_page_load_details 06:08:32 INFO - PROCESS | 12705 | |i|pagename|runs| 06:08:32 INFO - PROCESS | 12705 | |0;Richards;167.50418760469012 06:08:32 INFO - PROCESS | 12705 | |1;DeltaBlue;191.131498470948 06:08:32 INFO - PROCESS | 12705 | |2;Encrypt;280.19052956010086 06:08:32 INFO - PROCESS | 12705 | |3;Decrypt;5159.79381443299 06:08:32 INFO - PROCESS | 12705 | |4;RayTrace;1112.3470522803113 06:08:32 INFO - PROCESS | 12705 | |5;Earley;805.3097345132743 06:08:32 INFO - PROCESS | 12705 | |6;Boyer;12231.707317073171 06:08:32 INFO - PROCESS | 12705 | |7;RegExp;26179.48717948718 06:08:32 INFO - PROCESS | 12705 | |8;Splay;633.2518337408313 06:08:32 INFO - PROCESS | 12705 | |9;NavierStokes;4840.579710144928 06:08:32 INFO - PROCESS | 12705 | __end_tp_report 06:08:32 INFO - PROCESS | 12705 | __startTimestamp1451743712450__endTimestamp 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | ------- Summary: start ------- 06:08:32 INFO - PROCESS | 12705 | Number of tests: 10 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 167.5 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#1] DeltaBlue Cycles:1 Average:191.13 Median:191.13 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 191.1 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 280.2 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 5159.8 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 1112.3 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#5] Earley Cycles:1 Average:805.31 Median:805.31 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 805.3 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 12231.7 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 26179.5 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#8] Splay Cycles:1 Average:633.25 Median:633.25 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 633.3 06:08:32 INFO - PROCESS | 12705 | 06:08:32 INFO - PROCESS | 12705 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 06:08:32 INFO - PROCESS | 12705 | Values: 4840.6 06:08:32 INFO - PROCESS | 12705 | -------- Summary: end -------- 06:08:32 INFO - PROCESS | 12705 | 06:08:33 INFO - TEST-INFO | 12705: exit 0 06:08:33 INFO - TEST-OK | v8_7 | took 39830ms 06:08:33 INFO - SUITE-END | took 1212s 06:08:33 INFO - Completed test suite (00:20:12) 06:08:33 INFO - Working with test: dromaeo_css 06:08:33 INFO - Generating results file: dromaeo_css 06:08:33 INFO - Working with test: kraken 06:08:33 INFO - Generating results file: kraken 06:08:33 INFO - javascript benchmark 06:08:33 INFO - Working with test: v8_7 06:08:33 INFO - Generating results file: v8_7 06:08:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:08:33 INFO - process_Request line: dromaeo_css 6790.18 graph.html#tests=[[72,1,35]] 06:08:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:33 INFO - process_Request line: kraken 1505.00 graph.html#tests=[[232,1,35]] 06:08:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:33 INFO - process_Request line: v8_7 20821.83 graph.html#tests=[[230,1,35]] 06:08:33 INFO - RETURN: dromaeo_css: 6790.18 06:08:33 INFO - RETURN: kraken: 1505.00 06:08:33 INFO - RETURN: v8_7: 20821.83 06:08:33 INFO - javascript benchmark 06:08:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3128.3117714102896, 3184.5541624172606, 3223.339215460829, 3224.516322551617, 3255.26756479792, 5091.490850914916, 5192.480751924815, 5240.685558866466, 5250.7112108834, 5302.072137375953, 5140.331756871611, 5167.147420675584, 5224.63427560071, 5257.631965762398, 5260.289860868782, 4740.241561350184, 4763.3569468121705, 4767.5709186173235, 4826.855194344158, 4862.610991120702, 4812.7352995585225, 4825.372701548794, 4870.220764677652, 4875.8537243882565, 4885.560299573038, 4651.069786042805, 4696.788644511005, 4756.90486190276, 4785.545373189541, 4804.975975120137, 4742.715437073786, 4756.857294281177, 4757.048590281957, 4776.713397196145, 4790.856274311776, 4635.351050852883, 4741.525847415265, 4743.7628118594275, 4758.191107511731, 4775.116603428342, 4976.129177393942, 5014.824481143142, 5031.622628302892, 5058.696478211319, 5093.006863661588, 5543.029969755276, 5546.306711661043, 5548.72256387179, 5549.278593782823, 5559.777608895639, 5504.6421982571, 5607.495325420732, 5607.57943154261, 5647.124695672177, 5649.830505084854, 5177.508136727005, 5184.040952423814, 5258.158694608883, 5276.92084618731, 5288.127458969266, 5739.053056245672, 5744.827655170351, 5750.281214848144, 5775.537956963432, 5796.449337312949, 5524.392316845224, 5524.4199359066715, 5537.944620553823, 5550.722463876871, 5557.055300598908, 5481.808136715196, 5531.612787104864, 5578.972105139448, 5591.720413979285, 5618.719064046782, 5566.081596536607, 5591.692456914909, 5592.888142237214, 5595.188697638901, 5619.381867994517, 5530.10111899695, 5575.219469274305, 5577.0, 5582.553395728332, 5582.7766889324785, 4276.273033584298, 4283.400323954649, 4379.4087798147475, 4387.824487020547, 4431.0251744616135, 3927.2145570885937, 3929.7838618876235, 3951.5258169019903, 3952.2490726761825, 3961.9405708914387, 5117.104506711311, 5118.948810511922, 5121.0526052679625, 5163.0, 5209.0, 5424.077906755861, 5557.388687244481, 5569.805056823073, 5571.192177134293, 5624.803131890446, 5133.974330128325, 5137.33214682089, 5160.40655324635, 5161.019406312788, 5185.377754669464, 4772.308015337826, 4789.95210047902, 4791.712497250176, 4797.520247975174, 4818.95181048185, 5666.829995100154, 5714.771409143587, 5774.0761478163295, 5774.2782152230975, 5789.710514474344, 5522.972385138049, 5544.168374743821, 5647.040003199384, 5656.066748986371, 5679.403662615531, 5806.274215723035, 5811.128330750421, 5811.854703632443, 5813.593048486566, 5820.534357251325, 5440.619156658996, 5525.917111243415, 5532.585056120887, 5542.418046105262, 5544.251526043932, 5628.409017053151, 5687.20379146928, 5692.914606280992, 5697.316322041382, 5741.339745929272, 5468.671879687232, 5500.092484740133, 5527.39198688152, 5529.336479622471, 5530.391656917655, 5346.893062138814, 5388.380336261223, 5411.648242864201, 5483.616146869681, 5507.449255074461, 5326.121190003761, 5336.599755018467, 5342.171963345688, 5369.731513424391, 5374.677519348852, 5408.567314614743, 5408.5673146149, 5411.83764487066, 5414.593905457185, 5433.266509021231, 5246.685198887926, 5305.389880163676, 5318.228856815817, 5376.354837419534, 5387.0], "unit": "score", "name": "dojo.html", "value": 5156.698956371912}, {"lowerIsBetter": false, "replicates": [516.891452794913, 519.1589624807812, 523.4033202149548, 544.0506316477747, 554.5037191713419, 27889.721102788964, 28492.572611410844, 35481.645183548186, 36388.45417318743, 36455.27089458209, 39127.413088803616, 39635.20729585407, 39719.0, 39725.60274397255, 39726.60273397265, 8196.91803081969, 8347.83304333913, 8354.331653467738, 8355.248027677508, 8357.665693372257, 8278.089410164877, 8468.872966905501, 8513.361497887652, 8518.063013068557, 8520.0, 8690.782730431727, 8798.51608161551, 8817.73546793594, 8819.95590022049, 8823.250023747989, 8562.700305489308, 8631.913680863237, 8659.696910608098, 8678.609462574137, 8683.739487815345, 8270.131636178176, 8470.491770493729, 8479.940007499063, 8507.319414446829, 8515.74452766418, 38854.80572597147, 39426.0, 39650.801745991375, 39748.40377394341, 39789.602103978876, 3302.339532093567, 3307.7849939753837, 3452.5684289463816, 3647.361711700442, 4055.776932268724, 29080.41839163226, 29374.41251174986, 29581.112566623036, 30237.941672041372, 30645.01614790063, 3415.316936612687, 3477.9130521736906, 3500.264944361687, 3562.447820587813, 3575.6245594212755, 260355.0, 260380.0, 261104.0, 261458.0, 261826.0, 55193.724031379585, 55232.72383638056, 55602.16596751052, 55629.165562516595, 55672.721636392365, 53520.0, 54172.729136354064, 60405.697971509864, 61279.0, 61403.0, 14244.07413518118, 14377.712445751236, 14409.495667651581, 14427.711445771236, 14516.274186290642, 10250.179985601135, 10497.685069447929, 10964.890351096386, 11104.333739975627, 11113.777724445466, 15277.312520936584, 15402.383904643688, 15443.382264709286, 15480.84519154794, 15985.120818355103, 7388.926110738824, 7422.183559808417, 7506.13679426862, 7631.732889348847, 7664.271894170045, 901.9458832470073, 982.1946004276567, 1088.9094031347008, 1115.5482029777952, 1141.8305220081745, 27815.0, 27927.720722792918, 28236.43527129487, 28241.43517129646, 28243.293917652223, 968.1867231525553, 998.336106489191, 1011.5852500474917, 1089.727568107973, 1120.5685810962675, 13758.380872860746, 14114.153150810984, 14233.0, 14266.144031358152, 14636.268186590627, 317967.0, 319118.0, 321450.0, 321794.0, 322222.0, 49740.0, 50015.49984500181, 50022.24966625503, 50063.24905126426, 50119.24821127686, 1279.5329704657734, 1286.3825363825417, 1295.0416691648113, 1308.6793735534854, 1323.0804590809487, 23729.58980485876, 24343.0, 24640.753592463847, 24798.504029919663, 24810.875945620155, 43176.35235471408, 43477.0, 43852.780736096116, 43876.0, 43890.12219755523, 285180.0, 286601.0, 288724.0, 288980.0, 289026.0, 23468.76531234666, 23676.88161559181, 23699.289021329387, 28864.42271154523, 29251.0, 34621.13447163841, 35080.47379289262, 35108.82445587858, 35303.470447943815, 35465.82267088648, 25635.472699873015, 25684.871575642002, 26665.0, 28900.132996010154, 29037.0, 32853.0, 33646.66353336435, 33761.0, 33792.3241535163, 33832.83083584566, 26405.0, 26630.0, 35110.64889351074, 35214.647853521135, 35391.46912796362, 25492.0, 28580.42839143247, 29121.0, 29135.417291654474, 29138.0, 21925.671114933608, 23036.769632304135, 23869.641955370334, 24181.0, 24254.0], "unit": "score", "name": "ext.html", "value": 17257.01783351835}, {"lowerIsBetter": false, "replicates": [361.39466393790394, 363.96906262967644, 365.3515010855731, 366.14505130520234, 367.8675676756368, 13620.182789032666, 13829.585112446643, 16315.673686526277, 16482.42311519097, 16938.237779299914, 14341.56975290743, 14410.92794536026, 14807.33366998485, 14807.55577332679, 14819.629509262273, 5065.138926382524, 5149.510796474338, 5220.190870415092, 5237.711925844077, 5237.973810130944, 3932.351162058257, 4036.697247706419, 5218.1650935850275, 5229.294045303874, 5824.184614154022, 5833.474987251147, 5852.590318677694, 5887.35239123696, 5891.204687367215, 5909.172715819789, 5733.569982251327, 5865.648061116325, 5902.32123305821, 5911.586188966774, 5916.91124633133, 5222.32109825724, 5228.4510126436935, 5229.189475631283, 5229.241759944786, 5231.110711179071, 18563.16465759044, 19631.90184049085, 19885.701714474293, 20040.298589549297, 20045.498862528406, 2053.722747429108, 2111.134434881691, 2129.4676330917273, 2154.005931754862, 2165.621016322137, 12981.026423018311, 13031.86968130316, 13117.803232951514, 13337.599872003855, 13414.26221557814, 1797.4607617714764, 1816.9182386792627, 1823.6597694280495, 1828.4057681253646, 1891.8581106417073, 58377.416225838046, 58671.0, 58932.705336473475, 63305.68347158281, 63448.2827366564, 9101.81796364069, 9125.77185570366, 9142.908570914205, 9234.122758337948, 9699.0, 11669.124815638861, 11669.708257293636, 11672.766544669228, 11697.941510292394, 11750.823737643943, 7326.487145899842, 7332.1934587195365, 7369.189389167187, 7384.2246564111065, 7638.923610763933, 7323.780286591411, 7388.630568471663, 7389.8152546186775, 7433.0, 7472.850542989218, 5642.435756424325, 5650.208970744099, 5674.319081710221, 5688.77244910199, 5803.187553742479, 1541.3372249932636, 1639.213177674699, 1671.7993840739189, 1695.711729006072, 1790.7822680577333, 880.8986966498807, 922.216116301152, 967.2552134856262, 968.5883499512679, 1047.3401756893109, 14081.225532595601, 16325.755113673304, 16660.50018499447, 16694.165291735364, 16962.49112526626, 897.555709923579, 934.1919239857474, 947.6446332625266, 964.064857088623, 1013.533774463755, 7697.923020769721, 8376.288015518627, 8865.778355541162, 8909.866352004725, 9439.0, 564472.0, 568258.0, 572250.5878902094, 580243.0, 585294.0, 76679.2332076672, 77147.0, 78756.6062169697, 80103.59948200222, 80377.0, 1132.116948779953, 1136.108155098244, 1144.1418935798151, 1147.6212849759559, 1156.9132315076404, 14704.705905881608, 14942.0, 15159.696806063597, 15226.162561059247, 15494.612634683772, 18890.811091889456, 19264.90367548153, 31815.0, 34265.972020839414, 36583.26833463369, 44576.777116114215, 45054.77472612747, 45107.32339014983, 45383.54616453925, 49588.752056239486, 9008.729738107868, 9075.54622268897, 9222.584983675884, 9245.815083698153, 9356.251499880129, 11165.934302154128, 11240.213185077293, 11349.48927298257, 11367.033802126913, 12412.317322547347, 11062.668119956414, 11134.665960021212, 11388.0, 11653.883461165618, 12881.742365152832, 11776.0, 13037.674058148623, 13212.471501139848, 13542.458301667823, 14034.157950523002, 12646.494140234656, 12882.806757898452, 13101.934490327869, 13144.0799144059, 13160.078794484294, 9056.909430905607, 9078.228350590274, 9484.762880927756, 9516.19112375456, 9524.14282714559, 9579.616815327308, 13455.46178152863, 13645.727085458433, 14205.573832785032, 14280.857191427953], "unit": "score", "name": "jquery.html", "value": 8590.46285907248}, {"lowerIsBetter": false, "replicates": [1244.5270797097103, 1295.9546415875445, 1296.4490091711023, 1317.4335035934544, 1816.2553353125222, 6850.143732033496, 7400.185979542252, 7568.281013303741, 7572.772816815491, 7578.355839753627, 7398.778036658895, 7585.013948186728, 7589.051368578927, 7589.127250366196, 7597.202293759145, 1927.286903845579, 1960.872543284682, 2190.7371115466085, 2224.655178447335, 2262.2195342606774, 2276.0, 2280.5096904165603, 2280.5894938910988, 2283.0867652938873, 2284.983182483795, 2086.374087773662, 2167.4147980045377, 2169.934901952944, 2170.2838063439026, 2170.2838063439026, 2209.701690271817, 2227.365200917731, 2243.663450482424, 2285.234446460421, 2287.553926984239, 2242.798148166673, 2265.3770213191337, 2286.2912497125944, 2288.3592594073684, 2312.9653055204185, 7535.321821036078, 7608.771736847848, 7616.809579760495, 7617.885731714029, 7620.199879012679, 4463.531329210418, 4542.04617030424, 4570.360149579062, 4572.337011133401, 4579.244424669925, 2878.453093912171, 3000.699930007004, 3077.461444247248, 3093.257618171645, 3107.782455228135, 960.5149399553251, 967.2213867836389, 968.2786324188525, 987.4766373821886, 998.1465846701038, 9806.313558050939, 10076.09315161639, 10105.848412273821, 10112.747181320452, 10135.341202821794, 4030.4760381150263, 4050.9797451012555, 4098.918021639551, 4184.476940382391, 4187.748735075906, 8944.68693595721, 8947.507887066144, 8960.193582577469, 8961.23829474489, 8961.865572016424, 4516.616087632522, 4529.705569138061, 4544.613707834871, 4620.768961551909, 4632.119897219518, 4207.97896010518, 4228.85199018039, 4234.089670720809, 4238.109996900624, 4241.384999175164, 3343.4650455926935, 3375.9493607595905, 3381.966180338214, 3631.5279013728573, 3674.6692797647806, 1147.0594112827569, 1150.424787606197, 1155.653304008794, 1158.5076342554548, 1161.848959635259, 966.8888077870994, 967.6564819489121, 1044.1594516414207, 1090.6455401994224, 1359.9592012239648, 7111.893321600181, 7157.498975071695, 7176.82057948545, 7183.245759195209, 7192.928070719226, 1162.7616338650557, 1165.8484397028333, 1177.611388241878, 1198.7422704118655, 1201.8677945425995, 5551.72241387929, 5595.0208713475795, 5643.463870932255, 5644.661320320712, 5647.971760141255, 8597.957010215034, 8832.823343533222, 8835.33734969867, 8844.778880528038, 8929.10708929102, 8831.514266715263, 9005.819883602291, 9033.367664263438, 9040.231580315747, 9047.050059743764, 6843.623600702009, 7174.426045916314, 7187.31720486553, 7189.604571748604, 7208.24313447091, 6770.2891196425635, 6817.181938167451, 6828.180618325634, 6830.521863469509, 6830.726770929107, 7651.88522172179, 8086.7169649062, 8095.190480951857, 8109.635066421907, 8301.501909885426, 8386.203310685476, 8520.61657225414, 8521.573921304034, 8547.74356769298, 8558.486490810572, 6507.869842603216, 6626.204855417381, 6631.204255489372, 6631.63526006055, 6632.0, 6413.647249401328, 6527.0, 6939.236683964861, 7099.290070992859, 7179.533330333512, 6562.475001999924, 6575.80272591823, 6618.900716489353, 6706.83232919181, 6842.04211410393, 6609.735610575715, 6611.272759996493, 6624.536282460182, 6712.295209002984, 6757.93242067573, 6577.671116444254, 6600.504962127956, 6649.63427011519, 6656.534042617164, 6664.400203981665, 6085.726142323518, 6116.17431646722, 6126.724297406717, 6137.84655383619, 6146.846328841814, 6159.692015399301, 6288.905666415099, 6289.842753931005, 6338.207724034496, 6353.237611486651], "unit": "score", "name": "mootools.html", "value": 4334.035687795358}, {"lowerIsBetter": false, "replicates": [343.6151510308454, 344.67944811325486, 345.3266131044464, 348.65657327532375, 350.48526820066036, 5798.275215598051, 5852.707364631773, 5854.297484301885, 5889.2049573307595, 5932.228810254672, 5522.254495643087, 5580.525655319303, 5713.771449142029, 5779.393163717812, 5801.854953626162, 4505.5719706627815, 4507.053518761048, 4507.760365899388, 4509.909801803954, 4517.073999830027, 4289.463817022872, 4509.1883460977015, 4517.322401639747, 4518.70628409154, 4522.3216517522305, 4344.500382456011, 4369.541198174194, 4456.844010459635, 4472.3515090311885, 4475.060237350161, 4424.823007079713, 4433.889152771174, 4437.933430998538, 4440.844570440036, 4445.844395446144, 3907.472491213678, 3908.4137379393032, 3909.6872250219913, 3911.1395492991783, 3918.5101862267215, 5449.182622606601, 5539.944600554023, 5545.972270138664, 5546.362168350611, 5552.167174923794, 5178.430372659004, 5188.948110518884, 5190.351206099238, 5197.948020519784, 5209.869753256161, 6111.449969502766, 6118.755249790003, 6125.264968203799, 6126.387361263838, 6127.417895299939, 4363.280058790296, 4375.2124617568825, 4375.7593332366705, 4376.124775044972, 4381.627561657263, 6290.779822706183, 6388.425041746265, 6415.26224484181, 6415.262244841856, 6415.903761443582, 4506.864794056183, 4507.414036175342, 4508.842190523316, 4521.570450807168, 4525.456945166536, 4524.660650451229, 4562.703424277412, 4565.315202719618, 4570.81716731327, 4575.473820510617, 5181.5595674368105, 5195.038917800219, 5204.323437953042, 5217.34783152106, 5219.217117432339, 5989.940100598938, 6165.938340616626, 6179.258488981351, 6187.84530386735, 6189.133521307021, 1559.5165498695214, 1568.0826716370823, 1570.8272090070084, 1570.874330053593, 1572.1667516216196, 1041.0740130758038, 1048.1457612046158, 1049.0401282826128, 1049.821530339844, 1064.7497838008062, 5796.956547821348, 5798.246227990334, 5806.361300256968, 5808.3901190375245, 5811.0411782056335, 6300.59046161998, 6310.873782524323, 6312.905306420407, 6318.210223722035, 6320.62076275425, 5611.859703507445, 5678.432156784371, 5727.398623144593, 5728.684922329312, 5731.971340143356, 3369.5451114099774, 3419.760616756853, 3423.8972830815114, 3425.1094715374184, 3425.5033020212427, 6559.672016399257, 6592.0, 6596.60420374779, 6602.73589056442, 6619.834504137435, 6360.9045864312075, 6520.869582608321, 6538.313477084837, 6555.246146693096, 6556.967215163893, 6600.1089852869245, 6619.338066193439, 6620.337966203341, 6620.933790662032, 6621.86756264872, 6338.334474880256, 6358.395952384516, 6361.173047503795, 6361.664050549436, 6363.077353783583, 6156.09858123881, 6297.653629050446, 6299.118123462627, 6304.905426418699, 6312.715927783169, 6610.768623098168, 6614.735410583523, 6622.443725724547, 6624.205095388392, 6626.83432914181, 4433.490148632948, 4435.82256709728, 4438.733675979452, 4442.222611043119, 4442.600165985077, 6218.19163508741, 6362.363763623785, 6363.681815909279, 6371.0, 6431.903521447276, 6226.003839385677, 6227.221597300338, 6228.065790131516, 6228.532860035606, 6235.407636274546, 6215.254169499689, 6227.719752611053, 6229.034499652561, 6236.345183755821, 6245.750169993149, 5999.370066143167, 6038.547108966933, 6090.756369745338, 6129.785457508966, 6134.7852825152695, 6199.163112979871, 6201.224846894138, 6208.565400421927, 6219.160413344141, 6226.470749986302, 6122.632642041492, 6122.938770612237, 6129.877402451837, 6130.356312587292, 6131.724072416841], "unit": "score", "name": "prototype.html", "value": 4674.28485045245}, {"lowerIsBetter": false, "replicates": [739.223814994256, 783.8589053970285, 806.6047636658031, 868.3487384461654, 895.9686410975618, 13092.279924604143, 13317.667058323546, 13319.001074919384, 13401.731965360712, 13408.798868016987, 12902.22586644802, 13248.867511324885, 13269.601911942656, 13272.933635331834, 13297.0, 675.395521008697, 686.5743239191684, 832.063928080909, 832.5629044751508, 849.1466076593015, 820.1962077164383, 833.3916241143969, 837.5979529825687, 840.4201101240155, 841.1504380575601, 874.6632546469591, 890.7684002159452, 893.4148132972913, 893.7944272817256, 896.7713233125544, 699.2552931128357, 710.9431245500348, 711.4841739738699, 855.3584811391456, 870.9782255443602, 645.686841881687, 646.3084499585445, 646.3310473659786, 646.5894157210205, 649.8505343770959, 13390.598282051555, 13492.325383730775, 13494.662633434145, 13495.527656532073, 13512.932435337858, 12197.512099516009, 12837.935810320982, 12875.420606072748, 12903.516095649027, 13003.869961300456, 9948.10467057961, 9975.401475911469, 9999.200063994864, 10232.0, 10262.7434314142, 3587.515685382466, 3620.8008559529217, 3681.37416639172, 3749.0, 3753.6246375362243, 46259.768701156616, 46456.7677161612, 46461.767691161665, 46498.76750616225, 48998.265026024994, 9827.017298270259, 9980.850287245697, 10081.445520496443, 10178.949105254427, 10336.638217662347, 18145.183466744027, 18157.909210453865, 18172.63654726898, 18174.545636358933, 18181.0, 7615.5430674159725, 7649.847003059907, 7699.615019249015, 7727.111382191008, 7782.143964164051, 4308.0, 4308.439902812677, 4330.198913201005, 4358.171947329997, 4400.4939431965095, 3102.953455698166, 3115.5482455043893, 3123.6720144384967, 3144.2925341797913, 3153.858076386568, 571.0549041336594, 574.2448679985805, 582.3972188784587, 588.2382314902212, 588.7409539802474, 625.2153547298112, 653.9869202615921, 665.5241502325861, 687.5840116729406, 712.7113519024804, 8560.272376847914, 8763.737087887373, 8769.824603508021, 8909.0, 9115.407498512575, 575.8253163546402, 580.8780156167252, 629.7921685843661, 638.3616383616384, 641.2913730328014, 3818.9236215275537, 3883.2815929053218, 3911.413288006822, 4110.77390743512, 4229.154169166179, 53102.46897531053, 57853.42146578564, 58606.0, 58632.41367586269, 58788.11817822736, 52221.21668174981, 52275.0, 52496.73751631294, 52893.471065289625, 53054.73472632612, 46239.76880115645, 47022.76488617535, 47038.76480617575, 47512.52487475081, 48399.75800120977, 8094.83810323802, 8331.875021874797, 8583.0, 8613.956930215309, 8735.0, 34186.829065855505, 34328.14179645529, 35044.64955350516, 35164.82417587896, 35165.64834351726, 40791.7960410196, 42710.78644606757, 45129.323060154784, 47175.76412117918, 48883.0, 10813.025598489088, 11202.83195752048, 11300.378479183724, 11431.199816012799, 11596.768064638829, 11707.88292117068, 11738.589149380072, 11740.236884602473, 12329.568465103679, 12618.621441356774, 10911.945440272748, 11213.60752373663, 11284.21010529255, 11568.826467602825, 11671.241369310968, 11536.711582210512, 11564.537418503165, 11667.474963626488, 11792.469338879599, 12161.148719589544, 10952.835707464554, 11050.668479945614, 11157.776844463227, 11263.605773798206, 11324.011393850968, 9598.712038638852, 9819.803603927738, 9825.213982881496, 10292.639757608447, 10294.691159265234, 8782.673043590505, 8953.462792232487, 9328.766780830534, 9512.476813775309, 9784.902150978683], "unit": "score", "name": "yui.html", "value": 6328.340479960341}], "name": "dromaeo_css", "value": 6790.184646050919}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 111.0, 110.0, 112.0, 100.0, 109.0, 111.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 155.0, 166.0, 125.0, 160.0, 150.0, 126.0, 165.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 162.0, 159.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 90.0, 99.0, 77.0, 73.0, 73.0, 102.0, 89.0, 75.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 149.0, 97.0, 96.0, 96.0, 142.0, 97.0, 98.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 57.0, 58.0, 56.0, 57.0, 56.0, 64.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 69.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 85.0, 86.0, 85.0, 86.0, 85.0, 86.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [124.0, 131.0, 117.0, 120.0, 115.0, 117.0, 126.0, 123.0, 122.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [141.0, 142.0, 150.0, 150.0, 152.0, 141.0, 154.0, 151.0, 142.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 67.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1504.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [191.131498470948], "unit": "score", "name": "DeltaBlue", "value": 345.9293760000001}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [805.3097345132743], "unit": "score", "name": "Earley", "value": 827.5859230769231}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [633.2518337408313], "unit": "score", "name": "Splay", "value": 128.6865598455598}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20821.82901963434}]} 06:08:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20821.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1505.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6790.18"}}} 06:08:33 INFO - Return code: 0 06:08:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:08:33 INFO - # TBPL SUCCESS # 06:08:33 INFO - Running post-action listener: _resource_record_post_action 06:08:33 INFO - Running post-run listener: _resource_record_post_run 06:08:34 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 572878848; Read time: 0; Write time: 495512 06:08:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252448768; Read time: 0; Write time: 299756 06:08:34 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 320114688; Read time: 0; Write time: 195732 06:08:34 INFO - Running post-run listener: _upload_blobber_files 06:08:34 INFO - Blob upload gear active. 06:08:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:08:34 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 06:08:34 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:08:34 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:08:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:36 INFO - (blobuploader) - INFO - Done attempting. 06:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:37 INFO - (blobuploader) - INFO - Done attempting. 06:08:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:37 INFO - Return code: 0 06:08:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:08:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd42d32719116136abe79f47cefb6cc668b513b5e27ba8f41fda9e85814bf41f66ddac387716593afa523b10e5fb895c71e3515e4e14c5dcf7a19a65695de5b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd818e9d90fd17524644ce1b3287119a94ccb93e59a0fcd8aedfd421852cdcc8a3c37326e8bc005f42c02cf3f4008a8ee2b1139e456854fae160c3815a30aa0"} 06:08:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:08:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:08:37 INFO - Contents: 06:08:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd42d32719116136abe79f47cefb6cc668b513b5e27ba8f41fda9e85814bf41f66ddac387716593afa523b10e5fb895c71e3515e4e14c5dcf7a19a65695de5b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd818e9d90fd17524644ce1b3287119a94ccb93e59a0fcd8aedfd421852cdcc8a3c37326e8bc005f42c02cf3f4008a8ee2b1139e456854fae160c3815a30aa0"} 06:08:37 INFO - Copying logs to upload dir... 06:08:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.357098 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-02 06:08:36.595444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:36.599794) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd42d32719116136abe79f47cefb6cc668b513b5e27ba8f41fda9e85814bf41f66ddac387716593afa523b10e5fb895c71e3515e4e14c5dcf7a19a65695de5b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd818e9d90fd17524644ce1b3287119a94ccb93e59a0fcd8aedfd421852cdcc8a3c37326e8bc005f42c02cf3f4008a8ee2b1139e456854fae160c3815a30aa0"} build_url:https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/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/Firefox/sha512/cd42d32719116136abe79f47cefb6cc668b513b5e27ba8f41fda9e85814bf41f66ddac387716593afa523b10e5fb895c71e3515e4e14c5dcf7a19a65695de5b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcd818e9d90fd17524644ce1b3287119a94ccb93e59a0fcd8aedfd421852cdcc8a3c37326e8bc005f42c02cf3f4008a8ee2b1139e456854fae160c3815a30aa0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:36.625238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:36.625621) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451741680.713437-1022225410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:36.711377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 06:08:36.711746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 06:08:36.712069) ========= ========= Total master_lag: 0.23 =========