builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1452603830.35 results: success (0) buildid: 20160112023016 builduid: 1910835897344f09a7f0bc00538d2524 revision: 35c1ed58949d991030af52b8af23c879c8ccb364 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.353316) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.353797) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.354138) ========= 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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.18 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.536935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.537256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.837618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.837913) ========= 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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.033374 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.897095) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.897464) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.897925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.898285) ========= 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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 05:03:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 207M=0s 2016-01-12 05:03:51 (207 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.068647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.068975) ========= 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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.088530 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.169338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.169759) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 35c1ed58949d991030af52b8af23c879c8ccb364 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 35c1ed58949d991030af52b8af23c879c8ccb364 --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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 05:03:51,722 truncating revision to first 12 chars 2016-01-12 05:03:51,722 Setting DEBUG logging. 2016-01-12 05:03:51,722 attempt 1/10 2016-01-12 05:03:51,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/35c1ed58949d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 05:03:51,984 unpacking tar archive at: fx-team-35c1ed58949d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.737136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.737486) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.758545) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.758826) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.759258) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-12 05:03:51.759592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:52 INFO - MultiFileLogger online at 20160112 05:03:52 in /builds/slave/test-pgo 05:03:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:03:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:03:52 INFO - {'append_to_log': False, 05:03:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:03:52 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:03:52 INFO - 'branch': 'Fx-Team', 05:03:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:52 INFO - 'config_files': ('talos/linux_config.py',), 05:03:52 INFO - 'default_actions': ('clobber', 05:03:52 INFO - 'read-buildbot-config', 05:03:52 INFO - 'download-and-extract', 05:03:52 INFO - 'populate-webroot', 05:03:52 INFO - 'create-virtualenv', 05:03:52 INFO - 'install', 05:03:52 INFO - 'run-tests'), 05:03:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:52 INFO - 'download_minidump_stackwalk': True, 05:03:52 INFO - 'download_symbols': 'ondemand', 05:03:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:52 INFO - 'installer_path': 'installer.exe', 05:03:52 INFO - 'log_level': 'info', 05:03:52 INFO - 'log_name': 'talos', 05:03:52 INFO - 'log_to_console': True, 05:03:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:52 INFO - 'opt_config_files': (), 05:03:52 INFO - 'pip_index': False, 05:03:52 INFO - 'sps_profile': False, 05:03:52 INFO - 'sps_profile_interval': 0, 05:03:52 INFO - 'suite': 'dromaeojs', 05:03:52 INFO - 'system_bits': '32', 05:03:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:52 INFO - 'title': 'talos-linux64-ix-020', 05:03:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:52 INFO - 'use_talos_json': True, 05:03:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:03:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:52 INFO - 'work_dir': 'build'} 05:03:52 INFO - ##### 05:03:52 INFO - ##### Running clobber step. 05:03:52 INFO - ##### 05:03:52 INFO - Running pre-action listener: _resource_record_pre_action 05:03:52 INFO - Running main action method: clobber 05:03:52 INFO - rmtree: /builds/slave/test-pgo/build 05:03:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:03:53 INFO - Running post-action listener: _resource_record_post_action 05:03:53 INFO - ##### 05:03:53 INFO - ##### Running read-buildbot-config step. 05:03:53 INFO - ##### 05:03:53 INFO - Running pre-action listener: _resource_record_pre_action 05:03:53 INFO - Running main action method: read_buildbot_config 05:03:53 INFO - Using buildbot properties: 05:03:53 INFO - { 05:03:53 INFO - "project": "", 05:03:53 INFO - "product": "firefox", 05:03:53 INFO - "script_repo_revision": "production", 05:03:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:03:53 INFO - "repository": "", 05:03:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:03:53 INFO - "buildid": "20160112023016", 05:03:53 INFO - "pgo_build": "True", 05:03:53 INFO - "basedir": "/builds/slave/test-pgo", 05:03:53 INFO - "buildnumber": 576, 05:03:53 INFO - "slavename": "talos-linux64-ix-020", 05:03:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:03:53 INFO - "platform": "ubuntu64_hw", 05:03:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:03:53 INFO - "branch": "fx-team", 05:03:53 INFO - "repo_path": "integration/fx-team", 05:03:53 INFO - "revision": "35c1ed58949d991030af52b8af23c879c8ccb364", 05:03:53 INFO - "stage_platform": "linux64-pgo", 05:03:53 INFO - "builduid": "1910835897344f09a7f0bc00538d2524", 05:03:53 INFO - "slavebuilddir": "test" 05:03:53 INFO - } 05:03:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:03:53 INFO - Running post-action listener: _resource_record_post_action 05:03:53 INFO - ##### 05:03:53 INFO - ##### Running download-and-extract step. 05:03:53 INFO - ##### 05:03:53 INFO - Running pre-action listener: _resource_record_pre_action 05:03:53 INFO - Running main action method: download_and_extract 05:03:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:53 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json 05:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json 05:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:03:55 INFO - Downloaded 1302 bytes. 05:03:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:03:55 INFO - Using the following test package requirements: 05:03:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:03:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:55 INFO - u'jsshell-linux-x86_64.zip'], 05:03:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:03:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:03:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:03:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:03:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:03:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:55 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:03:57 INFO - Downloaded 24025081 bytes. 05:03:57 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:03:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:57 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:03:59 INFO - Return code: 0 05:03:59 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:03:59 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:03:59 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:04:12 INFO - Downloaded 24025081 bytes. 05:04:12 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:04:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:04:12 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:04:13 INFO - Return code: 0 05:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:13 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:04:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:04:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:04:15 INFO - Downloaded 11132285 bytes. 05:04:15 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:04:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:15 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:04:15 INFO - Return code: 0 05:04:15 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:04:15 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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:04:18 INFO - Downloaded 55796332 bytes. 05:04:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:18 INFO - mkdir: /builds/slave/test-pgo/properties 05:04:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:04:18 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:04:18 INFO - Contents: 05:04:18 INFO - build_url:https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:18 INFO - Running post-action listener: _resource_record_post_action 05:04:18 INFO - Running post-action listener: set_extra_try_arguments 05:04:18 INFO - ##### 05:04:18 INFO - ##### Running populate-webroot step. 05:04:18 INFO - ##### 05:04:18 INFO - Running pre-action listener: _resource_record_pre_action 05:04:18 INFO - Running main action method: populate_webroot 05:04:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:18 INFO - '--tppagecycles', 05:04:18 INFO - '7'], 05:04:18 INFO - 'tests': ['tsvgm']}}, 05:04:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:04:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:04:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:04:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'tests': ['damp', 'tps']}, 05:04:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['damp', 'tps']}, 05:04:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:04:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:18 INFO - 'other': {'tests': ['a11yr', 05:04:18 INFO - 'ts_paint', 05:04:18 INFO - 'tpaint', 05:04:18 INFO - 'sessionrestore', 05:04:18 INFO - 'sessionrestore_no_auto_restore']}, 05:04:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['a11yr', 05:04:18 INFO - 'ts_paint', 05:04:18 INFO - 'tpaint', 05:04:18 INFO - 'sessionrestore', 05:04:18 INFO - 'sessionrestore_no_auto_restore']}, 05:04:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['a11yr', 05:04:18 INFO - 'ts_paint', 05:04:18 INFO - 'tpaint', 05:04:18 INFO - 'sessionrestore', 05:04:18 INFO - 'sessionrestore_no_auto_restore']}, 05:04:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['a11yr', 05:04:18 INFO - 'ts_paint', 05:04:18 INFO - 'tpaint', 05:04:18 INFO - 'sessionrestore', 05:04:18 INFO - 'sessionrestore_no_auto_restore']}, 05:04:18 INFO - 'other_l64': {'tests': ['a11yr', 05:04:18 INFO - 'ts_paint', 05:04:18 INFO - 'tpaint', 05:04:18 INFO - 'sessionrestore', 05:04:18 INFO - 'sessionrestore_no_auto_restore']}, 05:04:18 INFO - 'other_nol64': {'tests': ['a11yr', 05:04:18 INFO - 'ts_paint', 05:04:18 INFO - 'tpaint', 05:04:18 INFO - 'sessionrestore', 05:04:18 INFO - 'sessionrestore_no_auto_restore']}, 05:04:18 INFO - 'svgr': {'tests': ['tsvgx', 05:04:18 INFO - 'tsvgr_opacity', 05:04:18 INFO - 'tart', 05:04:18 INFO - 'tscrollx', 05:04:18 INFO - 'cart']}, 05:04:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['tsvgx', 05:04:18 INFO - 'tsvgr_opacity', 05:04:18 INFO - 'tart', 05:04:18 INFO - 'tscrollx', 05:04:18 INFO - 'cart']}, 05:04:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'tests': ['tp5o']}, 05:04:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'talos_options': ['--e10s'], 05:04:18 INFO - 'tests': ['tp5o']}, 05:04:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'talos_options': ['--xperf_path', 05:04:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:18 INFO - 'tests': ['tp5n']}, 05:04:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:18 INFO - 'talos_options': ['--e10s', 05:04:18 INFO - '--xperf_path', 05:04:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:18 INFO - 'tests': ['tp5n']}}, 05:04:18 INFO - 'talos.zip': {'path': '', 05:04:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:18 INFO - Running post-action listener: _resource_record_post_action 05:04:18 INFO - ##### 05:04:18 INFO - ##### Running create-virtualenv step. 05:04:18 INFO - ##### 05:04:18 INFO - Running pre-action listener: _resource_record_pre_action 05:04:18 INFO - Running main action method: create_virtualenv 05:04:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:04:18 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:04:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:04:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:18 INFO - Using real prefix '/usr' 05:04:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:04:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:21 INFO - Installing pip.................done. 05:04:21 INFO - Return code: 0 05:04:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:04:21 INFO - Using env: {'DISPLAY': ':0', 05:04:21 INFO - 'HOME': '/home/cltbld', 05:04:21 INFO - 'LANG': 'en_US.UTF-8', 05:04:21 INFO - 'LANGUAGE': 'en_US:en', 05:04:21 INFO - 'LOGNAME': 'cltbld', 05:04:21 INFO - 'MAIL': '/var/mail/cltbld', 05:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:21 INFO - 'MOZ_NO_REMOTE': '1', 05:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:21 INFO - 'NO_EM_RESTART': '1', 05:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:21 INFO - 'SHELL': '/bin/bash', 05:04:21 INFO - 'SHLVL': '1', 05:04:21 INFO - 'TERM': 'linux', 05:04:21 INFO - 'TMOUT': '86400', 05:04:21 INFO - 'USER': 'cltbld', 05:04:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:21 INFO - '_': '/tools/buildbot/bin/python'} 05:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:21 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:04:21 INFO - Cleaning up... 05:04:21 INFO - Return code: 0 05:04:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:04:21 INFO - Using env: {'DISPLAY': ':0', 05:04:21 INFO - 'HOME': '/home/cltbld', 05:04:21 INFO - 'LANG': 'en_US.UTF-8', 05:04:21 INFO - 'LANGUAGE': 'en_US:en', 05:04:21 INFO - 'LOGNAME': 'cltbld', 05:04:21 INFO - 'MAIL': '/var/mail/cltbld', 05:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:21 INFO - 'MOZ_NO_REMOTE': '1', 05:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:21 INFO - 'NO_EM_RESTART': '1', 05:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:21 INFO - 'SHELL': '/bin/bash', 05:04:21 INFO - 'SHLVL': '1', 05:04:21 INFO - 'TERM': 'linux', 05:04:21 INFO - 'TMOUT': '86400', 05:04:21 INFO - 'USER': 'cltbld', 05:04:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:21 INFO - '_': '/tools/buildbot/bin/python'} 05:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:21 INFO - Downloading/unpacking psutil>=0.7.1 05:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:23 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:04:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:23 INFO - Installing collected packages: psutil 05:04:23 INFO - Running setup.py install for psutil 05:04:23 INFO - building 'psutil._psutil_linux' extension 05:04:23 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:04:23 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:04:23 INFO - building 'psutil._psutil_posix' extension 05:04:23 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:04:24 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:04:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:24 INFO - Successfully installed psutil 05:04:24 INFO - Cleaning up... 05:04:24 INFO - Return code: 0 05:04:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:04:24 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:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:24 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:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:24 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 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:24 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:04:24 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:04:24 INFO - Using env: {'DISPLAY': ':0', 05:04:24 INFO - 'HOME': '/home/cltbld', 05:04:24 INFO - 'LANG': 'en_US.UTF-8', 05:04:24 INFO - 'LANGUAGE': 'en_US:en', 05:04:24 INFO - 'LOGNAME': 'cltbld', 05:04:24 INFO - 'MAIL': '/var/mail/cltbld', 05:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:24 INFO - 'MOZ_NO_REMOTE': '1', 05:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:24 INFO - 'NO_EM_RESTART': '1', 05:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:24 INFO - 'SHELL': '/bin/bash', 05:04:24 INFO - 'SHLVL': '1', 05:04:24 INFO - 'TERM': 'linux', 05:04:24 INFO - 'TMOUT': '86400', 05:04:24 INFO - 'USER': 'cltbld', 05:04:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:24 INFO - '_': '/tools/buildbot/bin/python'} 05:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:04:24 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:04:24 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:04:24 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:04:24 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:04:24 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:04:24 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:04:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:04:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:26 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:04:26 INFO - Installing collected packages: mozsystemmonitor 05:04:26 INFO - Running setup.py install for mozsystemmonitor 05:04:26 INFO - Successfully installed mozsystemmonitor 05:04:26 INFO - Cleaning up... 05:04:26 INFO - Return code: 0 05:04:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:26 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 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:26 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:04:26 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:04:26 INFO - Using env: {'DISPLAY': ':0', 05:04:26 INFO - 'HOME': '/home/cltbld', 05:04:26 INFO - 'LANG': 'en_US.UTF-8', 05:04:26 INFO - 'LANGUAGE': 'en_US:en', 05:04:26 INFO - 'LOGNAME': 'cltbld', 05:04:26 INFO - 'MAIL': '/var/mail/cltbld', 05:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:26 INFO - 'MOZ_NO_REMOTE': '1', 05:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:26 INFO - 'NO_EM_RESTART': '1', 05:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:26 INFO - 'SHELL': '/bin/bash', 05:04:26 INFO - 'SHLVL': '1', 05:04:26 INFO - 'TERM': 'linux', 05:04:26 INFO - 'TMOUT': '86400', 05:04:26 INFO - 'USER': 'cltbld', 05:04:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:26 INFO - '_': '/tools/buildbot/bin/python'} 05:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:26 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:04:26 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:04:26 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:04:26 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:04:26 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:04:26 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:04:28 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:04:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:28 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:04:28 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:04:28 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:04:28 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:04:28 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:04:28 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:04:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:04:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:04:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:28 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:04:28 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:04:28 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:04:28 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:04:28 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:04:28 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:04:28 INFO - Downloading docopt-0.6.1.tar.gz 05:04:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:04:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:28 INFO - Running setup.py install for blobuploader 05:04:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:04:29 INFO - Running setup.py install for requests 05:04:29 INFO - Running setup.py install for docopt 05:04:29 INFO - Successfully installed blobuploader requests docopt 05:04:29 INFO - Cleaning up... 05:04:29 INFO - Return code: 0 05:04:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04:29 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:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:29 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:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:29 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 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:29 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:04:29 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:04:29 INFO - Using env: {'DISPLAY': ':0', 05:04:29 INFO - 'HOME': '/home/cltbld', 05:04:29 INFO - 'LANG': 'en_US.UTF-8', 05:04:29 INFO - 'LANGUAGE': 'en_US:en', 05:04:29 INFO - 'LOGNAME': 'cltbld', 05:04:29 INFO - 'MAIL': '/var/mail/cltbld', 05:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:29 INFO - 'MOZ_NO_REMOTE': '1', 05:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:29 INFO - 'NO_EM_RESTART': '1', 05:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:29 INFO - 'SHELL': '/bin/bash', 05:04:29 INFO - 'SHLVL': '1', 05:04:29 INFO - 'TERM': 'linux', 05:04:29 INFO - 'TMOUT': '86400', 05:04:29 INFO - 'USER': 'cltbld', 05:04:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:29 INFO - '_': '/tools/buildbot/bin/python'} 05:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:29 INFO - Running setup.py (path:/tmp/pip-BN9Wl_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:29 INFO - Running setup.py (path:/tmp/pip-pkrE4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:29 INFO - Running setup.py (path:/tmp/pip-i5uIzP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:29 INFO - Running setup.py (path:/tmp/pip-eMslaG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:30 INFO - Running setup.py (path:/tmp/pip-YiFHIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:30 INFO - Running setup.py (path:/tmp/pip-jYCTVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:30 INFO - Running setup.py (path:/tmp/pip-PbK9OT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:30 INFO - Running setup.py (path:/tmp/pip-uAoIbR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:30 INFO - Running setup.py (path:/tmp/pip-CbOCKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:30 INFO - Running setup.py (path:/tmp/pip-KXQDpd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:30 INFO - Running setup.py (path:/tmp/pip-YdqZ63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:30 INFO - Running setup.py (path:/tmp/pip-j8bqoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:30 INFO - Running setup.py (path:/tmp/pip-B7zSpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:30 INFO - Running setup.py (path:/tmp/pip-ApIggb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:30 INFO - Running setup.py (path:/tmp/pip-1BZISu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:30 INFO - Running setup.py (path:/tmp/pip-EIhwXf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:30 INFO - Running setup.py (path:/tmp/pip-iBF8bj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:31 INFO - Running setup.py install for manifestparser 05:04:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Running setup.py install for mozcrash 05:04:31 INFO - Running setup.py install for mozdebug 05:04:31 INFO - Running setup.py install for mozdevice 05:04:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Running setup.py install for mozfile 05:04:31 INFO - Running setup.py install for mozhttpd 05:04:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Running setup.py install for mozinfo 05:04:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Running setup.py install for mozInstall 05:04:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:04:31 INFO - Running setup.py install for mozleak 05:04:31 INFO - Running setup.py install for mozlog 05:04:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:04:32 INFO - Running setup.py install for moznetwork 05:04:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:04:32 INFO - Running setup.py install for mozprocess 05:04:32 INFO - Running setup.py install for mozprofile 05:04:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:04:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:04:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:04:32 INFO - Running setup.py install for mozrunner 05:04:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:04:32 INFO - Running setup.py install for mozscreenshot 05:04:32 INFO - Running setup.py install for moztest 05:04:32 INFO - Running setup.py install for mozversion 05:04:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:04:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:32 INFO - Cleaning up... 05:04:32 INFO - Return code: 0 05:04:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:32 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 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:32 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:04:32 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:04:32 INFO - Using env: {'DISPLAY': ':0', 05:04:32 INFO - 'HOME': '/home/cltbld', 05:04:32 INFO - 'LANG': 'en_US.UTF-8', 05:04:32 INFO - 'LANGUAGE': 'en_US:en', 05:04:32 INFO - 'LOGNAME': 'cltbld', 05:04:32 INFO - 'MAIL': '/var/mail/cltbld', 05:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:32 INFO - 'MOZ_NO_REMOTE': '1', 05:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:32 INFO - 'NO_EM_RESTART': '1', 05:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:32 INFO - 'SHELL': '/bin/bash', 05:04:32 INFO - 'SHLVL': '1', 05:04:32 INFO - 'TERM': 'linux', 05:04:32 INFO - 'TMOUT': '86400', 05:04:32 INFO - 'USER': 'cltbld', 05:04:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:32 INFO - '_': '/tools/buildbot/bin/python'} 05:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:32 INFO - Running setup.py (path:/tmp/pip-CnXl6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:33 INFO - Running setup.py (path:/tmp/pip-WySyTd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:33 INFO - Running setup.py (path:/tmp/pip-KLZnwm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:33 INFO - Running setup.py (path:/tmp/pip-scUl1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:33 INFO - Running setup.py (path:/tmp/pip-1g7jcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:33 INFO - Running setup.py (path:/tmp/pip-Wq7suK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:33 INFO - Running setup.py (path:/tmp/pip-bkCw2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:33 INFO - Running setup.py (path:/tmp/pip-hAJoQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:33 INFO - Running setup.py (path:/tmp/pip-QeZTTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:33 INFO - Running setup.py (path:/tmp/pip-68wmwS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:33 INFO - Running setup.py (path:/tmp/pip-Sdut7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:33 INFO - Running setup.py (path:/tmp/pip-_hCHCt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:33 INFO - Running setup.py (path:/tmp/pip-uIEit_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:33 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:04:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:33 INFO - Running setup.py (path:/tmp/pip-qmPX3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:34 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:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:34 INFO - Running setup.py (path:/tmp/pip-gTPQum-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:34 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:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:34 INFO - Running setup.py (path:/tmp/pip-fbE45x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:34 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:04:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:34 INFO - Running setup.py (path:/tmp/pip-WfSwZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:34 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:04:34 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:04:34 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:04:34 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:04:34 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:04:34 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:04:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:35 INFO - Downloading blessings-1.5.1.tar.gz 05:04:35 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:04:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:36 INFO - Installing collected packages: blessings 05:04:36 INFO - Running setup.py install for blessings 05:04:36 INFO - Successfully installed blessings 05:04:36 INFO - Cleaning up... 05:04:36 INFO - Return code: 0 05:04:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:04:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:36 INFO - Reading from file tmpfile_stdout 05:04:36 INFO - Current package versions: 05:04:36 INFO - argparse == 1.2.1 05:04:36 INFO - blessings == 1.5.1 05:04:36 INFO - blobuploader == 1.2.4 05:04:36 INFO - docopt == 0.6.1 05:04:36 INFO - manifestparser == 1.1 05:04:36 INFO - mozInstall == 1.12 05:04:36 INFO - mozcrash == 0.16 05:04:36 INFO - mozdebug == 0.1 05:04:36 INFO - mozdevice == 0.47 05:04:36 INFO - mozfile == 1.2 05:04:36 INFO - mozhttpd == 0.7 05:04:36 INFO - mozinfo == 0.9 05:04:36 INFO - mozleak == 0.1 05:04:36 INFO - mozlog == 3.1 05:04:36 INFO - moznetwork == 0.27 05:04:36 INFO - mozprocess == 0.22 05:04:36 INFO - mozprofile == 0.28 05:04:36 INFO - mozrunner == 6.11 05:04:36 INFO - mozscreenshot == 0.1 05:04:36 INFO - mozsystemmonitor == 0.0 05:04:36 INFO - moztest == 0.7 05:04:36 INFO - mozversion == 1.4 05:04:36 INFO - psutil == 3.1.1 05:04:36 INFO - requests == 1.2.3 05:04:36 INFO - wsgiref == 0.1.2 05:04:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:36 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:04:36 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:04:36 INFO - Using env: {'DISPLAY': ':0', 05:04:36 INFO - 'HOME': '/home/cltbld', 05:04:36 INFO - 'LANG': 'en_US.UTF-8', 05:04:36 INFO - 'LANGUAGE': 'en_US:en', 05:04:36 INFO - 'LOGNAME': 'cltbld', 05:04:36 INFO - 'MAIL': '/var/mail/cltbld', 05:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:36 INFO - 'MOZ_NO_REMOTE': '1', 05:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:36 INFO - 'NO_EM_RESTART': '1', 05:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:36 INFO - 'SHELL': '/bin/bash', 05:04:36 INFO - 'SHLVL': '1', 05:04:36 INFO - 'TERM': 'linux', 05:04:36 INFO - 'TMOUT': '86400', 05:04:36 INFO - 'USER': 'cltbld', 05:04:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:36 INFO - '_': '/tools/buildbot/bin/python'} 05:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 INFO - Cleaning up... 05:04:36 INFO - Return code: 0 05:04:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:04:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:04:36 INFO - Using env: {'DISPLAY': ':0', 05:04:36 INFO - 'HOME': '/home/cltbld', 05:04:36 INFO - 'LANG': 'en_US.UTF-8', 05:04:36 INFO - 'LANGUAGE': 'en_US:en', 05:04:36 INFO - 'LOGNAME': 'cltbld', 05:04:36 INFO - 'MAIL': '/var/mail/cltbld', 05:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:36 INFO - 'MOZ_NO_REMOTE': '1', 05:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:36 INFO - 'NO_EM_RESTART': '1', 05:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:36 INFO - 'SHELL': '/bin/bash', 05:04:36 INFO - 'SHLVL': '1', 05:04:36 INFO - 'TERM': 'linux', 05:04:36 INFO - 'TMOUT': '86400', 05:04:36 INFO - 'USER': 'cltbld', 05:04:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:36 INFO - '_': '/tools/buildbot/bin/python'} 05:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:36 INFO - Downloading/unpacking jsonschema 05:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:38 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:04:38 INFO - Downloading/unpacking functools32 (from jsonschema) 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:38 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:04:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:38 INFO - warning: no files found matching '*.txt' 05:04:38 INFO - no previously-included directories found matching 'build' 05:04:38 INFO - no previously-included directories found matching 'dist' 05:04:38 INFO - no previously-included directories found matching '.git*' 05:04:38 INFO - Installing collected packages: jsonschema, functools32 05:04:38 INFO - Running setup.py install for functools32 05:04:38 INFO - warning: no files found matching '*.txt' 05:04:38 INFO - no previously-included directories found matching 'build' 05:04:38 INFO - no previously-included directories found matching 'dist' 05:04:38 INFO - no previously-included directories found matching '.git*' 05:04:38 INFO - Successfully installed jsonschema functools32 05:04:38 INFO - Cleaning up... 05:04:39 INFO - Return code: 0 05:04:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:04:39 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:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:39 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:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:39 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 0x7f930347bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', '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:04:39 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:04:39 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:04:39 INFO - Using env: {'DISPLAY': ':0', 05:04:39 INFO - 'HOME': '/home/cltbld', 05:04:39 INFO - 'LANG': 'en_US.UTF-8', 05:04:39 INFO - 'LANGUAGE': 'en_US:en', 05:04:39 INFO - 'LOGNAME': 'cltbld', 05:04:39 INFO - 'MAIL': '/var/mail/cltbld', 05:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:39 INFO - 'MOZ_NO_REMOTE': '1', 05:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:39 INFO - 'NO_EM_RESTART': '1', 05:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:39 INFO - 'SHELL': '/bin/bash', 05:04:39 INFO - 'SHLVL': '1', 05:04:39 INFO - 'TERM': 'linux', 05:04:39 INFO - 'TMOUT': '86400', 05:04:39 INFO - 'USER': 'cltbld', 05:04:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:39 INFO - '_': '/tools/buildbot/bin/python'} 05:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:39 INFO - Downloading/unpacking flake8 05:04:39 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:04:39 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:04:39 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:04:39 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:04:39 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:04:39 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:04:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:04:40 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:04:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:04:40 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:04:40 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:04:40 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:04:40 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:04:40 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:04:40 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:04:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:04:41 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:04:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:04:41 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:04:41 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:04:41 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:04:41 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:04:41 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:04:41 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:04:41 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:04:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04:41 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:04:41 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:04:41 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:04:41 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:04:41 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:04:41 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:04:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:04:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:41 INFO - no previously-included directories found matching 'docs/_build' 05:04:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:41 INFO - Running setup.py install for pep8 05:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:41 INFO - no previously-included directories found matching 'docs/_build' 05:04:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:04:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:41 INFO - Cleaning up... 05:04:41 INFO - Return code: 0 05:04:41 INFO - Running post-action listener: _resource_record_post_action 05:04:41 INFO - Running post-action listener: _start_resource_monitoring 05:04:41 INFO - Starting resource monitoring. 05:04:41 INFO - ##### 05:04:41 INFO - ##### Running install step. 05:04:41 INFO - ##### 05:04:41 INFO - Running pre-action listener: _resource_record_pre_action 05:04:41 INFO - Running main action method: install 05:04:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:42 INFO - Reading from file tmpfile_stdout 05:04:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:04:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:04:42 INFO - Reading from file tmpfile_stdout 05:04:42 INFO - Output received: 05:04:42 INFO - Usage: mozinstall [options] installer 05:04:42 INFO - Options: 05:04:42 INFO - -h, --help show this help message and exit 05:04:42 INFO - -d DEST, --destination=DEST 05:04:42 INFO - Directory to install application into. [default: 05:04:42 INFO - "/builds/slave/test-pgo"] 05:04:42 INFO - --app=APP Application being installed. [default: firefox] 05:04:42 INFO - mkdir: /builds/slave/test-pgo/build/application 05:04:42 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:04:42 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:04:58 INFO - Reading from file tmpfile_stdout 05:04:58 INFO - Output received: 05:04:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:04:58 INFO - Running post-action listener: _resource_record_post_action 05:04:58 INFO - ##### 05:04:58 INFO - ##### Running run-tests step. 05:04:58 INFO - ##### 05:04:58 INFO - Running pre-action listener: _resource_record_pre_action 05:04:58 INFO - Running main action method: run_tests 05:04:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:04:58 INFO - Python 2.7.3 05:04:58 INFO - Return code: 0 05:04:58 INFO - grabbing minidump binary from tooltool 05:04: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:04:58 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 0x22a3840>, '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 0x22106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:04:58 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:04:58 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:04:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:58 INFO - Return code: 0 05:04:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:04:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:04:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:04:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:04:59 INFO - Return code: 0 05:04:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:04:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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:04:59 INFO - Using env: {'DISPLAY': ':0', 05:04:59 INFO - 'HOME': '/home/cltbld', 05:04:59 INFO - 'LANG': 'en_US.UTF-8', 05:04:59 INFO - 'LANGUAGE': 'en_US:en', 05:04:59 INFO - 'LOGNAME': 'cltbld', 05:04:59 INFO - 'MAIL': '/var/mail/cltbld', 05:04:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:59 INFO - 'MOZ_NO_REMOTE': '1', 05:04:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:59 INFO - 'NO_EM_RESTART': '1', 05:04:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:04:59 INFO - 'SHELL': '/bin/bash', 05:04:59 INFO - 'SHLVL': '1', 05:04:59 INFO - 'TERM': 'linux', 05:04:59 INFO - 'TMOUT': '86400', 05:04:59 INFO - 'USER': 'cltbld', 05:04:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535', 05:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:59 INFO - '_': '/tools/buildbot/bin/python'} 05:04:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:04:59 INFO - mozversion application_buildid: 20160112023016 05:04:59 INFO - mozversion application_changeset: 35c1ed58949d991030af52b8af23c879c8ccb364 05:04:59 INFO - mozversion application_display_name: Nightly 05:04:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:59 INFO - mozversion application_name: Firefox 05:04:59 INFO - mozversion application_remotingname: firefox 05:04:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:59 INFO - mozversion application_vendor: Mozilla 05:04:59 INFO - mozversion application_version: 46.0a1 05:04:59 INFO - mozversion platform_buildid: 20160112023016 05:04:59 INFO - mozversion platform_changeset: 35c1ed58949d991030af52b8af23c879c8ccb364 05:04:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:59 INFO - mozversion platform_version: 46.0a1 05:04:59 INFO - using testdate: 1452603899 05:04:59 INFO - actual date: 1452603899 05:04:59 INFO - starting webserver on 'localhost:43897' 05:04:59 INFO - SUITE-START | Running 3 tests 05:04:59 INFO - TEST-START | dromaeo_css 05:04:59 INFO - operating with platform_type : linux_ 05:04:59 INFO - Initialising browser for dromaeo_css test... 05:04:59 INFO - TEST-INFO | started process 32694 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp73_HbH/profile http://localhost:43897/getInfo.html) 05:05:04 INFO - PROCESS | 32694 | __metrics Screen width/height:1600/1200 05:05:04 INFO - PROCESS | 32694 | colorDepth:24 05:05:04 INFO - PROCESS | 32694 | Browser inner width/height: 1024/697 05:05:04 INFO - PROCESS | 32694 | __metrics 05:05:04 INFO - PROCESS | 32694 | 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:05:04 INFO - PROCESS | 32694 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:05 INFO - TEST-INFO | 32694: exit 0 05:05:05 INFO - Browser initialized. 05:05:05 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:05 INFO - TEST-INFO | started process 320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp73_HbH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:17 INFO - PROCESS | 320 | RSS: Main: 148639744 05:05:17 INFO - PROCESS | 320 | 05:06:08 INFO - PROCESS | 320 | 1452603968585 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:08:17 INFO - PROCESS | 320 | Cycle 1(1): loaded http://localhost:43897/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43897/tests/dromaeo/cssquery-ext.html) 05:08:18 INFO - PROCESS | 320 | RSS: Main: 246566912 05:08:18 INFO - PROCESS | 320 | 05:11:20 INFO - PROCESS | 320 | Cycle 1(1): loaded http://localhost:43897/tests/dromaeo/cssquery-ext.html (next: http://localhost:43897/tests/dromaeo/cssquery-jquery.html) 05:11:21 INFO - PROCESS | 320 | RSS: Main: 239263744 05:11:21 INFO - PROCESS | 320 | 05:14:23 INFO - PROCESS | 320 | Cycle 1(1): loaded http://localhost:43897/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43897/tests/dromaeo/cssquery-mootools.html) 05:14:23 INFO - PROCESS | 320 | RSS: Main: 246259712 05:14:23 INFO - PROCESS | 320 | 05:17:25 INFO - PROCESS | 320 | Cycle 1(1): loaded http://localhost:43897/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43897/tests/dromaeo/cssquery-prototype.html) 05:17:26 INFO - PROCESS | 320 | RSS: Main: 212635648 05:17:26 INFO - PROCESS | 320 | 05:20:28 INFO - PROCESS | 320 | Cycle 1(1): loaded http://localhost:43897/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43897/tests/dromaeo/cssquery-yui.html) 05:20:29 INFO - PROCESS | 320 | RSS: Main: 216743936 05:20:29 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | Cycle 1(1): loaded http://localhost:43897/tests/dromaeo/cssquery-yui.html (next: http://localhost:43897/tests/dromaeo/cssquery-dojo.html) 05:23:32 INFO - PROCESS | 320 | RSS: Main: 271556608 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | __start_tp_report 05:23:32 INFO - PROCESS | 320 | _x_x_mozilla_page_load 05:23:32 INFO - PROCESS | 320 | _x_x_mozilla_page_load_details 05:23:32 INFO - PROCESS | 320 | |i|pagename|runs| 05:23:32 INFO - PROCESS | 320 | |0;dojo.html;3141.6230052393707;3173.4446471867445;3198.312362841987;3215.5980502437196;3242.85407156678;5112.590992720583;5190.091733946559;5198.586191940899;5236.1098613235745;5241.633085684004;5140.742962851852;5214.947850521494;5222.529972302502;5239.978204250173;5256.237845512398;4805.639577031719;4815.614750819926;4833.468318484964;4841.951580484185;4888.071266459379;4858.149823780825;4913.066517361708;4954.455009948921;4961.355023846912;4983.252512123175;4642.466116396624;4715.952840471586;4730.881727956794;4885.193942999401;4893.14369985253;4745.074710431467;4754.405699287589;4759.357486739281;4759.428868535798;4762.666613337068;4723.527647235283;4739.123262196505;4744.715317080986;4825.10735513931;4849.709017458964;5189.065968125736;5207.6354655174155;5210.270562121306;5210.374755029383;5237.4500677428705;5713.457221563945;5728.054870946289;5734.799282025151;5740.483356497935;5751.913721294184;5533.391326954032;5580.414056524047;5679.858003549944;5681.062624666925;5824.504917082053;5319.228711836762;5369.946300537023;5374.6506477078865;5375.516203541661;5380.569554435636;5794.62334948227;5817.360090390053;5847.8245652630485;5852.180694702745;5854.2389489366105;5433.918491222635;5501.449855014546;5524.475174858382;5527.834164975057;5618.606697531133;5549.72251387429;5599.916001259984;5600;5603.635763675348;5634.154876768517;5624.437556244343;5626.409227031185;5627.634203776742;5627.662340259598;5636.633618814764;5501.4223506532035;5565.443455654483;5608.186812912187;5628.71856407178;5644.435556444405;4393.121375724868;4399.890002749957;4402.031553058322;4402.427684401071;4434.290513517822;3910.296146693566;3917.334053210961;3924.4898163238595;3967.9801600992387;3969.92060158801;5024.296598476216;5154.871128221825;5175.9741201293755;5186.766595503212;5293.973530132324;5643.746031428595;5660.830175094754;5662.065759149694;5689.573282003867;5692.203091567184;5118.820841270612;5290.92063619046;5297.655652382583;5303.469653034743;5354.089804733205;4715.198416269242;4733.9763301183275;4761.142994261067;4781.617470602343;4815.518448155157;5883.117532370093;5917.7928772493615;5918.496927761188;5918.496927761188;5918.881622367615;5435.483629055233;5556.916646250229;5630.465105814941;5685.772569097356;5751.4536119068625;5863.325717542537;5952.791652292149;5962.135490353788;5967.940320596738;5993.790217342372;5554.166874968787;5558.499735023867;5561.4716601922755;5562.833115006556;5565.638233514808;5572.219889215432;5625.184348269559;5634.549236061023;5652.349979752381;5694.06048002075;5580.302462192226;5595.300587426572;5601.747921343468;5602.383737788921;5609.803656872153;5561.944380556142;5576.581756368208;5577.581681373995;5578.246936663661;5580.302462192226;5339.893202136013;5376.838694839161;5471.06991811401;5508.807191748269;5534;5586.16207568868;5599.60802743804;5611.691356975405;5616.691081990366;5616.719164041863;5468.5351745100525;5469.097598896137;5480.972595136999;5483.314585676791;5483.396826349178 05:23:32 INFO - PROCESS | 320 | |1;ext.html;533.3386600615237;537.0923139893578;545.1903922674829;560.7663141089604;574.4513989140369;30352.54471182934;31022.224444388874;36432.81783591085;36443;36642.45036324454;40006.59993400065;40500.59499405005;40509.59490405095;40515;40529;8491.320694344438;8687.782805429852;8696.21734043936;8698.130186981283;8701.390902636818;8418.957905210465;8491.575421228914;8527.317814574819;8537.701180458685;8540;8487.40588158829;8546.188112129337;8546.786330341729;8550.957245213796;8558;8489.193526614961;8525.232729054353;8534.359923005737;8553.358498112666;8560.871586926201;8567.31461483086;8716.607752651145;8719.956400217958;8721.956390218009;8723.476591404537;39429.80285098585;39558;39832;39921.80039099786;39931.8003409984;2968.8218706877656;3065.724084832376;3101.5347697845277;3238.87044518219;3403.149212696826;29438.85280573605;29976.700232997828;30135.698643013508;30993.225169370722;31251.687483125104;3969.64273215412;4014.7992600369867;4037.7577345359373;4040.454538637305;4107.753534787892;258851.9999999981;259422;259605;259997;260011;53105.2034219487;53755.46244537583;54376.728116359955;57328.42671573314;59599.40400595938;55056.724716376964;55392;55486.44513554894;55493.72253138709;55526;15470.458533951258;15972.920135399481;15977.520674379788;16050.117243551484;16074.357025719075;10954.561817527368;11086.61196858106;11581.88418115808;12024.398780061138;12326.75346493083;19256.22975080981;19262.518437039187;19310.517237069187;19382.903085484766;19496.31762888292;7139.678714457862;7218.8917166242545;7258.782236532912;7298.927010729931;7370.520916140434;939.4316438554713;958.8513780364054;985.1675334342469;1046.6075221791828;1069.9251052426255;27348.589771153052;28915;29547.704522954926;29644.258893527833;29912;935.219092058139;983.5328219096016;998.6155330197926;1005.527402121002;1083.8320060390652;13097.934510327388;13153.868461315456;13331;13406.128601640861;13432.328383580782;339236;345631;347405;347747;348624;52114;52421;52437;52439.475605244224;52531.47468525342;1327.508821735964;1331.447449308526;1355.0311527257861;1356.837179538442;1358.8165597644388;25826.99681549363;26489.60265596056;26918.192454226406;26936;26997.730022700307;36912.44631330586;37159.442608360354;37266.62733372632;38361.42457863079;38476.615233848424;313775;313953;315248;316791;317245;27933.441331172857;31296.530552042193;31692.366152677278;31900.840495797373;31943.361132777678;37458;38041.4293785599;38225.426618600184;38300.80849595734;38821;33236.335273294884;34961.65038349584;34987;35227.82386088053;35465.468017979234;27885.302867427665;31814.840925795223;32539;35057.298854023284;35806.82096589501;32145.678543214268;32692;32927.50608740823;32955.34089318152;32987;30402.391952161277;30942.690573094882;36008.63991360053;36342.27315453729;36689;24230.23179759564;24328.391790205387;24467.265982020566;24660.260192194262;24663.753362466145 05:23:32 INFO - PROCESS | 320 | |2;jquery.html;361.4271379862917;363.1647211413748;364.215116424106;364.67726062434747;371.66735771484537;13179.60461186166;13557.457701691945;15943.282552285145;16115.75826362604;16545.090020048894;14570.271486425689;14625.92687036566;15737.449189278377;15786.684266314667;15791.210439478038;4803.783829727662;5256.421793602701;5463.098588732854;5467.20725494803;5467.343918729758;3763.0780458787635;3896.5518965319066;3898.610138986107;5286.836895882919;5317.813876514323;5257.474252574751;5446.428125046872;5482.451754824526;5488.067028605126;5500.944990550103;5360.356757189143;5380.031594313022;5384.380796208447;5388.838334849941;5389.272448219479;5022.347094877679;5156.381234251876;5164.509371609691;5266.526012658879;5272.815451459219;12726.363681815872;12836.294003829786;12876.454825420915;16981.23584438691;17593;1929.305450037985;2016.1532156494306;2105.768365479796;2195.6157672407426;2202.9559408811733;8911.465312081296;9340.953295233548;9447.574859131355;10974.835377469344;13137.474501019948;1667.1330907927809;1774.352361388097;1835.632873425307;1847.0395394394973;1882.8023057578894;53816;54045;55161.172582411295;57440.425595744346;57544.71227643835;9674.854877176847;9847.458389788488;9852.11330980201;9926.15627671656;9994.200463962865;12876.613701588967;12967.22196668203;12973;13013.674658133434;13025.153365031432;7045.506814522934;7078.610676412847;7096.57420554758;7582.696692132363;7645.961770191114;7005.614691191931;7431.739889103856;7452.888206676904;7516.812079697942;7552.244775522514;4209.5579964103945;4330.870073897788;4341.9131617367475;4369.191699535596;4371.540988196193;1668;1700.8469237768413;1705.1474262868567;1760.64787042592;1764.2325588368844;420.9705320627527;871.5729292646685;897.9506127162938;911.266430523435;990.2573070197352;9393.389429687048;10478.318909270873;10665.41340226295;10675.62635307776;11104.056155226735;449.9885511762417;467.8269040454985;470.77402846633805;475.91433541962084;491.33178876727624;5091.312672789126;6083.726232319467;6184.196054512884;6194.349593292639;6201;408034;409968;410817;413146;415670;64758.35241647618;66168;72360.27639723536;73270.63364683143;73811.63094184495;1112.2770199370311;1116.983245251322;1124.3872089711126;1156.9074474042056;1160.6169963911889;14097.718045639234;14379.885486681604;14749.631259218606;14936.103833770008;14962.700745985238;33589;33636;34130.48804267988;34406;35283;39869.60130398659;40217.19565608613;40833;40964;41760;6884.65576721152;7028.297170282931;7094.503384763017;7424.740134095281;7517.774466766005;7816.452848300564;10076.596936122472;10703.946480267548;10834.566617335533;11084;3138.1526987713646;3158.3051728620585;7791.610419479117;9222.492762898106;9250.676226332045;9655.827438826207;9809.411435313905;9892.208623309974;9984.35101718386;10082.243831712503;9828.361156524803;9863.753406164904;10079.798404032024;10124.69625911224;10167.79664406693;7191.20896701352;7208.855822883408;7246.4202863769715;7281.381082608038;7414.888776668462;8064.233897779702;9878.506074696093;9971.903090660167;9999.3000489965;10047.09576138151 05:23:32 INFO - PROCESS | 320 | |3;mootools.html;1296.209312319485;1301.5119330251157;1316.8880645145161;1361.8842398396137;1643.8027436707596;6839;7463.738769143074;7684.769456916301;7697.653605587748;7697.923020769791;7396.149442814078;7579.4694371394025;7584.241575842413;7608.619569021541;7644.770656880289;2008.8694234874758;2053.5995480881234;2321.1063740459876;2366.976330236693;2397;2349.800266977309;2358.0803486640225;2359;2359.504504054151;2361.327021798788;2281.041962375806;2335.532893421314;2336.88315584221;2337.906483740648;2338.9766102339013;2271;2274.067632270761;2377.0372998935372;2377.3818807110274;2378.1557547070715;2345.3667509772436;2356.575816353056;2375.251795684354;2382.809375249976;2388.1402695029774;7661.463697541174;7704.499207551491;7717.922820771777;7782.377409807202;7807.765767026998;4737.668363214576;4834.58905992991;4851.781669824866;4866.951330486685;4867.464578896319;3092.6288845338704;3156.510740835174;3182.252170739874;3191.6010498687665;3199.9040028799172;994.8618661106532;1021.764994051365;1023.6417253961129;1033.4316126130673;1051.8948105189497;10607.469626518721;10632.202584806093;10637.414942178177;10642.09542188915;10702.250842441032;4407.405000324915;4433.069055498381;4464.709793863389;4561.384213131251;4575.290829921368;8169.42814003026;8209.95895020533;8242.76358546223;8256.669733210725;8258.091609922903;4762.285657151455;4794.7842347094465;4795.376601041842;4798.832040878552;4799.544043315879;4421.137878113737;4426.800793964279;4430.335449682573;4432.29083346663;4452.30989196675;3319;3366.5455163553097;3568.3398571264397;3624.583172935146;3666.1201311685004;1131.6322195286564;1133.82992551118;1135.0635725526474;1139.6751925701135;1143.8684551276542;1218.3847157185564;1233.975320493585;1247.058470854499;1320.570814485296;1321.6101250131235;7281.927180728231;7282.781516554512;7284.417246620258;7450.217727138681;7458.179600243969;1021.6526381030485;1042.5569133118395;1045.3832238978887;1049.8792638846478;1069.1233188785122;5575.303087114111;5632.183333416631;5633.211350410946;5640.5487560995025;5641.210230567724;9175.816483670289;9288.489133097744;9355.204807591295;9599.32804703664;9602.567884445216;9378.85931711025;9404.106609872051;9508.096730810563;9508.619655213852;9513.476758778334;7187.820304492429;7352.669129889167;7358.742444014434;7436.814079648052;7436.85126297471;6992.405645520188;7034.5427547209265;7037.366637002694;7042.683079261343;7049.259827718221;8089;8327.875081873897;8481.09175435522;8485.618147183268;8492.278156356779;8375.329973601976;8653.17794809492;8790.472571645721;8797.560121994004;8806.295496360404;5948.078047902582;6571.441427478718;6580.736770529125;6673.866522669617;6701.865962680817;6832.624205668736;6888.276730943179;6889.414399776075;7014.894776578253;7250.456215783732;6659.134312539339;6714.160729908762;6793.864122717617;6884.898416253375;6964.665730768992;6632.502562307943;6768.763093291908;6797.776400248003;6828.556143850634;6839.555428897106;6902.378785909293;6907.240203577703;6921.446284297345;6951.2353641098425;6973.267806880204;6185.165002724754;6203.565750397429;6225.097360882556;6225.128482012612;6259.280182779039;6473.482121430368;6475.708593113415;6487.124238227779;6510.990796426561;6537.28089910119 05:23:32 INFO - PROCESS | 320 | |4;prototype.html;345.9290845376698;347.2984571166243;348.1018971054679;353.76651410069326;357.7317012240821;5745.195672605839;5831.533477321815;5931.08068249422;5935.970320148404;5944.167816505687;5687.687177205252;5829.708514574265;5833.241678581789;5854.853628659285;5858.853528661785;4559.612432943204;4562.794674239667;4564.680472366936;4565.88585285368;4568.7944042518;4386.056997745484;4464.776761161945;4466.8436604718845;4548.840790572331;4589.816407343702;4525.705829121097;4529.977350113245;4543.22765129927;4546.772661366918;4549.749763763009;4537.568930951587;4538.1377538267625;4550.567696068868;4551.249043907751;4551.749653769041;4007.73949693269;4008.599140085997;4017.4576432181575;4019.7588144711412;4021.617946295097;5456;5584.162375643646;5604.691741954191;5606.103023516218;5620.213170156181;5250.291210686547;5312.096943519611;5320.574354051667;5326.280952071459;5326.7070311132875;5916.7337469813965;6249.375062493759;6255.374462553754;6257.405546473078;6266.310705822356;4303.655707543389;4368.279233926399;4377.387165796791;4393.07745373472;4401.273789824675;6359.491240700733;6450.129232553592;6455.354464553554;6461.386168314003;6464.5798023128345;4575.771211439414;4584.426946631671;4585.403897493371;4586.266197408466;4588.059447813257;4557.886052848639;4642.442906851132;4646.372739680168;4661.3707149534375;4675.392199014174;5273;5279.944011197776;5282.049231138432;5287.180487024518;5288.867778305573;6159.599626024384;6219.720112594853;6236.158118654014;6243.188385509946;6243.500519958392;1622.7160246956971;1623.3263195773623;1639.6392793585392;1641.6962861870593;1648.464249119017;1124.3534967393782;1127.836463712757;1135.9602413915472;1138.1065863297272;1168.118070856498;5902.527797776168;5904.852378690482;5910.261217347832;5910.379410161957;5911.793087241926;6385.553011289258;6404.807855764335;6410.166678331787;6416.743330266737;6417.876871547461;5903.144044113666;5903.6457812530525;5903.822885313448;5904.616199947076;5911.556633252523;3377.257003459235;3477.6870081692264;3483.4600636901323;3510.227749895019;3516.331896939573;6757.8648427031185;6761.425278851353;6763.188417389944;6768.255491895888;6770.864582708318;6653.301403352578;6655.900161497581;6664.067030615621;6668.466522678174;6670.0661907333015;6570.408663220333;6714.899276510954;6822.965885170543;6854.5201835872;6867.587944723333;6239.594426362272;6402.071699603624;6456.805490984183;6494.577852439576;6501.284858665637;6281.057841323655;6343.333949935375;6424.935750642434;6432.839179020375;6434.549581529248;6679.265280819009;6705.329467053256;6733.595984240961;6737.562058466184;6743.426808721314;4366.126774645148;4448.755318457386;4492.3935268738305;4493.415855938707;4494.887627809331;6415.743370265137;6437.485001199986;6475.3200913903365;6477.676116194266;6483.222013358427;6271.404216599416;6314.179156709598;6319.304876463493;6332.461740751904;6337.96831015842;6200.224971878515;6241.469475094668;6264.937350626617;6296.0555916612875;6305.716242769178;6178.104174894705;6178.135061091541;6180.6291622502795;6188.535859810442;6193.071039344134;6261.467775239155;6315.810525684236;6320.304766475776;6323.114763932961;6330.620162790247;6073.817785466443;6134.2332208473945;6150.692465376624;6162.938370616416;6167.321594624677 05:23:32 INFO - PROCESS | 320 | |5;yui.html;754.2985023927747;829.4442723375334;837.7779888329594;843.7300063979525;853.978650533737;13163.670908227286;13289.136206146593;13296.069275150743;13336.866631333683;13348.132371395852;12061.638150855466;12069.51721931124;12104.031677465804;12186.390680465985;12222.694432639166;652.3281020548842;666.8432918264205;802.2899733735628;811.6591031766643;813.4996976859219;801.0227522422636;805.4643661964786;806.2018601584448;808.4098608016122;809.0857331215718;836.3977935886182;838.1157878438245;839.5046922315832;839.5508403004394;840.8276303357796;684.3191024930202;684.3635419060272;684.6816230452813;694.3438450664124;831.9459235149726;516.6693316277585;518.7847043476952;519.2393144043956;519.4857091479446;520.6043407010661;12552.686182845411;12572.685682857911;12636;12664.240145591293;12673.619791406272;11623;12187.32969686667;12293.56972505958;12524.185927914748;12749.872501275055;10085.394876307371;10109.797804043877;10180.745481362952;10212.897871021269;10317.277790554665;3486.1981744198974;3512.736544759128;3531.040272648679;3534.6995505382074;3622.4385220290897;41987.37018944718;42211.36682949758;42682.146357073;42754.35868461976;42924.141517169795;9803.30815717472;9810.705678829647;9863.556139973718;10047.497625118714;10300.55792189094;16384.344626214817;16572.088535130682;16607.169641517874;16630.251638676287;16668;7097.290270972861;7281.1262648482525;7336.669849856769;7417.369523590447;7448.59032753193;4241.893952651147;4302.053548219386;4312.396264522969;4361.847335343247;4368.475782906072;3109.16052665779;3130.248740302311;3134.81191128533;3135.7177853992794;3144.9056528304186;577.9682117483495;579.3308728418683;581.4360070731384;584.4185035889233;594.4917095883044;498.63848709685914;596.8985272503598;608.6895683201599;609.8414412252846;614.1954040207343;8386.161383861565;8538.231559159582;8539.316854651737;8615.784605384915;8860.158284962918;545.5744519274972;599.5743022454019;635.4281146967766;650.5153660522941;653.3956090616161;3707.480952666629;3821.637048896681;3866.304065268279;3911.78485183312;4035.435039094529;53686.463135368926;54136.45863541393;54521.454785451635;54539.45460545423;54570.72714636401;47133.5286647136;47678.76160619175;48407.273890891665;48435.75782121067;48826.26760598594;42833.78583107064;43077.78461107674;44116.3382549262;44505;46011.30983035324;8468.534230617375;8678.392512524062;8700;8912.197902188835;9129.77175570616;31138.22154446157;31591.368172636878;31630.841845790623;32772.83613581917;32784.83607581947;39614.20771584495;39715;43545.56454435542;44586;44683.329750053126;10443.738906527398;10555.419451930218;10677;10744.83882741744;10746.892531074589;11489.770204595694;11556.711082223012;11616.361100139235;11925.284482931052;11987.280763154238;10932.781344373227;11069.391183484986;11404.087672985976;11680.123990700562;11794.410279485819;10944.23390362667;11081.27971681838;11195.888041119484;11505.482253298454;11549.42252887369;11204.719882003015;11251;11259.887401126212;11393.829092563452;11626.418679066182;9197.678081267124;9365.157135857806;9418.387804792941;9542.713718588453;9731;8782.912170878464;8962.238209752244;9003;9950.651727189514;9997.300188986701 05:23:32 INFO - PROCESS | 320 | __end_tp_report 05:23:32 INFO - PROCESS | 320 | __start_cc_report 05:23:32 INFO - PROCESS | 320 | _x_x_mozilla_cycle_collect,804 05:23:32 INFO - PROCESS | 320 | __end_cc_report 05:23:32 INFO - PROCESS | 320 | __startTimestamp1452605012393__endTimestamp 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | ------- Summary: start ------- 05:23:32 INFO - PROCESS | 320 | Number of tests: 6 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | [#0] dojo.html Cycles:165 Average:5254.74 Median:5480.97 stddev:581.22 (10.6%) stddev-sans-first:558.86 05:23:32 INFO - PROCESS | 320 | Values: 3141.6 3173.4 3198.3 3215.6 3242.9 5112.6 5190.1 5198.6 5236.1 5241.6 5140.7 5214.9 5222.5 5240.0 5256.2 4805.6 4815.6 4833.5 4842.0 4888.1 4858.1 4913.1 4954.5 4961.4 4983.3 4642.5 4716.0 4730.9 4885.2 4893.1 4745.1 4754.4 4759.4 4759.4 4762.7 4723.5 4739.1 4744.7 4825.1 4849.7 5189.1 5207.6 5210.3 5210.4 5237.5 5713.5 5728.1 5734.8 5740.5 5751.9 5533.4 5580.4 5679.9 5681.1 5824.5 5319.2 5369.9 5374.7 5375.5 5380.6 5794.6 5817.4 5847.8 5852.2 5854.2 5433.9 5501.4 5524.5 5527.8 5618.6 5549.7 5599.9 5600.0 5603.6 5634.2 5624.4 5626.4 5627.6 5627.7 5636.6 5501.4 5565.4 5608.2 5628.7 5644.4 4393.1 4399.9 4402.0 4402.4 4434.3 3910.3 3917.3 3924.5 3968.0 3969.9 5024.3 5154.9 5176.0 5186.8 5294.0 5643.7 5660.8 5662.1 5689.6 5692.2 5118.8 5290.9 5297.7 5303.5 5354.1 4715.2 4734.0 4761.1 4781.6 4815.5 5883.1 5917.8 5918.5 5918.5 5918.9 5435.5 5556.9 5630.5 5685.8 5751.5 5863.3 5952.8 5962.1 5967.9 5993.8 5554.2 5558.5 5561.5 5562.8 5565.6 5572.2 5625.2 5634.5 5652.3 5694.1 5580.3 5595.3 5601.7 5602.4 5609.8 5561.9 5576.6 5577.6 5578.2 5580.3 5339.9 5376.8 5471.1 5508.8 5534.0 5586.2 5599.6 5611.7 5616.7 5616.7 5468.5 5469.1 5481.0 5483.3 5483.4 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | [#1] ext.html Cycles:180 Average:46426.35 Median:35346.65 stddev:81008.43 (229.2%) stddev-sans-first:81162.40 05:23:32 INFO - PROCESS | 320 | Values: 533.3 537.1 545.2 560.8 574.5 30352.5 31022.2 36432.8 36443.0 36642.5 40006.6 40500.6 40509.6 40515.0 40529.0 8491.3 8687.8 8696.2 8698.1 8701.4 8419.0 8491.6 8527.3 8537.7 8540.0 8487.4 8546.2 8546.8 8551.0 8558.0 8489.2 8525.2 8534.4 8553.4 8560.9 8567.3 8716.6 8720.0 8722.0 8723.5 39429.8 39558.0 39832.0 39921.8 39931.8 2968.8 3065.7 3101.5 3238.9 3403.1 29438.9 29976.7 30135.7 30993.2 31251.7 3969.6 4014.8 4037.8 4040.5 4107.8 258852.0 259422.0 259605.0 259997.0 260011.0 53105.2 53755.5 54376.7 57328.4 59599.4 55056.7 55392.0 55486.4 55493.7 55526.0 15470.5 15972.9 15977.5 16050.1 16074.4 10954.6 11086.6 11581.9 12024.4 12326.8 19256.2 19262.5 19310.5 19382.9 19496.3 7139.7 7218.9 7258.8 7298.9 7370.5 939.4 958.9 985.2 1046.6 1069.9 27348.6 28915.0 29547.7 29644.3 29912.0 935.2 983.5 998.6 1005.5 1083.8 13097.9 13153.9 13331.0 13406.1 13432.3 339236.0 345631.0 347405.0 347747.0 348624.0 52114.0 52421.0 52437.0 52439.5 52531.5 1327.5 1331.4 1355.0 1356.8 1358.8 25827.0 26489.6 26918.2 26936.0 26997.7 36912.4 37159.4 37266.6 38361.4 38476.6 313775.0 313953.0 315248.0 316791.0 317245.0 27933.4 31296.5 31692.4 31900.8 31943.4 37458.0 38041.4 38225.4 38300.8 38821.0 33236.3 34961.7 34987.0 35227.8 35465.5 27885.3 31814.8 32539.0 35057.3 35806.8 32145.7 32692.0 32927.5 32955.3 32987.0 30402.4 30942.7 36008.6 36342.3 36689.0 24230.2 24328.4 24467.3 24660.3 24663.8 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | [#2] jquery.html Cycles:180 Average:23195.32 Median:2410.76 stddev:67492.98 (2799.7%) stddev-sans-first:67660.54 05:23:32 INFO - PROCESS | 320 | Values: 361.4 363.2 364.2 364.7 371.7 13179.6 13557.5 15943.3 16115.8 16545.1 14570.3 14625.9 15737.4 15786.7 15791.2 4803.8 5256.4 5463.1 5467.2 5467.3 3763.1 3896.6 3898.6 5286.8 5317.8 5257.5 5446.4 5482.5 5488.1 5500.9 5360.4 5380.0 5384.4 5388.8 5389.3 5022.3 5156.4 5164.5 5266.5 5272.8 12726.4 12836.3 12876.5 16981.2 17593.0 1929.3 2016.2 2105.8 2195.6 2203.0 8911.5 9341.0 9447.6 10974.8 13137.5 1667.1 1774.4 1835.6 1847.0 1882.8 53816.0 54045.0 55161.2 57440.4 57544.7 9674.9 9847.5 9852.1 9926.2 9994.2 12876.6 12967.2 12973.0 13013.7 13025.2 7045.5 7078.6 7096.6 7582.7 7646.0 7005.6 7431.7 7452.9 7516.8 7552.2 4209.6 4330.9 4341.9 4369.2 4371.5 1668.0 1700.8 1705.1 1760.6 1764.2 421.0 871.6 898.0 911.3 990.3 9393.4 10478.3 10665.4 10675.6 11104.1 450.0 467.8 470.8 475.9 491.3 5091.3 6083.7 6184.2 6194.3 6201.0 408034.0 409968.0 410817.0 413146.0 415670.0 64758.4 66168.0 72360.3 73270.6 73811.6 1112.3 1117.0 1124.4 1156.9 1160.6 14097.7 14379.9 14749.6 14936.1 14962.7 33589.0 33636.0 34130.5 34406.0 35283.0 39869.6 40217.2 40833.0 40964.0 41760.0 6884.7 7028.3 7094.5 7424.7 7517.8 7816.5 10076.6 10703.9 10834.6 11084.0 3138.2 3158.3 7791.6 9222.5 9250.7 9655.8 9809.4 9892.2 9984.4 10082.2 9828.4 9863.8 10079.8 10124.7 10167.8 7191.2 7208.9 7246.4 7281.4 7414.9 8064.2 9878.5 9971.9 9999.3 10047.1 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | [#3] mootools.html Cycles:180 Average:5397.88 Median:6194.37 stddev:2758.80 (44.5%) stddev-sans-first:2749.30 05:23:32 INFO - PROCESS | 320 | Values: 1296.2 1301.5 1316.9 1361.9 1643.8 6839.0 7463.7 7684.8 7697.7 7697.9 7396.1 7579.5 7584.2 7608.6 7644.8 2008.9 2053.6 2321.1 2367.0 2397.0 2349.8 2358.1 2359.0 2359.5 2361.3 2281.0 2335.5 2336.9 2337.9 2339.0 2271.0 2274.1 2377.0 2377.4 2378.2 2345.4 2356.6 2375.3 2382.8 2388.1 7661.5 7704.5 7717.9 7782.4 7807.8 4737.7 4834.6 4851.8 4867.0 4867.5 3092.6 3156.5 3182.3 3191.6 3199.9 994.9 1021.8 1023.6 1033.4 1051.9 10607.5 10632.2 10637.4 10642.1 10702.3 4407.4 4433.1 4464.7 4561.4 4575.3 8169.4 8210.0 8242.8 8256.7 8258.1 4762.3 4794.8 4795.4 4798.8 4799.5 4421.1 4426.8 4430.3 4432.3 4452.3 3319.0 3366.5 3568.3 3624.6 3666.1 1131.6 1133.8 1135.1 1139.7 1143.9 1218.4 1234.0 1247.1 1320.6 1321.6 7281.9 7282.8 7284.4 7450.2 7458.2 1021.7 1042.6 1045.4 1049.9 1069.1 5575.3 5632.2 5633.2 5640.5 5641.2 9175.8 9288.5 9355.2 9599.3 9602.6 9378.9 9404.1 9508.1 9508.6 9513.5 7187.8 7352.7 7358.7 7436.8 7436.9 6992.4 7034.5 7037.4 7042.7 7049.3 8089.0 8327.9 8481.1 8485.6 8492.3 8375.3 8653.2 8790.5 8797.6 8806.3 5948.1 6571.4 6580.7 6673.9 6701.9 6832.6 6888.3 6889.4 7014.9 7250.5 6659.1 6714.2 6793.9 6884.9 6964.7 6632.5 6768.8 6797.8 6828.6 6839.6 6902.4 6907.2 6921.4 6951.2 6973.3 6185.2 6203.6 6225.1 6225.1 6259.3 6473.5 6475.7 6487.1 6511.0 6537.3 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | [#4] prototype.html Cycles:180 Average:5252.92 Median:5904.22 stddev:1559.43 (26.4%) stddev-sans-first:1519.69 05:23:32 INFO - PROCESS | 320 | Values: 345.9 347.3 348.1 353.8 357.7 5745.2 5831.5 5931.1 5936.0 5944.2 5687.7 5829.7 5833.2 5854.9 5858.9 4559.6 4562.8 4564.7 4565.9 4568.8 4386.1 4464.8 4466.8 4548.8 4589.8 4525.7 4530.0 4543.2 4546.8 4549.7 4537.6 4538.1 4550.6 4551.2 4551.7 4007.7 4008.6 4017.5 4019.8 4021.6 5456.0 5584.2 5604.7 5606.1 5620.2 5250.3 5312.1 5320.6 5326.3 5326.7 5916.7 6249.4 6255.4 6257.4 6266.3 4303.7 4368.3 4377.4 4393.1 4401.3 6359.5 6450.1 6455.4 6461.4 6464.6 4575.8 4584.4 4585.4 4586.3 4588.1 4557.9 4642.4 4646.4 4661.4 4675.4 5273.0 5279.9 5282.0 5287.2 5288.9 6159.6 6219.7 6236.2 6243.2 6243.5 1622.7 1623.3 1639.6 1641.7 1648.5 1124.4 1127.8 1136.0 1138.1 1168.1 5902.5 5904.9 5910.3 5910.4 5911.8 6385.6 6404.8 6410.2 6416.7 6417.9 5903.1 5903.6 5903.8 5904.6 5911.6 3377.3 3477.7 3483.5 3510.2 3516.3 6757.9 6761.4 6763.2 6768.3 6770.9 6653.3 6655.9 6664.1 6668.5 6670.1 6570.4 6714.9 6823.0 6854.5 6867.6 6239.6 6402.1 6456.8 6494.6 6501.3 6281.1 6343.3 6424.9 6432.8 6434.5 6679.3 6705.3 6733.6 6737.6 6743.4 4366.1 4448.8 4492.4 4493.4 4494.9 6415.7 6437.5 6475.3 6477.7 6483.2 6271.4 6314.2 6319.3 6332.5 6338.0 6200.2 6241.5 6264.9 6296.1 6305.7 6178.1 6178.1 6180.6 6188.5 6193.1 6261.5 6315.8 6320.3 6323.1 6330.6 6073.8 6134.2 6150.7 6162.9 6167.3 05:23:32 INFO - PROCESS | 320 | 05:23:32 INFO - PROCESS | 320 | [#5] yui.html Cycles:180 Average:13092.86 Median:4365.16 stddev:14818.87 (339.5%) stddev-sans-first:14831.47 05:23:32 INFO - PROCESS | 320 | Values: 754.3 829.4 837.8 843.7 854.0 13163.7 13289.1 13296.1 13336.9 13348.1 12061.6 12069.5 12104.0 12186.4 12222.7 652.3 666.8 802.3 811.7 813.5 801.0 805.5 806.2 808.4 809.1 836.4 838.1 839.5 839.6 840.8 684.3 684.4 684.7 694.3 831.9 516.7 518.8 519.2 519.5 520.6 12552.7 12572.7 12636.0 12664.2 12673.6 11623.0 12187.3 12293.6 12524.2 12749.9 10085.4 10109.8 10180.7 10212.9 10317.3 3486.2 3512.7 3531.0 3534.7 3622.4 41987.4 42211.4 42682.1 42754.4 42924.1 9803.3 9810.7 9863.6 10047.5 10300.6 16384.3 16572.1 16607.2 16630.3 16668.0 7097.3 7281.1 7336.7 7417.4 7448.6 4241.9 4302.1 4312.4 4361.8 4368.5 3109.2 3130.2 3134.8 3135.7 3144.9 578.0 579.3 581.4 584.4 594.5 498.6 596.9 608.7 609.8 614.2 8386.2 8538.2 8539.3 8615.8 8860.2 545.6 599.6 635.4 650.5 653.4 3707.5 3821.6 3866.3 3911.8 4035.4 53686.5 54136.5 54521.5 54539.5 54570.7 47133.5 47678.8 48407.3 48435.8 48826.3 42833.8 43077.8 44116.3 44505.0 46011.3 8468.5 8678.4 8700.0 8912.2 9129.8 31138.2 31591.4 31630.8 32772.8 32784.8 39614.2 39715.0 43545.6 44586.0 44683.3 10443.7 10555.4 10677.0 10744.8 10746.9 11489.8 11556.7 11616.4 11925.3 11987.3 10932.8 11069.4 11404.1 11680.1 11794.4 10944.2 11081.3 11195.9 11505.5 11549.4 11204.7 11251.0 11259.9 11393.8 11626.4 9197.7 9365.2 9418.4 9542.7 9731.0 8782.9 8962.2 9003.0 9950.7 9997.3 05:23:32 INFO - PROCESS | 320 | -------- Summary: end -------- 05:23:32 INFO - PROCESS | 320 | 05:23:33 INFO - TEST-INFO | 320: exit 0 05:23:33 INFO - TEST-OK | dromaeo_css | took 1113678ms 05:23:33 INFO - TEST-START | kraken 05:23:33 INFO - operating with platform_type : linux_ 05:23:33 INFO - Initialising browser for kraken test... 05:23:33 INFO - TEST-INFO | started process 514 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRdlPEQ/profile http://localhost:43897/getInfo.html) 05:23:37 INFO - PROCESS | 514 | __metrics Screen width/height:1600/1200 05:23:37 INFO - PROCESS | 514 | colorDepth:24 05:23:37 INFO - PROCESS | 514 | Browser inner width/height: 1024/697 05:23:37 INFO - PROCESS | 514 | __metrics 05:23:37 INFO - PROCESS | 514 | 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:23:37 INFO - PROCESS | 514 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:39 INFO - TEST-INFO | 514: exit 0 05:23:39 INFO - Browser initialized. 05:23:39 INFO - Running cycle 1/1 for kraken test... 05:23:39 INFO - TEST-INFO | started process 596 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRdlPEQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:50 INFO - PROCESS | 596 | RSS: Main: 148176896 05:23:50 INFO - PROCESS | 596 | 05:23:53 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43897/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:54 INFO - PROCESS | 596 | RSS: Main: 184135680 05:23:54 INFO - PROCESS | 596 | 05:23:56 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43897/tests/kraken/driver.html?testName=audio-dft) 05:23:57 INFO - PROCESS | 596 | RSS: Main: 175001600 05:23:57 INFO - PROCESS | 596 | 05:24:00 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43897/tests/kraken/driver.html?testName=audio-fft) 05:24:00 INFO - PROCESS | 596 | RSS: Main: 159006720 05:24:00 INFO - PROCESS | 596 | 05:24:02 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43897/tests/kraken/driver.html?testName=audio-oscillator) 05:24:03 INFO - PROCESS | 596 | RSS: Main: 162521088 05:24:03 INFO - PROCESS | 596 | 05:24:05 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43897/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:06 INFO - PROCESS | 596 | RSS: Main: 163860480 05:24:06 INFO - PROCESS | 596 | 05:24:09 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43897/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:09 INFO - PROCESS | 596 | RSS: Main: 165756928 05:24:09 INFO - PROCESS | 596 | 05:24:13 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43897/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:13 INFO - PROCESS | 596 | RSS: Main: 166277120 05:24:13 INFO - PROCESS | 596 | 05:24:16 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43897/tests/kraken/driver.html?testName=json-parse-financial) 05:24:16 INFO - PROCESS | 596 | RSS: Main: 163921920 05:24:16 INFO - PROCESS | 596 | 05:24:18 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43897/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:19 INFO - PROCESS | 596 | RSS: Main: 173330432 05:24:19 INFO - PROCESS | 596 | 05:24:20 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:21 INFO - PROCESS | 596 | RSS: Main: 171085824 05:24:21 INFO - PROCESS | 596 | 05:24:23 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:24 INFO - PROCESS | 596 | RSS: Main: 180715520 05:24:24 INFO - PROCESS | 596 | 05:24:26 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:27 INFO - PROCESS | 596 | RSS: Main: 186339328 05:24:27 INFO - PROCESS | 596 | 05:24:29 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:30 INFO - PROCESS | 596 | RSS: Main: 185430016 05:24:30 INFO - PROCESS | 596 | 05:24:31 INFO - PROCESS | 596 | Cycle 1(1): loaded http://localhost:43897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43897/tests/kraken/driver.html?testName=ai-astar) 05:24:32 INFO - PROCESS | 596 | RSS: Main: 242466816 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | __start_tp_report 05:24:32 INFO - PROCESS | 596 | _x_x_mozilla_page_load 05:24:32 INFO - PROCESS | 596 | _x_x_mozilla_page_load_details 05:24:32 INFO - PROCESS | 596 | |i|pagename|runs| 05:24:32 INFO - PROCESS | 596 | |0;ai-astar;109;110;104;111;112;112;100;112;111;111 05:24:32 INFO - PROCESS | 596 | |1;audio-beat-detection;151;134;164;172;125;150;159;127;168;124 05:24:32 INFO - PROCESS | 596 | |2;audio-dft;159;160;160;160;161;162;158;168;161;163 05:24:32 INFO - PROCESS | 596 | |3;audio-fft;74;73;85;89;76;73;75;98;93;72 05:24:32 INFO - PROCESS | 596 | |4;audio-oscillator;97;96;145;97;96;96;138;95;95;137 05:24:32 INFO - PROCESS | 596 | |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;109 05:24:32 INFO - PROCESS | 596 | |6;imaging-darkroom;147;144;145;144;146;145;145;145;146;145 05:24:32 INFO - PROCESS | 596 | |7;imaging-desaturate;97;95;95;96;96;96;95;95;96;95 05:24:32 INFO - PROCESS | 596 | |8;json-parse-financial;55;56;55;54;56;56;55;63;52;54 05:24:32 INFO - PROCESS | 596 | |9;json-stringify-tinderbox;67;68;67;68;68;69;69;68;68;68 05:24:32 INFO - PROCESS | 596 | |10;stanford-crypto-aes;92;93;86;86;95;86;86;86;85;86 05:24:32 INFO - PROCESS | 596 | |11;stanford-crypto-ccm;124;122;116;125;115;118;117;123;125;119 05:24:32 INFO - PROCESS | 596 | |12;stanford-crypto-pbkdf2;151;141;152;149;150;145;155;149;144;140 05:24:32 INFO - PROCESS | 596 | |13;stanford-crypto-sha256-iterative;72;68;68;68;68;67;68;67;67;69 05:24:32 INFO - PROCESS | 596 | __end_tp_report 05:24:32 INFO - PROCESS | 596 | __start_cc_report 05:24:32 INFO - PROCESS | 596 | _x_x_mozilla_cycle_collect,938 05:24:32 INFO - PROCESS | 596 | __end_cc_report 05:24:32 INFO - PROCESS | 596 | __startTimestamp1452605072200__endTimestamp 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | ------- Summary: start ------- 05:24:32 INFO - PROCESS | 596 | Number of tests: 14 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:4.02 (3.6%) stddev-sans-first:4.27 05:24:32 INFO - PROCESS | 596 | Values: 109.0 110.0 104.0 111.0 112.0 112.0 100.0 112.0 111.0 111.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:155.00 stddev:18.57 (12.0%) stddev-sans-first:19.65 05:24:32 INFO - PROCESS | 596 | Values: 151.0 134.0 164.0 172.0 125.0 150.0 159.0 127.0 168.0 124.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:2.78 (1.7%) stddev-sans-first:2.83 05:24:32 INFO - PROCESS | 596 | Values: 159.0 160.0 160.0 160.0 161.0 162.0 158.0 168.0 161.0 163.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#3] audio-fft Cycles:10 Average:80.80 Median:80.50 stddev:9.61 (11.9%) stddev-sans-first:9.88 05:24:32 INFO - PROCESS | 596 | Values: 74.0 73.0 85.0 89.0 76.0 73.0 75.0 98.0 93.0 72.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.36 (22.3%) stddev-sans-first:22.20 05:24:32 INFO - PROCESS | 596 | Values: 97.0 96.0 145.0 97.0 96.0 96.0 138.0 95.0 95.0 137.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:24:32 INFO - PROCESS | 596 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 05:24:32 INFO - PROCESS | 596 | Values: 147.0 144.0 145.0 144.0 146.0 145.0 145.0 145.0 146.0 145.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 05:24:32 INFO - PROCESS | 596 | Values: 97.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:2.88 (5.2%) stddev-sans-first:3.04 05:24:32 INFO - PROCESS | 596 | Values: 55.0 56.0 55.0 54.0 56.0 56.0 55.0 63.0 52.0 54.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 05:24:32 INFO - PROCESS | 596 | Values: 67.0 68.0 67.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:3.70 (4.3%) stddev-sans-first:3.64 05:24:32 INFO - PROCESS | 596 | Values: 92.0 93.0 86.0 86.0 95.0 86.0 86.0 86.0 85.0 86.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:122.50 stddev:3.84 (3.1%) stddev-sans-first:3.84 05:24:32 INFO - PROCESS | 596 | Values: 124.0 122.0 116.0 125.0 115.0 118.0 117.0 123.0 125.0 119.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:149.50 stddev:4.90 (3.3%) stddev-sans-first:5.04 05:24:32 INFO - PROCESS | 596 | Values: 151.0 141.0 152.0 149.0 150.0 145.0 155.0 149.0 144.0 140.0 05:24:32 INFO - PROCESS | 596 | 05:24:32 INFO - PROCESS | 596 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:0.67 05:24:32 INFO - PROCESS | 596 | Values: 72.0 68.0 68.0 68.0 68.0 67.0 68.0 67.0 67.0 69.0 05:24:32 INFO - PROCESS | 596 | -------- Summary: end -------- 05:24:32 INFO - PROCESS | 596 | 05:24:33 INFO - TEST-INFO | 596: exit 0 05:24:33 INFO - TEST-OK | kraken | took 60127ms 05:24:33 INFO - TEST-START | v8_7 05:24:33 INFO - operating with platform_type : linux_ 05:24:33 INFO - Initialising browser for v8_7 test... 05:24:33 INFO - TEST-INFO | started process 852 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKL9nnH/profile http://localhost:43897/getInfo.html) 05:24:37 INFO - PROCESS | 852 | __metrics Screen width/height:1600/1200 05:24:37 INFO - PROCESS | 852 | colorDepth:24 05:24:37 INFO - PROCESS | 852 | Browser inner width/height: 1024/697 05:24:37 INFO - PROCESS | 852 | __metrics 05:24:37 INFO - PROCESS | 852 | 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:24:37 INFO - PROCESS | 852 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:39 INFO - TEST-INFO | 852: exit 0 05:24:39 INFO - Browser initialized. 05:24:39 INFO - Running cycle 1/1 for v8_7 test... 05:24:39 INFO - TEST-INFO | started process 941 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKL9nnH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:51 INFO - PROCESS | 941 | RSS: Main: 148258816 05:24:51 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | Cycle 1(1): loaded http://localhost:43897/tests/v8_7/run.html (next: http://localhost:43897/tests/v8_7/run.html) 05:25:13 INFO - PROCESS | 941 | RSS: Main: 557793280 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | __start_tp_report 05:25:13 INFO - PROCESS | 941 | _x_x_mozilla_page_load 05:25:13 INFO - PROCESS | 941 | _x_x_mozilla_page_load_details 05:25:13 INFO - PROCESS | 941 | |i|pagename|runs| 05:25:13 INFO - PROCESS | 941 | |0;Richards;167.8697330871244 05:25:13 INFO - PROCESS | 941 | |1;DeltaBlue;191.20458891013385 05:25:13 INFO - PROCESS | 941 | |2;Encrypt;280.50490883590464 05:25:13 INFO - PROCESS | 941 | |3;Decrypt;5181.347150259067 05:25:13 INFO - PROCESS | 941 | |4;RayTrace;1129.9435028248588 05:25:13 INFO - PROCESS | 941 | |5;Earley;793.0214115781126 05:25:13 INFO - PROCESS | 941 | |6;Boyer;12231.707317073171 05:25:13 INFO - PROCESS | 941 | |7;RegExp;43666.666666666664 05:25:13 INFO - PROCESS | 941 | |8;Splay;574.3825387708214 05:25:13 INFO - PROCESS | 941 | |9;NavierStokes;4830.917874396136 05:25:13 INFO - PROCESS | 941 | __end_tp_report 05:25:13 INFO - PROCESS | 941 | __startTimestamp1452605113902__endTimestamp 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | ------- Summary: start ------- 05:25:13 INFO - PROCESS | 941 | Number of tests: 10 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 167.9 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 191.2 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 280.5 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 5181.3 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#4] RayTrace Cycles:1 Average:1129.94 Median:1129.94 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 1129.9 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 793.0 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 12231.7 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#7] RegExp Cycles:1 Average:43666.67 Median:43666.67 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 43666.7 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#8] Splay Cycles:1 Average:574.38 Median:574.38 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 574.4 05:25:13 INFO - PROCESS | 941 | 05:25:13 INFO - PROCESS | 941 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:25:13 INFO - PROCESS | 941 | Values: 4830.9 05:25:13 INFO - PROCESS | 941 | -------- Summary: end -------- 05:25:13 INFO - PROCESS | 941 | 05:25:14 INFO - TEST-INFO | 941: exit 0 05:25:14 INFO - TEST-OK | v8_7 | took 41544ms 05:25:14 INFO - SUITE-END | took 1215s 05:25:14 INFO - Completed test suite (00:20:15) 05:25:14 INFO - Working with test: dromaeo_css 05:25:14 INFO - Generating results file: dromaeo_css 05:25:14 INFO - Working with test: kraken 05:25:14 INFO - Generating results file: kraken 05:25:14 INFO - javascript benchmark 05:25:14 INFO - Working with test: v8_7 05:25:14 INFO - Generating results file: v8_7 05:25:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:25:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:25:14 INFO - process_Request line: dromaeo_css 6687.14 graph.html#tests=[[72,64,35]] 05:25:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:25:15 INFO - process_Request line: kraken 1505.60 graph.html#tests=[[232,64,35]] 05:25:15 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:25:15 INFO - process_Request line: v8_7 19996.75 graph.html#tests=[[230,64,35]] 05:25:15 INFO - RETURN: dromaeo_css: 6687.14 05:25:15 INFO - RETURN: kraken: 1505.60 05:25:15 INFO - RETURN: v8_7: 19996.75 05:25:15 INFO - javascript benchmark 05:25:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3141.6230052393707, 3173.4446471867445, 3198.312362841987, 3215.5980502437196, 3242.85407156678, 5112.590992720583, 5190.091733946559, 5198.586191940899, 5236.1098613235745, 5241.633085684004, 5140.742962851852, 5214.947850521494, 5222.529972302502, 5239.978204250173, 5256.237845512398, 4805.639577031719, 4815.614750819926, 4833.468318484964, 4841.951580484185, 4888.071266459379, 4858.149823780825, 4913.066517361708, 4954.455009948921, 4961.355023846912, 4983.252512123175, 4642.466116396624, 4715.952840471586, 4730.881727956794, 4885.193942999401, 4893.14369985253, 4745.074710431467, 4754.405699287589, 4759.357486739281, 4759.428868535798, 4762.666613337068, 4723.527647235283, 4739.123262196505, 4744.715317080986, 4825.10735513931, 4849.709017458964, 5189.065968125736, 5207.6354655174155, 5210.270562121306, 5210.374755029383, 5237.4500677428705, 5713.457221563945, 5728.054870946289, 5734.799282025151, 5740.483356497935, 5751.913721294184, 5533.391326954032, 5580.414056524047, 5679.858003549944, 5681.062624666925, 5824.504917082053, 5319.228711836762, 5369.946300537023, 5374.6506477078865, 5375.516203541661, 5380.569554435636, 5794.62334948227, 5817.360090390053, 5847.8245652630485, 5852.180694702745, 5854.2389489366105, 5433.918491222635, 5501.449855014546, 5524.475174858382, 5527.834164975057, 5618.606697531133, 5549.72251387429, 5599.916001259984, 5600.0, 5603.635763675348, 5634.154876768517, 5624.437556244343, 5626.409227031185, 5627.634203776742, 5627.662340259598, 5636.633618814764, 5501.4223506532035, 5565.443455654483, 5608.186812912187, 5628.71856407178, 5644.435556444405, 4393.121375724868, 4399.890002749957, 4402.031553058322, 4402.427684401071, 4434.290513517822, 3910.296146693566, 3917.334053210961, 3924.4898163238595, 3967.9801600992387, 3969.92060158801, 5024.296598476216, 5154.871128221825, 5175.9741201293755, 5186.766595503212, 5293.973530132324, 5643.746031428595, 5660.830175094754, 5662.065759149694, 5689.573282003867, 5692.203091567184, 5118.820841270612, 5290.92063619046, 5297.655652382583, 5303.469653034743, 5354.089804733205, 4715.198416269242, 4733.9763301183275, 4761.142994261067, 4781.617470602343, 4815.518448155157, 5883.117532370093, 5917.7928772493615, 5918.496927761188, 5918.496927761188, 5918.881622367615, 5435.483629055233, 5556.916646250229, 5630.465105814941, 5685.772569097356, 5751.4536119068625, 5863.325717542537, 5952.791652292149, 5962.135490353788, 5967.940320596738, 5993.790217342372, 5554.166874968787, 5558.499735023867, 5561.4716601922755, 5562.833115006556, 5565.638233514808, 5572.219889215432, 5625.184348269559, 5634.549236061023, 5652.349979752381, 5694.06048002075, 5580.302462192226, 5595.300587426572, 5601.747921343468, 5602.383737788921, 5609.803656872153, 5561.944380556142, 5576.581756368208, 5577.581681373995, 5578.246936663661, 5580.302462192226, 5339.893202136013, 5376.838694839161, 5471.06991811401, 5508.807191748269, 5534.0, 5586.16207568868, 5599.60802743804, 5611.691356975405, 5616.691081990366, 5616.719164041863, 5468.5351745100525, 5469.097598896137, 5480.972595136999, 5483.314585676791, 5483.396826349178], "unit": "score", "name": "dojo.html", "value": 5217.560143965346}, {"lowerIsBetter": false, "replicates": [533.3386600615237, 537.0923139893578, 545.1903922674829, 560.7663141089604, 574.4513989140369, 30352.54471182934, 31022.224444388874, 36432.81783591085, 36443.0, 36642.45036324454, 40006.59993400065, 40500.59499405005, 40509.59490405095, 40515.0, 40529.0, 8491.320694344438, 8687.782805429852, 8696.21734043936, 8698.130186981283, 8701.390902636818, 8418.957905210465, 8491.575421228914, 8527.317814574819, 8537.701180458685, 8540.0, 8487.40588158829, 8546.188112129337, 8546.786330341729, 8550.957245213796, 8558.0, 8489.193526614961, 8525.232729054353, 8534.359923005737, 8553.358498112666, 8560.871586926201, 8567.31461483086, 8716.607752651145, 8719.956400217958, 8721.956390218009, 8723.476591404537, 39429.80285098585, 39558.0, 39832.0, 39921.80039099786, 39931.8003409984, 2968.8218706877656, 3065.724084832376, 3101.5347697845277, 3238.87044518219, 3403.149212696826, 29438.85280573605, 29976.700232997828, 30135.698643013508, 30993.225169370722, 31251.687483125104, 3969.64273215412, 4014.7992600369867, 4037.7577345359373, 4040.454538637305, 4107.753534787892, 258851.9999999981, 259422.0, 259605.0, 259997.0, 260011.0, 53105.2034219487, 53755.46244537583, 54376.728116359955, 57328.42671573314, 59599.40400595938, 55056.724716376964, 55392.0, 55486.44513554894, 55493.72253138709, 55526.0, 15470.458533951258, 15972.920135399481, 15977.520674379788, 16050.117243551484, 16074.357025719075, 10954.561817527368, 11086.61196858106, 11581.88418115808, 12024.398780061138, 12326.75346493083, 19256.22975080981, 19262.518437039187, 19310.517237069187, 19382.903085484766, 19496.31762888292, 7139.678714457862, 7218.8917166242545, 7258.782236532912, 7298.927010729931, 7370.520916140434, 939.4316438554713, 958.8513780364054, 985.1675334342469, 1046.6075221791828, 1069.9251052426255, 27348.589771153052, 28915.0, 29547.704522954926, 29644.258893527833, 29912.0, 935.219092058139, 983.5328219096016, 998.6155330197926, 1005.527402121002, 1083.8320060390652, 13097.934510327388, 13153.868461315456, 13331.0, 13406.128601640861, 13432.328383580782, 339236.0, 345631.0, 347405.0, 347747.0, 348624.0, 52114.0, 52421.0, 52437.0, 52439.475605244224, 52531.47468525342, 1327.508821735964, 1331.447449308526, 1355.0311527257861, 1356.837179538442, 1358.8165597644388, 25826.99681549363, 26489.60265596056, 26918.192454226406, 26936.0, 26997.730022700307, 36912.44631330586, 37159.442608360354, 37266.62733372632, 38361.42457863079, 38476.615233848424, 313775.0, 313953.0, 315248.0, 316791.0, 317245.0, 27933.441331172857, 31296.530552042193, 31692.366152677278, 31900.840495797373, 31943.361132777678, 37458.0, 38041.4293785599, 38225.426618600184, 38300.80849595734, 38821.0, 33236.335273294884, 34961.65038349584, 34987.0, 35227.82386088053, 35465.468017979234, 27885.302867427665, 31814.840925795223, 32539.0, 35057.298854023284, 35806.82096589501, 32145.678543214268, 32692.0, 32927.50608740823, 32955.34089318152, 32987.0, 30402.391952161277, 30942.690573094882, 36008.63991360053, 36342.27315453729, 36689.0, 24230.23179759564, 24328.391790205387, 24467.265982020566, 24660.260192194262, 24663.753362466145], "unit": "score", "name": "ext.html", "value": 17886.878479684743}, {"lowerIsBetter": false, "replicates": [361.4271379862917, 363.1647211413748, 364.215116424106, 364.67726062434747, 371.66735771484537, 13179.60461186166, 13557.457701691945, 15943.282552285145, 16115.75826362604, 16545.090020048894, 14570.271486425689, 14625.92687036566, 15737.449189278377, 15786.684266314667, 15791.210439478038, 4803.783829727662, 5256.421793602701, 5463.098588732854, 5467.20725494803, 5467.343918729758, 3763.0780458787635, 3896.5518965319066, 3898.610138986107, 5286.836895882919, 5317.813876514323, 5257.474252574751, 5446.428125046872, 5482.451754824526, 5488.067028605126, 5500.944990550103, 5360.356757189143, 5380.031594313022, 5384.380796208447, 5388.838334849941, 5389.272448219479, 5022.347094877679, 5156.381234251876, 5164.509371609691, 5266.526012658879, 5272.815451459219, 12726.363681815872, 12836.294003829786, 12876.454825420915, 16981.23584438691, 17593.0, 1929.305450037985, 2016.1532156494306, 2105.768365479796, 2195.6157672407426, 2202.9559408811733, 8911.465312081296, 9340.953295233548, 9447.574859131355, 10974.835377469344, 13137.474501019948, 1667.1330907927809, 1774.352361388097, 1835.632873425307, 1847.0395394394973, 1882.8023057578894, 53816.0, 54045.0, 55161.172582411295, 57440.425595744346, 57544.71227643835, 9674.854877176847, 9847.458389788488, 9852.11330980201, 9926.15627671656, 9994.200463962865, 12876.613701588967, 12967.22196668203, 12973.0, 13013.674658133434, 13025.153365031432, 7045.506814522934, 7078.610676412847, 7096.57420554758, 7582.696692132363, 7645.961770191114, 7005.614691191931, 7431.739889103856, 7452.888206676904, 7516.812079697942, 7552.244775522514, 4209.5579964103945, 4330.870073897788, 4341.9131617367475, 4369.191699535596, 4371.540988196193, 1668.0, 1700.8469237768413, 1705.1474262868567, 1760.64787042592, 1764.2325588368844, 420.9705320627527, 871.5729292646685, 897.9506127162938, 911.266430523435, 990.2573070197352, 9393.389429687048, 10478.318909270873, 10665.41340226295, 10675.62635307776, 11104.056155226735, 449.9885511762417, 467.8269040454985, 470.77402846633805, 475.91433541962084, 491.33178876727624, 5091.312672789126, 6083.726232319467, 6184.196054512884, 6194.349593292639, 6201.0, 408034.0, 409968.0, 410817.0, 413146.0, 415670.0, 64758.35241647618, 66168.0, 72360.27639723536, 73270.63364683143, 73811.63094184495, 1112.2770199370311, 1116.983245251322, 1124.3872089711126, 1156.9074474042056, 1160.6169963911889, 14097.718045639234, 14379.885486681604, 14749.631259218606, 14936.103833770008, 14962.700745985238, 33589.0, 33636.0, 34130.48804267988, 34406.0, 35283.0, 39869.60130398659, 40217.19565608613, 40833.0, 40964.0, 41760.0, 6884.65576721152, 7028.297170282931, 7094.503384763017, 7424.740134095281, 7517.774466766005, 7816.452848300564, 10076.596936122472, 10703.946480267548, 10834.566617335533, 11084.0, 3138.1526987713646, 3158.3051728620585, 7791.610419479117, 9222.492762898106, 9250.676226332045, 9655.827438826207, 9809.411435313905, 9892.208623309974, 9984.35101718386, 10082.243831712503, 9828.361156524803, 9863.753406164904, 10079.798404032024, 10124.69625911224, 10167.79664406693, 7191.20896701352, 7208.855822883408, 7246.4202863769715, 7281.381082608038, 7414.888776668462, 8064.233897779702, 9878.506074696093, 9971.903090660167, 9999.3000489965, 10047.09576138151], "unit": "score", "name": "jquery.html", "value": 7454.427963156638}, {"lowerIsBetter": false, "replicates": [1296.209312319485, 1301.5119330251157, 1316.8880645145161, 1361.8842398396137, 1643.8027436707596, 6839.0, 7463.738769143074, 7684.769456916301, 7697.653605587748, 7697.923020769791, 7396.149442814078, 7579.4694371394025, 7584.241575842413, 7608.619569021541, 7644.770656880289, 2008.8694234874758, 2053.5995480881234, 2321.1063740459876, 2366.976330236693, 2397.0, 2349.800266977309, 2358.0803486640225, 2359.0, 2359.504504054151, 2361.327021798788, 2281.041962375806, 2335.532893421314, 2336.88315584221, 2337.906483740648, 2338.9766102339013, 2271.0, 2274.067632270761, 2377.0372998935372, 2377.3818807110274, 2378.1557547070715, 2345.3667509772436, 2356.575816353056, 2375.251795684354, 2382.809375249976, 2388.1402695029774, 7661.463697541174, 7704.499207551491, 7717.922820771777, 7782.377409807202, 7807.765767026998, 4737.668363214576, 4834.58905992991, 4851.781669824866, 4866.951330486685, 4867.464578896319, 3092.6288845338704, 3156.510740835174, 3182.252170739874, 3191.6010498687665, 3199.9040028799172, 994.8618661106532, 1021.764994051365, 1023.6417253961129, 1033.4316126130673, 1051.8948105189497, 10607.469626518721, 10632.202584806093, 10637.414942178177, 10642.09542188915, 10702.250842441032, 4407.405000324915, 4433.069055498381, 4464.709793863389, 4561.384213131251, 4575.290829921368, 8169.42814003026, 8209.95895020533, 8242.76358546223, 8256.669733210725, 8258.091609922903, 4762.285657151455, 4794.7842347094465, 4795.376601041842, 4798.832040878552, 4799.544043315879, 4421.137878113737, 4426.800793964279, 4430.335449682573, 4432.29083346663, 4452.30989196675, 3319.0, 3366.5455163553097, 3568.3398571264397, 3624.583172935146, 3666.1201311685004, 1131.6322195286564, 1133.82992551118, 1135.0635725526474, 1139.6751925701135, 1143.8684551276542, 1218.3847157185564, 1233.975320493585, 1247.058470854499, 1320.570814485296, 1321.6101250131235, 7281.927180728231, 7282.781516554512, 7284.417246620258, 7450.217727138681, 7458.179600243969, 1021.6526381030485, 1042.5569133118395, 1045.3832238978887, 1049.8792638846478, 1069.1233188785122, 5575.303087114111, 5632.183333416631, 5633.211350410946, 5640.5487560995025, 5641.210230567724, 9175.816483670289, 9288.489133097744, 9355.204807591295, 9599.32804703664, 9602.567884445216, 9378.85931711025, 9404.106609872051, 9508.096730810563, 9508.619655213852, 9513.476758778334, 7187.820304492429, 7352.669129889167, 7358.742444014434, 7436.814079648052, 7436.85126297471, 6992.405645520188, 7034.5427547209265, 7037.366637002694, 7042.683079261343, 7049.259827718221, 8089.0, 8327.875081873897, 8481.09175435522, 8485.618147183268, 8492.278156356779, 8375.329973601976, 8653.17794809492, 8790.472571645721, 8797.560121994004, 8806.295496360404, 5948.078047902582, 6571.441427478718, 6580.736770529125, 6673.866522669617, 6701.865962680817, 6832.624205668736, 6888.276730943179, 6889.414399776075, 7014.894776578253, 7250.456215783732, 6659.134312539339, 6714.160729908762, 6793.864122717617, 6884.898416253375, 6964.665730768992, 6632.502562307943, 6768.763093291908, 6797.776400248003, 6828.556143850634, 6839.555428897106, 6902.378785909293, 6907.240203577703, 6921.446284297345, 6951.2353641098425, 6973.267806880204, 6185.165002724754, 6203.565750397429, 6225.097360882556, 6225.128482012612, 6259.280182779039, 6473.482121430368, 6475.708593113415, 6487.124238227779, 6510.990796426561, 6537.28089910119], "unit": "score", "name": "mootools.html", "value": 4455.907739060865}, {"lowerIsBetter": false, "replicates": [345.9290845376698, 347.2984571166243, 348.1018971054679, 353.76651410069326, 357.7317012240821, 5745.195672605839, 5831.533477321815, 5931.08068249422, 5935.970320148404, 5944.167816505687, 5687.687177205252, 5829.708514574265, 5833.241678581789, 5854.853628659285, 5858.853528661785, 4559.612432943204, 4562.794674239667, 4564.680472366936, 4565.88585285368, 4568.7944042518, 4386.056997745484, 4464.776761161945, 4466.8436604718845, 4548.840790572331, 4589.816407343702, 4525.705829121097, 4529.977350113245, 4543.22765129927, 4546.772661366918, 4549.749763763009, 4537.568930951587, 4538.1377538267625, 4550.567696068868, 4551.249043907751, 4551.749653769041, 4007.73949693269, 4008.599140085997, 4017.4576432181575, 4019.7588144711412, 4021.617946295097, 5456.0, 5584.162375643646, 5604.691741954191, 5606.103023516218, 5620.213170156181, 5250.291210686547, 5312.096943519611, 5320.574354051667, 5326.280952071459, 5326.7070311132875, 5916.7337469813965, 6249.375062493759, 6255.374462553754, 6257.405546473078, 6266.310705822356, 4303.655707543389, 4368.279233926399, 4377.387165796791, 4393.07745373472, 4401.273789824675, 6359.491240700733, 6450.129232553592, 6455.354464553554, 6461.386168314003, 6464.5798023128345, 4575.771211439414, 4584.426946631671, 4585.403897493371, 4586.266197408466, 4588.059447813257, 4557.886052848639, 4642.442906851132, 4646.372739680168, 4661.3707149534375, 4675.392199014174, 5273.0, 5279.944011197776, 5282.049231138432, 5287.180487024518, 5288.867778305573, 6159.599626024384, 6219.720112594853, 6236.158118654014, 6243.188385509946, 6243.500519958392, 1622.7160246956971, 1623.3263195773623, 1639.6392793585392, 1641.6962861870593, 1648.464249119017, 1124.3534967393782, 1127.836463712757, 1135.9602413915472, 1138.1065863297272, 1168.118070856498, 5902.527797776168, 5904.852378690482, 5910.261217347832, 5910.379410161957, 5911.793087241926, 6385.553011289258, 6404.807855764335, 6410.166678331787, 6416.743330266737, 6417.876871547461, 5903.144044113666, 5903.6457812530525, 5903.822885313448, 5904.616199947076, 5911.556633252523, 3377.257003459235, 3477.6870081692264, 3483.4600636901323, 3510.227749895019, 3516.331896939573, 6757.8648427031185, 6761.425278851353, 6763.188417389944, 6768.255491895888, 6770.864582708318, 6653.301403352578, 6655.900161497581, 6664.067030615621, 6668.466522678174, 6670.0661907333015, 6570.408663220333, 6714.899276510954, 6822.965885170543, 6854.5201835872, 6867.587944723333, 6239.594426362272, 6402.071699603624, 6456.805490984183, 6494.577852439576, 6501.284858665637, 6281.057841323655, 6343.333949935375, 6424.935750642434, 6432.839179020375, 6434.549581529248, 6679.265280819009, 6705.329467053256, 6733.595984240961, 6737.562058466184, 6743.426808721314, 4366.126774645148, 4448.755318457386, 4492.3935268738305, 4493.415855938707, 4494.887627809331, 6415.743370265137, 6437.485001199986, 6475.3200913903365, 6477.676116194266, 6483.222013358427, 6271.404216599416, 6314.179156709598, 6319.304876463493, 6332.461740751904, 6337.96831015842, 6200.224971878515, 6241.469475094668, 6264.937350626617, 6296.0555916612875, 6305.716242769178, 6178.104174894705, 6178.135061091541, 6180.6291622502795, 6188.535859810442, 6193.071039344134, 6261.467775239155, 6315.810525684236, 6320.304766475776, 6323.114763932961, 6330.620162790247, 6073.817785466443, 6134.2332208473945, 6150.692465376624, 6162.938370616416, 6167.321594624677], "unit": "score", "name": "prototype.html", "value": 4757.408305888796}, {"lowerIsBetter": false, "replicates": [754.2985023927747, 829.4442723375334, 837.7779888329594, 843.7300063979525, 853.978650533737, 13163.670908227286, 13289.136206146593, 13296.069275150743, 13336.866631333683, 13348.132371395852, 12061.638150855466, 12069.51721931124, 12104.031677465804, 12186.390680465985, 12222.694432639166, 652.3281020548842, 666.8432918264205, 802.2899733735628, 811.6591031766643, 813.4996976859219, 801.0227522422636, 805.4643661964786, 806.2018601584448, 808.4098608016122, 809.0857331215718, 836.3977935886182, 838.1157878438245, 839.5046922315832, 839.5508403004394, 840.8276303357796, 684.3191024930202, 684.3635419060272, 684.6816230452813, 694.3438450664124, 831.9459235149726, 516.6693316277585, 518.7847043476952, 519.2393144043956, 519.4857091479446, 520.6043407010661, 12552.686182845411, 12572.685682857911, 12636.0, 12664.240145591293, 12673.619791406272, 11623.0, 12187.32969686667, 12293.56972505958, 12524.185927914748, 12749.872501275055, 10085.394876307371, 10109.797804043877, 10180.745481362952, 10212.897871021269, 10317.277790554665, 3486.1981744198974, 3512.736544759128, 3531.040272648679, 3534.6995505382074, 3622.4385220290897, 41987.37018944718, 42211.36682949758, 42682.146357073, 42754.35868461976, 42924.141517169795, 9803.30815717472, 9810.705678829647, 9863.556139973718, 10047.497625118714, 10300.55792189094, 16384.344626214817, 16572.088535130682, 16607.169641517874, 16630.251638676287, 16668.0, 7097.290270972861, 7281.1262648482525, 7336.669849856769, 7417.369523590447, 7448.59032753193, 4241.893952651147, 4302.053548219386, 4312.396264522969, 4361.847335343247, 4368.475782906072, 3109.16052665779, 3130.248740302311, 3134.81191128533, 3135.7177853992794, 3144.9056528304186, 577.9682117483495, 579.3308728418683, 581.4360070731384, 584.4185035889233, 594.4917095883044, 498.63848709685914, 596.8985272503598, 608.6895683201599, 609.8414412252846, 614.1954040207343, 8386.161383861565, 8538.231559159582, 8539.316854651737, 8615.784605384915, 8860.158284962918, 545.5744519274972, 599.5743022454019, 635.4281146967766, 650.5153660522941, 653.3956090616161, 3707.480952666629, 3821.637048896681, 3866.304065268279, 3911.78485183312, 4035.435039094529, 53686.463135368926, 54136.45863541393, 54521.454785451635, 54539.45460545423, 54570.72714636401, 47133.5286647136, 47678.76160619175, 48407.273890891665, 48435.75782121067, 48826.26760598594, 42833.78583107064, 43077.78461107674, 44116.3382549262, 44505.0, 46011.30983035324, 8468.534230617375, 8678.392512524062, 8700.0, 8912.197902188835, 9129.77175570616, 31138.22154446157, 31591.368172636878, 31630.841845790623, 32772.83613581917, 32784.83607581947, 39614.20771584495, 39715.0, 43545.56454435542, 44586.0, 44683.329750053126, 10443.738906527398, 10555.419451930218, 10677.0, 10744.83882741744, 10746.892531074589, 11489.770204595694, 11556.711082223012, 11616.361100139235, 11925.284482931052, 11987.280763154238, 10932.781344373227, 11069.391183484986, 11404.087672985976, 11680.123990700562, 11794.410279485819, 10944.23390362667, 11081.27971681838, 11195.888041119484, 11505.482253298454, 11549.42252887369, 11204.719882003015, 11251.0, 11259.887401126212, 11393.829092563452, 11626.418679066182, 9197.678081267124, 9365.157135857806, 9418.387804792941, 9542.713718588453, 9731.0, 8782.912170878464, 8962.238209752244, 9003.0, 9950.651727189514, 9997.300188986701], "unit": "score", "name": "yui.html", "value": 6062.916314871508}], "name": "dromaeo_css", "value": 6687.136208325702}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 111.0, 112.0, 112.0, 100.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [151.0, 134.0, 164.0, 172.0, 125.0, 150.0, 159.0, 127.0, 168.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 160.0, 161.0, 162.0, 158.0, 168.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 85.0, 89.0, 76.0, 73.0, 75.0, 98.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 145.0, 97.0, 96.0, 96.0, 138.0, 95.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 144.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 54.0, 56.0, 56.0, 55.0, 63.0, 52.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 86.0, 86.0, 95.0, 86.0, 86.0, 86.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 116.0, 125.0, 115.0, 118.0, 117.0, 123.0, 125.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [151.0, 141.0, 152.0, 149.0, 150.0, 145.0, 155.0, 149.0, 144.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1505.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "Richards", "value": 210.29401399999998}, {"lowerIsBetter": false, "replicates": [191.20458891013385], "unit": "score", "name": "DeltaBlue", "value": 345.79713999999984}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1129.9435028248588], "unit": "score", "name": "RayTrace", "value": 654.890265}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [43666.666666666664], "unit": "score", "name": "RegExp", "value": 20.862251908396956}, {"lowerIsBetter": false, "replicates": [574.3825387708214], "unit": "score", "name": "Splay", "value": 141.87583100000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19996.753935024422}]} 05:25:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19996.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1505.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6687.14"}}} 05:25:15 INFO - Return code: 0 05:25:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:25:15 INFO - # TBPL SUCCESS # 05:25:15 INFO - Running post-action listener: _resource_record_post_action 05:25:15 INFO - Running post-run listener: _resource_record_post_run 05:25:16 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 16384; Write bytes: 550309888; Read time: 56; Write time: 1035628 05:25:16 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 239161344; Read time: 0; Write time: 608480 05:25:16 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 16384; Write bytes: 311148544; Read time: 56; Write time: 427148 05:25:16 INFO - Running post-run listener: _upload_blobber_files 05:25:16 INFO - Blob upload gear active. 05:25:16 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:25:16 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:25:16 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:25:16 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:25:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:17 INFO - (blobuploader) - INFO - Done attempting. 05:25:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:25:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:18 INFO - (blobuploader) - INFO - Done attempting. 05:25:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:18 INFO - Return code: 0 05:25:18 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:25:18 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/922dc76253f454b999bc21fe69c3bac09e3b3fe2dd7041d568a9b94a88be31ab254df48f6022b32a04b69e2bbcc513de13a61767eba392c43d54538475e0fbe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3756a7c6b71b9c2e8b11fa22d38475ebc2f3c7b2248ff2313140320e0637ae5562020521ee01e477359bda64e8d7ddf297b132b5c28d6f14b37538d4de856858"} 05:25:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:25:18 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:25:18 INFO - Contents: 05:25:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/922dc76253f454b999bc21fe69c3bac09e3b3fe2dd7041d568a9b94a88be31ab254df48f6022b32a04b69e2bbcc513de13a61767eba392c43d54538475e0fbe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3756a7c6b71b9c2e8b11fa22d38475ebc2f3c7b2248ff2313140320e0637ae5562020521ee01e477359bda64e8d7ddf297b132b5c28d6f14b37538d4de856858"} 05:25:18 INFO - Copying logs to upload dir... 05:25:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1286.634551 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-12 05:25:18.405224) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:18.408931) ========= 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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/922dc76253f454b999bc21fe69c3bac09e3b3fe2dd7041d568a9b94a88be31ab254df48f6022b32a04b69e2bbcc513de13a61767eba392c43d54538475e0fbe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3756a7c6b71b9c2e8b11fa22d38475ebc2f3c7b2248ff2313140320e0637ae5562020521ee01e477359bda64e8d7ddf297b132b5c28d6f14b37538d4de856858"} build_url:https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/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/Fx-Team/sha512/922dc76253f454b999bc21fe69c3bac09e3b3fe2dd7041d568a9b94a88be31ab254df48f6022b32a04b69e2bbcc513de13a61767eba392c43d54538475e0fbe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3756a7c6b71b9c2e8b11fa22d38475ebc2f3c7b2248ff2313140320e0637ae5562020521ee01e477359bda64e8d7ddf297b132b5c28d6f14b37538d4de856858"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:18.433646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:18.433965) ========= 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=af724c981e2a0f424dbabf99000001e7-1452602134.728759-2097395535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:18.517511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 05:25:18.517856) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 05:25:18.518196) ========= ========= Total master_lag: 0.35 =========