builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1453740010.63 results: success (0) buildid: 20160125030203 builduid: fa9411aaf741499a9b7142874c71568d revision: 67c66c2878aed17ae3096d7db483ddbb2293c503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.629040) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.629543) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.629843) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004365 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.646850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.647224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.661938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.662543) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.712847) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.713209) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.713636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.713946) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 08:40:11-- 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% 78.0M=0s 2016-01-25 08:40:11 (78.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.968741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:10.969100) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017940 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:11.020642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:11.021252) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 67c66c2878aed17ae3096d7db483ddbb2293c503 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 67c66c2878aed17ae3096d7db483ddbb2293c503 --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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 08:40:11,530 truncating revision to first 12 chars 2016-01-25 08:40:11,530 Setting DEBUG logging. 2016-01-25 08:40:11,530 attempt 1/10 2016-01-25 08:40:11,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/67c66c2878ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 08:40:11,804 unpacking tar archive at: mozilla-central-67c66c2878ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:11.653187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:11.653779) ========= echo 67c66c2878aed17ae3096d7db483ddbb2293c503 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'67c66c2878aed17ae3096d7db483ddbb2293c503'] 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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 67c66c2878aed17ae3096d7db483ddbb2293c503 program finished with exit code 0 elapsedTime=0.004688 script_repo_revision: '67c66c2878aed17ae3096d7db483ddbb2293c503' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:11.704679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:11.705033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:40:11.715720) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-25 08:40:11.716121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:12 INFO - MultiFileLogger online at 20160125 08:40:12 in /builds/slave/test-pgo 08:40:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:40:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:40:12 INFO - {'append_to_log': False, 08:40:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:40:12 INFO - 'blob_upload_branch': 'Firefox', 08:40:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:40:12 INFO - 'branch': 'Firefox', 08:40:12 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:12 INFO - 'config_files': ('talos/linux_config.py',), 08:40:12 INFO - 'default_actions': ('clobber', 08:40:12 INFO - 'read-buildbot-config', 08:40:12 INFO - 'download-and-extract', 08:40:12 INFO - 'populate-webroot', 08:40:12 INFO - 'create-virtualenv', 08:40:12 INFO - 'install', 08:40:12 INFO - 'run-tests'), 08:40:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:12 INFO - 'download_minidump_stackwalk': True, 08:40:12 INFO - 'download_symbols': 'ondemand', 08:40:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:12 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:12 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:12 INFO - 'installer_path': 'installer.exe', 08:40:12 INFO - 'log_level': 'info', 08:40:12 INFO - 'log_name': 'talos', 08:40:12 INFO - 'log_to_console': True, 08:40:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:12 INFO - 'opt_config_files': (), 08:40:12 INFO - 'pip_index': False, 08:40:12 INFO - 'sps_profile': False, 08:40:12 INFO - 'sps_profile_interval': 0, 08:40:12 INFO - 'suite': 'dromaeojs', 08:40:12 INFO - 'system_bits': '32', 08:40:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:12 INFO - 'title': 'talos-linux64-ix-019', 08:40:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:12 INFO - 'use_talos_json': True, 08:40:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:40:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:12 INFO - 'work_dir': 'build'} 08:40:12 INFO - ##### 08:40:12 INFO - ##### Running clobber step. 08:40:12 INFO - ##### 08:40:12 INFO - Running pre-action listener: _resource_record_pre_action 08:40:12 INFO - Running main action method: clobber 08:40:12 INFO - rmtree: /builds/slave/test-pgo/build 08:40:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:40:13 INFO - Running post-action listener: _resource_record_post_action 08:40:13 INFO - ##### 08:40:13 INFO - ##### Running read-buildbot-config step. 08:40:13 INFO - ##### 08:40:13 INFO - Running pre-action listener: _resource_record_pre_action 08:40:13 INFO - Running main action method: read_buildbot_config 08:40:13 INFO - Using buildbot properties: 08:40:13 INFO - { 08:40:13 INFO - "project": "", 08:40:13 INFO - "product": "firefox", 08:40:13 INFO - "script_repo_revision": "production", 08:40:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:40:13 INFO - "repository": "", 08:40:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:40:13 INFO - "buildid": "20160125030203", 08:40:13 INFO - "stage_platform": "linux64-pgo", 08:40:13 INFO - "basedir": "/builds/slave/test-pgo", 08:40:13 INFO - "nightly_build": "True", 08:40:13 INFO - "buildnumber": 170, 08:40:13 INFO - "slavename": "talos-linux64-ix-019", 08:40:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:40:13 INFO - "platform": "ubuntu64_hw", 08:40:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:40:13 INFO - "branch": "mozilla-central", 08:40:13 INFO - "repo_path": "mozilla-central", 08:40:13 INFO - "revision": "67c66c2878aed17ae3096d7db483ddbb2293c503", 08:40:13 INFO - "pgo_build": "True", 08:40:13 INFO - "builduid": "fa9411aaf741499a9b7142874c71568d", 08:40:13 INFO - "slavebuilddir": "test" 08:40:13 INFO - } 08:40:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:40:13 INFO - Running post-action listener: _resource_record_post_action 08:40:13 INFO - ##### 08:40:13 INFO - ##### Running download-and-extract step. 08:40:13 INFO - ##### 08:40:13 INFO - Running pre-action listener: _resource_record_pre_action 08:40:13 INFO - Running main action method: download_and_extract 08:40:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:40: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')]} 08:40:13 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:40:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json 08:40:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json 08:40:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:40:13 INFO - Downloaded 1448 bytes. 08:40:13 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:40:13 INFO - Using the following test package requirements: 08:40:13 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:13 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:13 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:40:13 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'jsshell-linux-x86_64.zip'], 08:40:13 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:13 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:13 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:40:13 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:40:13 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:13 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:13 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:13 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40: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')]} 08:40:13 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:40:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:40:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:14 INFO - Downloaded 22494448 bytes. 08:40:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:40:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:40:16 INFO - Return code: 0 08:40:16 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 08:40:16 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')]} 08:40:16 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:40:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:40:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:17 INFO - Downloaded 22494448 bytes. 08:40:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:40:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:40:18 INFO - Return code: 0 08:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:18 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:19 INFO - Downloaded 10706572 bytes. 08:40:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:40:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:40:20 INFO - Return code: 0 08:40:20 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')]} 08:40:20 INFO - https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:40:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:40:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/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 08:40:21 INFO - Downloaded 55990395 bytes. 08:40:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:40:21 INFO - mkdir: /builds/slave/test-pgo/properties 08:40:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:40:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:40:21 INFO - Contents: 08:40:21 INFO - build_url:https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:40:21 INFO - Running post-action listener: _resource_record_post_action 08:40:21 INFO - Running post-action listener: set_extra_try_arguments 08:40:21 INFO - ##### 08:40:21 INFO - ##### Running populate-webroot step. 08:40:21 INFO - ##### 08:40:21 INFO - Running pre-action listener: _resource_record_pre_action 08:40:21 INFO - Running main action method: populate_webroot 08:40:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:21 INFO - '--tppagecycles', 08:40:21 INFO - '7'], 08:40:21 INFO - 'tests': ['tsvgm']}}, 08:40:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:40:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:40:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:40:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'tests': ['damp', 'tps']}, 08:40:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['damp', 'tps']}, 08:40:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:40:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:21 INFO - 'other': {'tests': ['a11yr', 08:40:21 INFO - 'ts_paint', 08:40:21 INFO - 'tpaint', 08:40:21 INFO - 'sessionrestore', 08:40:21 INFO - 'sessionrestore_no_auto_restore']}, 08:40:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['a11yr', 08:40:21 INFO - 'ts_paint', 08:40:21 INFO - 'tpaint', 08:40:21 INFO - 'sessionrestore', 08:40:21 INFO - 'sessionrestore_no_auto_restore']}, 08:40:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['a11yr', 08:40:21 INFO - 'ts_paint', 08:40:21 INFO - 'tpaint', 08:40:21 INFO - 'sessionrestore', 08:40:21 INFO - 'sessionrestore_no_auto_restore']}, 08:40:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['a11yr', 08:40:21 INFO - 'ts_paint', 08:40:21 INFO - 'tpaint', 08:40:21 INFO - 'sessionrestore', 08:40:21 INFO - 'sessionrestore_no_auto_restore']}, 08:40:21 INFO - 'other_l64': {'tests': ['a11yr', 08:40:21 INFO - 'ts_paint', 08:40:21 INFO - 'tpaint', 08:40:21 INFO - 'sessionrestore', 08:40:21 INFO - 'sessionrestore_no_auto_restore']}, 08:40:21 INFO - 'other_nol64': {'tests': ['a11yr', 08:40:21 INFO - 'ts_paint', 08:40:21 INFO - 'tpaint', 08:40:21 INFO - 'sessionrestore', 08:40:21 INFO - 'sessionrestore_no_auto_restore']}, 08:40:21 INFO - 'svgr': {'tests': ['tsvgx', 08:40:21 INFO - 'tsvgr_opacity', 08:40:21 INFO - 'tart', 08:40:21 INFO - 'tscrollx', 08:40:21 INFO - 'cart']}, 08:40:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['tsvgx', 08:40:21 INFO - 'tsvgr_opacity', 08:40:21 INFO - 'tart', 08:40:21 INFO - 'tscrollx', 08:40:21 INFO - 'cart']}, 08:40:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'tests': ['tp5o']}, 08:40:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'talos_options': ['--e10s'], 08:40:21 INFO - 'tests': ['tp5o']}, 08:40:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'talos_options': ['--xperf_path', 08:40:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:21 INFO - 'tests': ['tp5n']}, 08:40:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:21 INFO - 'talos_options': ['--e10s', 08:40:21 INFO - '--xperf_path', 08:40:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:21 INFO - 'tests': ['tp5n']}}, 08:40:21 INFO - 'talos.zip': {'path': '', 08:40:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:21 INFO - Running post-action listener: _resource_record_post_action 08:40:21 INFO - ##### 08:40:21 INFO - ##### Running create-virtualenv step. 08:40:21 INFO - ##### 08:40:21 INFO - Running pre-action listener: _resource_record_pre_action 08:40:21 INFO - Running main action method: create_virtualenv 08:40:21 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:40:21 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 08:40:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:40:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:22 INFO - Using real prefix '/usr' 08:40:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:40:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:24 INFO - Installing pip.................done. 08:40:24 INFO - Return code: 0 08:40:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:40: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')]} 08:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:24 INFO - Using env: {'DISPLAY': ':0', 08:40:24 INFO - 'HOME': '/home/cltbld', 08:40:24 INFO - 'LANG': 'en_US.UTF-8', 08:40:24 INFO - 'LANGUAGE': 'en_US:en', 08:40:24 INFO - 'LOGNAME': 'cltbld', 08:40:24 INFO - 'MAIL': '/var/mail/cltbld', 08:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:24 INFO - 'MOZ_NO_REMOTE': '1', 08:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:24 INFO - 'NO_EM_RESTART': '1', 08:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:24 INFO - 'SHELL': '/bin/bash', 08:40:24 INFO - 'SHLVL': '1', 08:40:24 INFO - 'TERM': 'linux', 08:40:24 INFO - 'TMOUT': '86400', 08:40:24 INFO - 'USER': 'cltbld', 08:40:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:24 INFO - '_': '/tools/buildbot/bin/python'} 08:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:24 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 08:40:24 INFO - Cleaning up... 08:40:24 INFO - Return code: 0 08:40:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:40: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')]} 08:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:24 INFO - Using env: {'DISPLAY': ':0', 08:40:24 INFO - 'HOME': '/home/cltbld', 08:40:24 INFO - 'LANG': 'en_US.UTF-8', 08:40:24 INFO - 'LANGUAGE': 'en_US:en', 08:40:24 INFO - 'LOGNAME': 'cltbld', 08:40:24 INFO - 'MAIL': '/var/mail/cltbld', 08:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:24 INFO - 'MOZ_NO_REMOTE': '1', 08:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:24 INFO - 'NO_EM_RESTART': '1', 08:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:24 INFO - 'SHELL': '/bin/bash', 08:40:24 INFO - 'SHLVL': '1', 08:40:24 INFO - 'TERM': 'linux', 08:40:24 INFO - 'TMOUT': '86400', 08:40:24 INFO - 'USER': 'cltbld', 08:40:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:24 INFO - '_': '/tools/buildbot/bin/python'} 08:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:25 INFO - Downloading/unpacking psutil>=0.7.1 08:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:26 INFO - Installing collected packages: psutil 08:40:26 INFO - Running setup.py install for psutil 08:40:26 INFO - building 'psutil._psutil_linux' extension 08:40:26 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 08:40:27 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 08:40:27 INFO - building 'psutil._psutil_posix' extension 08:40:27 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 08:40:27 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 08:40:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:27 INFO - Successfully installed psutil 08:40:27 INFO - Cleaning up... 08:40:27 INFO - Return code: 0 08:40:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:40:27 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')]} 08:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 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')]} 08:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:27 INFO - Using env: {'DISPLAY': ':0', 08:40:27 INFO - 'HOME': '/home/cltbld', 08:40:27 INFO - 'LANG': 'en_US.UTF-8', 08:40:27 INFO - 'LANGUAGE': 'en_US:en', 08:40:27 INFO - 'LOGNAME': 'cltbld', 08:40:27 INFO - 'MAIL': '/var/mail/cltbld', 08:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:27 INFO - 'MOZ_NO_REMOTE': '1', 08:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:27 INFO - 'NO_EM_RESTART': '1', 08:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:27 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:27 INFO - 'SHELL': '/bin/bash', 08:40:27 INFO - 'SHLVL': '1', 08:40:27 INFO - 'TERM': 'linux', 08:40:27 INFO - 'TMOUT': '86400', 08:40:27 INFO - 'USER': 'cltbld', 08:40:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:27 INFO - '_': '/tools/buildbot/bin/python'} 08:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:27 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 08:40:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:40:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:40:29 INFO - Installing collected packages: mozsystemmonitor 08:40:29 INFO - Running setup.py install for mozsystemmonitor 08:40:29 INFO - Successfully installed mozsystemmonitor 08:40:29 INFO - Cleaning up... 08:40:29 INFO - Return code: 0 08:40:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:40: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')]} 08:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:29 INFO - Using env: {'DISPLAY': ':0', 08:40:29 INFO - 'HOME': '/home/cltbld', 08:40:29 INFO - 'LANG': 'en_US.UTF-8', 08:40:29 INFO - 'LANGUAGE': 'en_US:en', 08:40:29 INFO - 'LOGNAME': 'cltbld', 08:40:29 INFO - 'MAIL': '/var/mail/cltbld', 08:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:29 INFO - 'MOZ_NO_REMOTE': '1', 08:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:29 INFO - 'NO_EM_RESTART': '1', 08:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:29 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:29 INFO - 'SHELL': '/bin/bash', 08:40:29 INFO - 'SHLVL': '1', 08:40:29 INFO - 'TERM': 'linux', 08:40:29 INFO - 'TMOUT': '86400', 08:40:29 INFO - 'USER': 'cltbld', 08:40:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:29 INFO - '_': '/tools/buildbot/bin/python'} 08:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:29 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 08:40:29 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 08:40:29 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 08:40:29 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 08:40:29 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 08:40:29 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 08:40:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:40:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:32 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 08:40:32 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 08:40:32 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 08:40:32 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 08:40:32 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 08:40:32 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 08:40:32 INFO - Downloading docopt-0.6.1.tar.gz 08:40:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:32 INFO - Running setup.py install for blobuploader 08:40:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:32 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:40:32 INFO - Running setup.py install for requests 08:40:32 INFO - Running setup.py install for docopt 08:40:32 INFO - Successfully installed blobuploader requests docopt 08:40:32 INFO - Cleaning up... 08:40:32 INFO - Return code: 0 08:40:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:40: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')]} 08:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 08:40:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 08:40:32 INFO - Using env: {'DISPLAY': ':0', 08:40:32 INFO - 'HOME': '/home/cltbld', 08:40:32 INFO - 'LANG': 'en_US.UTF-8', 08:40:32 INFO - 'LANGUAGE': 'en_US:en', 08:40:32 INFO - 'LOGNAME': 'cltbld', 08:40:32 INFO - 'MAIL': '/var/mail/cltbld', 08:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:32 INFO - 'MOZ_NO_REMOTE': '1', 08:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:32 INFO - 'NO_EM_RESTART': '1', 08:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:32 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:32 INFO - 'SHELL': '/bin/bash', 08:40:32 INFO - 'SHLVL': '1', 08:40:32 INFO - 'TERM': 'linux', 08:40:32 INFO - 'TMOUT': '86400', 08:40:32 INFO - 'USER': 'cltbld', 08:40:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:32 INFO - '_': '/tools/buildbot/bin/python'} 08:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:33 INFO - Running setup.py (path:/tmp/pip-makmGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:33 INFO - Running setup.py (path:/tmp/pip-y8gmOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:33 INFO - Running setup.py (path:/tmp/pip-p3e80X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:33 INFO - Running setup.py (path:/tmp/pip-Vk3nK5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:33 INFO - Running setup.py (path:/tmp/pip-Jd0ESa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:33 INFO - Running setup.py (path:/tmp/pip-MycwTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:33 INFO - Running setup.py (path:/tmp/pip-nImvM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:33 INFO - Running setup.py (path:/tmp/pip-Voeqya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:33 INFO - Running setup.py (path:/tmp/pip-INHtq7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:33 INFO - Running setup.py (path:/tmp/pip-zaL6pK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:33 INFO - Running setup.py (path:/tmp/pip-g2uuvS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:33 INFO - Running setup.py (path:/tmp/pip-FeWysd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:34 INFO - Running setup.py (path:/tmp/pip-Nhlrlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:34 INFO - Running setup.py (path:/tmp/pip-rZhJah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:34 INFO - Running setup.py (path:/tmp/pip-hodDVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:34 INFO - Running setup.py (path:/tmp/pip-psEtWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:34 INFO - Running setup.py (path:/tmp/pip-Mg6s1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:34 INFO - Running setup.py install for manifestparser 08:40:34 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:40:34 INFO - Running setup.py install for mozcrash 08:40:34 INFO - Running setup.py install for mozdebug 08:40:34 INFO - Running setup.py install for mozdevice 08:40:34 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:40:34 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:40:34 INFO - Running setup.py install for mozfile 08:40:34 INFO - Running setup.py install for mozhttpd 08:40:34 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:40:34 INFO - Running setup.py install for mozinfo 08:40:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Running setup.py install for mozInstall 08:40:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Running setup.py install for mozleak 08:40:35 INFO - Running setup.py install for mozlog 08:40:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Running setup.py install for moznetwork 08:40:35 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Running setup.py install for mozprocess 08:40:35 INFO - Running setup.py install for mozprofile 08:40:35 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Running setup.py install for mozrunner 08:40:35 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:40:35 INFO - Running setup.py install for mozscreenshot 08:40:35 INFO - Running setup.py install for moztest 08:40:36 INFO - Running setup.py install for mozversion 08:40:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:40:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:40: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')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:36 INFO - Running setup.py (path:/tmp/pip-16MNQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:36 INFO - Running setup.py (path:/tmp/pip-nG8dtu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:36 INFO - Running setup.py (path:/tmp/pip-9vTuIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:36 INFO - Running setup.py (path:/tmp/pip-SsIhN9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:36 INFO - Running setup.py (path:/tmp/pip-zCSdrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:36 INFO - Running setup.py (path:/tmp/pip-gG7gMU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:36 INFO - Running setup.py (path:/tmp/pip-D0zExy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:36 INFO - Running setup.py (path:/tmp/pip-_21VxL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:36 INFO - Running setup.py (path:/tmp/pip-UnztTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:36 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)) 08:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:37 INFO - Running setup.py (path:/tmp/pip-2SXyHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:37 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)) 08:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:37 INFO - Running setup.py (path:/tmp/pip-3hgvqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:37 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)) 08:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:37 INFO - Running setup.py (path:/tmp/pip-_zfrO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:37 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)) 08:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:37 INFO - Running setup.py (path:/tmp/pip-kV0Qni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:37 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)) 08:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:37 INFO - Running setup.py (path:/tmp/pip-SyR2KG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:37 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)) 08:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:37 INFO - Running setup.py (path:/tmp/pip-zxQT3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:37 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)) 08:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:37 INFO - Running setup.py (path:/tmp/pip-ZTrLTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:37 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)) 08:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:37 INFO - Running setup.py (path:/tmp/pip-x9Uc8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:37 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)) 08:40:37 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)) 08:40:37 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)) 08:40:37 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)) 08:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:37 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 08:40:37 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 08:40:37 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 08:40:37 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 08:40:37 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 08:40:37 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 08:40:39 INFO - Downloading blessings-1.6.tar.gz 08:40:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:39 INFO - Installing collected packages: blessings 08:40:39 INFO - Running setup.py install for blessings 08:40:39 INFO - Successfully installed blessings 08:40:39 INFO - Cleaning up... 08:40:39 INFO - Return code: 0 08:40:39 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:40:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:40:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:40:39 INFO - Reading from file tmpfile_stdout 08:40:39 INFO - Current package versions: 08:40:39 INFO - argparse == 1.2.1 08:40:39 INFO - blessings == 1.6 08:40:39 INFO - blobuploader == 1.2.4 08:40:39 INFO - docopt == 0.6.1 08:40:39 INFO - manifestparser == 1.1 08:40:39 INFO - mozInstall == 1.12 08:40:39 INFO - mozcrash == 0.16 08:40:39 INFO - mozdebug == 0.1 08:40:39 INFO - mozdevice == 0.48 08:40:39 INFO - mozfile == 1.2 08:40:39 INFO - mozhttpd == 0.7 08:40:39 INFO - mozinfo == 0.9 08:40:39 INFO - mozleak == 0.1 08:40:39 INFO - mozlog == 3.1 08:40:39 INFO - moznetwork == 0.27 08:40:39 INFO - mozprocess == 0.22 08:40:39 INFO - mozprofile == 0.28 08:40:39 INFO - mozrunner == 6.11 08:40:39 INFO - mozscreenshot == 0.1 08:40:39 INFO - mozsystemmonitor == 0.0 08:40:39 INFO - moztest == 0.7 08:40:39 INFO - mozversion == 1.4 08:40:39 INFO - psutil == 3.1.1 08:40:39 INFO - requests == 1.2.3 08:40:39 INFO - wsgiref == 0.1.2 08:40:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:40: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')]} 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:39 INFO - Using env: {'DISPLAY': ':0', 08:40:39 INFO - 'HOME': '/home/cltbld', 08:40:39 INFO - 'LANG': 'en_US.UTF-8', 08:40:39 INFO - 'LANGUAGE': 'en_US:en', 08:40:39 INFO - 'LOGNAME': 'cltbld', 08:40:39 INFO - 'MAIL': '/var/mail/cltbld', 08:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:39 INFO - 'MOZ_NO_REMOTE': '1', 08:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:39 INFO - 'NO_EM_RESTART': '1', 08:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:39 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:39 INFO - 'SHELL': '/bin/bash', 08:40:39 INFO - 'SHLVL': '1', 08:40:39 INFO - 'TERM': 'linux', 08:40:39 INFO - 'TMOUT': '86400', 08:40:39 INFO - 'USER': 'cltbld', 08:40:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:39 INFO - '_': '/tools/buildbot/bin/python'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 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)) 08:40:40 INFO - Cleaning up... 08:40:40 INFO - Return code: 0 08:40:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:40 INFO - Using env: {'DISPLAY': ':0', 08:40:40 INFO - 'HOME': '/home/cltbld', 08:40:40 INFO - 'LANG': 'en_US.UTF-8', 08:40:40 INFO - 'LANGUAGE': 'en_US:en', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MAIL': '/var/mail/cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SHLVL': '1', 08:40:40 INFO - 'TERM': 'linux', 08:40:40 INFO - 'TMOUT': '86400', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - '_': '/tools/buildbot/bin/python'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 INFO - Downloading/unpacking jsonschema 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:42 INFO - Downloading/unpacking functools32 (from jsonschema) 08:40:42 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 08:40:42 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 08:40:42 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 08:40:42 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 08:40:42 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 08:40:42 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 08:40:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:42 INFO - warning: no files found matching '*.txt' 08:40:42 INFO - no previously-included directories found matching 'build' 08:40:42 INFO - no previously-included directories found matching 'dist' 08:40:42 INFO - no previously-included directories found matching '.git*' 08:40:42 INFO - Installing collected packages: jsonschema, functools32 08:40:42 INFO - Running setup.py install for functools32 08:40:42 INFO - warning: no files found matching '*.txt' 08:40:42 INFO - no previously-included directories found matching 'build' 08:40:42 INFO - no previously-included directories found matching 'dist' 08:40:42 INFO - no previously-included directories found matching '.git*' 08:40:42 INFO - Successfully installed jsonschema functools32 08:40:42 INFO - Cleaning up... 08:40:42 INFO - Return code: 0 08:40:42 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f854ae3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', '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 08:40:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:40:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:40:42 INFO - Using env: {'DISPLAY': ':0', 08:40:42 INFO - 'HOME': '/home/cltbld', 08:40:42 INFO - 'LANG': 'en_US.UTF-8', 08:40:42 INFO - 'LANGUAGE': 'en_US:en', 08:40:42 INFO - 'LOGNAME': 'cltbld', 08:40:42 INFO - 'MAIL': '/var/mail/cltbld', 08:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:42 INFO - 'MOZ_NO_REMOTE': '1', 08:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:42 INFO - 'NO_EM_RESTART': '1', 08:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:42 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:42 INFO - 'SHELL': '/bin/bash', 08:40:42 INFO - 'SHLVL': '1', 08:40:42 INFO - 'TERM': 'linux', 08:40:42 INFO - 'TMOUT': '86400', 08:40:42 INFO - 'USER': 'cltbld', 08:40:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:42 INFO - '_': '/tools/buildbot/bin/python'} 08:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:42 INFO - Downloading/unpacking flake8 08:40:42 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 08:40:42 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 08:40:42 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 08:40:42 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 08:40:42 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 08:40:42 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 08:40:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:40:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:40:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:44 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 08:40:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:40:45 INFO - no previously-included directories found matching 'docs/_build' 08:40:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:40:45 INFO - Running setup.py install for pep8 08:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:40:45 INFO - no previously-included directories found matching 'docs/_build' 08:40:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:40:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:40:45 INFO - Cleaning up... 08:40:45 INFO - Return code: 0 08:40:45 INFO - Running post-action listener: _resource_record_post_action 08:40:45 INFO - Running post-action listener: _start_resource_monitoring 08:40:45 INFO - Starting resource monitoring. 08:40:45 INFO - ##### 08:40:45 INFO - ##### Running install step. 08:40:45 INFO - ##### 08:40:45 INFO - Running pre-action listener: _resource_record_pre_action 08:40:45 INFO - Running main action method: install 08:40:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:40:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:40:45 INFO - Reading from file tmpfile_stdout 08:40:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:40:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:40:45 INFO - Reading from file tmpfile_stdout 08:40:45 INFO - Output received: 08:40:45 INFO - Usage: mozinstall [options] installer 08:40:45 INFO - Options: 08:40:45 INFO - -h, --help show this help message and exit 08:40:45 INFO - -d DEST, --destination=DEST 08:40:45 INFO - Directory to install application into. [default: 08:40:45 INFO - "/builds/slave/test-pgo"] 08:40:45 INFO - --app=APP Application being installed. [default: firefox] 08:40:45 INFO - mkdir: /builds/slave/test-pgo/build/application 08:40:45 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'] 08:40:45 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 08:41:01 INFO - Reading from file tmpfile_stdout 08:41:01 INFO - Output received: 08:41:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:41:01 INFO - Running post-action listener: _resource_record_post_action 08:41:01 INFO - ##### 08:41:01 INFO - ##### Running run-tests step. 08:41:01 INFO - ##### 08:41:01 INFO - Running pre-action listener: _resource_record_pre_action 08:41:01 INFO - Running main action method: run_tests 08:41:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:41:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:41:01 INFO - Python 2.7.3 08:41:01 INFO - Return code: 0 08:41:01 INFO - grabbing minidump binary from tooltool 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:01 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 0x1b52840>, '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 0x1abf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abfb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:41:01 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 08:41:01 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 08:41:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:01 INFO - Return code: 0 08:41:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:41:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:41:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:41:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:41:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:41:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:41:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:41:02 INFO - Return code: 0 08:41:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:41:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 08:41:02 INFO - Using env: {'DISPLAY': ':0', 08:41:02 INFO - 'HOME': '/home/cltbld', 08:41:02 INFO - 'LANG': 'en_US.UTF-8', 08:41:02 INFO - 'LANGUAGE': 'en_US:en', 08:41:02 INFO - 'LOGNAME': 'cltbld', 08:41:02 INFO - 'MAIL': '/var/mail/cltbld', 08:41:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:41:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:02 INFO - 'MOZ_NO_REMOTE': '1', 08:41:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:02 INFO - 'NO_EM_RESTART': '1', 08:41:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:41:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:41:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:41:02 INFO - 'SHELL': '/bin/bash', 08:41:02 INFO - 'SHLVL': '1', 08:41:02 INFO - 'TERM': 'linux', 08:41:02 INFO - 'TMOUT': '86400', 08:41:02 INFO - 'USER': 'cltbld', 08:41:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622', 08:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:02 INFO - '_': '/tools/buildbot/bin/python'} 08:41:02 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:41:03 INFO - mozversion application_buildid: 20160125030203 08:41:03 INFO - mozversion application_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 08:41:03 INFO - mozversion application_display_name: Nightly 08:41:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:03 INFO - mozversion application_name: Firefox 08:41:03 INFO - mozversion application_remotingname: firefox 08:41:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:03 INFO - mozversion application_vendor: Mozilla 08:41:03 INFO - mozversion application_version: 46.0a1 08:41:03 INFO - mozversion platform_buildid: 20160125030203 08:41:03 INFO - mozversion platform_changeset: 67c66c2878aed17ae3096d7db483ddbb2293c503 08:41:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:03 INFO - mozversion platform_version: 46.0a1 08:41:03 INFO - using testdate: 1453740063 08:41:03 INFO - actual date: 1453740063 08:41:03 INFO - starting webserver on 'localhost:33262' 08:41:03 INFO - SUITE-START | Running 3 tests 08:41:03 INFO - TEST-START | dromaeo_css 08:41:03 INFO - operating with platform_type : linux_ 08:41:03 INFO - Initialising browser for dromaeo_css test... 08:41:03 INFO - TEST-INFO | started process 5780 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFtezmn/profile http://localhost:33262/getInfo.html) 08:41:07 INFO - PROCESS | 5780 | __metrics Screen width/height:1600/1200 08:41:07 INFO - PROCESS | 5780 | colorDepth:24 08:41:07 INFO - PROCESS | 5780 | Browser inner width/height: 1024/697 08:41:07 INFO - PROCESS | 5780 | __metrics 08:41:07 INFO - PROCESS | 5780 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:41:07 INFO - PROCESS | 5780 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:08 INFO - TEST-INFO | 5780: exit 0 08:41:08 INFO - Browser initialized. 08:41:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:08 INFO - TEST-INFO | started process 5874 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFtezmn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:20 INFO - PROCESS | 5874 | RSS: Main: 148250624 08:41:20 INFO - PROCESS | 5874 | 08:42:11 INFO - PROCESS | 5874 | 1453740131929 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] 08:44:20 INFO - PROCESS | 5874 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33262/tests/dromaeo/cssquery-ext.html) 08:44:21 INFO - PROCESS | 5874 | RSS: Main: 245522432 08:44:21 INFO - PROCESS | 5874 | 08:47:23 INFO - PROCESS | 5874 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-ext.html (next: http://localhost:33262/tests/dromaeo/cssquery-jquery.html) 08:47:24 INFO - PROCESS | 5874 | RSS: Main: 228458496 08:47:24 INFO - PROCESS | 5874 | 08:50:26 INFO - PROCESS | 5874 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33262/tests/dromaeo/cssquery-mootools.html) 08:50:26 INFO - PROCESS | 5874 | RSS: Main: 237182976 08:50:26 INFO - PROCESS | 5874 | 08:53:28 INFO - PROCESS | 5874 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33262/tests/dromaeo/cssquery-prototype.html) 08:53:29 INFO - PROCESS | 5874 | RSS: Main: 213020672 08:53:29 INFO - PROCESS | 5874 | 08:56:31 INFO - PROCESS | 5874 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33262/tests/dromaeo/cssquery-yui.html) 08:56:32 INFO - PROCESS | 5874 | RSS: Main: 213049344 08:56:32 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-yui.html (next: http://localhost:33262/tests/dromaeo/cssquery-dojo.html) 08:59:35 INFO - PROCESS | 5874 | RSS: Main: 270258176 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | __start_tp_report 08:59:35 INFO - PROCESS | 5874 | _x_x_mozilla_page_load 08:59:35 INFO - PROCESS | 5874 | _x_x_mozilla_page_load_details 08:59:35 INFO - PROCESS | 5874 | |i|pagename|runs| 08:59:35 INFO - PROCESS | 5874 | |0;dojo.html;3185.8407079646017;3194.760392970528;3232.886848960287;3235.0941736313825;3264.738820894329;5111.7699703513335;5196.272521846944;5219.739013049351;5248.029114613794;5309.203619457084;5241.449647786984;5261.473852614737;5269.8946021079555;5285.048691235576;5324.41431442541;4709.788059537312;4753.073150735608;4826.034793041388;4898.583620392253;4988.850334489953;4884.780184891671;4939.185034469308;4989.226669866159;4998.2752500887345;5010;4632.884177895546;4732.645051621108;4744.217204161309;4797.944452220506;4844.757762111915;4774.188387974053;4785.353977213066;4787.784549695272;4802.967362017148;4838.056578967103;4744.620430365597;4781.42622885256;4785.066911952171;4799.616030717569;4825.710457372569;5016.899662006739;5024.447310795809;5065.113605119126;5097.898042039175;5105.872353191163;5556.444355564452;5574.777008919638;5582.86042848932;5582.972085139589;5588.133839254922;5544.362398324204;5603.215549823028;5609.439056094398;5617.157426386034;5626.324841019104;5195.506426889439;5218.243354713545;5244.6328756987405;5247.16045432729;5251.133562962106;5693.715314234271;5698.116791897262;5699.401562835926;5708.086706127;5730.226419433407;5477.835664930059;5505.724713764296;5509.256250406224;5513.7794488220825;5553.944460555424;5551.306086739158;5600.747966341524;5606.55147588192;5610.046292130348;5643.492085712305;5568.192612071227;5601;5609.934112518608;5617.915731264035;5619.8595035124445;5463.207834864002;5552.750126244328;5600.103983362643;5602.38373778884;5609.887802243932;4271.23117838792;4287.485501739811;4292.291771857671;4294.892627684333;4331.675124365685;3862;3873.7869417182324;3875.0893540018074;3900.1809619979554;3901.356276214393;5119.641625086283;5156.20078887773;5200.7139607321205;5216.035033518811;5228.05894938907;5549.556035517149;5562.082256427725;5565.9443405566235;5572.359178694421;5576.832695019156;5169.53474187325;5184.662996905189;5188.792448302026;5190.11767999441;5216.478352164753;4705.788239529229;4770.260609605517;4778.020505796303;4784.473707892129;4850.563449289581;5840.737166827503;5854.765809367577;5855.063189889683;5863.296404431496;5871.2073870027;5521.254630624814;5625.268715067015;5629.943700563106;5631.267935168402;5637.267155269788;5779.219805326227;5867.530597552271;5910.7931222407005;5921.911171332519;5931.377205393372;5563.831595364857;5569.470900264469;5570.637908535932;5573.303337082864;5576.665400075846;5457.645253058538;5592.804251851328;5617.831465056055;5637.069883469346;5639.464250896158;5507.981023510663;5545.584081194007;5550.611457198119;5557.44425557441;5591.804286849941;5414.756335964812;5426.104692725656;5430.945690543202;5431.239626452379;5433.510984011458;5254.579633629224;5325.840224793263;5358.812441564526;5376.704281264411;5386.569074473954;5547.11246200606;5548.195511650869;5582.581306401955;5594.832155035356;5601.859953501032;5387.272718182995;5421.159720243369;5422.322209723785;5423.430539793265;5467.207254947931 08:59:35 INFO - PROCESS | 5874 | |1;ext.html;528.2577977940995;537.6424677589404;560.9467100625442;594.5867622002708;597.3071237364658;29072.709272907265;29532.704672953263;36260.2747945041;36792.81603591979;36865;39674.8016259919;40017;40198.19603607926;40271.59728402715;40315.39526907091;8449.915500844989;8649;8649.870251946226;8651.610677519528;8656.826863462727;8364.790880227982;8476.110008449086;8477.152284771504;8488.702895398663;8488.915110848875;8631.65473381064;8701;8710.259627931602;8718.389712720113;8720.258778003878;8574.185452382013;8576.485410875368;8611.26804221642;8654.048054713976;8654.134586541328;8472.15278472154;8587.098354672795;8607;8612.52631105289;8612.674577863942;39287;39766.21052052636;39782.60217397818;39892.80053599743;39906.40140397896;3369.983150084234;3409.7783644063056;3470.7917524948584;3912.628300311466;3980.6019398060253;30010.699893001227;30058.699413006027;30480;30659.233519161975;30708;3879.301725689375;3926.7447615904875;3969.4244334571326;3970;4030.7984600769846;210784;210838;211282;211534;211550;57774;58125;58252.70873645604;58276.708616457494;58296;60504;60630;60659.69670151621;60711.69644151751;60757.392426075174;12721.300328482022;12865.871341286655;12866.871331286755;12869.935650321875;12872.485100596059;9424.528773561295;9455.243580513543;9472.857907131398;9480.857787133198;9486.146246837818;18569.214120674842;19374.128164232643;19397;19441.61116777685;19540.804591954184;6349.523785715997;7443.776686699408;7781.688732450752;7812.765617031499;7841.5687137208;899.2581120575551;931.3247895276006;983.4689267795453;999.5352161245056;1056.1339701444742;27955.301117472227;28356.858215708788;28931.132066037633;28979;29060.27349316284;1008.8284991551454;1012.3217444312181;1020.3214862116757;1062.129054175584;1091.7106966653844;13400.32998350098;13540.458381664623;13572;13601.183928964294;13757.656058598415;308568;311209;347907;351973;352515;43522.56477435248;43532.56467435348;43852.34221486616;43878;43900.121997560505;1164.5341863254596;1247.1955588645455;1324.3047400115017;1326.7412854493475;1334.5729366602593;26602.334941626614;28757.424851502434;28945.85527072351;29123.563146552395;29144.562831557967;45428;47084.29373559468;47185.29222061603;47294.76352618215;47298.527014729414;269669;271146;406423;414222.00445968495;427839;30857.69142308548;30901.53647695331;30918.381632367677;31191;31390.529142063344;42689;42919;43290.56709432991;43935;44253;36087.88895728693;36270.8186459066;37233;37238.8138059308;37859.432108517845;34723.13192170216;35866.10334741652;36011;36505.45241821428;37222.813885930394;32023.359532809678;32136.19659508531;32173.35653286968;32191;32221.194470138435;29804.254893627833;30297.69702303037;31917.36165276635;32267;32833.835830820695;22887.542249155256;22917.31248062561;22965.65551516762;24181.879090604434;24717.50564988654 08:59:35 INFO - PROCESS | 5874 | |2;jquery.html;366.95596528416587;367.280130943351;367.889633110067;369.1030795167743;370.9944350834736;13386.464541418356;13495.865041349583;15439.150846703427;16973.74539381909;17845.375411860587;15466.690666186669;15690.05859648419;15757.763633545477;15780.368785248605;16659.416920407788;5328.440513746059;5493.533049690781;5501;5501.284832971708;5502.9174562381595;3976.562578116405;4069.8779036628803;5362.785488580472;5590.552755779528;5821.6507009579345;5595.328560572737;5713.971430142843;5749.626274292157;5786.68173250471;5787.710614469281;5606.719664016803;5859.53123750099;5878.5297176225795;5890.116482527634;5891.617044892068;4912.77892494835;5066.442691303953;5067;5106.923396149061;5194.454582268845;12570.182938109085;13578.864211357957;18952.715709264372;19733.21067157312;19778.30775922836;2056.5475595368994;2096.9790302096935;2157.169489746459;2215.678726584636;2225.1321984425927;9681.177099946513;9698.078682525149;10046.296759226858;11597.942010289895;11956;1768.5578605348662;1810.8008119106887;1859.4328729737424;1867.3557622620174;1896.0993528074193;54844.72577637126;56538.43461565373;57075;57773.422265777226;58514;10061.748456288651;10124.69625911224;10163.796724065478;10236.641717539851;10271.281010329205;13210.669733256746;13282.800757988638;13336.133151345131;13348.599542013755;13373.799393009112;6868.519203655696;6884.483663725241;6910.239873613898;6951.131108611424;6955.826104347432;6403.135576697179;6414.583052101599;6440.935590644127;6446.161998940108;6458.38645328693;4087.3664581989838;4432.268675668479;4469.262571675702;4508.661850361236;4523.5024147343765;1720.7935047794344;1756.5081777102432;1761.4451447793904;1781.518989872753;1869.2149297295168;891.8528442806994;919.5494207838245;932.6968735160964;933.9953300233591;1022.3916769522123;15772;16238.512844614681;16522.669546609002;16700.164991750607;16734.832651673572;863.4387648028707;912.6668765900398;931.3061768982152;935.0836180543106;950.2160717408166;9241.815163696689;9493.477858717837;9517.524123793783;9525.999770024047;9693.321467497348;527956;552248;552987;559158;565836;66256.46221003843;68667.65666171638;69157.65421172862;70546;71387.64306178436;1109.4563663804677;1144.9313041217554;1147.042219746521;1150.1603829204728;1150.3787954504642;14740.852591473948;14898.329575168927;14941.477048303257;15157.242137893281;15167.544973650809;32060.5190922141;32642.836785815918;33253.50119748157;33326.833365833016;33528.832355838065;39077.80461097676;39603.80198098991;40574;40613.59386406216;41063.38404923988;3038.529028000575;6580.473562115115;6996.895046574204;7248;7387.741429049957;7434.597102255375;10282.434466104436;10836.620718274822;11174.66476005721;11472.31166130035;7758.650860711395;8602.655893764178;8999.055099214489;9116.635334586543;9496.715098547054;9090.36367454272;9209.493477858781;9497.19273861702;9713.465759383302;9940.254480914105;8227.341812654853;9026.729198124067;9361.157495825408;10373.32573382758;10598.523066461874;7165.713371465083;7233.710651573878;7275.308845659654;7305.3425191732995;7360.227176146642;9429.15137637616;9701.6604418845;9752.512374381395;9845.212383009486;10008.299419040597 08:59:35 INFO - PROCESS | 5874 | |3;mootools.html;1366.344154805694;1468.1704836767226;1472.2491529320048;1617.9676406471872;1763.6472705458912;6738.764143254987;7643.808904777384;7860.68557257709;7865.292123708865;7868.17384174662;7774.183710710378;7964.641591128398;7977.760667179994;7978.760637180894;7988.081370642378;1981.6036792641457;2031.3296612117965;2207.304699019812;2251.5609456156058;2276.2829708641807;2250.8536945098517;2264.2527965771337;2265.0939624150305;2265.343050515357;2268.750437451879;2217.789310015546;2320.3619004773655;2321.5705094557475;2325.6278995360744;2326.8720220387872;1973.842092632586;2027.8681885677458;2244.2145249162663;2296.644020176875;2301.528186721718;2220.6891035255076;2221.8111460525874;2255.064148378421;2261.7738226177253;2281.555096756133;7850.411219158586;7907.209279072104;7909.920900790976;7910.4462687611895;7921.485103468256;4531.252343363374;4662.487126416091;4680.789364478606;4682.672212945095;4692.6245900327895;3029.606151200352;3040.4223197592387;3089.3780765098277;3100.0544833825675;3202.4235637585225;954.9092836180552;966.6616684160558;971.8736564246602;1021.4790456867051;1065.3075500924383;10923.945380273128;10952.28810127347;11015.779684406267;11057;11071;4032.3749818778138;4154.231467178582;4174.248635245624;4183.748975061506;4211.178820130045;8875.689350872688;9163.862542061874;9168.862467063;9171.358004939724;9194.586243619053;4652.813887444464;4685.367475390779;4695.154872122982;4695.272232803921;4695.929561056587;4267.317229243306;4304.203722311382;4305.160493703697;4306.913861722748;4312.029793296546;3534.081138903852;3573.6426357364057;3625.4380571011534;3628.219932714479;3628.4920111184456;1062.2351906627216;1079.6005477973042;1084.511969613677;1093.9343639381664;1103.3986477369854;1068.1668298727006;1109.2623405435456;1110.783397237547;1271.2563150556844;1367.1660287224786;7584.810379740551;7705.576193309422;7727.961360193163;7752.224777522202;7767.834824776216;437.6783064447628;443.56309035599907;443.5763845527578;444;454.9226631472658;5860.560457965669;6021.668808215591;6022.09668549721;6024.518038556905;6031.638101713911;9302.813943721088;9486.715398538056;9505.144536991704;9548.331616786758;9601.32790704644;9415.105564971316;9424.811503770023;9544.856827147598;9549.809003819884;9553;7263.0921134858145;7393.8151546211775;7430.182679905206;7463.5521868686965;7502.3622992046285;7369.152547457111;7385.667644956097;7463.962680186564;7471.8879216812875;7472.103347598323;8790;8881.600327985385;8952.820943581222;9030.05184455649;9044.728658140266;9030.954845225731;9066.95466522663;9136.26909847224;9184.357095003286;9236.26109911192;7272.745453909088;7348.301911318416;7369.263073692588;7378.667959941708;7379.2251813558805;7214.71141154348;7333.779986600411;7760.767176984699;7838.686452541834;7847.843043138991;7045.506814522934;7174.713011479483;7230.674619642024;7282.12614486265;7292.781216563511;6066.3023752269055;6935.757248496278;7026.3676269133975;7152.284771522806;7156.677949492389;7063.117110361205;7135.108111486064;7160.606166660884;7188.892166617609;7191.892121618075;6501.4798816095545;6615.4046135848;6615.66921653925;6620.63586502747;6622.602643841385;6652.966735166487;6713.227978782503;6715.496337774589;6719.731210751515;6726.8654626908165 08:59:35 INFO - PROCESS | 5874 | |4;prototype.html;321.3444573070935;324.90902547286754;331.58220641991085;333.62300600321635;337.3472331039439;5641.012822756012;5760.942390576093;5845.678487683176;5849.7367618457165;5861.325947516037;5541.861453463665;5687.8578035549135;5703.144528320744;5743.052396354607;5763.740631671574;4483.529229430904;4517.051419201972;4517.367568540407;4518.322251662261;4524.932126018096;4258.382534532491;4357.782110894458;4406.647468202536;4510.616597589209;4525.977370113144;4415.977920110395;4431.423914891059;4436.733795972236;4448.377227188196;4460.643148548108;4421.801018954155;4422.071365013335;4424.579664931826;4424.911501769979;4479.529649386833;3933.606639336072;3935.9212815743813;3944.8027598619956;3947.8618248361167;3948.368261078214;5364.14173732201;5541.085720856054;5546.972265138689;5553.861153471155;5559.499645031926;5189.584833213372;5207.4792520748;5216.774058096382;5218.712970786605;5224.373075230958;6178.320384757673;6184.165137706397;6190.566660333733;6196.752129914798;6206.317305096436;4179.331306990867;4259.70182087254;4261.786910654455;4332.631726303268;4357.063231405263;6325.177726895474;6383.553151279412;6386.68066596673;6398.584092033956;6404.391582799627;4454.77726113693;4457.108578284357;4462.754548499799;4463.486699029589;4465.24090904547;4381.627561657231;4520.819167233274;4522.909541809146;4524.457065152203;4528.728276303366;5138.537531622172;5197.376314842243;5200.115980283361;5202.53177214045;5202.97398513005;6198.504119670415;6200.100985357098;6202.596831205957;6209.06863970399;6210.378962103844;1591.3634546181388;1606.3414000259838;1607.0759313394844;1607.742761158209;1607.9356825727075;1086.1093902999623;1086.1528008153653;1109.9056580190613;1112.4271000434783;1115.8772535021142;5857.70711464425;5875.294964604275;5875.6474611523445;5877.324107727581;5878.941210587925;6349.46029587481;6357.14178585885;6361.109444677749;6366.522510811615;6368.363163683594;5852;5858.326292476419;5860.38465961068;5861.150133230658;5861.70691465425;3333.3000069985574;3431.897043088711;3438.6045604755273;3438.9312213755584;3442.053435305261;6624.27133015368;6651.966740166365;6685.598864068074;6691.297413771581;6697.330266973361;6560.343965603402;6572.704228309737;6576.5067619928695;6583.407493325623;6588.176477940257;6539.705713242915;6669.599824010575;6673.232578253563;6674.2658307586125;6677.799666010124;6149.969250153899;6410;6412.3908228720065;6419.646919419477;6420.3258657842125;6218.191635087591;6257.155284036597;6349.587276826992;6357.523185761179;6368.713407896563;6634.270230274762;6651.933480665325;6658.201015878126;6658.500612454182;6664.067030615621;4355.956440435555;4397.340398940185;4402.471703395613;4405.515393306798;4409.294512877924;6247.843803904939;6414.454771344488;6427.678616069272;6428.421442070049;6428.774992875227;6226.470749986302;6271.310155882758;6282;6282.591631543935;6286.622802631857;6172.382761723792;6242.3133455320785;6249.437550620466;6256.6246025236815;6264.718087686157;6063.72713227897;6139.3553676863285;6145.938540614537;6146.969265153645;6155.6614386209185;6268.874622507433;6271.278802937538;6276.905846412216;6278.46633036197;6282.434580887742;6125.877482450415;6132.969335153296;6134.846628834315;6138.294096178996;6151.046587778901 08:59:35 INFO - PROCESS | 5874 | |5;yui.html;680.5372346804173;742.3096520236181;745.5079647432696;749.6064566102796;771.3636250093671;12526.373681315932;12704.364781760909;12707.936460317696;12719.1732537385;12777.425015874285;11486.310821350724;11756.294622322666;11788.17482776206;11825.349605771678;11869.584564540242;664.3754870421789;672.9024291477733;783.9725609603679;801.0467543623099;801.4670244287571;803.7468197517763;808.6361137488125;811.8944537210155;811.9553424561647;812.3744716568239;852.0116664668985;854.1885209051395;856.8372009318241;857.5926434943415;857.7855536115972;688.3873352716087;698.7484505577988;822.4982760516081;833.1002517281322;834.6661335465801;610.2829175718557;611.4832966143601;612.0085461552269;612.2438788096697;612.265281662003;12045.096617753616;12092.818607720892;12117.454714537867;12119.454624541917;12120.636380908587;11132.61035863749;11541.249818761838;11752.941235293854;11766.294022358601;12016.399180041051;9538.475383853885;9577.856332155023;9643.421394716339;9699.757506062335;9706.805863882682;3439.3809114359406;3513.367593833109;3534.823258837048;3611.133328001287;3625.673689367943;45336.77331613321;45495.317570236475;45571.088578228584;45708.542914571095;45786.77106614479;8537.871931920901;8622.31021518277;8653.610587523577;8782.912170878337;9437.197838183694;15961.521154365388;16076.678466430605;16095.356185752438;16180.838191618168;16195.676086478205;6703.798886033427;6725.562838415487;6806.931930680729;6821.147356580427;6965.33829286217;3640.8179591020344;3693.538307711536;3693.8153092345274;3712.5730540987593;3730.0488375464083;2820.3795165063652;2891.161563146664;2891.233823036897;2892.6673432555103;2906.869190886373;552.4834279948261;563.7181409295353;566.6373520946597;568.2357229526281;570.5777724483852;552.7043031977872;554.1604469229121;568.9573282003867;571.5827445964469;582.7581553655185;7881.133075361706;7922.326602238759;7997.520148790974;8091.676332946734;8191.221833925768;501.46844344994423;544.1810075835841;562.3757629031771;606.6945606694543;718.5042320798736;3941.152652179795;3998.1603863189057;4003.159336539359;4087.1212689271947;4218.282891908383;51617.48382516202;53560.732196338766;53566.196507052424;53630;53931;48048.759756201;48890.26664600034;49394.75302623536;49415.752921235886;50108.74945625249;42101.789491052965;42609.147817043486;42970.78514607407;43969.78015109904;43994.78002610031;8019.398545109024;8098.959505202436;8110.4728192669645;8149.066336119111;8232.753017409488;32425.513617295288;33200.501992469646;33277.33445331128;33293.33413331768;33302.50046249357;39579;39791.40312895251;41797.79101104475;42366.36450453307;42752.358714618684;9498.95250523743;9708.514574271117;9775.560099795384;9889.208863291064;10131.240156988108;11395.886041139815;11539.36533490666;11626.418679066182;12774.105812593029;12903.870961290642;10583.894161058292;10860.837087443853;11053.723656908642;11081.778364432828;11581.305121692725;10617.946910265398;10916.508757106109;10962.451877406258;10986.725331866768;11340.829887551858;7462.664180112017;10695.358278503314;11110.277831940897;11128.272028870419;11379.203455758017;9157.404768690014;9203.60706216402;9219.354645174773;9269.860952085859;9509.334346595671;9135.908640913505;9193.218576421079;9208.493532855757;9281.39670921388;9625.374350667184 08:59:35 INFO - PROCESS | 5874 | __end_tp_report 08:59:35 INFO - PROCESS | 5874 | __start_cc_report 08:59:35 INFO - PROCESS | 5874 | _x_x_mozilla_cycle_collect,866 08:59:35 INFO - PROCESS | 5874 | __end_cc_report 08:59:35 INFO - PROCESS | 5874 | __startTimestamp1453741175275__endTimestamp 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | ------- Summary: start ------- 08:59:35 INFO - PROCESS | 5874 | Number of tests: 6 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | [#0] dojo.html Cycles:165 Average:5213.09 Median:5421.16 stddev:563.69 (10.4%) stddev-sans-first:542.53 08:59:35 INFO - PROCESS | 5874 | Values: 3185.8 3194.8 3232.9 3235.1 3264.7 5111.8 5196.3 5219.7 5248.0 5309.2 5241.4 5261.5 5269.9 5285.0 5324.4 4709.8 4753.1 4826.0 4898.6 4988.9 4884.8 4939.2 4989.2 4998.3 5010.0 4632.9 4732.6 4744.2 4797.9 4844.8 4774.2 4785.4 4787.8 4803.0 4838.1 4744.6 4781.4 4785.1 4799.6 4825.7 5016.9 5024.4 5065.1 5097.9 5105.9 5556.4 5574.8 5582.9 5583.0 5588.1 5544.4 5603.2 5609.4 5617.2 5626.3 5195.5 5218.2 5244.6 5247.2 5251.1 5693.7 5698.1 5699.4 5708.1 5730.2 5477.8 5505.7 5509.3 5513.8 5553.9 5551.3 5600.7 5606.6 5610.0 5643.5 5568.2 5601.0 5609.9 5617.9 5619.9 5463.2 5552.8 5600.1 5602.4 5609.9 4271.2 4287.5 4292.3 4294.9 4331.7 3862.0 3873.8 3875.1 3900.2 3901.4 5119.6 5156.2 5200.7 5216.0 5228.1 5549.6 5562.1 5565.9 5572.4 5576.8 5169.5 5184.7 5188.8 5190.1 5216.5 4705.8 4770.3 4778.0 4784.5 4850.6 5840.7 5854.8 5855.1 5863.3 5871.2 5521.3 5625.3 5629.9 5631.3 5637.3 5779.2 5867.5 5910.8 5921.9 5931.4 5563.8 5569.5 5570.6 5573.3 5576.7 5457.6 5592.8 5617.8 5637.1 5639.5 5508.0 5545.6 5550.6 5557.4 5591.8 5414.8 5426.1 5430.9 5431.2 5433.5 5254.6 5325.8 5358.8 5376.7 5386.6 5547.1 5548.2 5582.6 5594.8 5601.9 5387.3 5421.2 5422.3 5423.4 5467.2 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | [#1] ext.html Cycles:180 Average:46264.82 Median:20869.37 stddev:81951.16 (392.7%) stddev-sans-first:82109.11 08:59:35 INFO - PROCESS | 5874 | Values: 528.3 537.6 560.9 594.6 597.3 29072.7 29532.7 36260.3 36792.8 36865.0 39674.8 40017.0 40198.2 40271.6 40315.4 8449.9 8649.0 8649.9 8651.6 8656.8 8364.8 8476.1 8477.2 8488.7 8488.9 8631.7 8701.0 8710.3 8718.4 8720.3 8574.2 8576.5 8611.3 8654.0 8654.1 8472.2 8587.1 8607.0 8612.5 8612.7 39287.0 39766.2 39782.6 39892.8 39906.4 3370.0 3409.8 3470.8 3912.6 3980.6 30010.7 30058.7 30480.0 30659.2 30708.0 3879.3 3926.7 3969.4 3970.0 4030.8 210784.0 210838.0 211282.0 211534.0 211550.0 57774.0 58125.0 58252.7 58276.7 58296.0 60504.0 60630.0 60659.7 60711.7 60757.4 12721.3 12865.9 12866.9 12869.9 12872.5 9424.5 9455.2 9472.9 9480.9 9486.1 18569.2 19374.1 19397.0 19441.6 19540.8 6349.5 7443.8 7781.7 7812.8 7841.6 899.3 931.3 983.5 999.5 1056.1 27955.3 28356.9 28931.1 28979.0 29060.3 1008.8 1012.3 1020.3 1062.1 1091.7 13400.3 13540.5 13572.0 13601.2 13757.7 308568.0 311209.0 347907.0 351973.0 352515.0 43522.6 43532.6 43852.3 43878.0 43900.1 1164.5 1247.2 1324.3 1326.7 1334.6 26602.3 28757.4 28945.9 29123.6 29144.6 45428.0 47084.3 47185.3 47294.8 47298.5 269669.0 271146.0 406423.0 414222.0 427839.0 30857.7 30901.5 30918.4 31191.0 31390.5 42689.0 42919.0 43290.6 43935.0 44253.0 36087.9 36270.8 37233.0 37238.8 37859.4 34723.1 35866.1 36011.0 36505.5 37222.8 32023.4 32136.2 32173.4 32191.0 32221.2 29804.3 30297.7 31917.4 32267.0 32833.8 22887.5 22917.3 22965.7 24181.9 24717.5 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | [#2] jquery.html Cycles:180 Average:27482.04 Median:5066.72 stddev:90097.84 (1778.2%) stddev-sans-first:90327.58 08:59:35 INFO - PROCESS | 5874 | Values: 367.0 367.3 367.9 369.1 371.0 13386.5 13495.9 15439.2 16973.7 17845.4 15466.7 15690.1 15757.8 15780.4 16659.4 5328.4 5493.5 5501.0 5501.3 5502.9 3976.6 4069.9 5362.8 5590.6 5821.7 5595.3 5714.0 5749.6 5786.7 5787.7 5606.7 5859.5 5878.5 5890.1 5891.6 4912.8 5066.4 5067.0 5106.9 5194.5 12570.2 13578.9 18952.7 19733.2 19778.3 2056.5 2097.0 2157.2 2215.7 2225.1 9681.2 9698.1 10046.3 11597.9 11956.0 1768.6 1810.8 1859.4 1867.4 1896.1 54844.7 56538.4 57075.0 57773.4 58514.0 10061.7 10124.7 10163.8 10236.6 10271.3 13210.7 13282.8 13336.1 13348.6 13373.8 6868.5 6884.5 6910.2 6951.1 6955.8 6403.1 6414.6 6440.9 6446.2 6458.4 4087.4 4432.3 4469.3 4508.7 4523.5 1720.8 1756.5 1761.4 1781.5 1869.2 891.9 919.5 932.7 934.0 1022.4 15772.0 16238.5 16522.7 16700.2 16734.8 863.4 912.7 931.3 935.1 950.2 9241.8 9493.5 9517.5 9526.0 9693.3 527956.0 552248.0 552987.0 559158.0 565836.0 66256.5 68667.7 69157.7 70546.0 71387.6 1109.5 1144.9 1147.0 1150.2 1150.4 14740.9 14898.3 14941.5 15157.2 15167.5 32060.5 32642.8 33253.5 33326.8 33528.8 39077.8 39603.8 40574.0 40613.6 41063.4 3038.5 6580.5 6996.9 7248.0 7387.7 7434.6 10282.4 10836.6 11174.7 11472.3 7758.7 8602.7 8999.1 9116.6 9496.7 9090.4 9209.5 9497.2 9713.5 9940.3 8227.3 9026.7 9361.2 10373.3 10598.5 7165.7 7233.7 7275.3 7305.3 7360.2 9429.2 9701.7 9752.5 9845.2 10008.3 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | [#3] mootools.html Cycles:180 Average:5541.03 Median:6618.15 stddev:2964.81 (44.8%) stddev-sans-first:2956.52 08:59:35 INFO - PROCESS | 5874 | Values: 1366.3 1468.2 1472.2 1618.0 1763.6 6738.8 7643.8 7860.7 7865.3 7868.2 7774.2 7964.6 7977.8 7978.8 7988.1 1981.6 2031.3 2207.3 2251.6 2276.3 2250.9 2264.3 2265.1 2265.3 2268.8 2217.8 2320.4 2321.6 2325.6 2326.9 1973.8 2027.9 2244.2 2296.6 2301.5 2220.7 2221.8 2255.1 2261.8 2281.6 7850.4 7907.2 7909.9 7910.4 7921.5 4531.3 4662.5 4680.8 4682.7 4692.6 3029.6 3040.4 3089.4 3100.1 3202.4 954.9 966.7 971.9 1021.5 1065.3 10923.9 10952.3 11015.8 11057.0 11071.0 4032.4 4154.2 4174.2 4183.7 4211.2 8875.7 9163.9 9168.9 9171.4 9194.6 4652.8 4685.4 4695.2 4695.3 4695.9 4267.3 4304.2 4305.2 4306.9 4312.0 3534.1 3573.6 3625.4 3628.2 3628.5 1062.2 1079.6 1084.5 1093.9 1103.4 1068.2 1109.3 1110.8 1271.3 1367.2 7584.8 7705.6 7728.0 7752.2 7767.8 437.7 443.6 443.6 444.0 454.9 5860.6 6021.7 6022.1 6024.5 6031.6 9302.8 9486.7 9505.1 9548.3 9601.3 9415.1 9424.8 9544.9 9549.8 9553.0 7263.1 7393.8 7430.2 7463.6 7502.4 7369.2 7385.7 7464.0 7471.9 7472.1 8790.0 8881.6 8952.8 9030.1 9044.7 9031.0 9067.0 9136.3 9184.4 9236.3 7272.7 7348.3 7369.3 7378.7 7379.2 7214.7 7333.8 7760.8 7838.7 7847.8 7045.5 7174.7 7230.7 7282.1 7292.8 6066.3 6935.8 7026.4 7152.3 7156.7 7063.1 7135.1 7160.6 7188.9 7191.9 6501.5 6615.4 6615.7 6620.6 6622.6 6653.0 6713.2 6715.5 6719.7 6726.9 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | [#4] prototype.html Cycles:180 Average:5187.19 Median:5858.02 stddev:1556.65 (26.6%) stddev-sans-first:1517.57 08:59:35 INFO - PROCESS | 5874 | Values: 321.3 324.9 331.6 333.6 337.3 5641.0 5760.9 5845.7 5849.7 5861.3 5541.9 5687.9 5703.1 5743.1 5763.7 4483.5 4517.1 4517.4 4518.3 4524.9 4258.4 4357.8 4406.6 4510.6 4526.0 4416.0 4431.4 4436.7 4448.4 4460.6 4421.8 4422.1 4424.6 4424.9 4479.5 3933.6 3935.9 3944.8 3947.9 3948.4 5364.1 5541.1 5547.0 5553.9 5559.5 5189.6 5207.5 5216.8 5218.7 5224.4 6178.3 6184.2 6190.6 6196.8 6206.3 4179.3 4259.7 4261.8 4332.6 4357.1 6325.2 6383.6 6386.7 6398.6 6404.4 4454.8 4457.1 4462.8 4463.5 4465.2 4381.6 4520.8 4522.9 4524.5 4528.7 5138.5 5197.4 5200.1 5202.5 5203.0 6198.5 6200.1 6202.6 6209.1 6210.4 1591.4 1606.3 1607.1 1607.7 1607.9 1086.1 1086.2 1109.9 1112.4 1115.9 5857.7 5875.3 5875.6 5877.3 5878.9 6349.5 6357.1 6361.1 6366.5 6368.4 5852.0 5858.3 5860.4 5861.2 5861.7 3333.3 3431.9 3438.6 3438.9 3442.1 6624.3 6652.0 6685.6 6691.3 6697.3 6560.3 6572.7 6576.5 6583.4 6588.2 6539.7 6669.6 6673.2 6674.3 6677.8 6150.0 6410.0 6412.4 6419.6 6420.3 6218.2 6257.2 6349.6 6357.5 6368.7 6634.3 6651.9 6658.2 6658.5 6664.1 4356.0 4397.3 4402.5 4405.5 4409.3 6247.8 6414.5 6427.7 6428.4 6428.8 6226.5 6271.3 6282.0 6282.6 6286.6 6172.4 6242.3 6249.4 6256.6 6264.7 6063.7 6139.4 6145.9 6147.0 6155.7 6268.9 6271.3 6276.9 6278.5 6282.4 6125.9 6133.0 6134.8 6138.3 6151.0 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - PROCESS | 5874 | [#5] yui.html Cycles:180 Average:12898.35 Median:50863.12 stddev:14960.35 (29.4%) stddev-sans-first:14974.18 08:59:35 INFO - PROCESS | 5874 | Values: 680.5 742.3 745.5 749.6 771.4 12526.4 12704.4 12707.9 12719.2 12777.4 11486.3 11756.3 11788.2 11825.3 11869.6 664.4 672.9 784.0 801.0 801.5 803.7 808.6 811.9 812.0 812.4 852.0 854.2 856.8 857.6 857.8 688.4 698.7 822.5 833.1 834.7 610.3 611.5 612.0 612.2 612.3 12045.1 12092.8 12117.5 12119.5 12120.6 11132.6 11541.2 11752.9 11766.3 12016.4 9538.5 9577.9 9643.4 9699.8 9706.8 3439.4 3513.4 3534.8 3611.1 3625.7 45336.8 45495.3 45571.1 45708.5 45786.8 8537.9 8622.3 8653.6 8782.9 9437.2 15961.5 16076.7 16095.4 16180.8 16195.7 6703.8 6725.6 6806.9 6821.1 6965.3 3640.8 3693.5 3693.8 3712.6 3730.0 2820.4 2891.2 2891.2 2892.7 2906.9 552.5 563.7 566.6 568.2 570.6 552.7 554.2 569.0 571.6 582.8 7881.1 7922.3 7997.5 8091.7 8191.2 501.5 544.2 562.4 606.7 718.5 3941.2 3998.2 4003.2 4087.1 4218.3 51617.5 53560.7 53566.2 53630.0 53931.0 48048.8 48890.3 49394.8 49415.8 50108.7 42101.8 42609.1 42970.8 43969.8 43994.8 8019.4 8099.0 8110.5 8149.1 8232.8 32425.5 33200.5 33277.3 33293.3 33302.5 39579.0 39791.4 41797.8 42366.4 42752.4 9499.0 9708.5 9775.6 9889.2 10131.2 11395.9 11539.4 11626.4 12774.1 12903.9 10583.9 10860.8 11053.7 11081.8 11581.3 10617.9 10916.5 10962.5 10986.7 11340.8 7462.7 10695.4 11110.3 11128.3 11379.2 9157.4 9203.6 9219.4 9269.9 9509.3 9135.9 9193.2 9208.5 9281.4 9625.4 08:59:35 INFO - PROCESS | 5874 | -------- Summary: end -------- 08:59:35 INFO - PROCESS | 5874 | 08:59:35 INFO - TEST-INFO | 5874: exit 0 08:59:35 INFO - TEST-OK | dromaeo_css | took 1112891ms 08:59:35 INFO - TEST-START | kraken 08:59:35 INFO - operating with platform_type : linux_ 08:59:35 INFO - Initialising browser for kraken test... 08:59:35 INFO - TEST-INFO | started process 6075 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx8JFag/profile http://localhost:33262/getInfo.html) 08:59:39 INFO - PROCESS | 6075 | __metrics Screen width/height:1600/1200 08:59:39 INFO - PROCESS | 6075 | colorDepth:24 08:59:39 INFO - PROCESS | 6075 | Browser inner width/height: 1024/697 08:59:39 INFO - PROCESS | 6075 | __metrics 08:59:40 INFO - PROCESS | 6075 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:59:40 INFO - PROCESS | 6075 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:41 INFO - TEST-INFO | 6075: exit 0 08:59:41 INFO - Browser initialized. 08:59:41 INFO - Running cycle 1/1 for kraken test... 08:59:41 INFO - TEST-INFO | started process 6162 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx8JFag/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:53 INFO - PROCESS | 6162 | RSS: Main: 148414464 08:59:53 INFO - PROCESS | 6162 | 08:59:55 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-beat-detection) 08:59:56 INFO - PROCESS | 6162 | RSS: Main: 187711488 08:59:56 INFO - PROCESS | 6162 | 08:59:58 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-dft) 08:59:59 INFO - PROCESS | 6162 | RSS: Main: 179253248 08:59:59 INFO - PROCESS | 6162 | 09:00:02 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-fft) 09:00:02 INFO - PROCESS | 6162 | RSS: Main: 164241408 09:00:02 INFO - PROCESS | 6162 | 09:00:04 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-oscillator) 09:00:05 INFO - PROCESS | 6162 | RSS: Main: 167006208 09:00:05 INFO - PROCESS | 6162 | 09:00:07 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:08 INFO - PROCESS | 6162 | RSS: Main: 167591936 09:00:08 INFO - PROCESS | 6162 | 09:00:11 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33262/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:11 INFO - PROCESS | 6162 | RSS: Main: 166793216 09:00:11 INFO - PROCESS | 6162 | 09:00:15 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33262/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:15 INFO - PROCESS | 6162 | RSS: Main: 169230336 09:00:15 INFO - PROCESS | 6162 | 09:00:18 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33262/tests/kraken/driver.html?testName=json-parse-financial) 09:00:19 INFO - PROCESS | 6162 | RSS: Main: 167526400 09:00:19 INFO - PROCESS | 6162 | 09:00:20 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:21 INFO - PROCESS | 6162 | RSS: Main: 181886976 09:00:21 INFO - PROCESS | 6162 | 09:00:22 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:23 INFO - PROCESS | 6162 | RSS: Main: 177582080 09:00:23 INFO - PROCESS | 6162 | 09:00:25 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:26 INFO - PROCESS | 6162 | RSS: Main: 186245120 09:00:26 INFO - PROCESS | 6162 | 09:00:28 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:29 INFO - PROCESS | 6162 | RSS: Main: 196292608 09:00:29 INFO - PROCESS | 6162 | 09:00:31 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:32 INFO - PROCESS | 6162 | RSS: Main: 195358720 09:00:32 INFO - PROCESS | 6162 | 09:00:33 INFO - PROCESS | 6162 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33262/tests/kraken/driver.html?testName=ai-astar) 09:00:34 INFO - PROCESS | 6162 | RSS: Main: 255229952 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | __start_tp_report 09:00:34 INFO - PROCESS | 6162 | _x_x_mozilla_page_load 09:00:34 INFO - PROCESS | 6162 | _x_x_mozilla_page_load_details 09:00:34 INFO - PROCESS | 6162 | |i|pagename|runs| 09:00:34 INFO - PROCESS | 6162 | |0;ai-astar;112;112;108;111;111;112;112;110;103;109 09:00:34 INFO - PROCESS | 6162 | |1;audio-beat-detection;152;124;159;166;128;154;151;132;163;126 09:00:34 INFO - PROCESS | 6162 | |2;audio-dft;162;161;160;161;162;163;161;161;162;162 09:00:34 INFO - PROCESS | 6162 | |3;audio-fft;76;74;97;98;72;73;74;115;106;73 09:00:34 INFO - PROCESS | 6162 | |4;audio-oscillator;97;97;141;97;98;97;143;96;97;141 09:00:34 INFO - PROCESS | 6162 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;108 09:00:34 INFO - PROCESS | 6162 | |6;imaging-darkroom;145;145;146;145;145;144;147;146;147;146 09:00:34 INFO - PROCESS | 6162 | |7;imaging-desaturate;96;97;96;96;96;96;98;96;96;96 09:00:34 INFO - PROCESS | 6162 | |8;json-parse-financial;55;57;56;55;54;56;56;55;58;53 09:00:34 INFO - PROCESS | 6162 | |9;json-stringify-tinderbox;66;66;67;67;67;66;66;67;66;66 09:00:34 INFO - PROCESS | 6162 | |10;stanford-crypto-aes;81;82;82;82;82;83;83;83;91;83 09:00:34 INFO - PROCESS | 6162 | |11;stanford-crypto-ccm;119;115;121;114;111;124;122;121;122;115 09:00:34 INFO - PROCESS | 6162 | |12;stanford-crypto-pbkdf2;139;141;143;140;139;132;141;140;139;141 09:00:34 INFO - PROCESS | 6162 | |13;stanford-crypto-sha256-iterative;66;65;67;67;67;66;66;67;66;65 09:00:34 INFO - PROCESS | 6162 | __end_tp_report 09:00:34 INFO - PROCESS | 6162 | __start_cc_report 09:00:34 INFO - PROCESS | 6162 | _x_x_mozilla_cycle_collect,914 09:00:34 INFO - PROCESS | 6162 | __end_cc_report 09:00:34 INFO - PROCESS | 6162 | __startTimestamp1453741234182__endTimestamp 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | ------- Summary: start ------- 09:00:34 INFO - PROCESS | 6162 | Number of tests: 14 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:2.83 (2.5%) stddev-sans-first:2.91 09:00:34 INFO - PROCESS | 6162 | Values: 112.0 112.0 108.0 111.0 111.0 112.0 112.0 110.0 103.0 109.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:153.00 stddev:16.28 (10.6%) stddev-sans-first:17.09 09:00:34 INFO - PROCESS | 6162 | Values: 152.0 124.0 159.0 166.0 128.0 154.0 151.0 132.0 163.0 126.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 09:00:34 INFO - PROCESS | 6162 | Values: 162.0 161.0 160.0 161.0 162.0 163.0 161.0 161.0 162.0 162.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#3] audio-fft Cycles:10 Average:85.80 Median:74.00 stddev:16.42 (22.2%) stddev-sans-first:17.03 09:00:34 INFO - PROCESS | 6162 | Values: 76.0 74.0 97.0 98.0 72.0 73.0 74.0 115.0 106.0 73.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:97.00 stddev:21.59 (22.3%) stddev-sans-first:22.35 09:00:34 INFO - PROCESS | 6162 | Values: 97.0 97.0 141.0 97.0 98.0 97.0 143.0 96.0 97.0 141.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:00:34 INFO - PROCESS | 6162 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 09:00:34 INFO - PROCESS | 6162 | Values: 145.0 145.0 146.0 145.0 145.0 144.0 147.0 146.0 147.0 146.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:00:34 INFO - PROCESS | 6162 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 09:00:34 INFO - PROCESS | 6162 | Values: 55.0 57.0 56.0 55.0 54.0 56.0 56.0 55.0 58.0 53.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:00:34 INFO - PROCESS | 6162 | Values: 66.0 66.0 67.0 67.0 67.0 66.0 66.0 67.0 66.0 66.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.82 (3.4%) stddev-sans-first:2.88 09:00:34 INFO - PROCESS | 6162 | Values: 81.0 82.0 82.0 82.0 82.0 83.0 83.0 83.0 91.0 83.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:121.00 stddev:4.33 (3.6%) stddev-sans-first:4.58 09:00:34 INFO - PROCESS | 6162 | Values: 119.0 115.0 121.0 114.0 111.0 124.0 122.0 121.0 122.0 115.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.50 Median:140.50 stddev:2.92 (2.1%) stddev-sans-first:3.09 09:00:34 INFO - PROCESS | 6162 | Values: 139.0 141.0 143.0 140.0 139.0 132.0 141.0 140.0 139.0 141.0 09:00:34 INFO - PROCESS | 6162 | 09:00:34 INFO - PROCESS | 6162 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 09:00:34 INFO - PROCESS | 6162 | Values: 66.0 65.0 67.0 67.0 67.0 66.0 66.0 67.0 66.0 65.0 09:00:34 INFO - PROCESS | 6162 | -------- Summary: end -------- 09:00:34 INFO - PROCESS | 6162 | 09:00:35 INFO - TEST-INFO | 6162: exit 0 09:00:35 INFO - TEST-OK | kraken | took 59201ms 09:00:35 INFO - TEST-START | v8_7 09:00:35 INFO - operating with platform_type : linux_ 09:00:35 INFO - Initialising browser for v8_7 test... 09:00:35 INFO - TEST-INFO | started process 6410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi6hNvB/profile http://localhost:33262/getInfo.html) 09:00:39 INFO - PROCESS | 6410 | __metrics Screen width/height:1600/1200 09:00:39 INFO - PROCESS | 6410 | colorDepth:24 09:00:39 INFO - PROCESS | 6410 | Browser inner width/height: 1024/697 09:00:39 INFO - PROCESS | 6410 | __metrics 09:00:39 INFO - PROCESS | 6410 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:00:39 INFO - PROCESS | 6410 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:40 INFO - TEST-INFO | 6410: exit 0 09:00:40 INFO - Browser initialized. 09:00:40 INFO - Running cycle 1/1 for v8_7 test... 09:00:40 INFO - TEST-INFO | started process 6492 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi6hNvB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:52 INFO - PROCESS | 6492 | RSS: Main: 148918272 09:00:52 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | Cycle 1(1): loaded http://localhost:33262/tests/v8_7/run.html (next: http://localhost:33262/tests/v8_7/run.html) 09:01:14 INFO - PROCESS | 6492 | RSS: Main: 586874880 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | __start_tp_report 09:01:14 INFO - PROCESS | 6492 | _x_x_mozilla_page_load 09:01:14 INFO - PROCESS | 6492 | _x_x_mozilla_page_load_details 09:01:14 INFO - PROCESS | 6492 | |i|pagename|runs| 09:01:14 INFO - PROCESS | 6492 | |0;Richards;167.95431642593215 09:01:14 INFO - PROCESS | 6492 | |1;DeltaBlue;189.78933383943823 09:01:14 INFO - PROCESS | 6492 | |2;Encrypt;279.4076557697681 09:01:14 INFO - PROCESS | 6492 | |3;Decrypt;5240.837696335078 09:01:14 INFO - PROCESS | 6492 | |4;RayTrace;1112.3470522803113 09:01:14 INFO - PROCESS | 6492 | |5;Earley;813.8211382113822 09:01:14 INFO - PROCESS | 6492 | |6;Boyer;12670.886075949367 09:01:14 INFO - PROCESS | 6492 | |7;RegExp;42687.5 09:01:14 INFO - PROCESS | 6492 | |8;Splay;579.7101449275362 09:01:14 INFO - PROCESS | 6492 | |9;NavierStokes;4817.307692307692 09:01:14 INFO - PROCESS | 6492 | __end_tp_report 09:01:14 INFO - PROCESS | 6492 | __startTimestamp1453741274828__endTimestamp 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | ------- Summary: start ------- 09:01:14 INFO - PROCESS | 6492 | Number of tests: 10 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 168.0 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#1] DeltaBlue Cycles:1 Average:189.79 Median:189.79 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 189.8 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 279.4 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 5240.8 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 1112.3 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#5] Earley Cycles:1 Average:813.82 Median:813.82 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 813.8 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#6] Boyer Cycles:1 Average:12670.89 Median:12670.89 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 12670.9 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#7] RegExp Cycles:1 Average:42687.50 Median:42687.50 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 42687.5 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#8] Splay Cycles:1 Average:579.71 Median:579.71 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 579.7 09:01:14 INFO - PROCESS | 6492 | 09:01:14 INFO - PROCESS | 6492 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 09:01:14 INFO - PROCESS | 6492 | Values: 4817.3 09:01:14 INFO - PROCESS | 6492 | -------- Summary: end -------- 09:01:14 INFO - PROCESS | 6492 | 09:01:15 INFO - TEST-INFO | 6492: exit 0 09:01:15 INFO - TEST-OK | v8_7 | took 40599ms 09:01:15 INFO - SUITE-END | took 1212s 09:01:15 INFO - Completed test suite (00:20:12) 09:01:15 INFO - Working with test: dromaeo_css 09:01:15 INFO - Generating results file: dromaeo_css 09:01:15 INFO - Working with test: kraken 09:01:15 INFO - Generating results file: kraken 09:01:15 INFO - javascript benchmark 09:01:15 INFO - Working with test: v8_7 09:01:15 INFO - Generating results file: v8_7 09:01:15 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:01:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 09:01:15 INFO - process_Request line: dromaeo_css 6701.09 graph.html#tests=[[72,1,35]] 09:01:15 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:01:15 INFO - process_Request line: kraken 1493.20 graph.html#tests=[[232,1,35]] 09:01:15 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:01:15 INFO - process_Request line: v8_7 19936.77 graph.html#tests=[[230,1,35]] 09:01:16 INFO - RETURN: dromaeo_css: 6701.09 09:01:16 INFO - RETURN: kraken: 1493.20 09:01:16 INFO - RETURN: v8_7: 19936.77 09:01:16 INFO - javascript benchmark 09:01:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3185.8407079646017, 3194.760392970528, 3232.886848960287, 3235.0941736313825, 3264.738820894329, 5111.7699703513335, 5196.272521846944, 5219.739013049351, 5248.029114613794, 5309.203619457084, 5241.449647786984, 5261.473852614737, 5269.8946021079555, 5285.048691235576, 5324.41431442541, 4709.788059537312, 4753.073150735608, 4826.034793041388, 4898.583620392253, 4988.850334489953, 4884.780184891671, 4939.185034469308, 4989.226669866159, 4998.2752500887345, 5010.0, 4632.884177895546, 4732.645051621108, 4744.217204161309, 4797.944452220506, 4844.757762111915, 4774.188387974053, 4785.353977213066, 4787.784549695272, 4802.967362017148, 4838.056578967103, 4744.620430365597, 4781.42622885256, 4785.066911952171, 4799.616030717569, 4825.710457372569, 5016.899662006739, 5024.447310795809, 5065.113605119126, 5097.898042039175, 5105.872353191163, 5556.444355564452, 5574.777008919638, 5582.86042848932, 5582.972085139589, 5588.133839254922, 5544.362398324204, 5603.215549823028, 5609.439056094398, 5617.157426386034, 5626.324841019104, 5195.506426889439, 5218.243354713545, 5244.6328756987405, 5247.16045432729, 5251.133562962106, 5693.715314234271, 5698.116791897262, 5699.401562835926, 5708.086706127, 5730.226419433407, 5477.835664930059, 5505.724713764296, 5509.256250406224, 5513.7794488220825, 5553.944460555424, 5551.306086739158, 5600.747966341524, 5606.55147588192, 5610.046292130348, 5643.492085712305, 5568.192612071227, 5601.0, 5609.934112518608, 5617.915731264035, 5619.8595035124445, 5463.207834864002, 5552.750126244328, 5600.103983362643, 5602.38373778884, 5609.887802243932, 4271.23117838792, 4287.485501739811, 4292.291771857671, 4294.892627684333, 4331.675124365685, 3862.0, 3873.7869417182324, 3875.0893540018074, 3900.1809619979554, 3901.356276214393, 5119.641625086283, 5156.20078887773, 5200.7139607321205, 5216.035033518811, 5228.05894938907, 5549.556035517149, 5562.082256427725, 5565.9443405566235, 5572.359178694421, 5576.832695019156, 5169.53474187325, 5184.662996905189, 5188.792448302026, 5190.11767999441, 5216.478352164753, 4705.788239529229, 4770.260609605517, 4778.020505796303, 4784.473707892129, 4850.563449289581, 5840.737166827503, 5854.765809367577, 5855.063189889683, 5863.296404431496, 5871.2073870027, 5521.254630624814, 5625.268715067015, 5629.943700563106, 5631.267935168402, 5637.267155269788, 5779.219805326227, 5867.530597552271, 5910.7931222407005, 5921.911171332519, 5931.377205393372, 5563.831595364857, 5569.470900264469, 5570.637908535932, 5573.303337082864, 5576.665400075846, 5457.645253058538, 5592.804251851328, 5617.831465056055, 5637.069883469346, 5639.464250896158, 5507.981023510663, 5545.584081194007, 5550.611457198119, 5557.44425557441, 5591.804286849941, 5414.756335964812, 5426.104692725656, 5430.945690543202, 5431.239626452379, 5433.510984011458, 5254.579633629224, 5325.840224793263, 5358.812441564526, 5376.704281264411, 5386.569074473954, 5547.11246200606, 5548.195511650869, 5582.581306401955, 5594.832155035356, 5601.859953501032, 5387.272718182995, 5421.159720243369, 5422.322209723785, 5423.430539793265, 5467.207254947931], "unit": "score", "name": "dojo.html", "value": 5177.796893381034}, {"lowerIsBetter": false, "replicates": [528.2577977940995, 537.6424677589404, 560.9467100625442, 594.5867622002708, 597.3071237364658, 29072.709272907265, 29532.704672953263, 36260.2747945041, 36792.81603591979, 36865.0, 39674.8016259919, 40017.0, 40198.19603607926, 40271.59728402715, 40315.39526907091, 8449.915500844989, 8649.0, 8649.870251946226, 8651.610677519528, 8656.826863462727, 8364.790880227982, 8476.110008449086, 8477.152284771504, 8488.702895398663, 8488.915110848875, 8631.65473381064, 8701.0, 8710.259627931602, 8718.389712720113, 8720.258778003878, 8574.185452382013, 8576.485410875368, 8611.26804221642, 8654.048054713976, 8654.134586541328, 8472.15278472154, 8587.098354672795, 8607.0, 8612.52631105289, 8612.674577863942, 39287.0, 39766.21052052636, 39782.60217397818, 39892.80053599743, 39906.40140397896, 3369.983150084234, 3409.7783644063056, 3470.7917524948584, 3912.628300311466, 3980.6019398060253, 30010.699893001227, 30058.699413006027, 30480.0, 30659.233519161975, 30708.0, 3879.301725689375, 3926.7447615904875, 3969.4244334571326, 3970.0, 4030.7984600769846, 210784.0, 210838.0, 211282.0, 211534.0, 211550.0, 57774.0, 58125.0, 58252.70873645604, 58276.708616457494, 58296.0, 60504.0, 60630.0, 60659.69670151621, 60711.69644151751, 60757.392426075174, 12721.300328482022, 12865.871341286655, 12866.871331286755, 12869.935650321875, 12872.485100596059, 9424.528773561295, 9455.243580513543, 9472.857907131398, 9480.857787133198, 9486.146246837818, 18569.214120674842, 19374.128164232643, 19397.0, 19441.61116777685, 19540.804591954184, 6349.523785715997, 7443.776686699408, 7781.688732450752, 7812.765617031499, 7841.5687137208, 899.2581120575551, 931.3247895276006, 983.4689267795453, 999.5352161245056, 1056.1339701444742, 27955.301117472227, 28356.858215708788, 28931.132066037633, 28979.0, 29060.27349316284, 1008.8284991551454, 1012.3217444312181, 1020.3214862116757, 1062.129054175584, 1091.7106966653844, 13400.32998350098, 13540.458381664623, 13572.0, 13601.183928964294, 13757.656058598415, 308568.0, 311209.0, 347907.0, 351973.0, 352515.0, 43522.56477435248, 43532.56467435348, 43852.34221486616, 43878.0, 43900.121997560505, 1164.5341863254596, 1247.1955588645455, 1324.3047400115017, 1326.7412854493475, 1334.5729366602593, 26602.334941626614, 28757.424851502434, 28945.85527072351, 29123.563146552395, 29144.562831557967, 45428.0, 47084.29373559468, 47185.29222061603, 47294.76352618215, 47298.527014729414, 269669.0, 271146.0, 406423.0, 414222.00445968495, 427839.0, 30857.69142308548, 30901.53647695331, 30918.381632367677, 31191.0, 31390.529142063344, 42689.0, 42919.0, 43290.56709432991, 43935.0, 44253.0, 36087.88895728693, 36270.8186459066, 37233.0, 37238.8138059308, 37859.432108517845, 34723.13192170216, 35866.10334741652, 36011.0, 36505.45241821428, 37222.813885930394, 32023.359532809678, 32136.19659508531, 32173.35653286968, 32191.0, 32221.194470138435, 29804.254893627833, 30297.69702303037, 31917.36165276635, 32267.0, 32833.835830820695, 22887.542249155256, 22917.31248062561, 22965.65551516762, 24181.879090604434, 24717.50564988654], "unit": "score", "name": "ext.html", "value": 17878.02850526982}, {"lowerIsBetter": false, "replicates": [366.95596528416587, 367.280130943351, 367.889633110067, 369.1030795167743, 370.9944350834736, 13386.464541418356, 13495.865041349583, 15439.150846703427, 16973.74539381909, 17845.375411860587, 15466.690666186669, 15690.05859648419, 15757.763633545477, 15780.368785248605, 16659.416920407788, 5328.440513746059, 5493.533049690781, 5501.0, 5501.284832971708, 5502.9174562381595, 3976.562578116405, 4069.8779036628803, 5362.785488580472, 5590.552755779528, 5821.6507009579345, 5595.328560572737, 5713.971430142843, 5749.626274292157, 5786.68173250471, 5787.710614469281, 5606.719664016803, 5859.53123750099, 5878.5297176225795, 5890.116482527634, 5891.617044892068, 4912.77892494835, 5066.442691303953, 5067.0, 5106.923396149061, 5194.454582268845, 12570.182938109085, 13578.864211357957, 18952.715709264372, 19733.21067157312, 19778.30775922836, 2056.5475595368994, 2096.9790302096935, 2157.169489746459, 2215.678726584636, 2225.1321984425927, 9681.177099946513, 9698.078682525149, 10046.296759226858, 11597.942010289895, 11956.0, 1768.5578605348662, 1810.8008119106887, 1859.4328729737424, 1867.3557622620174, 1896.0993528074193, 54844.72577637126, 56538.43461565373, 57075.0, 57773.422265777226, 58514.0, 10061.748456288651, 10124.69625911224, 10163.796724065478, 10236.641717539851, 10271.281010329205, 13210.669733256746, 13282.800757988638, 13336.133151345131, 13348.599542013755, 13373.799393009112, 6868.519203655696, 6884.483663725241, 6910.239873613898, 6951.131108611424, 6955.826104347432, 6403.135576697179, 6414.583052101599, 6440.935590644127, 6446.161998940108, 6458.38645328693, 4087.3664581989838, 4432.268675668479, 4469.262571675702, 4508.661850361236, 4523.5024147343765, 1720.7935047794344, 1756.5081777102432, 1761.4451447793904, 1781.518989872753, 1869.2149297295168, 891.8528442806994, 919.5494207838245, 932.6968735160964, 933.9953300233591, 1022.3916769522123, 15772.0, 16238.512844614681, 16522.669546609002, 16700.164991750607, 16734.832651673572, 863.4387648028707, 912.6668765900398, 931.3061768982152, 935.0836180543106, 950.2160717408166, 9241.815163696689, 9493.477858717837, 9517.524123793783, 9525.999770024047, 9693.321467497348, 527956.0, 552248.0, 552987.0, 559158.0, 565836.0, 66256.46221003843, 68667.65666171638, 69157.65421172862, 70546.0, 71387.64306178436, 1109.4563663804677, 1144.9313041217554, 1147.042219746521, 1150.1603829204728, 1150.3787954504642, 14740.852591473948, 14898.329575168927, 14941.477048303257, 15157.242137893281, 15167.544973650809, 32060.5190922141, 32642.836785815918, 33253.50119748157, 33326.833365833016, 33528.832355838065, 39077.80461097676, 39603.80198098991, 40574.0, 40613.59386406216, 41063.38404923988, 3038.529028000575, 6580.473562115115, 6996.895046574204, 7248.0, 7387.741429049957, 7434.597102255375, 10282.434466104436, 10836.620718274822, 11174.66476005721, 11472.31166130035, 7758.650860711395, 8602.655893764178, 8999.055099214489, 9116.635334586543, 9496.715098547054, 9090.36367454272, 9209.493477858781, 9497.19273861702, 9713.465759383302, 9940.254480914105, 8227.341812654853, 9026.729198124067, 9361.157495825408, 10373.32573382758, 10598.523066461874, 7165.713371465083, 7233.710651573878, 7275.308845659654, 7305.3425191732995, 7360.227176146642, 9429.15137637616, 9701.6604418845, 9752.512374381395, 9845.212383009486, 10008.299419040597], "unit": "score", "name": "jquery.html", "value": 8004.954253231505}, {"lowerIsBetter": false, "replicates": [1366.344154805694, 1468.1704836767226, 1472.2491529320048, 1617.9676406471872, 1763.6472705458912, 6738.764143254987, 7643.808904777384, 7860.68557257709, 7865.292123708865, 7868.17384174662, 7774.183710710378, 7964.641591128398, 7977.760667179994, 7978.760637180894, 7988.081370642378, 1981.6036792641457, 2031.3296612117965, 2207.304699019812, 2251.5609456156058, 2276.2829708641807, 2250.8536945098517, 2264.2527965771337, 2265.0939624150305, 2265.343050515357, 2268.750437451879, 2217.789310015546, 2320.3619004773655, 2321.5705094557475, 2325.6278995360744, 2326.8720220387872, 1973.842092632586, 2027.8681885677458, 2244.2145249162663, 2296.644020176875, 2301.528186721718, 2220.6891035255076, 2221.8111460525874, 2255.064148378421, 2261.7738226177253, 2281.555096756133, 7850.411219158586, 7907.209279072104, 7909.920900790976, 7910.4462687611895, 7921.485103468256, 4531.252343363374, 4662.487126416091, 4680.789364478606, 4682.672212945095, 4692.6245900327895, 3029.606151200352, 3040.4223197592387, 3089.3780765098277, 3100.0544833825675, 3202.4235637585225, 954.9092836180552, 966.6616684160558, 971.8736564246602, 1021.4790456867051, 1065.3075500924383, 10923.945380273128, 10952.28810127347, 11015.779684406267, 11057.0, 11071.0, 4032.3749818778138, 4154.231467178582, 4174.248635245624, 4183.748975061506, 4211.178820130045, 8875.689350872688, 9163.862542061874, 9168.862467063, 9171.358004939724, 9194.586243619053, 4652.813887444464, 4685.367475390779, 4695.154872122982, 4695.272232803921, 4695.929561056587, 4267.317229243306, 4304.203722311382, 4305.160493703697, 4306.913861722748, 4312.029793296546, 3534.081138903852, 3573.6426357364057, 3625.4380571011534, 3628.219932714479, 3628.4920111184456, 1062.2351906627216, 1079.6005477973042, 1084.511969613677, 1093.9343639381664, 1103.3986477369854, 1068.1668298727006, 1109.2623405435456, 1110.783397237547, 1271.2563150556844, 1367.1660287224786, 7584.810379740551, 7705.576193309422, 7727.961360193163, 7752.224777522202, 7767.834824776216, 437.6783064447628, 443.56309035599907, 443.5763845527578, 444.0, 454.9226631472658, 5860.560457965669, 6021.668808215591, 6022.09668549721, 6024.518038556905, 6031.638101713911, 9302.813943721088, 9486.715398538056, 9505.144536991704, 9548.331616786758, 9601.32790704644, 9415.105564971316, 9424.811503770023, 9544.856827147598, 9549.809003819884, 9553.0, 7263.0921134858145, 7393.8151546211775, 7430.182679905206, 7463.5521868686965, 7502.3622992046285, 7369.152547457111, 7385.667644956097, 7463.962680186564, 7471.8879216812875, 7472.103347598323, 8790.0, 8881.600327985385, 8952.820943581222, 9030.05184455649, 9044.728658140266, 9030.954845225731, 9066.95466522663, 9136.26909847224, 9184.357095003286, 9236.26109911192, 7272.745453909088, 7348.301911318416, 7369.263073692588, 7378.667959941708, 7379.2251813558805, 7214.71141154348, 7333.779986600411, 7760.767176984699, 7838.686452541834, 7847.843043138991, 7045.506814522934, 7174.713011479483, 7230.674619642024, 7282.12614486265, 7292.781216563511, 6066.3023752269055, 6935.757248496278, 7026.3676269133975, 7152.284771522806, 7156.677949492389, 7063.117110361205, 7135.108111486064, 7160.606166660884, 7188.892166617609, 7191.892121618075, 6501.4798816095545, 6615.4046135848, 6615.66921653925, 6620.63586502747, 6622.602643841385, 6652.966735166487, 6713.227978782503, 6715.496337774589, 6719.731210751515, 6726.8654626908165], "unit": "score", "name": "mootools.html", "value": 4412.878311110639}, {"lowerIsBetter": false, "replicates": [321.3444573070935, 324.90902547286754, 331.58220641991085, 333.62300600321635, 337.3472331039439, 5641.012822756012, 5760.942390576093, 5845.678487683176, 5849.7367618457165, 5861.325947516037, 5541.861453463665, 5687.8578035549135, 5703.144528320744, 5743.052396354607, 5763.740631671574, 4483.529229430904, 4517.051419201972, 4517.367568540407, 4518.322251662261, 4524.932126018096, 4258.382534532491, 4357.782110894458, 4406.647468202536, 4510.616597589209, 4525.977370113144, 4415.977920110395, 4431.423914891059, 4436.733795972236, 4448.377227188196, 4460.643148548108, 4421.801018954155, 4422.071365013335, 4424.579664931826, 4424.911501769979, 4479.529649386833, 3933.606639336072, 3935.9212815743813, 3944.8027598619956, 3947.8618248361167, 3948.368261078214, 5364.14173732201, 5541.085720856054, 5546.972265138689, 5553.861153471155, 5559.499645031926, 5189.584833213372, 5207.4792520748, 5216.774058096382, 5218.712970786605, 5224.373075230958, 6178.320384757673, 6184.165137706397, 6190.566660333733, 6196.752129914798, 6206.317305096436, 4179.331306990867, 4259.70182087254, 4261.786910654455, 4332.631726303268, 4357.063231405263, 6325.177726895474, 6383.553151279412, 6386.68066596673, 6398.584092033956, 6404.391582799627, 4454.77726113693, 4457.108578284357, 4462.754548499799, 4463.486699029589, 4465.24090904547, 4381.627561657231, 4520.819167233274, 4522.909541809146, 4524.457065152203, 4528.728276303366, 5138.537531622172, 5197.376314842243, 5200.115980283361, 5202.53177214045, 5202.97398513005, 6198.504119670415, 6200.100985357098, 6202.596831205957, 6209.06863970399, 6210.378962103844, 1591.3634546181388, 1606.3414000259838, 1607.0759313394844, 1607.742761158209, 1607.9356825727075, 1086.1093902999623, 1086.1528008153653, 1109.9056580190613, 1112.4271000434783, 1115.8772535021142, 5857.70711464425, 5875.294964604275, 5875.6474611523445, 5877.324107727581, 5878.941210587925, 6349.46029587481, 6357.14178585885, 6361.109444677749, 6366.522510811615, 6368.363163683594, 5852.0, 5858.326292476419, 5860.38465961068, 5861.150133230658, 5861.70691465425, 3333.3000069985574, 3431.897043088711, 3438.6045604755273, 3438.9312213755584, 3442.053435305261, 6624.27133015368, 6651.966740166365, 6685.598864068074, 6691.297413771581, 6697.330266973361, 6560.343965603402, 6572.704228309737, 6576.5067619928695, 6583.407493325623, 6588.176477940257, 6539.705713242915, 6669.599824010575, 6673.232578253563, 6674.2658307586125, 6677.799666010124, 6149.969250153899, 6410.0, 6412.3908228720065, 6419.646919419477, 6420.3258657842125, 6218.191635087591, 6257.155284036597, 6349.587276826992, 6357.523185761179, 6368.713407896563, 6634.270230274762, 6651.933480665325, 6658.201015878126, 6658.500612454182, 6664.067030615621, 4355.956440435555, 4397.340398940185, 4402.471703395613, 4405.515393306798, 4409.294512877924, 6247.843803904939, 6414.454771344488, 6427.678616069272, 6428.421442070049, 6428.774992875227, 6226.470749986302, 6271.310155882758, 6282.0, 6282.591631543935, 6286.622802631857, 6172.382761723792, 6242.3133455320785, 6249.437550620466, 6256.6246025236815, 6264.718087686157, 6063.72713227897, 6139.3553676863285, 6145.938540614537, 6146.969265153645, 6155.6614386209185, 6268.874622507433, 6271.278802937538, 6276.905846412216, 6278.46633036197, 6282.434580887742, 6125.877482450415, 6132.969335153296, 6134.846628834315, 6138.294096178996, 6151.046587778901], "unit": "score", "name": "prototype.html", "value": 4685.890187672991}, {"lowerIsBetter": false, "replicates": [680.5372346804173, 742.3096520236181, 745.5079647432696, 749.6064566102796, 771.3636250093671, 12526.373681315932, 12704.364781760909, 12707.936460317696, 12719.1732537385, 12777.425015874285, 11486.310821350724, 11756.294622322666, 11788.17482776206, 11825.349605771678, 11869.584564540242, 664.3754870421789, 672.9024291477733, 783.9725609603679, 801.0467543623099, 801.4670244287571, 803.7468197517763, 808.6361137488125, 811.8944537210155, 811.9553424561647, 812.3744716568239, 852.0116664668985, 854.1885209051395, 856.8372009318241, 857.5926434943415, 857.7855536115972, 688.3873352716087, 698.7484505577988, 822.4982760516081, 833.1002517281322, 834.6661335465801, 610.2829175718557, 611.4832966143601, 612.0085461552269, 612.2438788096697, 612.265281662003, 12045.096617753616, 12092.818607720892, 12117.454714537867, 12119.454624541917, 12120.636380908587, 11132.61035863749, 11541.249818761838, 11752.941235293854, 11766.294022358601, 12016.399180041051, 9538.475383853885, 9577.856332155023, 9643.421394716339, 9699.757506062335, 9706.805863882682, 3439.3809114359406, 3513.367593833109, 3534.823258837048, 3611.133328001287, 3625.673689367943, 45336.77331613321, 45495.317570236475, 45571.088578228584, 45708.542914571095, 45786.77106614479, 8537.871931920901, 8622.31021518277, 8653.610587523577, 8782.912170878337, 9437.197838183694, 15961.521154365388, 16076.678466430605, 16095.356185752438, 16180.838191618168, 16195.676086478205, 6703.798886033427, 6725.562838415487, 6806.931930680729, 6821.147356580427, 6965.33829286217, 3640.8179591020344, 3693.538307711536, 3693.8153092345274, 3712.5730540987593, 3730.0488375464083, 2820.3795165063652, 2891.161563146664, 2891.233823036897, 2892.6673432555103, 2906.869190886373, 552.4834279948261, 563.7181409295353, 566.6373520946597, 568.2357229526281, 570.5777724483852, 552.7043031977872, 554.1604469229121, 568.9573282003867, 571.5827445964469, 582.7581553655185, 7881.133075361706, 7922.326602238759, 7997.520148790974, 8091.676332946734, 8191.221833925768, 501.46844344994423, 544.1810075835841, 562.3757629031771, 606.6945606694543, 718.5042320798736, 3941.152652179795, 3998.1603863189057, 4003.159336539359, 4087.1212689271947, 4218.282891908383, 51617.48382516202, 53560.732196338766, 53566.196507052424, 53630.0, 53931.0, 48048.759756201, 48890.26664600034, 49394.75302623536, 49415.752921235886, 50108.74945625249, 42101.789491052965, 42609.147817043486, 42970.78514607407, 43969.78015109904, 43994.78002610031, 8019.398545109024, 8098.959505202436, 8110.4728192669645, 8149.066336119111, 8232.753017409488, 32425.513617295288, 33200.501992469646, 33277.33445331128, 33293.33413331768, 33302.50046249357, 39579.0, 39791.40312895251, 41797.79101104475, 42366.36450453307, 42752.358714618684, 9498.95250523743, 9708.514574271117, 9775.560099795384, 9889.208863291064, 10131.240156988108, 11395.886041139815, 11539.36533490666, 11626.418679066182, 12774.105812593029, 12903.870961290642, 10583.894161058292, 10860.837087443853, 11053.723656908642, 11081.778364432828, 11581.305121692725, 10617.946910265398, 10916.508757106109, 10962.451877406258, 10986.725331866768, 11340.829887551858, 7462.664180112017, 10695.358278503314, 11110.277831940897, 11128.272028870419, 11379.203455758017, 9157.404768690014, 9203.60706216402, 9219.354645174773, 9269.860952085859, 9509.334346595671, 9135.908640913505, 9193.218576421079, 9208.493532855757, 9281.39670921388, 9625.374350667184], "unit": "score", "name": "yui.html", "value": 5908.778883308444}], "name": "dromaeo_css", "value": 6701.091883839046}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 108.0, 111.0, 111.0, 112.0, 112.0, 110.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 159.0, 166.0, 128.0, 154.0, 151.0, 132.0, 163.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 162.0, 163.0, 161.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 97.0, 98.0, 72.0, 73.0, 74.0, 115.0, 106.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 97.0, 98.0, 97.0, 143.0, 96.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 144.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 55.0, 54.0, 56.0, 56.0, 55.0, 58.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 82.0, 83.0, 83.0, 83.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 121.0, 114.0, 111.0, 124.0, 122.0, 121.0, 122.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [139.0, 141.0, 143.0, 140.0, 139.0, 132.0, 141.0, 140.0, 139.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.5}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1493.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [189.78933383943823], "unit": "score", "name": "DeltaBlue", "value": 348.37574199999995}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [813.8211382113822], "unit": "score", "name": "Earley", "value": 818.9305594405593}, {"lowerIsBetter": false, "replicates": [12670.886075949367], "unit": "score", "name": "Boyer", "value": 52.597979020979054}, {"lowerIsBetter": false, "replicates": [42687.5], "unit": "score", "name": "RegExp", "value": 21.340790629575395}, {"lowerIsBetter": false, "replicates": [579.7101449275362], "unit": "score", "name": "Splay", "value": 140.57197499999998}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 19936.766186321107}]} 09:01:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19936.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1493.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6701.09"}}} 09:01:16 INFO - Return code: 0 09:01:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:01:16 INFO - # TBPL SUCCESS # 09:01:16 INFO - Running post-action listener: _resource_record_post_action 09:01:16 INFO - Running post-run listener: _resource_record_post_run 09:01:17 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 550207488; Read time: 0; Write time: 491300 09:01:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236552192; Read time: 0; Write time: 271816 09:01:17 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 313655296; Read time: 0; Write time: 219484 09:01:17 INFO - Running post-run listener: _upload_blobber_files 09:01:17 INFO - Blob upload gear active. 09:01:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:01:17 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 09:01:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:01:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:01:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:18 INFO - (blobuploader) - INFO - Done attempting. 09:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:19 INFO - (blobuploader) - INFO - Done attempting. 09:01:19 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:19 INFO - Return code: 0 09:01:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:01:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35251030ba632da37048de9c57f8e2cb86376b4189e79ebf0c576c8f51f44bae173fb487217a7fe3a1943d8daac7bf91c174c704e6d974555ea222ca2ccfd8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fbe7a2b1917b7feee8fd4f7ae677d1e4d0bdde5c3e8bc499ecd85a201f6af71e9d5e0ef1f4915d88c3ce4eafb65484a20820b8ac01bf07d1f3fe0a75490f5ce"} 09:01:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:01:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:01:19 INFO - Contents: 09:01:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35251030ba632da37048de9c57f8e2cb86376b4189e79ebf0c576c8f51f44bae173fb487217a7fe3a1943d8daac7bf91c174c704e6d974555ea222ca2ccfd8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fbe7a2b1917b7feee8fd4f7ae677d1e4d0bdde5c3e8bc499ecd85a201f6af71e9d5e0ef1f4915d88c3ce4eafb65484a20820b8ac01bf07d1f3fe0a75490f5ce"} 09:01:19 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:19 INFO - Copying logs to upload dir... 09:01:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:01:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.358942 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-25 09:01:19.110814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:01:19.114846) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35251030ba632da37048de9c57f8e2cb86376b4189e79ebf0c576c8f51f44bae173fb487217a7fe3a1943d8daac7bf91c174c704e6d974555ea222ca2ccfd8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fbe7a2b1917b7feee8fd4f7ae677d1e4d0bdde5c3e8bc499ecd85a201f6af71e9d5e0ef1f4915d88c3ce4eafb65484a20820b8ac01bf07d1f3fe0a75490f5ce"} build_url:https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/JsKFvlSVTsSnFtXY-mAJ_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35251030ba632da37048de9c57f8e2cb86376b4189e79ebf0c576c8f51f44bae173fb487217a7fe3a1943d8daac7bf91c174c704e6d974555ea222ca2ccfd8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fbe7a2b1917b7feee8fd4f7ae677d1e4d0bdde5c3e8bc499ecd85a201f6af71e9d5e0ef1f4915d88c3ce4eafb65484a20820b8ac01bf07d1f3fe0a75490f5ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:01:19.139961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:01:19.140276) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1453740010.248797-653837622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:01:19.226640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:01:19.227095) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:01:19.227595) ========= ========= Total master_lag: 0.30 =========