builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1452182909.07 results: success (0) buildid: 20160107053016 builduid: eeebb9f0b27746009e841b82177b5124 revision: 054095c4601c7e99758463a882676c7c8202a0d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.066234) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.066639) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.066932) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.095424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.095780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.124680) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.124973) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.184819) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.185118) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.185486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.185775) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 08:08:29-- 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% 60.4M=0s 2016-01-07 08:08:29 (60.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117698 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.315938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.316298) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022506 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.365916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:29.366290) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 054095c4601c7e99758463a882676c7c8202a0d0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 054095c4601c7e99758463a882676c7c8202a0d0 --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=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 08:08:30,107 truncating revision to first 12 chars 2016-01-07 08:08:30,107 Setting DEBUG logging. 2016-01-07 08:08:30,107 attempt 1/10 2016-01-07 08:08:30,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/054095c4601c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 08:08:30,420 unpacking tar archive at: b2g-inbound-054095c4601c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:30.019050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:30.019332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:30.037418) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:30.037676) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:08:30.038071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-07 08:08:30.038358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:30 INFO - MultiFileLogger online at 20160107 08:08:30 in /builds/slave/test-pgo 08:08:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 08:08:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:08:30 INFO - {'append_to_log': False, 08:08:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:08:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 08:08:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:08:30 INFO - 'branch': 'B2G-Inbound', 08:08:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:30 INFO - 'config_files': ('talos/linux_config.py',), 08:08:30 INFO - 'default_actions': ('clobber', 08:08:30 INFO - 'read-buildbot-config', 08:08:30 INFO - 'download-and-extract', 08:08:30 INFO - 'populate-webroot', 08:08:30 INFO - 'create-virtualenv', 08:08:30 INFO - 'install', 08:08:30 INFO - 'run-tests'), 08:08:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:30 INFO - 'download_minidump_stackwalk': True, 08:08:30 INFO - 'download_symbols': 'ondemand', 08:08:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:30 INFO - 'installer_path': 'installer.exe', 08:08:30 INFO - 'log_level': 'info', 08:08:30 INFO - 'log_name': 'talos', 08:08:30 INFO - 'log_to_console': True, 08:08:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:30 INFO - 'opt_config_files': (), 08:08:30 INFO - 'pip_index': False, 08:08:30 INFO - 'sps_profile': False, 08:08:30 INFO - 'sps_profile_interval': 0, 08:08:30 INFO - 'suite': 'dromaeojs', 08:08:30 INFO - 'system_bits': '32', 08:08:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:30 INFO - 'title': 'talos-linux64-ix-014', 08:08:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:30 INFO - 'use_talos_json': True, 08:08:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:08:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:30 INFO - 'work_dir': 'build'} 08:08:30 INFO - ##### 08:08:30 INFO - ##### Running clobber step. 08:08:30 INFO - ##### 08:08:30 INFO - Running pre-action listener: _resource_record_pre_action 08:08:30 INFO - Running main action method: clobber 08:08:30 INFO - rmtree: /builds/slave/test-pgo/build 08:08:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:08:31 INFO - Running post-action listener: _resource_record_post_action 08:08:31 INFO - ##### 08:08:31 INFO - ##### Running read-buildbot-config step. 08:08:31 INFO - ##### 08:08:31 INFO - Running pre-action listener: _resource_record_pre_action 08:08:31 INFO - Running main action method: read_buildbot_config 08:08:31 INFO - Using buildbot properties: 08:08:31 INFO - { 08:08:31 INFO - "project": "", 08:08:31 INFO - "product": "firefox", 08:08:31 INFO - "script_repo_revision": "production", 08:08:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:08:31 INFO - "repository": "", 08:08:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 08:08:31 INFO - "buildid": "20160107053016", 08:08:31 INFO - "pgo_build": "True", 08:08:31 INFO - "basedir": "/builds/slave/test-pgo", 08:08:31 INFO - "buildnumber": 191, 08:08:31 INFO - "slavename": "talos-linux64-ix-014", 08:08:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:08:31 INFO - "platform": "ubuntu64_hw", 08:08:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 08:08:31 INFO - "branch": "b2g-inbound", 08:08:31 INFO - "repo_path": "integration/b2g-inbound", 08:08:31 INFO - "revision": "054095c4601c7e99758463a882676c7c8202a0d0", 08:08:31 INFO - "stage_platform": "linux64-pgo", 08:08:31 INFO - "builduid": "eeebb9f0b27746009e841b82177b5124", 08:08:31 INFO - "slavebuilddir": "test" 08:08:31 INFO - } 08:08:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:08:31 INFO - Running post-action listener: _resource_record_post_action 08:08:31 INFO - ##### 08:08:31 INFO - ##### Running download-and-extract step. 08:08:31 INFO - ##### 08:08:31 INFO - Running pre-action listener: _resource_record_pre_action 08:08:31 INFO - Running main action method: download_and_extract 08:08:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:31 INFO - https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/test_packages.json 08:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/test_packages.json 08:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:08:36 INFO - Downloaded 1302 bytes. 08:08:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:08:36 INFO - Using the following test package requirements: 08:08:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:36 INFO - u'jsshell-linux-x86_64.zip'], 08:08:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:36 INFO - https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:40 INFO - Downloaded 24056497 bytes. 08:08:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:08:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:08:41 INFO - Return code: 0 08:08:41 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:08:41 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:08:41 INFO - https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:42 INFO - Downloaded 24056497 bytes. 08:08:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:08:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:08:43 INFO - Return code: 0 08:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:43 INFO - https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:44 INFO - Downloaded 11132285 bytes. 08:08:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 08:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:08:44 INFO - Return code: 0 08:08:44 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:08:44 INFO - https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/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:08:46 INFO - Downloaded 55918246 bytes. 08:08:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:46 INFO - mkdir: /builds/slave/test-pgo/properties 08:08:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:08:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:08:46 INFO - Contents: 08:08:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:46 INFO - Running post-action listener: _resource_record_post_action 08:08:46 INFO - Running post-action listener: set_extra_try_arguments 08:08:46 INFO - ##### 08:08:46 INFO - ##### Running populate-webroot step. 08:08:46 INFO - ##### 08:08:46 INFO - Running pre-action listener: _resource_record_pre_action 08:08:46 INFO - Running main action method: populate_webroot 08:08:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:46 INFO - '--tppagecycles', 08:08:46 INFO - '7'], 08:08:46 INFO - 'tests': ['tsvgm']}}, 08:08:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:08:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'tests': ['damp', 'tps']}, 08:08:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['damp', 'tps']}, 08:08:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:08:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:46 INFO - 'other': {'tests': ['a11yr', 08:08:46 INFO - 'ts_paint', 08:08:46 INFO - 'tpaint', 08:08:46 INFO - 'sessionrestore', 08:08:46 INFO - 'sessionrestore_no_auto_restore']}, 08:08:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['a11yr', 08:08:46 INFO - 'ts_paint', 08:08:46 INFO - 'tpaint', 08:08:46 INFO - 'sessionrestore', 08:08:46 INFO - 'sessionrestore_no_auto_restore']}, 08:08:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['a11yr', 08:08:46 INFO - 'ts_paint', 08:08:46 INFO - 'tpaint', 08:08:46 INFO - 'sessionrestore', 08:08:46 INFO - 'sessionrestore_no_auto_restore']}, 08:08:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['a11yr', 08:08:46 INFO - 'ts_paint', 08:08:46 INFO - 'tpaint', 08:08:46 INFO - 'sessionrestore', 08:08:46 INFO - 'sessionrestore_no_auto_restore']}, 08:08:46 INFO - 'other_l64': {'tests': ['a11yr', 08:08:46 INFO - 'ts_paint', 08:08:46 INFO - 'tpaint', 08:08:46 INFO - 'sessionrestore', 08:08:46 INFO - 'sessionrestore_no_auto_restore']}, 08:08:46 INFO - 'other_nol64': {'tests': ['a11yr', 08:08:46 INFO - 'ts_paint', 08:08:46 INFO - 'tpaint', 08:08:46 INFO - 'sessionrestore', 08:08:46 INFO - 'sessionrestore_no_auto_restore']}, 08:08:46 INFO - 'svgr': {'tests': ['tsvgx', 08:08:46 INFO - 'tsvgr_opacity', 08:08:46 INFO - 'tart', 08:08:46 INFO - 'tscrollx', 08:08:46 INFO - 'cart']}, 08:08:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['tsvgx', 08:08:46 INFO - 'tsvgr_opacity', 08:08:46 INFO - 'tart', 08:08:46 INFO - 'tscrollx', 08:08:46 INFO - 'cart']}, 08:08:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'tests': ['tp5o']}, 08:08:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'talos_options': ['--e10s'], 08:08:46 INFO - 'tests': ['tp5o']}, 08:08:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'talos_options': ['--xperf_path', 08:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:46 INFO - 'tests': ['tp5n']}, 08:08:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:46 INFO - 'talos_options': ['--e10s', 08:08:46 INFO - '--xperf_path', 08:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:46 INFO - 'tests': ['tp5n']}}, 08:08:46 INFO - 'talos.zip': {'path': '', 08:08:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:46 INFO - Running post-action listener: _resource_record_post_action 08:08:46 INFO - ##### 08:08:46 INFO - ##### Running create-virtualenv step. 08:08:46 INFO - ##### 08:08:46 INFO - Running pre-action listener: _resource_record_pre_action 08:08:46 INFO - Running main action method: create_virtualenv 08:08:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:08:46 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:08:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:08:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:46 INFO - Using real prefix '/usr' 08:08:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:08:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:49 INFO - Installing pip.................done. 08:08:49 INFO - Return code: 0 08:08:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:08:49 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:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 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:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:08:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:08:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:08:49 INFO - Using env: {'DISPLAY': ':0', 08:08:49 INFO - 'HOME': '/home/cltbld', 08:08:49 INFO - 'LANG': 'en_US.UTF-8', 08:08:49 INFO - 'LANGUAGE': 'en_US:en', 08:08:49 INFO - 'LOGNAME': 'cltbld', 08:08:49 INFO - 'MAIL': '/var/mail/cltbld', 08:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:49 INFO - 'MOZ_NO_REMOTE': '1', 08:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:49 INFO - 'NO_EM_RESTART': '1', 08:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:49 INFO - 'SHELL': '/bin/bash', 08:08:49 INFO - 'SHLVL': '1', 08:08:49 INFO - 'TERM': 'linux', 08:08:49 INFO - 'TMOUT': '86400', 08:08:49 INFO - 'USER': 'cltbld', 08:08:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:49 INFO - '_': '/tools/buildbot/bin/python'} 08:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:49 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:08:49 INFO - Cleaning up... 08:08:49 INFO - Return code: 0 08:08:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:08:49 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:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 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:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:08:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:08:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:08:49 INFO - Using env: {'DISPLAY': ':0', 08:08:49 INFO - 'HOME': '/home/cltbld', 08:08:49 INFO - 'LANG': 'en_US.UTF-8', 08:08:49 INFO - 'LANGUAGE': 'en_US:en', 08:08:49 INFO - 'LOGNAME': 'cltbld', 08:08:49 INFO - 'MAIL': '/var/mail/cltbld', 08:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:49 INFO - 'MOZ_NO_REMOTE': '1', 08:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:49 INFO - 'NO_EM_RESTART': '1', 08:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:49 INFO - 'SHELL': '/bin/bash', 08:08:49 INFO - 'SHLVL': '1', 08:08:49 INFO - 'TERM': 'linux', 08:08:49 INFO - 'TMOUT': '86400', 08:08:49 INFO - 'USER': 'cltbld', 08:08:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:49 INFO - '_': '/tools/buildbot/bin/python'} 08:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:49 INFO - Downloading/unpacking psutil>=0.7.1 08:08:49 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:08:49 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:08:49 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:08:49 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:08:49 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:08:49 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:08:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:08:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:51 INFO - Installing collected packages: psutil 08:08:51 INFO - Running setup.py install for psutil 08:08:51 INFO - building 'psutil._psutil_linux' extension 08:08:51 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:08:51 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:08:51 INFO - building 'psutil._psutil_posix' extension 08:08:51 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:08:51 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:08:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:51 INFO - Successfully installed psutil 08:08:51 INFO - Cleaning up... 08:08:51 INFO - Return code: 0 08:08:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:08:51 INFO - Using env: {'DISPLAY': ':0', 08:08:51 INFO - 'HOME': '/home/cltbld', 08:08:51 INFO - 'LANG': 'en_US.UTF-8', 08:08:51 INFO - 'LANGUAGE': 'en_US:en', 08:08:51 INFO - 'LOGNAME': 'cltbld', 08:08:51 INFO - 'MAIL': '/var/mail/cltbld', 08:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:51 INFO - 'MOZ_NO_REMOTE': '1', 08:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:51 INFO - 'NO_EM_RESTART': '1', 08:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:51 INFO - 'SHELL': '/bin/bash', 08:08:51 INFO - 'SHLVL': '1', 08:08:51 INFO - 'TERM': 'linux', 08:08:51 INFO - 'TMOUT': '86400', 08:08:51 INFO - 'USER': 'cltbld', 08:08:51 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:51 INFO - '_': '/tools/buildbot/bin/python'} 08:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08:51 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:08:51 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:08:51 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:08:51 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:08:51 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:08:51 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:08:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:53 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:08:53 INFO - Installing collected packages: mozsystemmonitor 08:08:53 INFO - Running setup.py install for mozsystemmonitor 08:08:53 INFO - Successfully installed mozsystemmonitor 08:08:53 INFO - Cleaning up... 08:08:53 INFO - Return code: 0 08:08:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:08:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:08:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:08:53 INFO - Using env: {'DISPLAY': ':0', 08:08:53 INFO - 'HOME': '/home/cltbld', 08:08:53 INFO - 'LANG': 'en_US.UTF-8', 08:08:53 INFO - 'LANGUAGE': 'en_US:en', 08:08:53 INFO - 'LOGNAME': 'cltbld', 08:08:53 INFO - 'MAIL': '/var/mail/cltbld', 08:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:53 INFO - 'MOZ_NO_REMOTE': '1', 08:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:53 INFO - 'NO_EM_RESTART': '1', 08:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:53 INFO - 'SHELL': '/bin/bash', 08:08:53 INFO - 'SHLVL': '1', 08:08:53 INFO - 'TERM': 'linux', 08:08:53 INFO - 'TMOUT': '86400', 08:08:53 INFO - 'USER': 'cltbld', 08:08:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:53 INFO - '_': '/tools/buildbot/bin/python'} 08:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:08:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:08:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:56 INFO - Downloading docopt-0.6.1.tar.gz 08:08:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:56 INFO - Running setup.py install for blobuploader 08:08:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:08:56 INFO - Running setup.py install for requests 08:08:56 INFO - Running setup.py install for docopt 08:08:57 INFO - Successfully installed blobuploader requests docopt 08:08:57 INFO - Cleaning up... 08:08:57 INFO - Return code: 0 08:08:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:57 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:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:57 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:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:08:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:08:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:08:57 INFO - Using env: {'DISPLAY': ':0', 08:08:57 INFO - 'HOME': '/home/cltbld', 08:08:57 INFO - 'LANG': 'en_US.UTF-8', 08:08:57 INFO - 'LANGUAGE': 'en_US:en', 08:08:57 INFO - 'LOGNAME': 'cltbld', 08:08:57 INFO - 'MAIL': '/var/mail/cltbld', 08:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:57 INFO - 'MOZ_NO_REMOTE': '1', 08:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:57 INFO - 'NO_EM_RESTART': '1', 08:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:57 INFO - 'SHELL': '/bin/bash', 08:08:57 INFO - 'SHLVL': '1', 08:08:57 INFO - 'TERM': 'linux', 08:08:57 INFO - 'TMOUT': '86400', 08:08:57 INFO - 'USER': 'cltbld', 08:08:57 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:57 INFO - '_': '/tools/buildbot/bin/python'} 08:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:57 INFO - Running setup.py (path:/tmp/pip-_Ian22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:57 INFO - Running setup.py (path:/tmp/pip-pZC79G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:57 INFO - Running setup.py (path:/tmp/pip-n1zSXZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:57 INFO - Running setup.py (path:/tmp/pip-DrpM1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:57 INFO - Running setup.py (path:/tmp/pip-3b5r5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:57 INFO - Running setup.py (path:/tmp/pip-xqJYAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:57 INFO - Running setup.py (path:/tmp/pip-RmtShU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:57 INFO - Running setup.py (path:/tmp/pip-wPhzKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:57 INFO - Running setup.py (path:/tmp/pip-eTRNsP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:57 INFO - Running setup.py (path:/tmp/pip-YhlBpN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:58 INFO - Running setup.py (path:/tmp/pip-wWr_z4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:58 INFO - Running setup.py (path:/tmp/pip-dYyO_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:58 INFO - Running setup.py (path:/tmp/pip-dMWGsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:58 INFO - Running setup.py (path:/tmp/pip-U_uFAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:58 INFO - Running setup.py (path:/tmp/pip-bQJVP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:58 INFO - Running setup.py (path:/tmp/pip-W2QP7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:58 INFO - Running setup.py (path:/tmp/pip-ia5GyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:58 INFO - Running setup.py install for manifestparser 08:08:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:08:58 INFO - Running setup.py install for mozcrash 08:08:58 INFO - Running setup.py install for mozdebug 08:08:58 INFO - Running setup.py install for mozdevice 08:08:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:08:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:08:58 INFO - Running setup.py install for mozfile 08:08:59 INFO - Running setup.py install for mozhttpd 08:08:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Running setup.py install for mozinfo 08:08:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Running setup.py install for mozInstall 08:08:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Running setup.py install for mozleak 08:08:59 INFO - Running setup.py install for mozlog 08:08:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Running setup.py install for moznetwork 08:08:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Running setup.py install for mozprocess 08:08:59 INFO - Running setup.py install for mozprofile 08:08:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Running setup.py install for mozrunner 08:08:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:08:59 INFO - Running setup.py install for mozscreenshot 08:09:00 INFO - Running setup.py install for moztest 08:09:00 INFO - Running setup.py install for mozversion 08:09:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:09:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:00 INFO - Cleaning up... 08:09:00 INFO - Return code: 0 08:09:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:09:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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:09:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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:09:00 INFO - Using env: {'DISPLAY': ':0', 08:09:00 INFO - 'HOME': '/home/cltbld', 08:09:00 INFO - 'LANG': 'en_US.UTF-8', 08:09:00 INFO - 'LANGUAGE': 'en_US:en', 08:09:00 INFO - 'LOGNAME': 'cltbld', 08:09:00 INFO - 'MAIL': '/var/mail/cltbld', 08:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:00 INFO - 'MOZ_NO_REMOTE': '1', 08:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:00 INFO - 'NO_EM_RESTART': '1', 08:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:00 INFO - 'SHELL': '/bin/bash', 08:09:00 INFO - 'SHLVL': '1', 08:09:00 INFO - 'TERM': 'linux', 08:09:00 INFO - 'TMOUT': '86400', 08:09:00 INFO - 'USER': 'cltbld', 08:09:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:00 INFO - '_': '/tools/buildbot/bin/python'} 08:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:00 INFO - Running setup.py (path:/tmp/pip-_CvZAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:09:00 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:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:00 INFO - Running setup.py (path:/tmp/pip-6bsXwJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:09:00 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:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:00 INFO - Running setup.py (path:/tmp/pip-1DOvfw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:09:00 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:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:00 INFO - Running setup.py (path:/tmp/pip-AA5bLN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:00 INFO - Running setup.py (path:/tmp/pip-_5N7A1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:09:00 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:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:00 INFO - Running setup.py (path:/tmp/pip-2yBsRd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:09:00 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:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:00 INFO - Running setup.py (path:/tmp/pip-Zavnc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:01 INFO - Running setup.py (path:/tmp/pip-5Y6DU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:01 INFO - Running setup.py (path:/tmp/pip-RF8glf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:01 INFO - Running setup.py (path:/tmp/pip-lbxo4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:01 INFO - Running setup.py (path:/tmp/pip-hJ8qq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:01 INFO - Running setup.py (path:/tmp/pip-Pv1myL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:01 INFO - Running setup.py (path:/tmp/pip-eG17H2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:01 INFO - Running setup.py (path:/tmp/pip-8l9VpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:01 INFO - Running setup.py (path:/tmp/pip-LVUgNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:01 INFO - Running setup.py (path:/tmp/pip-bZpYzV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:09:01 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:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:01 INFO - Running setup.py (path:/tmp/pip-tpJHqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:09:01 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:09:01 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:09:01 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:09:01 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:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:03 INFO - Downloading blessings-1.5.1.tar.gz 08:09:03 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:09:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:03 INFO - Installing collected packages: blessings 08:09:03 INFO - Running setup.py install for blessings 08:09:03 INFO - Successfully installed blessings 08:09:03 INFO - Cleaning up... 08:09:03 INFO - Return code: 0 08:09:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:09:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:03 INFO - Reading from file tmpfile_stdout 08:09:03 INFO - Current package versions: 08:09:03 INFO - argparse == 1.2.1 08:09:03 INFO - blessings == 1.5.1 08:09:03 INFO - blobuploader == 1.2.4 08:09:03 INFO - docopt == 0.6.1 08:09:03 INFO - manifestparser == 1.1 08:09:03 INFO - mozInstall == 1.12 08:09:03 INFO - mozcrash == 0.16 08:09:03 INFO - mozdebug == 0.1 08:09:03 INFO - mozdevice == 0.47 08:09:03 INFO - mozfile == 1.2 08:09:03 INFO - mozhttpd == 0.7 08:09:03 INFO - mozinfo == 0.9 08:09:03 INFO - mozleak == 0.1 08:09:03 INFO - mozlog == 3.1 08:09:03 INFO - moznetwork == 0.27 08:09:03 INFO - mozprocess == 0.22 08:09:03 INFO - mozprofile == 0.28 08:09:03 INFO - mozrunner == 6.11 08:09:03 INFO - mozscreenshot == 0.1 08:09:03 INFO - mozsystemmonitor == 0.0 08:09:03 INFO - moztest == 0.7 08:09:03 INFO - mozversion == 1.4 08:09:03 INFO - psutil == 3.1.1 08:09:03 INFO - requests == 1.2.3 08:09:03 INFO - wsgiref == 0.1.2 08:09:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:09:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:09:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:03 INFO - Using env: {'DISPLAY': ':0', 08:09:03 INFO - 'HOME': '/home/cltbld', 08:09:03 INFO - 'LANG': 'en_US.UTF-8', 08:09:03 INFO - 'LANGUAGE': 'en_US:en', 08:09:03 INFO - 'LOGNAME': 'cltbld', 08:09:03 INFO - 'MAIL': '/var/mail/cltbld', 08:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:03 INFO - 'MOZ_NO_REMOTE': '1', 08:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:03 INFO - 'NO_EM_RESTART': '1', 08:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:04 INFO - 'SHELL': '/bin/bash', 08:09:04 INFO - 'SHLVL': '1', 08:09:04 INFO - 'TERM': 'linux', 08:09:04 INFO - 'TMOUT': '86400', 08:09:04 INFO - 'USER': 'cltbld', 08:09:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:04 INFO - '_': '/tools/buildbot/bin/python'} 08:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 INFO - Cleaning up... 08:09:04 INFO - Return code: 0 08:09:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:09:04 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:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:04 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:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:09:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:04 INFO - Using env: {'DISPLAY': ':0', 08:09:04 INFO - 'HOME': '/home/cltbld', 08:09:04 INFO - 'LANG': 'en_US.UTF-8', 08:09:04 INFO - 'LANGUAGE': 'en_US:en', 08:09:04 INFO - 'LOGNAME': 'cltbld', 08:09:04 INFO - 'MAIL': '/var/mail/cltbld', 08:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:04 INFO - 'MOZ_NO_REMOTE': '1', 08:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:04 INFO - 'NO_EM_RESTART': '1', 08:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:04 INFO - 'SHELL': '/bin/bash', 08:09:04 INFO - 'SHLVL': '1', 08:09:04 INFO - 'TERM': 'linux', 08:09:04 INFO - 'TMOUT': '86400', 08:09:04 INFO - 'USER': 'cltbld', 08:09:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:04 INFO - '_': '/tools/buildbot/bin/python'} 08:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:04 INFO - Downloading/unpacking jsonschema 08:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:04 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:09:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:09:06 INFO - Downloading/unpacking functools32 (from jsonschema) 08:09:06 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:09:06 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:09:06 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:09:06 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:09:06 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:09:06 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:09:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:09:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:06 INFO - warning: no files found matching '*.txt' 08:09:06 INFO - no previously-included directories found matching 'build' 08:09:06 INFO - no previously-included directories found matching 'dist' 08:09:06 INFO - no previously-included directories found matching '.git*' 08:09:06 INFO - Installing collected packages: jsonschema, functools32 08:09:06 INFO - Running setup.py install for functools32 08:09:06 INFO - warning: no files found matching '*.txt' 08:09:06 INFO - no previously-included directories found matching 'build' 08:09:06 INFO - no previously-included directories found matching 'dist' 08:09:06 INFO - no previously-included directories found matching '.git*' 08:09:06 INFO - Successfully installed jsonschema functools32 08:09:06 INFO - Cleaning up... 08:09:06 INFO - Return code: 0 08:09:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d15f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', '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:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:09:06 INFO - Using env: {'DISPLAY': ':0', 08:09:06 INFO - 'HOME': '/home/cltbld', 08:09:06 INFO - 'LANG': 'en_US.UTF-8', 08:09:06 INFO - 'LANGUAGE': 'en_US:en', 08:09:06 INFO - 'LOGNAME': 'cltbld', 08:09:06 INFO - 'MAIL': '/var/mail/cltbld', 08:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:06 INFO - 'MOZ_NO_REMOTE': '1', 08:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:06 INFO - 'NO_EM_RESTART': '1', 08:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:06 INFO - 'SHELL': '/bin/bash', 08:09:06 INFO - 'SHLVL': '1', 08:09:06 INFO - 'TERM': 'linux', 08:09:06 INFO - 'TMOUT': '86400', 08:09:06 INFO - 'USER': 'cltbld', 08:09:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:06 INFO - '_': '/tools/buildbot/bin/python'} 08:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:06 INFO - Downloading/unpacking flake8 08:09:06 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:09:06 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:09:06 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:09:06 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:09:06 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:09:06 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:09:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:09:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:09:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:09:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:09:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:09 INFO - no previously-included directories found matching 'docs/_build' 08:09:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:09 INFO - Running setup.py install for pep8 08:09:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:09 INFO - no previously-included directories found matching 'docs/_build' 08:09:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:09:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:09 INFO - Cleaning up... 08:09:09 INFO - Return code: 0 08:09:09 INFO - Running post-action listener: _resource_record_post_action 08:09:09 INFO - Running post-action listener: _start_resource_monitoring 08:09:09 INFO - Starting resource monitoring. 08:09:09 INFO - ##### 08:09:09 INFO - ##### Running install step. 08:09:09 INFO - ##### 08:09:09 INFO - Running pre-action listener: _resource_record_pre_action 08:09:09 INFO - Running main action method: install 08:09:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:09 INFO - Reading from file tmpfile_stdout 08:09:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:09:09 INFO - Reading from file tmpfile_stdout 08:09:09 INFO - Output received: 08:09:09 INFO - Usage: mozinstall [options] installer 08:09:09 INFO - Options: 08:09:09 INFO - -h, --help show this help message and exit 08:09:09 INFO - -d DEST, --destination=DEST 08:09:09 INFO - Directory to install application into. [default: 08:09:09 INFO - "/builds/slave/test-pgo"] 08:09:09 INFO - --app=APP Application being installed. [default: firefox] 08:09:09 INFO - mkdir: /builds/slave/test-pgo/build/application 08:09:09 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:09:09 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:09:25 INFO - Reading from file tmpfile_stdout 08:09:25 INFO - Output received: 08:09:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:09:25 INFO - Running post-action listener: _resource_record_post_action 08:09:25 INFO - ##### 08:09:25 INFO - ##### Running run-tests step. 08:09:25 INFO - ##### 08:09:25 INFO - Running pre-action listener: _resource_record_pre_action 08:09:25 INFO - Running main action method: run_tests 08:09:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:09:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:09:25 INFO - Python 2.7.3 08:09:25 INFO - Return code: 0 08:09:25 INFO - grabbing minidump binary from tooltool 08:09:25 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:09:25 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 0x2537840>, '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 0x24a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a4b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:09:25 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:09:25 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:09:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:25 INFO - Return code: 0 08:09:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:09:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:09:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:09:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:09:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:09:26 INFO - Return code: 0 08:09:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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:09:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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:09:26 INFO - Using env: {'DISPLAY': ':0', 08:09:26 INFO - 'HOME': '/home/cltbld', 08:09:26 INFO - 'LANG': 'en_US.UTF-8', 08:09:26 INFO - 'LANGUAGE': 'en_US:en', 08:09:26 INFO - 'LOGNAME': 'cltbld', 08:09:26 INFO - 'MAIL': '/var/mail/cltbld', 08:09:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:26 INFO - 'MOZ_NO_REMOTE': '1', 08:09:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:26 INFO - 'NO_EM_RESTART': '1', 08:09:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:09:26 INFO - 'SHELL': '/bin/bash', 08:09:26 INFO - 'SHLVL': '1', 08:09:26 INFO - 'TERM': 'linux', 08:09:26 INFO - 'TMOUT': '86400', 08:09:26 INFO - 'USER': 'cltbld', 08:09:26 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019', 08:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:26 INFO - '_': '/tools/buildbot/bin/python'} 08:09:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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:09:27 INFO - mozversion application_buildid: 20160107053016 08:09:27 INFO - mozversion application_changeset: 054095c4601c7e99758463a882676c7c8202a0d0 08:09:27 INFO - mozversion application_display_name: Nightly 08:09:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:27 INFO - mozversion application_name: Firefox 08:09:27 INFO - mozversion application_remotingname: firefox 08:09:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:09:27 INFO - mozversion application_vendor: Mozilla 08:09:27 INFO - mozversion application_version: 46.0a1 08:09:27 INFO - mozversion platform_buildid: 20160107053016 08:09:27 INFO - mozversion platform_changeset: 054095c4601c7e99758463a882676c7c8202a0d0 08:09:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:09:27 INFO - mozversion platform_version: 46.0a1 08:09:27 INFO - using testdate: 1452182967 08:09:27 INFO - actual date: 1452182967 08:09:27 INFO - starting webserver on 'localhost:38151' 08:09:27 INFO - SUITE-START | Running 3 tests 08:09:27 INFO - TEST-START | dromaeo_css 08:09:27 INFO - operating with platform_type : linux_ 08:09:27 INFO - Initialising browser for dromaeo_css test... 08:09:27 INFO - TEST-INFO | started process 30165 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQvolHN/profile http://localhost:38151/getInfo.html) 08:09:31 INFO - PROCESS | 30165 | __metrics Screen width/height:1600/1200 08:09:31 INFO - PROCESS | 30165 | colorDepth:24 08:09:31 INFO - PROCESS | 30165 | Browser inner width/height: 1024/697 08:09:31 INFO - PROCESS | 30165 | __metrics 08:09:31 INFO - PROCESS | 30165 | 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:09:31 INFO - PROCESS | 30165 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:32 INFO - TEST-INFO | 30165: exit 0 08:09:32 INFO - Browser initialized. 08:09:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:32 INFO - TEST-INFO | started process 30259 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQvolHN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:43 INFO - PROCESS | 30259 | RSS: Main: 150224896 08:09:43 INFO - PROCESS | 30259 | 08:10:35 INFO - PROCESS | 30259 | 1452183035611 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:12:43 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:38151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38151/tests/dromaeo/cssquery-ext.html) 08:12:45 INFO - PROCESS | 30259 | RSS: Main: 265928704 08:12:45 INFO - PROCESS | 30259 | 08:15:47 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:38151/tests/dromaeo/cssquery-ext.html (next: http://localhost:38151/tests/dromaeo/cssquery-jquery.html) 08:15:48 INFO - PROCESS | 30259 | RSS: Main: 236294144 08:15:48 INFO - PROCESS | 30259 | 08:18:50 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:38151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38151/tests/dromaeo/cssquery-mootools.html) 08:18:50 INFO - PROCESS | 30259 | RSS: Main: 222531584 08:18:50 INFO - PROCESS | 30259 | 08:21:52 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:38151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38151/tests/dromaeo/cssquery-prototype.html) 08:21:53 INFO - PROCESS | 30259 | RSS: Main: 209129472 08:21:53 INFO - PROCESS | 30259 | 08:24:55 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:38151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38151/tests/dromaeo/cssquery-yui.html) 08:24:56 INFO - PROCESS | 30259 | RSS: Main: 218976256 08:24:56 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:38151/tests/dromaeo/cssquery-yui.html (next: http://localhost:38151/tests/dromaeo/cssquery-dojo.html) 08:27:58 INFO - PROCESS | 30259 | RSS: Main: 288976896 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | __start_tp_report 08:27:58 INFO - PROCESS | 30259 | _x_x_mozilla_page_load 08:27:58 INFO - PROCESS | 30259 | _x_x_mozilla_page_load_details 08:27:58 INFO - PROCESS | 30259 | |i|pagename|runs| 08:27:58 INFO - PROCESS | 30259 | |0;dojo.html;3090.088423914945;3160.956884228205;3201.695838895304;3206.855691493884;3235.2882365879505;4862.854114376565;4945.085159245542;5099.776053747102;5119.564836988856;5153.716545589991;5036.866704991375;5127.077126117298;5183.481651834824;5200.713960732158;5219.9478005219935;4694.366260554824;4739.928901066487;4748.35897153885;4752.864869140492;4791.736454495001;4691.88270293242;4718.528147185289;4771.570558649721;4776.737279449629;4804.37543119394;4525.208088584484;4644.326572646981;4741.514360313333;4769.976150119262;4795.256735206031;4616.39986801717;4678.508756580578;4681.46163191234;4711.976440117812;4723.692959957626;4701.929471057937;4710.246360582325;4713.34013238147;4724.551167639103;4756.357891684613;4913.803447862081;4981.975090124526;4998.600111991032;5012.8997420051755;5013.022460620144;5491.972540137313;5492.1212605982855;5495.0658388073725;5501.229827824108;5507.366652834895;5527.170924361338;5527.419620939783;5532.059549876491;5534.75093620784;5535.806246781383;5026.447090820006;5132.999065182291;5143.639945203838;5170.250313704491;5233.1365324721755;5570.192322113271;5597.99236137491;5624.409437009137;5625.6905870176715;5669.291338582677;5392.514673679388;5407.648502847303;5410.783568657288;5416.566674666096;5417.404085550586;5337.62636615441;5384.434634363413;5391.272178255886;5428.972855135699;5479.698616576126;5462.754176062087;5465.754041068161;5466.480684334982;5467.015937131355;5515.61390702655;5460.481254280837;5469.425710300441;5472.671639701631;5475.6440831345835;5523.226748255167;4131.380292956021;4185.6232939035635;4223.831046758095;4284.207421627009;4301.376300436419;3806.562245341821;3807.371783655721;3820.083180036771;3837.865674701372;3843.8462461501786;5036.597072234213;5038.042771873405;5039.521245481674;5056.898862022739;5079.288899554065;5399.217113518518;5406.297181366476;5483.698396588146;5507.614466987273;5512.448755124536;5017.648764586444;5026.79892804291;5037.168867136881;5038.1435156022835;5038.79844806211;4575.9427634520525;4576.176288268143;4579.129965306581;4616.630669546428;4616.838410655611;5525.944740552623;5634.830955071355;5637.351704553947;5676.148577713376;5781.248437703156;5441.21102440136;5471.097268950738;5485.040117979258;5496.917546236729;5499.450054994469;5685.317761868602;5691.402402747817;5696.231008813757;5696.686682232517;5707.286589176353;5221.765020574007;5340.49265319794;5399.4060653327315;5464.617476776588;5514.558835293086;5459.508644222039;5492;5495.945040549544;5504.587155963399;5512.91730624049;5304.655197412156;5331.413544510178;5370.087085195604;5373.838784836461;5420.13277875538;5331.200319952039;5359.732013399393;5375.489328513785;5402.837914862561;5431.402545719889;5198.610104242121;5202.765875535534;5204.063268611686;5219.817306394258;5245.396779370421;5284.735763211901;5292.5501332387175;5312.1766126250495;5339.866503337447;5341.065313570032;5298.549623282064;5329.147336426153;5341.813036543703;5358;5397.730113494388 08:27:58 INFO - PROCESS | 30259 | |1;ext.html;530.7478947499941;539.9109146990746;563.963342382745;570.754575532521;589.5283772981613;27443.862780686093;35805.82097089514;35940.46089308656;36215.27569448616;36230.45654315184;39448;39957.20085598286;39969.60030399695;39986.20027599454;39995.40006899892;7375.483716139873;7459.515131516434;8248.051474080483;8395.706150284741;8416.032156302012;9837.065478779505;10064.29549931505;10069.144122749574;10075.395476271411;10077.748056298578;9698.418094914292;9830.066143716336;9830.705078847646;9831.459269740162;9834.360766550151;7507.924920750777;7657.923420765776;9680.757981050494;9931.404115753077;10176.949115254376;9639.469829159394;9746.46394448305;9757.658481953098;9760.17038551724;9764.170045546138;36091;36108.45837312443;36468.817655911815;36478.63521364806;36549.63450365489;3061.7703672224447;3093.427715872571;3110.9222269443217;3171.9365612687616;3239.676032396765;29645.110646680634;30282.84858575693;30305.393892122254;30376.69623303783;30400.239994000105;3753.305638456894;3866.4780254665543;4003.73975691582;4016.0763024504236;4039.454673619053;263546;263637;265037;265325;266010;53032.73483632557;53935.73032134893;59575.702121489114;59585;59845;57734.711326443095;58631.120533192036;58838.70580647155;58879.70560147172;58915.11627325508;13881.681240282158;14111.435542578181;14132.576022719335;14139.293035348192;14185.219812910183;10962.506687198937;11027.393493357782;11036.11711063113;11104.222704410775;11133.777324453466;17953.281868725368;18097.457076287734;18115.184816683282;18215.45353639393;18256;6889.483288753364;7013.228544860061;7065.646717664096;7067.43460523157;7168.53404528704;874.8162885793927;893.4014210478995;921.4287141971886;969.340848223215;1089.7983872983366;23851.52296954051;24344.634830477557;24628.630570541456;24676.876615617166;24689.62965555518;992.3847214726916;1088.4176965323513;1094.441834664327;1106.269861891148;1168.0305346562334;13002.479900803863;13558;13724.245166515739;13741.587752367444;13745.725085498434;302141.9571608555;304358;304608;305163;305582;47999;48360;48427.757861211176;48430.757846210545;48495.5150448498;1279.264422956785;1282.8717128287283;1317.6969297061537;1322.9272390018448;1324.6820763016806;24132.758672413052;24952.625710614717;25938.35154121162;26475.470490590465;28152.577711333935;40633.39049914195;40784;40970;41302.586974129874;41310.1737965233;239690;239851;239855;239962;240907;26632.60562007247;28684.282892927844;30211.697883021767;30614.693853061184;30710.692893070784;35196.296074078884;36170;36454;36580.26839463143;36685.81657091804;30624.693753062184;31564.526532101576;34358.31283374268;35544;36183.63816361908;29713.554296685135;31140.844295778377;31228.219294517818;31318.530222046233;32315.19212019718;33885.3222935535;33971.66028339685;34185.316293674485;34421.483677744356;34459.82770086134;31201.531977020815;31484.685153148177;31604.787664863237;31796.29731472851;31971;23628.29115126549;23791.524169516168;23901.521969560163;24226.636600450656;24359 08:27:58 INFO - PROCESS | 30259 | |2;jquery.html;342.03716537945684;342.76006795243336;343.7804956581613;344.3973047167457;344.5228358723168;13489.258090805002;13848.446062157502;16071.196440177988;16408.425705100322;17846.37537686181;15714.449994250175;15979.600509987256;16425.753613695804;16569.17154142294;16619.08595027273;5102.056119617873;5382.058139825534;5391.245225668409;5394.7842086316505;5398;4034.2939985502567;4148.253314403406;5260.184671375943;5838.124281357809;5996.430339117776;5844.678542680151;5846.181534585162;5889.263842019747;5900.822975310747;5947.583669143161;5779.768809247625;5924.58527903047;5926.792562260322;5934.376890426508;5941.19793827832;5173.4826517347965;5186.403563590197;5204.219367094928;5205.29728486657;5210.973945130288;20330.695039574417;21013.894930525403;21172.89413552938;21842;22411.887940560355;2111.746590409161;2143.153454385509;2197.1321328075483;2218.4232099654046;2219.323106452531;12830.294333811637;13287.069905106646;13556;14011.649708757363;14155.079919805283;1935.2162374238455;1947.1821834829407;1968.635802376565;2024.5647185854964;2035.2774764958374;63911.68044159749;68313.65843170752;68486.31513684899;68899.9999999995;69867;11226.438678066064;11337.943310283561;12887.61337159868;14822;14992.925035374754;22625.54748905013;22696.319110426713;22794;22879.542409152058;22886.084556617883;8031.156728543536;8108.918910810817;8123.634436450374;8127.959360203161;8169.75490735267;6790.864182716318;6800.727970881109;6820.795376138723;6861.519693621499;6862.107925969592;6944.583325000516;7116.92883071173;7151.070360853056;7152.92847071533;7171.89242161368;1566.3577933047395;1610.3091753658612;1638.279157170865;1668.0575474856666;2145.463634091477;790.0755423106253;1031.6286136990677;1045.7437927707608;1047.0942634621151;1049.6850944716707;15105.3202605883;15138.653508706167;15914.76127858083;16047.518574442785;16799.664006720042;875.0636818604032;924.611663101499;926.6571368593663;947.4410098042188;1018.1498448795339;7681.3854891608535;8632.395732298679;9532.714018579454;9611.519424028771;9620.75948101303;400288;402018;402144;404106;576135;66917.6654116736;77480.61259693665;79669;80609.19390806017;81420;1076.4294923690456;1109.4120116338354;1113.704868209925;1136.891995260449;1157.450211149714;14923;14978.925105374403;15066.397344106113;15110.622234444227;15505.84494155044;33502.66497334996;34398.6043000756;34578.48132277968;35128.47307290341;35310.823445882605;45956.54043459523;46262;46503.53496465128;48760;49244.26133607927;8501.702440414803;8537.871931920901;8978.147076027766;8981.550922453982;8999.10008999121;10480.895191047992;10582.206334524788;12726.490940362652;16408.17959102016;16834.831651683817;13737.24445155526;13825.792613111013;14083.436662533384;14159.433622654979;14271.71456570842;13533.932330338286;13558.457661693421;13734.107283026571;13956.302184890917;14026.08830426019;14314.069585476911;14426.85573144255;14438.566842994727;14929.477468288558;14951.177685227416;7872.252136047066;8109.3107085896;8294.917050829414;8920.152585504367;9033.187013168847;13492.12301200419;13668.65828354299;13770;13907.930460347634;14302 08:27:58 INFO - PROCESS | 30259 | |3;mootools.html;1229.7847876621588;1414.5473448496482;1417.5818133650573;1528.1900592685881;1716.1505054997779;6458.806235812927;7028.191757947831;7153.463490238233;7189.352958233758;7201.567905925635;7057.29427057294;7069.469789765775;7162.534435261718;7168.928310716891;7169.390601798853;1850.8889466631979;1881.5202123458566;2129.318618042223;2168.9891550542225;2171.023039632164;2065.3390914907236;2087.77034526202;2093;2094.1309356616985;2096.6540520814046;2066.245820275596;2073.295079672911;2074.553970896257;2086.8017538333834;2135.3487186408215;2154.762976072631;2163.156369016085;2176.249194028058;2181.923632672857;2187.2563328468395;2186.3768825884545;2206.293985924505;2207.966880496778;2209.9226527071637;2210.9115635374565;7257.8911316330295;7318.231585683533;7320.304571065741;7323;7324.963375183143;4336.479622445295;4379.912401751947;4382.211201983641;4393.53867843875;4396.318570621559;2784.707605701413;2929.29696872749;2944.219781757836;2959.7928145029855;2968.7328140467243;906.9773255668595;927.2072378116748;940.4874343482818;951.9533004041366;959.4770849886828;9404.153626173676;9490.193333566654;9504.762380940394;9525.380850244712;9574.090461406155;3753.042974041602;3760.7179461540495;3785.2240290740333;3799;3800.847966081326;8319.417640765208;8323.375746818892;8345.332373410112;8348.707795227137;8384.706535271236;4357.172137293904;4363.36731173978;4371.256886329332;4372.650187984954;4381.6494680425485;3985.9202815943518;3989.4215338776294;3991.8004099794894;3993.1414745829784;3999.1601763629383;3200.3119329344304;3230.353929214167;3325.1354647791263;3341.198112452994;3358.630550639428;1048.7640280936728;1054.8554669052799;1062.6493257225097;1063.4682658670665;1077.6820837852695;967.8983706710835;972.6352617768337;973.1971123822874;1026.2405819693522;1042.7705904700954;6893.551919125241;6953;6971.372576468142;6978.930210697828;6989.755358562527;1085.2511766880828;1100.2518287564374;1120.1542835159403;1127.520803658442;1142.8342890280862;5392.056390131711;5499.202615620713;5499.945000549943;5504.862378440491;5517.2551705520045;8253.95873020631;8673.913260867437;8680.826383472422;8803.691870784492;8901.777455563662;8742.038375778659;8772.473651580925;8773.692920747872;8775;8794.42836215644;6601.207855057424;6618.205815302098;6626.7017984190825;6732.394084532416;6975.860482790417;6656.267810540739;6709.966450167718;6717.664116794043;6733;6771.559848609824;7566.31903128721;7802.414818888719;7957.721479748181;7961.16407777175;7979.281864632211;7947.801304967422;7982.361411086983;8181.181881812009;8200.302974247255;8221;6490.740370385131;6508.381703738138;6570.047343135314;6572.901406478811;6582.210134783665;6350.7142178603;6474.5791523550815;6961.965190174017;7016.684249208696;7020.859582808417;6564.179477565304;6592.24189218246;6617.371349721769;6678.398944094861;6695.330466953461;6295.5907865988565;6414.903776443451;6565.606063636006;6586.077949087035;6598.967005164944;6505.60966342021;6571.507136964842;6578.967105164444;6584.176977877765;6589.6046237224;6084.087386892002;6120.08198770188;6131.141640170291;6132.938670613236;6134.693265336805;5988.970055149696;6020.8259389418645;6037.69811509414;6102.694865256631;6177.320494745484 08:27:58 INFO - PROCESS | 30259 | |4;prototype.html;315.8499712636497;318.312445118544;319.9648038715741;329.453107840984;329.4761329486118;5814.854628634286;5853.151293062503;5858.271809816104;5898.823035308937;5944.197533332998;5579.46995035472;5634.830955071344;5712.257406537145;5813.73838177282;5821.446962538552;4463.531329210435;4464.6651501137385;4484.506704262529;4491.977540112295;4509.864704058867;4498.617617502517;4502.279635258359;4503.932441013388;4504.887377815565;4511.977440112795;4254.510731265897;4333.544977777336;4342.413774140482;4391.582799634046;4425.668074894395;4448.33275008748;4448.421705178306;4453.398791163217;4470.687051906368;4471.552844715502;3920;3922.666573341269;3924.50943632046;3932.744371615836;3934.311495488278;5557.888842223133;5560.193771903051;5563.248961390201;5569.8607534811545;5590.888182236333;5104.719240441774;5191.948080519184;5192.221166825007;5203.219517072432;5209.895802083975;6173.074038894157;6179.5056395488255;6180.134781130645;6180.567360284782;6180.721867515973;4336.978315108436;4344.7827608619755;4346.369776382407;4347.543507931653;4347.913041739179;6316.557840951135;6438.227412710505;6467.094606755058;6483.773067942647;6485.5460117792245;4428.9813342930665;4432.512423633398;4432.601065904019;4444.444444444444;4444.999875028093;4486.170058539181;4493.842715505007;4495.460544734653;4495.527969563214;4498.257787465097;5171.043356978971;5171.818986335536;5178.326817513775;5185.403678576937;5186.481351864859;6132.049532322497;6244.906326405107;6245.406686364788;6254.280757712831;6258.092576576371;1568.34913510894;1568.9450869219522;1569.1918661889135;1573.4492927475521;1573.6695293988162;1066.344198318029;1068.893110688925;1070.6306324318098;1088.6679562733284;1092.6448904106198;5912.526997840162;5913.733881975321;5925.555583331267;5929.881402371929;5933.110033494924;6392.776252831221;6397.040443933354;6404.263509696445;6408.967955160194;6410.839729006719;5709.457601527848;5740.454656807597;5819.941800582024;5926.7925622603;5979.760809567569;3464.255185135208;3467.791932484059;3491.650834916488;3492.161881148506;3497.720182385403;6760.222574403908;6766.391024807791;6781.762638307636;6782.423494003065;6787.457003439713;6495.382938620824;6630.270670226271;6633.7346506140175;6646.83382915431;6653.135092437952;6757.189137303555;6781.966090169518;6783.3555812197765;6789.864202715918;6797.52417330792;6454.031895215755;6456.160699109274;6460.160179176677;6461.321561236003;6466.612003279818;6265.4361107500545;6393.552451328363;6405.487560995016;6406.90389644165;6409.4231519163495;6728.899066514105;6733.225679046776;6734.966325168539;6739.0902228198565;6739.157605299338;4504.797284122288;4508.594226519629;4513.413256276663;4515.661325400542;4518.841840535565;6378.138951241523;6497.805065848032;6509.381608747161;6514.088027676224;6514.478841692748;6305.621662700252;6328.335524769833;6331.240251169889;6331.778387756406;6336.778212762531;6310.6213627182515;6313.210848643919;6315.463185629089;6317.652529110759;6324;6059.939400605937;6187.9579738687025;6192.628442293477;6198.566100372931;6201.81394558164;6328.968355158195;6355.3326900674765;6356.046593011085;6357;6358.682065896594;6197.938020619736;6206.410391012847;6206.875862482635;6212.130301757667;6212.968935155295 08:27:58 INFO - PROCESS | 30259 | |5;yui.html;675.2875716119491;716.6345163966375;739.7558805594153;815.6492708135503;829.9917000829992;13307.667308317285;13504.594862154127;13582.728345433085;13606.251656158907;13622.45510179593;12662.556810511634;12863;12877.74244515109;12891.548795792149;12910.870891291084;655.2857385449859;662.2318110991251;770.4953255617579;782.5617654113714;793.8650429427012;779.4582764978343;790.0440467034895;792.8374683189933;796.9960150199241;797.1390897830329;687.2989550658325;819.115355416152;835.8328334333128;838.0278876503257;838.5010918503481;682.2427105912433;810.7608255564593;821.876718492225;822.0258993093204;823.7816978500703;595.7557401465422;599.7511032921333;599.865030368168;601.9428154325332;605.5186127029023;12272.509099636003;12394;12447;12458.81311780324;12484.625461236086;11450.312981221154;11789.233699809485;12016.158868879182;12032.759344813056;12041.819372709417;9178.449293042439;9366.812663746756;9411.341206115574;9566.282528810367;9587.952060239724;3549.236914063463;3607.2244467439627;3615.168511242429;3639.6906262967677;3652.817359132059;44565.55434445647;44689.77655111704;44752.55247447517;44790.776046119885;44841.32738008932;9596.856047159297;9697.757556061155;9732.172765314886;9950.35322704022;10037;17881.195346209453;17904.194311256026;17990.460286191435;18004.459866204033;18023.459296221135;7033.824154396181;7046.6828992695455;7131.322524360177;7141.392981596622;7157;4189.518205406356;4249.68127390447;4259.595338442843;4288;4304.632472009473;2846.8576571171775;2885.653721553385;2887.826730396141;2891.233823036897;2893.9131826045254;565.8104534980828;572.3818276261627;574.6063946196869;585.519873703559;586.1003359842621;528.3184691747603;576.9048107062372;597.5070566782422;602.6805792929754;625.8028720952885;8487.405881588229;8623.353248506262;8878.73363799087;8912.73261802147;8996.730098097067;518.3598256153647;618.71229878106;636.3858876184504;653.7019099421324;683.3371629519359;3734.79458629778;3808.9428658570146;3956.228535435562;4214.452121224283;4264.6801489888385;53539;54292.45707542953;58225.70887145622;58330;58786;44575.55424445779;45139.77430112829;45453.54546454559;46079;51988.48011519912;46038.309425358646;46072.539274607494;46691.29963050625;46959.29561056587;47055.29417058747;8461.32309415233;8548.316134709085;8783.429077109968;8843.429117248994;8946.597403117006;32602.51096233606;32923.67076329206;33795.3240935175;33949.321013580084;34009;39890.80054599708;41610.37584436296;46019;47063.76468117638;47167.528324717685;10384.636537721144;10493.265471416928;10561.366318020944;10676.252662313875;10844.566217351217;11339.376334301693;11840.940795296314;12026.338551379758;12226.266424014588;12472.314022728837;10908.890911091104;10979.890201097887;11080.445977701243;11102.333859968428;11499.367534785333;11037.724056898642;11266.493007814832;11351;11417.0295524878;11751.118666099906;10558.630447934285;10625.25623206368;10775.6228532001;10988.615398461016;11542.192046556997;9806.65676701312;9844.409335439897;10003;10055.547500362647;10326.845097323696;9258.166764991183;9353.36705345615;9737.853932191165;10000.949995249977;10119.443430611387 08:27:58 INFO - PROCESS | 30259 | __end_tp_report 08:27:58 INFO - PROCESS | 30259 | __start_cc_report 08:27:58 INFO - PROCESS | 30259 | _x_x_mozilla_cycle_collect,966 08:27:58 INFO - PROCESS | 30259 | __end_cc_report 08:27:58 INFO - PROCESS | 30259 | __startTimestamp1452184078885__endTimestamp 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | ------- Summary: start ------- 08:27:58 INFO - PROCESS | 30259 | Number of tests: 6 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | [#0] dojo.html Cycles:165 Average:5091.26 Median:5292.55 stddev:543.60 (10.3%) stddev-sans-first:522.11 08:27:58 INFO - PROCESS | 30259 | Values: 3090.1 3161.0 3201.7 3206.9 3235.3 4862.9 4945.1 5099.8 5119.6 5153.7 5036.9 5127.1 5183.5 5200.7 5219.9 4694.4 4739.9 4748.4 4752.9 4791.7 4691.9 4718.5 4771.6 4776.7 4804.4 4525.2 4644.3 4741.5 4770.0 4795.3 4616.4 4678.5 4681.5 4712.0 4723.7 4701.9 4710.2 4713.3 4724.6 4756.4 4913.8 4982.0 4998.6 5012.9 5013.0 5492.0 5492.1 5495.1 5501.2 5507.4 5527.2 5527.4 5532.1 5534.8 5535.8 5026.4 5133.0 5143.6 5170.3 5233.1 5570.2 5598.0 5624.4 5625.7 5669.3 5392.5 5407.6 5410.8 5416.6 5417.4 5337.6 5384.4 5391.3 5429.0 5479.7 5462.8 5465.8 5466.5 5467.0 5515.6 5460.5 5469.4 5472.7 5475.6 5523.2 4131.4 4185.6 4223.8 4284.2 4301.4 3806.6 3807.4 3820.1 3837.9 3843.8 5036.6 5038.0 5039.5 5056.9 5079.3 5399.2 5406.3 5483.7 5507.6 5512.4 5017.6 5026.8 5037.2 5038.1 5038.8 4575.9 4576.2 4579.1 4616.6 4616.8 5525.9 5634.8 5637.4 5676.1 5781.2 5441.2 5471.1 5485.0 5496.9 5499.5 5685.3 5691.4 5696.2 5696.7 5707.3 5221.8 5340.5 5399.4 5464.6 5514.6 5459.5 5492.0 5495.9 5504.6 5512.9 5304.7 5331.4 5370.1 5373.8 5420.1 5331.2 5359.7 5375.5 5402.8 5431.4 5198.6 5202.8 5204.1 5219.8 5245.4 5284.7 5292.6 5312.2 5339.9 5341.1 5298.5 5329.1 5341.8 5358.0 5397.7 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | [#1] ext.html Cycles:180 Average:42969.97 Median:32143.10 stddev:70763.08 (220.2%) stddev-sans-first:70889.84 08:27:58 INFO - PROCESS | 30259 | Values: 530.7 539.9 564.0 570.8 589.5 27443.9 35805.8 35940.5 36215.3 36230.5 39448.0 39957.2 39969.6 39986.2 39995.4 7375.5 7459.5 8248.1 8395.7 8416.0 9837.1 10064.3 10069.1 10075.4 10077.7 9698.4 9830.1 9830.7 9831.5 9834.4 7507.9 7657.9 9680.8 9931.4 10176.9 9639.5 9746.5 9757.7 9760.2 9764.2 36091.0 36108.5 36468.8 36478.6 36549.6 3061.8 3093.4 3110.9 3171.9 3239.7 29645.1 30282.8 30305.4 30376.7 30400.2 3753.3 3866.5 4003.7 4016.1 4039.5 263546.0 263637.0 265037.0 265325.0 266010.0 53032.7 53935.7 59575.7 59585.0 59845.0 57734.7 58631.1 58838.7 58879.7 58915.1 13881.7 14111.4 14132.6 14139.3 14185.2 10962.5 11027.4 11036.1 11104.2 11133.8 17953.3 18097.5 18115.2 18215.5 18256.0 6889.5 7013.2 7065.6 7067.4 7168.5 874.8 893.4 921.4 969.3 1089.8 23851.5 24344.6 24628.6 24676.9 24689.6 992.4 1088.4 1094.4 1106.3 1168.0 13002.5 13558.0 13724.2 13741.6 13745.7 302142.0 304358.0 304608.0 305163.0 305582.0 47999.0 48360.0 48427.8 48430.8 48495.5 1279.3 1282.9 1317.7 1322.9 1324.7 24132.8 24952.6 25938.4 26475.5 28152.6 40633.4 40784.0 40970.0 41302.6 41310.2 239690.0 239851.0 239855.0 239962.0 240907.0 26632.6 28684.3 30211.7 30614.7 30710.7 35196.3 36170.0 36454.0 36580.3 36685.8 30624.7 31564.5 34358.3 35544.0 36183.6 29713.6 31140.8 31228.2 31318.5 32315.2 33885.3 33971.7 34185.3 34421.5 34459.8 31201.5 31484.7 31604.8 31796.3 31971.0 23628.3 23791.5 23901.5 24226.6 24359.0 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | [#2] jquery.html Cycles:180 Average:26445.30 Median:16922.35 stddev:72560.23 (428.8%) stddev-sans-first:72737.31 08:27:58 INFO - PROCESS | 30259 | Values: 342.0 342.8 343.8 344.4 344.5 13489.3 13848.4 16071.2 16408.4 17846.4 15714.4 15979.6 16425.8 16569.2 16619.1 5102.1 5382.1 5391.2 5394.8 5398.0 4034.3 4148.3 5260.2 5838.1 5996.4 5844.7 5846.2 5889.3 5900.8 5947.6 5779.8 5924.6 5926.8 5934.4 5941.2 5173.5 5186.4 5204.2 5205.3 5211.0 20330.7 21013.9 21172.9 21842.0 22411.9 2111.7 2143.2 2197.1 2218.4 2219.3 12830.3 13287.1 13556.0 14011.6 14155.1 1935.2 1947.2 1968.6 2024.6 2035.3 63911.7 68313.7 68486.3 68900.0 69867.0 11226.4 11337.9 12887.6 14822.0 14992.9 22625.5 22696.3 22794.0 22879.5 22886.1 8031.2 8108.9 8123.6 8128.0 8169.8 6790.9 6800.7 6820.8 6861.5 6862.1 6944.6 7116.9 7151.1 7152.9 7171.9 1566.4 1610.3 1638.3 1668.1 2145.5 790.1 1031.6 1045.7 1047.1 1049.7 15105.3 15138.7 15914.8 16047.5 16799.7 875.1 924.6 926.7 947.4 1018.1 7681.4 8632.4 9532.7 9611.5 9620.8 400288.0 402018.0 402144.0 404106.0 576135.0 66917.7 77480.6 79669.0 80609.2 81420.0 1076.4 1109.4 1113.7 1136.9 1157.5 14923.0 14978.9 15066.4 15110.6 15505.8 33502.7 34398.6 34578.5 35128.5 35310.8 45956.5 46262.0 46503.5 48760.0 49244.3 8501.7 8537.9 8978.1 8981.6 8999.1 10480.9 10582.2 12726.5 16408.2 16834.8 13737.2 13825.8 14083.4 14159.4 14271.7 13533.9 13558.5 13734.1 13956.3 14026.1 14314.1 14426.9 14438.6 14929.5 14951.2 7872.3 8109.3 8294.9 8920.2 9033.2 13492.1 13668.7 13770.0 13907.9 14302.0 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | [#3] mootools.html Cycles:180 Average:5072.83 Median:6466.69 stddev:2609.75 (40.4%) stddev-sans-first:2601.08 08:27:58 INFO - PROCESS | 30259 | Values: 1229.8 1414.5 1417.6 1528.2 1716.2 6458.8 7028.2 7153.5 7189.4 7201.6 7057.3 7069.5 7162.5 7168.9 7169.4 1850.9 1881.5 2129.3 2169.0 2171.0 2065.3 2087.8 2093.0 2094.1 2096.7 2066.2 2073.3 2074.6 2086.8 2135.3 2154.8 2163.2 2176.2 2181.9 2187.3 2186.4 2206.3 2208.0 2209.9 2210.9 7257.9 7318.2 7320.3 7323.0 7325.0 4336.5 4379.9 4382.2 4393.5 4396.3 2784.7 2929.3 2944.2 2959.8 2968.7 907.0 927.2 940.5 952.0 959.5 9404.2 9490.2 9504.8 9525.4 9574.1 3753.0 3760.7 3785.2 3799.0 3800.8 8319.4 8323.4 8345.3 8348.7 8384.7 4357.2 4363.4 4371.3 4372.7 4381.6 3985.9 3989.4 3991.8 3993.1 3999.2 3200.3 3230.4 3325.1 3341.2 3358.6 1048.8 1054.9 1062.6 1063.5 1077.7 967.9 972.6 973.2 1026.2 1042.8 6893.6 6953.0 6971.4 6978.9 6989.8 1085.3 1100.3 1120.2 1127.5 1142.8 5392.1 5499.2 5499.9 5504.9 5517.3 8254.0 8673.9 8680.8 8803.7 8901.8 8742.0 8772.5 8773.7 8775.0 8794.4 6601.2 6618.2 6626.7 6732.4 6975.9 6656.3 6710.0 6717.7 6733.0 6771.6 7566.3 7802.4 7957.7 7961.2 7979.3 7947.8 7982.4 8181.2 8200.3 8221.0 6490.7 6508.4 6570.0 6572.9 6582.2 6350.7 6474.6 6962.0 7016.7 7020.9 6564.2 6592.2 6617.4 6678.4 6695.3 6295.6 6414.9 6565.6 6586.1 6599.0 6505.6 6571.5 6579.0 6584.2 6589.6 6084.1 6120.1 6131.1 6132.9 6134.7 5989.0 6020.8 6037.7 6102.7 6177.3 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | [#4] prototype.html Cycles:180 Average:5224.29 Median:5878.55 stddev:1582.24 (26.9%) stddev-sans-first:1543.19 08:27:58 INFO - PROCESS | 30259 | Values: 315.8 318.3 320.0 329.5 329.5 5814.9 5853.2 5858.3 5898.8 5944.2 5579.5 5634.8 5712.3 5813.7 5821.4 4463.5 4464.7 4484.5 4492.0 4509.9 4498.6 4502.3 4503.9 4504.9 4512.0 4254.5 4333.5 4342.4 4391.6 4425.7 4448.3 4448.4 4453.4 4470.7 4471.6 3920.0 3922.7 3924.5 3932.7 3934.3 5557.9 5560.2 5563.2 5569.9 5590.9 5104.7 5191.9 5192.2 5203.2 5209.9 6173.1 6179.5 6180.1 6180.6 6180.7 4337.0 4344.8 4346.4 4347.5 4347.9 6316.6 6438.2 6467.1 6483.8 6485.5 4429.0 4432.5 4432.6 4444.4 4445.0 4486.2 4493.8 4495.5 4495.5 4498.3 5171.0 5171.8 5178.3 5185.4 5186.5 6132.0 6244.9 6245.4 6254.3 6258.1 1568.3 1568.9 1569.2 1573.4 1573.7 1066.3 1068.9 1070.6 1088.7 1092.6 5912.5 5913.7 5925.6 5929.9 5933.1 6392.8 6397.0 6404.3 6409.0 6410.8 5709.5 5740.5 5819.9 5926.8 5979.8 3464.3 3467.8 3491.7 3492.2 3497.7 6760.2 6766.4 6781.8 6782.4 6787.5 6495.4 6630.3 6633.7 6646.8 6653.1 6757.2 6782.0 6783.4 6789.9 6797.5 6454.0 6456.2 6460.2 6461.3 6466.6 6265.4 6393.6 6405.5 6406.9 6409.4 6728.9 6733.2 6735.0 6739.1 6739.2 4504.8 4508.6 4513.4 4515.7 4518.8 6378.1 6497.8 6509.4 6514.1 6514.5 6305.6 6328.3 6331.2 6331.8 6336.8 6310.6 6313.2 6315.5 6317.7 6324.0 6059.9 6188.0 6192.6 6198.6 6201.8 6329.0 6355.3 6356.0 6357.0 6358.7 6197.9 6206.4 6206.9 6212.1 6213.0 08:27:58 INFO - PROCESS | 30259 | 08:27:58 INFO - PROCESS | 30259 | [#5] yui.html Cycles:180 Average:13374.10 Median:45736.27 stddev:15369.64 (33.6%) stddev-sans-first:15383.17 08:27:58 INFO - PROCESS | 30259 | Values: 675.3 716.6 739.8 815.6 830.0 13307.7 13504.6 13582.7 13606.3 13622.5 12662.6 12863.0 12877.7 12891.5 12910.9 655.3 662.2 770.5 782.6 793.9 779.5 790.0 792.8 797.0 797.1 687.3 819.1 835.8 838.0 838.5 682.2 810.8 821.9 822.0 823.8 595.8 599.8 599.9 601.9 605.5 12272.5 12394.0 12447.0 12458.8 12484.6 11450.3 11789.2 12016.2 12032.8 12041.8 9178.4 9366.8 9411.3 9566.3 9588.0 3549.2 3607.2 3615.2 3639.7 3652.8 44565.6 44689.8 44752.6 44790.8 44841.3 9596.9 9697.8 9732.2 9950.4 10037.0 17881.2 17904.2 17990.5 18004.5 18023.5 7033.8 7046.7 7131.3 7141.4 7157.0 4189.5 4249.7 4259.6 4288.0 4304.6 2846.9 2885.7 2887.8 2891.2 2893.9 565.8 572.4 574.6 585.5 586.1 528.3 576.9 597.5 602.7 625.8 8487.4 8623.4 8878.7 8912.7 8996.7 518.4 618.7 636.4 653.7 683.3 3734.8 3808.9 3956.2 4214.5 4264.7 53539.0 54292.5 58225.7 58330.0 58786.0 44575.6 45139.8 45453.5 46079.0 51988.5 46038.3 46072.5 46691.3 46959.3 47055.3 8461.3 8548.3 8783.4 8843.4 8946.6 32602.5 32923.7 33795.3 33949.3 34009.0 39890.8 41610.4 46019.0 47063.8 47167.5 10384.6 10493.3 10561.4 10676.3 10844.6 11339.4 11840.9 12026.3 12226.3 12472.3 10908.9 10979.9 11080.4 11102.3 11499.4 11037.7 11266.5 11351.0 11417.0 11751.1 10558.6 10625.3 10775.6 10988.6 11542.2 9806.7 9844.4 10003.0 10055.5 10326.8 9258.2 9353.4 9737.9 10000.9 10119.4 08:27:58 INFO - PROCESS | 30259 | -------- Summary: end -------- 08:27:58 INFO - PROCESS | 30259 | 08:27:59 INFO - TEST-INFO | 30259: exit 0 08:27:59 INFO - TEST-OK | dromaeo_css | took 1112502ms 08:27:59 INFO - TEST-START | kraken 08:27:59 INFO - operating with platform_type : linux_ 08:27:59 INFO - Initialising browser for kraken test... 08:27:59 INFO - TEST-INFO | started process 30454 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAPPYbo/profile http://localhost:38151/getInfo.html) 08:28:03 INFO - PROCESS | 30454 | __metrics Screen width/height:1600/1200 08:28:03 INFO - PROCESS | 30454 | colorDepth:24 08:28:03 INFO - PROCESS | 30454 | Browser inner width/height: 1024/697 08:28:03 INFO - PROCESS | 30454 | __metrics 08:28:03 INFO - PROCESS | 30454 | 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:28:03 INFO - PROCESS | 30454 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:04 INFO - TEST-INFO | 30454: exit 0 08:28:04 INFO - Browser initialized. 08:28:04 INFO - Running cycle 1/1 for kraken test... 08:28:04 INFO - TEST-INFO | started process 30535 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAPPYbo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:16 INFO - PROCESS | 30535 | RSS: Main: 150134784 08:28:16 INFO - PROCESS | 30535 | 08:28:18 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38151/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:19 INFO - PROCESS | 30535 | RSS: Main: 184692736 08:28:19 INFO - PROCESS | 30535 | 08:28:21 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38151/tests/kraken/driver.html?testName=audio-dft) 08:28:22 INFO - PROCESS | 30535 | RSS: Main: 175525888 08:28:22 INFO - PROCESS | 30535 | 08:28:25 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38151/tests/kraken/driver.html?testName=audio-fft) 08:28:25 INFO - PROCESS | 30535 | RSS: Main: 160608256 08:28:25 INFO - PROCESS | 30535 | 08:28:28 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38151/tests/kraken/driver.html?testName=audio-oscillator) 08:28:28 INFO - PROCESS | 30535 | RSS: Main: 163450880 08:28:28 INFO - PROCESS | 30535 | 08:28:30 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:31 INFO - PROCESS | 30535 | RSS: Main: 166113280 08:28:31 INFO - PROCESS | 30535 | 08:28:34 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38151/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:34 INFO - PROCESS | 30535 | RSS: Main: 166440960 08:28:34 INFO - PROCESS | 30535 | 08:28:38 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38151/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:38 INFO - PROCESS | 30535 | RSS: Main: 166088704 08:28:38 INFO - PROCESS | 30535 | 08:28:41 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38151/tests/kraken/driver.html?testName=json-parse-financial) 08:28:42 INFO - PROCESS | 30535 | RSS: Main: 167636992 08:28:42 INFO - PROCESS | 30535 | 08:28:43 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:44 INFO - PROCESS | 30535 | RSS: Main: 176955392 08:28:44 INFO - PROCESS | 30535 | 08:28:45 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:46 INFO - PROCESS | 30535 | RSS: Main: 174116864 08:28:46 INFO - PROCESS | 30535 | 08:28:48 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:49 INFO - PROCESS | 30535 | RSS: Main: 188088320 08:28:49 INFO - PROCESS | 30535 | 08:28:51 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:52 INFO - PROCESS | 30535 | RSS: Main: 193740800 08:28:52 INFO - PROCESS | 30535 | 08:28:54 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:55 INFO - PROCESS | 30535 | RSS: Main: 190844928 08:28:55 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | Cycle 1(1): loaded http://localhost:38151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38151/tests/kraken/driver.html?testName=ai-astar) 08:28:57 INFO - PROCESS | 30535 | RSS: Main: 248295424 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | __start_tp_report 08:28:57 INFO - PROCESS | 30535 | _x_x_mozilla_page_load 08:28:57 INFO - PROCESS | 30535 | _x_x_mozilla_page_load_details 08:28:57 INFO - PROCESS | 30535 | |i|pagename|runs| 08:28:57 INFO - PROCESS | 30535 | |0;ai-astar;109;110;104;109;112;110;99;110;109;110 08:28:57 INFO - PROCESS | 30535 | |1;audio-beat-detection;148;123;146;172;128;175;159;125;166;122 08:28:57 INFO - PROCESS | 30535 | |2;audio-dft;162;162;161;161;160;162;160;162;162;162 08:28:57 INFO - PROCESS | 30535 | |3;audio-fft;72;73;81;96;72;74;75;112;92;71 08:28:57 INFO - PROCESS | 30535 | |4;audio-oscillator;97;97;144;95;96;96;139;97;96;138 08:28:57 INFO - PROCESS | 30535 | |5;imaging-gaussian-blur;109;109;109;110;109;109;110;109;110;109 08:28:57 INFO - PROCESS | 30535 | |6;imaging-darkroom;146;145;145;146;146;146;146;166;145;145 08:28:57 INFO - PROCESS | 30535 | |7;imaging-desaturate;96;97;97;97;96;96;96;96;96;96 08:28:57 INFO - PROCESS | 30535 | |8;json-parse-financial;57;56;58;56;63;56;57;65;55;56 08:28:57 INFO - PROCESS | 30535 | |9;json-stringify-tinderbox;67;68;66;71;67;67;67;67;67;68 08:28:57 INFO - PROCESS | 30535 | |10;stanford-crypto-aes;84;86;87;86;86;86;86;86;88;93 08:28:57 INFO - PROCESS | 30535 | |11;stanford-crypto-ccm;124;119;128;116;123;119;122;120;116;118 08:28:57 INFO - PROCESS | 30535 | |12;stanford-crypto-pbkdf2;144;143;150;150;145;141;154;153;154;142 08:28:57 INFO - PROCESS | 30535 | |13;stanford-crypto-sha256-iterative;69;68;68;69;69;67;68;70;67;68 08:28:57 INFO - PROCESS | 30535 | __end_tp_report 08:28:57 INFO - PROCESS | 30535 | __start_cc_report 08:28:57 INFO - PROCESS | 30535 | _x_x_mozilla_cycle_collect,958 08:28:57 INFO - PROCESS | 30535 | __end_cc_report 08:28:57 INFO - PROCESS | 30535 | __startTimestamp1452184137340__endTimestamp 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | ------- Summary: start ------- 08:28:57 INFO - PROCESS | 30535 | Number of tests: 14 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.82 (3.5%) stddev-sans-first:4.04 08:28:57 INFO - PROCESS | 30535 | Values: 109.0 110.0 104.0 109.0 112.0 110.0 99.0 110.0 109.0 110.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:153.50 stddev:20.97 (13.7%) stddev-sans-first:22.24 08:28:57 INFO - PROCESS | 30535 | Values: 148.0 123.0 146.0 172.0 128.0 175.0 159.0 125.0 166.0 122.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 08:28:57 INFO - PROCESS | 30535 | Values: 162.0 162.0 161.0 161.0 160.0 162.0 160.0 162.0 162.0 162.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.50 stddev:13.79 (18.5%) stddev-sans-first:14.16 08:28:57 INFO - PROCESS | 30535 | Values: 72.0 73.0 81.0 96.0 72.0 74.0 75.0 112.0 92.0 71.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:21.34 (22.2%) stddev-sans-first:22.15 08:28:57 INFO - PROCESS | 30535 | Values: 97.0 97.0 144.0 95.0 96.0 96.0 139.0 97.0 96.0 138.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:28:57 INFO - PROCESS | 30535 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:146.00 stddev:6.48 (4.4%) stddev-sans-first:6.85 08:28:57 INFO - PROCESS | 30535 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 146.0 166.0 145.0 145.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:28:57 INFO - PROCESS | 30535 | Values: 96.0 97.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.00 stddev:3.35 (5.9%) stddev-sans-first:3.54 08:28:57 INFO - PROCESS | 30535 | Values: 57.0 56.0 58.0 56.0 63.0 56.0 57.0 65.0 55.0 56.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 08:28:57 INFO - PROCESS | 30535 | Values: 67.0 68.0 66.0 71.0 67.0 67.0 67.0 67.0 67.0 68.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:2.39 (2.8%) stddev-sans-first:2.32 08:28:57 INFO - PROCESS | 30535 | Values: 84.0 86.0 87.0 86.0 86.0 86.0 86.0 86.0 88.0 93.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.00 stddev:3.78 (3.1%) stddev-sans-first:3.79 08:28:57 INFO - PROCESS | 30535 | Values: 124.0 119.0 128.0 116.0 123.0 119.0 122.0 120.0 116.0 118.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.00 stddev:5.15 (3.4%) stddev-sans-first:5.29 08:28:57 INFO - PROCESS | 30535 | Values: 144.0 143.0 150.0 150.0 145.0 141.0 154.0 153.0 154.0 142.0 08:28:57 INFO - PROCESS | 30535 | 08:28:57 INFO - PROCESS | 30535 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 08:28:57 INFO - PROCESS | 30535 | Values: 69.0 68.0 68.0 69.0 69.0 67.0 68.0 70.0 67.0 68.0 08:28:57 INFO - PROCESS | 30535 | -------- Summary: end -------- 08:28:57 INFO - PROCESS | 30535 | 08:28:58 INFO - TEST-INFO | 30535: exit 0 08:28:58 INFO - TEST-OK | kraken | took 58633ms 08:28:58 INFO - TEST-START | v8_7 08:28:58 INFO - operating with platform_type : linux_ 08:28:58 INFO - Initialising browser for v8_7 test... 08:28:58 INFO - TEST-INFO | started process 30784 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjyQo_K/profile http://localhost:38151/getInfo.html) 08:29:02 INFO - PROCESS | 30784 | __metrics Screen width/height:1600/1200 08:29:02 INFO - PROCESS | 30784 | colorDepth:24 08:29:02 INFO - PROCESS | 30784 | Browser inner width/height: 1024/697 08:29:02 INFO - PROCESS | 30784 | __metrics 08:29:02 INFO - PROCESS | 30784 | 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:29:02 INFO - PROCESS | 30784 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:03 INFO - TEST-INFO | 30784: exit 0 08:29:03 INFO - Browser initialized. 08:29:03 INFO - Running cycle 1/1 for v8_7 test... 08:29:03 INFO - TEST-INFO | started process 30866 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjyQo_K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:14 INFO - PROCESS | 30866 | RSS: Main: 149733376 08:29:14 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | Cycle 1(1): loaded http://localhost:38151/tests/v8_7/run.html (next: http://localhost:38151/tests/v8_7/run.html) 08:29:36 INFO - PROCESS | 30866 | RSS: Main: 559611904 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | __start_tp_report 08:29:36 INFO - PROCESS | 30866 | _x_x_mozilla_page_load 08:29:36 INFO - PROCESS | 30866 | _x_x_mozilla_page_load_details 08:29:36 INFO - PROCESS | 30866 | |i|pagename|runs| 08:29:36 INFO - PROCESS | 30866 | |0;Richards;167.16817118020728 08:29:36 INFO - PROCESS | 30866 | |1;DeltaBlue;190.00570017100512 08:29:36 INFO - PROCESS | 30866 | |2;Encrypt;280.662363177098 08:29:36 INFO - PROCESS | 30866 | |3;Decrypt;5154.639175257732 08:29:36 INFO - PROCESS | 30866 | |4;RayTrace;1107.3008849557523 08:29:36 INFO - PROCESS | 30866 | |5;Earley;789.8894154818325 08:29:36 INFO - PROCESS | 30866 | |6;Boyer;12587.5 08:29:36 INFO - PROCESS | 30866 | |7;RegExp;26421.052631578947 08:29:36 INFO - PROCESS | 30866 | |8;Splay;607.90273556231 08:29:36 INFO - PROCESS | 30866 | |9;NavierStokes;4826.923076923077 08:29:36 INFO - PROCESS | 30866 | __end_tp_report 08:29:36 INFO - PROCESS | 30866 | __startTimestamp1452184176531__endTimestamp 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | ------- Summary: start ------- 08:29:36 INFO - PROCESS | 30866 | Number of tests: 10 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 167.2 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#1] DeltaBlue Cycles:1 Average:190.01 Median:190.01 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 190.0 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 280.7 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 5154.6 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#4] RayTrace Cycles:1 Average:1107.30 Median:1107.30 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 1107.3 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 789.9 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 12587.5 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#7] RegExp Cycles:1 Average:26421.05 Median:26421.05 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 26421.1 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#8] Splay Cycles:1 Average:607.90 Median:607.90 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 607.9 08:29:36 INFO - PROCESS | 30866 | 08:29:36 INFO - PROCESS | 30866 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:29:36 INFO - PROCESS | 30866 | Values: 4826.9 08:29:36 INFO - PROCESS | 30866 | -------- Summary: end -------- 08:29:36 INFO - PROCESS | 30866 | 08:29:37 INFO - TEST-INFO | 30866: exit 0 08:29:37 INFO - TEST-OK | v8_7 | took 39137ms 08:29:37 INFO - SUITE-END | took 1210s 08:29:37 INFO - Completed test suite (00:20:10) 08:29:37 INFO - Working with test: dromaeo_css 08:29:37 INFO - Generating results file: dromaeo_css 08:29:37 INFO - Working with test: kraken 08:29:37 INFO - Generating results file: kraken 08:29:37 INFO - javascript benchmark 08:29:37 INFO - Working with test: v8_7 08:29:37 INFO - Generating results file: v8_7 08:29:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:29:37 INFO - process_Request line: dromaeo_css 6779.08 graph.html#tests=[[72,201,35]] 08:29:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:37 INFO - process_Request line: kraken 1509.10 graph.html#tests=[[232,201,35]] 08:29:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:37 INFO - process_Request line: v8_7 20900.06 graph.html#tests=[[230,201,35]] 08:29:37 INFO - RETURN: dromaeo_css: 6779.08 08:29:37 INFO - RETURN: kraken: 1509.10 08:29:37 INFO - RETURN: v8_7: 20900.06 08:29:37 INFO - javascript benchmark 08:29:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3090.088423914945, 3160.956884228205, 3201.695838895304, 3206.855691493884, 3235.2882365879505, 4862.854114376565, 4945.085159245542, 5099.776053747102, 5119.564836988856, 5153.716545589991, 5036.866704991375, 5127.077126117298, 5183.481651834824, 5200.713960732158, 5219.9478005219935, 4694.366260554824, 4739.928901066487, 4748.35897153885, 4752.864869140492, 4791.736454495001, 4691.88270293242, 4718.528147185289, 4771.570558649721, 4776.737279449629, 4804.37543119394, 4525.208088584484, 4644.326572646981, 4741.514360313333, 4769.976150119262, 4795.256735206031, 4616.39986801717, 4678.508756580578, 4681.46163191234, 4711.976440117812, 4723.692959957626, 4701.929471057937, 4710.246360582325, 4713.34013238147, 4724.551167639103, 4756.357891684613, 4913.803447862081, 4981.975090124526, 4998.600111991032, 5012.8997420051755, 5013.022460620144, 5491.972540137313, 5492.1212605982855, 5495.0658388073725, 5501.229827824108, 5507.366652834895, 5527.170924361338, 5527.419620939783, 5532.059549876491, 5534.75093620784, 5535.806246781383, 5026.447090820006, 5132.999065182291, 5143.639945203838, 5170.250313704491, 5233.1365324721755, 5570.192322113271, 5597.99236137491, 5624.409437009137, 5625.6905870176715, 5669.291338582677, 5392.514673679388, 5407.648502847303, 5410.783568657288, 5416.566674666096, 5417.404085550586, 5337.62636615441, 5384.434634363413, 5391.272178255886, 5428.972855135699, 5479.698616576126, 5462.754176062087, 5465.754041068161, 5466.480684334982, 5467.015937131355, 5515.61390702655, 5460.481254280837, 5469.425710300441, 5472.671639701631, 5475.6440831345835, 5523.226748255167, 4131.380292956021, 4185.6232939035635, 4223.831046758095, 4284.207421627009, 4301.376300436419, 3806.562245341821, 3807.371783655721, 3820.083180036771, 3837.865674701372, 3843.8462461501786, 5036.597072234213, 5038.042771873405, 5039.521245481674, 5056.898862022739, 5079.288899554065, 5399.217113518518, 5406.297181366476, 5483.698396588146, 5507.614466987273, 5512.448755124536, 5017.648764586444, 5026.79892804291, 5037.168867136881, 5038.1435156022835, 5038.79844806211, 4575.9427634520525, 4576.176288268143, 4579.129965306581, 4616.630669546428, 4616.838410655611, 5525.944740552623, 5634.830955071355, 5637.351704553947, 5676.148577713376, 5781.248437703156, 5441.21102440136, 5471.097268950738, 5485.040117979258, 5496.917546236729, 5499.450054994469, 5685.317761868602, 5691.402402747817, 5696.231008813757, 5696.686682232517, 5707.286589176353, 5221.765020574007, 5340.49265319794, 5399.4060653327315, 5464.617476776588, 5514.558835293086, 5459.508644222039, 5492.0, 5495.945040549544, 5504.587155963399, 5512.91730624049, 5304.655197412156, 5331.413544510178, 5370.087085195604, 5373.838784836461, 5420.13277875538, 5331.200319952039, 5359.732013399393, 5375.489328513785, 5402.837914862561, 5431.402545719889, 5198.610104242121, 5202.765875535534, 5204.063268611686, 5219.817306394258, 5245.396779370421, 5284.735763211901, 5292.5501332387175, 5312.1766126250495, 5339.866503337447, 5341.065313570032, 5298.549623282064, 5329.147336426153, 5341.813036543703, 5358.0, 5397.730113494388], "unit": "score", "name": "dojo.html", "value": 5057.912717560548}, {"lowerIsBetter": false, "replicates": [530.7478947499941, 539.9109146990746, 563.963342382745, 570.754575532521, 589.5283772981613, 27443.862780686093, 35805.82097089514, 35940.46089308656, 36215.27569448616, 36230.45654315184, 39448.0, 39957.20085598286, 39969.60030399695, 39986.20027599454, 39995.40006899892, 7375.483716139873, 7459.515131516434, 8248.051474080483, 8395.706150284741, 8416.032156302012, 9837.065478779505, 10064.29549931505, 10069.144122749574, 10075.395476271411, 10077.748056298578, 9698.418094914292, 9830.066143716336, 9830.705078847646, 9831.459269740162, 9834.360766550151, 7507.924920750777, 7657.923420765776, 9680.757981050494, 9931.404115753077, 10176.949115254376, 9639.469829159394, 9746.46394448305, 9757.658481953098, 9760.17038551724, 9764.170045546138, 36091.0, 36108.45837312443, 36468.817655911815, 36478.63521364806, 36549.63450365489, 3061.7703672224447, 3093.427715872571, 3110.9222269443217, 3171.9365612687616, 3239.676032396765, 29645.110646680634, 30282.84858575693, 30305.393892122254, 30376.69623303783, 30400.239994000105, 3753.305638456894, 3866.4780254665543, 4003.73975691582, 4016.0763024504236, 4039.454673619053, 263546.0, 263637.0, 265037.0, 265325.0, 266010.0, 53032.73483632557, 53935.73032134893, 59575.702121489114, 59585.0, 59845.0, 57734.711326443095, 58631.120533192036, 58838.70580647155, 58879.70560147172, 58915.11627325508, 13881.681240282158, 14111.435542578181, 14132.576022719335, 14139.293035348192, 14185.219812910183, 10962.506687198937, 11027.393493357782, 11036.11711063113, 11104.222704410775, 11133.777324453466, 17953.281868725368, 18097.457076287734, 18115.184816683282, 18215.45353639393, 18256.0, 6889.483288753364, 7013.228544860061, 7065.646717664096, 7067.43460523157, 7168.53404528704, 874.8162885793927, 893.4014210478995, 921.4287141971886, 969.340848223215, 1089.7983872983366, 23851.52296954051, 24344.634830477557, 24628.630570541456, 24676.876615617166, 24689.62965555518, 992.3847214726916, 1088.4176965323513, 1094.441834664327, 1106.269861891148, 1168.0305346562334, 13002.479900803863, 13558.0, 13724.245166515739, 13741.587752367444, 13745.725085498434, 302141.9571608555, 304358.0, 304608.0, 305163.0, 305582.0, 47999.0, 48360.0, 48427.757861211176, 48430.757846210545, 48495.5150448498, 1279.264422956785, 1282.8717128287283, 1317.6969297061537, 1322.9272390018448, 1324.6820763016806, 24132.758672413052, 24952.625710614717, 25938.35154121162, 26475.470490590465, 28152.577711333935, 40633.39049914195, 40784.0, 40970.0, 41302.586974129874, 41310.1737965233, 239690.0, 239851.0, 239855.0, 239962.0, 240907.0, 26632.60562007247, 28684.282892927844, 30211.697883021767, 30614.693853061184, 30710.692893070784, 35196.296074078884, 36170.0, 36454.0, 36580.26839463143, 36685.81657091804, 30624.693753062184, 31564.526532101576, 34358.31283374268, 35544.0, 36183.63816361908, 29713.554296685135, 31140.844295778377, 31228.219294517818, 31318.530222046233, 32315.19212019718, 33885.3222935535, 33971.66028339685, 34185.316293674485, 34421.483677744356, 34459.82770086134, 31201.531977020815, 31484.685153148177, 31604.787664863237, 31796.29731472851, 31971.0, 23628.29115126549, 23791.524169516168, 23901.521969560163, 24226.636600450656, 24359.0], "unit": "score", "name": "ext.html", "value": 17541.835985418245}, {"lowerIsBetter": false, "replicates": [342.03716537945684, 342.76006795243336, 343.7804956581613, 344.3973047167457, 344.5228358723168, 13489.258090805002, 13848.446062157502, 16071.196440177988, 16408.425705100322, 17846.37537686181, 15714.449994250175, 15979.600509987256, 16425.753613695804, 16569.17154142294, 16619.08595027273, 5102.056119617873, 5382.058139825534, 5391.245225668409, 5394.7842086316505, 5398.0, 4034.2939985502567, 4148.253314403406, 5260.184671375943, 5838.124281357809, 5996.430339117776, 5844.678542680151, 5846.181534585162, 5889.263842019747, 5900.822975310747, 5947.583669143161, 5779.768809247625, 5924.58527903047, 5926.792562260322, 5934.376890426508, 5941.19793827832, 5173.4826517347965, 5186.403563590197, 5204.219367094928, 5205.29728486657, 5210.973945130288, 20330.695039574417, 21013.894930525403, 21172.89413552938, 21842.0, 22411.887940560355, 2111.746590409161, 2143.153454385509, 2197.1321328075483, 2218.4232099654046, 2219.323106452531, 12830.294333811637, 13287.069905106646, 13556.0, 14011.649708757363, 14155.079919805283, 1935.2162374238455, 1947.1821834829407, 1968.635802376565, 2024.5647185854964, 2035.2774764958374, 63911.68044159749, 68313.65843170752, 68486.31513684899, 68899.9999999995, 69867.0, 11226.438678066064, 11337.943310283561, 12887.61337159868, 14822.0, 14992.925035374754, 22625.54748905013, 22696.319110426713, 22794.0, 22879.542409152058, 22886.084556617883, 8031.156728543536, 8108.918910810817, 8123.634436450374, 8127.959360203161, 8169.75490735267, 6790.864182716318, 6800.727970881109, 6820.795376138723, 6861.519693621499, 6862.107925969592, 6944.583325000516, 7116.92883071173, 7151.070360853056, 7152.92847071533, 7171.89242161368, 1566.3577933047395, 1610.3091753658612, 1638.279157170865, 1668.0575474856666, 2145.463634091477, 790.0755423106253, 1031.6286136990677, 1045.7437927707608, 1047.0942634621151, 1049.6850944716707, 15105.3202605883, 15138.653508706167, 15914.76127858083, 16047.518574442785, 16799.664006720042, 875.0636818604032, 924.611663101499, 926.6571368593663, 947.4410098042188, 1018.1498448795339, 7681.3854891608535, 8632.395732298679, 9532.714018579454, 9611.519424028771, 9620.75948101303, 400288.0, 402018.0, 402144.0, 404106.0, 576135.0, 66917.6654116736, 77480.61259693665, 79669.0, 80609.19390806017, 81420.0, 1076.4294923690456, 1109.4120116338354, 1113.704868209925, 1136.891995260449, 1157.450211149714, 14923.0, 14978.925105374403, 15066.397344106113, 15110.622234444227, 15505.84494155044, 33502.66497334996, 34398.6043000756, 34578.48132277968, 35128.47307290341, 35310.823445882605, 45956.54043459523, 46262.0, 46503.53496465128, 48760.0, 49244.26133607927, 8501.702440414803, 8537.871931920901, 8978.147076027766, 8981.550922453982, 8999.10008999121, 10480.895191047992, 10582.206334524788, 12726.490940362652, 16408.17959102016, 16834.831651683817, 13737.24445155526, 13825.792613111013, 14083.436662533384, 14159.433622654979, 14271.71456570842, 13533.932330338286, 13558.457661693421, 13734.107283026571, 13956.302184890917, 14026.08830426019, 14314.069585476911, 14426.85573144255, 14438.566842994727, 14929.477468288558, 14951.177685227416, 7872.252136047066, 8109.3107085896, 8294.917050829414, 8920.152585504367, 9033.187013168847, 13492.12301200419, 13668.65828354299, 13770.0, 13907.930460347634, 14302.0], "unit": "score", "name": "jquery.html", "value": 9111.442300119628}, {"lowerIsBetter": false, "replicates": [1229.7847876621588, 1414.5473448496482, 1417.5818133650573, 1528.1900592685881, 1716.1505054997779, 6458.806235812927, 7028.191757947831, 7153.463490238233, 7189.352958233758, 7201.567905925635, 7057.29427057294, 7069.469789765775, 7162.534435261718, 7168.928310716891, 7169.390601798853, 1850.8889466631979, 1881.5202123458566, 2129.318618042223, 2168.9891550542225, 2171.023039632164, 2065.3390914907236, 2087.77034526202, 2093.0, 2094.1309356616985, 2096.6540520814046, 2066.245820275596, 2073.295079672911, 2074.553970896257, 2086.8017538333834, 2135.3487186408215, 2154.762976072631, 2163.156369016085, 2176.249194028058, 2181.923632672857, 2187.2563328468395, 2186.3768825884545, 2206.293985924505, 2207.966880496778, 2209.9226527071637, 2210.9115635374565, 7257.8911316330295, 7318.231585683533, 7320.304571065741, 7323.0, 7324.963375183143, 4336.479622445295, 4379.912401751947, 4382.211201983641, 4393.53867843875, 4396.318570621559, 2784.707605701413, 2929.29696872749, 2944.219781757836, 2959.7928145029855, 2968.7328140467243, 906.9773255668595, 927.2072378116748, 940.4874343482818, 951.9533004041366, 959.4770849886828, 9404.153626173676, 9490.193333566654, 9504.762380940394, 9525.380850244712, 9574.090461406155, 3753.042974041602, 3760.7179461540495, 3785.2240290740333, 3799.0, 3800.847966081326, 8319.417640765208, 8323.375746818892, 8345.332373410112, 8348.707795227137, 8384.706535271236, 4357.172137293904, 4363.36731173978, 4371.256886329332, 4372.650187984954, 4381.6494680425485, 3985.9202815943518, 3989.4215338776294, 3991.8004099794894, 3993.1414745829784, 3999.1601763629383, 3200.3119329344304, 3230.353929214167, 3325.1354647791263, 3341.198112452994, 3358.630550639428, 1048.7640280936728, 1054.8554669052799, 1062.6493257225097, 1063.4682658670665, 1077.6820837852695, 967.8983706710835, 972.6352617768337, 973.1971123822874, 1026.2405819693522, 1042.7705904700954, 6893.551919125241, 6953.0, 6971.372576468142, 6978.930210697828, 6989.755358562527, 1085.2511766880828, 1100.2518287564374, 1120.1542835159403, 1127.520803658442, 1142.8342890280862, 5392.056390131711, 5499.202615620713, 5499.945000549943, 5504.862378440491, 5517.2551705520045, 8253.95873020631, 8673.913260867437, 8680.826383472422, 8803.691870784492, 8901.777455563662, 8742.038375778659, 8772.473651580925, 8773.692920747872, 8775.0, 8794.42836215644, 6601.207855057424, 6618.205815302098, 6626.7017984190825, 6732.394084532416, 6975.860482790417, 6656.267810540739, 6709.966450167718, 6717.664116794043, 6733.0, 6771.559848609824, 7566.31903128721, 7802.414818888719, 7957.721479748181, 7961.16407777175, 7979.281864632211, 7947.801304967422, 7982.361411086983, 8181.181881812009, 8200.302974247255, 8221.0, 6490.740370385131, 6508.381703738138, 6570.047343135314, 6572.901406478811, 6582.210134783665, 6350.7142178603, 6474.5791523550815, 6961.965190174017, 7016.684249208696, 7020.859582808417, 6564.179477565304, 6592.24189218246, 6617.371349721769, 6678.398944094861, 6695.330466953461, 6295.5907865988565, 6414.903776443451, 6565.606063636006, 6586.077949087035, 6598.967005164944, 6505.60966342021, 6571.507136964842, 6578.967105164444, 6584.176977877765, 6589.6046237224, 6084.087386892002, 6120.08198770188, 6131.141640170291, 6132.938670613236, 6134.693265336805, 5988.970055149696, 6020.8259389418645, 6037.69811509414, 6102.694865256631, 6177.320494745484], "unit": "score", "name": "mootools.html", "value": 4171.260043240061}, {"lowerIsBetter": false, "replicates": [315.8499712636497, 318.312445118544, 319.9648038715741, 329.453107840984, 329.4761329486118, 5814.854628634286, 5853.151293062503, 5858.271809816104, 5898.823035308937, 5944.197533332998, 5579.46995035472, 5634.830955071344, 5712.257406537145, 5813.73838177282, 5821.446962538552, 4463.531329210435, 4464.6651501137385, 4484.506704262529, 4491.977540112295, 4509.864704058867, 4498.617617502517, 4502.279635258359, 4503.932441013388, 4504.887377815565, 4511.977440112795, 4254.510731265897, 4333.544977777336, 4342.413774140482, 4391.582799634046, 4425.668074894395, 4448.33275008748, 4448.421705178306, 4453.398791163217, 4470.687051906368, 4471.552844715502, 3920.0, 3922.666573341269, 3924.50943632046, 3932.744371615836, 3934.311495488278, 5557.888842223133, 5560.193771903051, 5563.248961390201, 5569.8607534811545, 5590.888182236333, 5104.719240441774, 5191.948080519184, 5192.221166825007, 5203.219517072432, 5209.895802083975, 6173.074038894157, 6179.5056395488255, 6180.134781130645, 6180.567360284782, 6180.721867515973, 4336.978315108436, 4344.7827608619755, 4346.369776382407, 4347.543507931653, 4347.913041739179, 6316.557840951135, 6438.227412710505, 6467.094606755058, 6483.773067942647, 6485.5460117792245, 4428.9813342930665, 4432.512423633398, 4432.601065904019, 4444.444444444444, 4444.999875028093, 4486.170058539181, 4493.842715505007, 4495.460544734653, 4495.527969563214, 4498.257787465097, 5171.043356978971, 5171.818986335536, 5178.326817513775, 5185.403678576937, 5186.481351864859, 6132.049532322497, 6244.906326405107, 6245.406686364788, 6254.280757712831, 6258.092576576371, 1568.34913510894, 1568.9450869219522, 1569.1918661889135, 1573.4492927475521, 1573.6695293988162, 1066.344198318029, 1068.893110688925, 1070.6306324318098, 1088.6679562733284, 1092.6448904106198, 5912.526997840162, 5913.733881975321, 5925.555583331267, 5929.881402371929, 5933.110033494924, 6392.776252831221, 6397.040443933354, 6404.263509696445, 6408.967955160194, 6410.839729006719, 5709.457601527848, 5740.454656807597, 5819.941800582024, 5926.7925622603, 5979.760809567569, 3464.255185135208, 3467.791932484059, 3491.650834916488, 3492.161881148506, 3497.720182385403, 6760.222574403908, 6766.391024807791, 6781.762638307636, 6782.423494003065, 6787.457003439713, 6495.382938620824, 6630.270670226271, 6633.7346506140175, 6646.83382915431, 6653.135092437952, 6757.189137303555, 6781.966090169518, 6783.3555812197765, 6789.864202715918, 6797.52417330792, 6454.031895215755, 6456.160699109274, 6460.160179176677, 6461.321561236003, 6466.612003279818, 6265.4361107500545, 6393.552451328363, 6405.487560995016, 6406.90389644165, 6409.4231519163495, 6728.899066514105, 6733.225679046776, 6734.966325168539, 6739.0902228198565, 6739.157605299338, 4504.797284122288, 4508.594226519629, 4513.413256276663, 4515.661325400542, 4518.841840535565, 6378.138951241523, 6497.805065848032, 6509.381608747161, 6514.088027676224, 6514.478841692748, 6305.621662700252, 6328.335524769833, 6331.240251169889, 6331.778387756406, 6336.778212762531, 6310.6213627182515, 6313.210848643919, 6315.463185629089, 6317.652529110759, 6324.0, 6059.939400605937, 6187.9579738687025, 6192.628442293477, 6198.566100372931, 6201.81394558164, 6328.968355158195, 6355.3326900674765, 6356.046593011085, 6357.0, 6358.682065896594, 6197.938020619736, 6206.410391012847, 6206.875862482635, 6212.130301757667, 6212.968935155295], "unit": "score", "name": "prototype.html", "value": 4708.372649710021}, {"lowerIsBetter": false, "replicates": [675.2875716119491, 716.6345163966375, 739.7558805594153, 815.6492708135503, 829.9917000829992, 13307.667308317285, 13504.594862154127, 13582.728345433085, 13606.251656158907, 13622.45510179593, 12662.556810511634, 12863.0, 12877.74244515109, 12891.548795792149, 12910.870891291084, 655.2857385449859, 662.2318110991251, 770.4953255617579, 782.5617654113714, 793.8650429427012, 779.4582764978343, 790.0440467034895, 792.8374683189933, 796.9960150199241, 797.1390897830329, 687.2989550658325, 819.115355416152, 835.8328334333128, 838.0278876503257, 838.5010918503481, 682.2427105912433, 810.7608255564593, 821.876718492225, 822.0258993093204, 823.7816978500703, 595.7557401465422, 599.7511032921333, 599.865030368168, 601.9428154325332, 605.5186127029023, 12272.509099636003, 12394.0, 12447.0, 12458.81311780324, 12484.625461236086, 11450.312981221154, 11789.233699809485, 12016.158868879182, 12032.759344813056, 12041.819372709417, 9178.449293042439, 9366.812663746756, 9411.341206115574, 9566.282528810367, 9587.952060239724, 3549.236914063463, 3607.2244467439627, 3615.168511242429, 3639.6906262967677, 3652.817359132059, 44565.55434445647, 44689.77655111704, 44752.55247447517, 44790.776046119885, 44841.32738008932, 9596.856047159297, 9697.757556061155, 9732.172765314886, 9950.35322704022, 10037.0, 17881.195346209453, 17904.194311256026, 17990.460286191435, 18004.459866204033, 18023.459296221135, 7033.824154396181, 7046.6828992695455, 7131.322524360177, 7141.392981596622, 7157.0, 4189.518205406356, 4249.68127390447, 4259.595338442843, 4288.0, 4304.632472009473, 2846.8576571171775, 2885.653721553385, 2887.826730396141, 2891.233823036897, 2893.9131826045254, 565.8104534980828, 572.3818276261627, 574.6063946196869, 585.519873703559, 586.1003359842621, 528.3184691747603, 576.9048107062372, 597.5070566782422, 602.6805792929754, 625.8028720952885, 8487.405881588229, 8623.353248506262, 8878.73363799087, 8912.73261802147, 8996.730098097067, 518.3598256153647, 618.71229878106, 636.3858876184504, 653.7019099421324, 683.3371629519359, 3734.79458629778, 3808.9428658570146, 3956.228535435562, 4214.452121224283, 4264.6801489888385, 53539.0, 54292.45707542953, 58225.70887145622, 58330.0, 58786.0, 44575.55424445779, 45139.77430112829, 45453.54546454559, 46079.0, 51988.48011519912, 46038.309425358646, 46072.539274607494, 46691.29963050625, 46959.29561056587, 47055.29417058747, 8461.32309415233, 8548.316134709085, 8783.429077109968, 8843.429117248994, 8946.597403117006, 32602.51096233606, 32923.67076329206, 33795.3240935175, 33949.321013580084, 34009.0, 39890.80054599708, 41610.37584436296, 46019.0, 47063.76468117638, 47167.528324717685, 10384.636537721144, 10493.265471416928, 10561.366318020944, 10676.252662313875, 10844.566217351217, 11339.376334301693, 11840.940795296314, 12026.338551379758, 12226.266424014588, 12472.314022728837, 10908.890911091104, 10979.890201097887, 11080.445977701243, 11102.333859968428, 11499.367534785333, 11037.724056898642, 11266.493007814832, 11351.0, 11417.0295524878, 11751.118666099906, 10558.630447934285, 10625.25623206368, 10775.6228532001, 10988.615398461016, 11542.192046556997, 9806.65676701312, 9844.409335439897, 10003.0, 10055.547500362647, 10326.845097323696, 9258.166764991183, 9353.36705345615, 9737.853932191165, 10000.949995249977, 10119.443430611387], "unit": "score", "name": "yui.html", "value": 6112.398143231799}], "name": "dromaeo_css", "value": 6779.079942983254}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 109.0, 112.0, 110.0, 99.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 146.0, 172.0, 128.0, 175.0, 159.0, 125.0, 166.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 160.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 81.0, 96.0, 72.0, 74.0, 75.0, 112.0, 92.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 144.0, 95.0, 96.0, 96.0, 139.0, 97.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 166.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 56.0, 63.0, 56.0, 57.0, 65.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 71.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 86.0, 86.0, 86.0, 86.0, 86.0, 88.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 128.0, 116.0, 123.0, 119.0, 122.0, 120.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [144.0, 143.0, 150.0, 150.0, 145.0, 141.0, 154.0, 153.0, 154.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 69.0, 67.0, 68.0, 70.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1509.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [190.00570017100512], "unit": "score", "name": "DeltaBlue", "value": 347.979034}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1107.3008849557523], "unit": "score", "name": "RayTrace", "value": 668.2817742257745}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [26421.052631578947], "unit": "score", "name": "RegExp", "value": 34.47951195219122}, {"lowerIsBetter": false, "replicates": [607.90273556231], "unit": "score", "name": "Splay", "value": 134.052695}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20900.064853908138}]} 08:29:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20900.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1509.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6779.08"}}} 08:29:37 INFO - Return code: 0 08:29:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:37 INFO - # TBPL SUCCESS # 08:29:37 INFO - Running post-action listener: _resource_record_post_action 08:29:37 INFO - Running post-run listener: _resource_record_post_run 08:29:38 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 567320576; Read time: 0; Write time: 487972 08:29:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238718976; Read time: 0; Write time: 275608 08:29:38 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 310738944; Read time: 0; Write time: 206612 08:29:38 INFO - Running post-run listener: _upload_blobber_files 08:29:38 INFO - Blob upload gear active. 08:29:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:29:38 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 08:29:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:29:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:29:39 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:40 INFO - (blobuploader) - INFO - Done attempting. 08:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:41 INFO - (blobuploader) - INFO - Done attempting. 08:29:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:41 INFO - Return code: 0 08:29:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:29:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/53448a78d831fa814f204ffe192fed0e66250f04b400b9a9723c5a4d3a341bc400fdca669683da5c1792611cc984e28f60be23e9bb409c1ae2b11890ae33aca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d2f570237c9a5ae661d7f039118d2a0ed74a5f1bdf1cdd3c355c0778b6b34951d968cda5314c624bf38420e8b998e761e492dd153691f4bf3e57f16dc5809804"} 08:29:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:29:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:29:41 INFO - Contents: 08:29:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/53448a78d831fa814f204ffe192fed0e66250f04b400b9a9723c5a4d3a341bc400fdca669683da5c1792611cc984e28f60be23e9bb409c1ae2b11890ae33aca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d2f570237c9a5ae661d7f039118d2a0ed74a5f1bdf1cdd3c355c0778b6b34951d968cda5314c624bf38420e8b998e761e492dd153691f4bf3e57f16dc5809804"} 08:29:41 INFO - Copying logs to upload dir... 08:29:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.399436 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-07 08:29:40.456988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:29:40.460390) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/53448a78d831fa814f204ffe192fed0e66250f04b400b9a9723c5a4d3a341bc400fdca669683da5c1792611cc984e28f60be23e9bb409c1ae2b11890ae33aca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d2f570237c9a5ae661d7f039118d2a0ed74a5f1bdf1cdd3c355c0778b6b34951d968cda5314c624bf38420e8b998e761e492dd153691f4bf3e57f16dc5809804"} build_url:https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/fH3EZ2S4RZyGtxa1ffyJpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/53448a78d831fa814f204ffe192fed0e66250f04b400b9a9723c5a4d3a341bc400fdca669683da5c1792611cc984e28f60be23e9bb409c1ae2b11890ae33aca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d2f570237c9a5ae661d7f039118d2a0ed74a5f1bdf1cdd3c355c0778b6b34951d968cda5314c624bf38420e8b998e761e492dd153691f4bf3e57f16dc5809804"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:29:40.484767) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:29:40.485134) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452182679.353266-2046535019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:29:40.567897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:29:40.568238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:29:40.568560) ========= ========= Total master_lag: 0.24 =========