builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1452588668.0 results: success (0) buildid: 20160111223014 builduid: d1a9893c62d04dce9b2db408ac2106e5 revision: c88ad0a6f5df36f6fd5ba16866252bdbb1b9d2ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.005125) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.005750) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.006071) ========= 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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006344 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.028895) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.029198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.042557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.042853) ========= 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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.092112) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.092443) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.092818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.093141) ========= 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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 00:51:09-- 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% 225M=0s 2016-01-12 00:51:09 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.268987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.269667) ========= 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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017687 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.320569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.320959) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c88ad0a6f5df36f6fd5ba16866252bdbb1b9d2ff --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/mozilla-inbound --rev c88ad0a6f5df36f6fd5ba16866252bdbb1b9d2ff --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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 00:51:09,608 truncating revision to first 12 chars 2016-01-12 00:51:09,608 Setting DEBUG logging. 2016-01-12 00:51:09,608 attempt 1/10 2016-01-12 00:51:09,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c88ad0a6f5df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 00:51:09,880 unpacking tar archive at: mozilla-inbound-c88ad0a6f5df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.934504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.934839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.944125) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.944383) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 00:51:08.944787) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-12 00:51:08.945096) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:51:10 INFO - MultiFileLogger online at 20160112 00:51:10 in /builds/slave/test-pgo 00:51:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:51:10 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:51:10 INFO - {'append_to_log': False, 00:51:10 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:51:10 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:51:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:51:10 INFO - 'branch': 'Mozilla-Inbound', 00:51:10 INFO - 'buildbot_json_path': 'buildprops.json', 00:51:10 INFO - 'config_files': ('talos/linux_config.py',), 00:51:10 INFO - 'default_actions': ('clobber', 00:51:10 INFO - 'read-buildbot-config', 00:51:10 INFO - 'download-and-extract', 00:51:10 INFO - 'populate-webroot', 00:51:10 INFO - 'create-virtualenv', 00:51:10 INFO - 'install', 00:51:10 INFO - 'run-tests'), 00:51:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:51:10 INFO - 'download_minidump_stackwalk': True, 00:51:10 INFO - 'download_symbols': 'ondemand', 00:51:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:51:10 INFO - 'tooltool.py': '/tools/tooltool.py', 00:51:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:51:10 INFO - '/tools/misc-python/virtualenv.py')}, 00:51:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:51:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:51:10 INFO - 'installer_path': 'installer.exe', 00:51:10 INFO - 'log_level': 'info', 00:51:10 INFO - 'log_name': 'talos', 00:51:10 INFO - 'log_to_console': True, 00:51:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:51:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:51:10 INFO - 'opt_config_files': (), 00:51:10 INFO - 'pip_index': False, 00:51:10 INFO - 'sps_profile': False, 00:51:10 INFO - 'sps_profile_interval': 0, 00:51:10 INFO - 'suite': 'dromaeojs-e10s', 00:51:10 INFO - 'system_bits': '32', 00:51:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:51:10 INFO - 'title': 'talos-linux64-ix-029', 00:51:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:51:10 INFO - 'use_talos_json': True, 00:51:10 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:51:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:51:10 INFO - 'work_dir': 'build'} 00:51:10 INFO - ##### 00:51:10 INFO - ##### Running clobber step. 00:51:10 INFO - ##### 00:51:10 INFO - Running pre-action listener: _resource_record_pre_action 00:51:10 INFO - Running main action method: clobber 00:51:10 INFO - rmtree: /builds/slave/test-pgo/build 00:51:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:51:10 INFO - Running post-action listener: _resource_record_post_action 00:51:10 INFO - ##### 00:51:10 INFO - ##### Running read-buildbot-config step. 00:51:10 INFO - ##### 00:51:10 INFO - Running pre-action listener: _resource_record_pre_action 00:51:10 INFO - Running main action method: read_buildbot_config 00:51:10 INFO - Using buildbot properties: 00:51:10 INFO - { 00:51:10 INFO - "project": "", 00:51:10 INFO - "product": "firefox", 00:51:10 INFO - "script_repo_revision": "production", 00:51:10 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 00:51:10 INFO - "repository": "", 00:51:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 00:51:10 INFO - "buildid": "20160111223014", 00:51:10 INFO - "pgo_build": "True", 00:51:10 INFO - "basedir": "/builds/slave/test-pgo", 00:51:10 INFO - "buildnumber": 245, 00:51:10 INFO - "slavename": "talos-linux64-ix-029", 00:51:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:51:10 INFO - "platform": "ubuntu64_hw", 00:51:10 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:51:10 INFO - "branch": "mozilla-inbound", 00:51:10 INFO - "repo_path": "integration/mozilla-inbound", 00:51:10 INFO - "revision": "c88ad0a6f5df36f6fd5ba16866252bdbb1b9d2ff", 00:51:10 INFO - "stage_platform": "linux64-pgo", 00:51:10 INFO - "builduid": "d1a9893c62d04dce9b2db408ac2106e5", 00:51:10 INFO - "slavebuilddir": "test" 00:51:10 INFO - } 00:51:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:51:10 INFO - Running post-action listener: _resource_record_post_action 00:51:10 INFO - ##### 00:51:10 INFO - ##### Running download-and-extract step. 00:51:10 INFO - ##### 00:51:10 INFO - Running pre-action listener: _resource_record_pre_action 00:51:10 INFO - Running main action method: download_and_extract 00:51:10 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:10 INFO - https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/test_packages.json 00:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/test_packages.json 00:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:51:11 INFO - Downloaded 1302 bytes. 00:51:11 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:51:11 INFO - Using the following test package requirements: 00:51:11 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:11 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:51:11 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:11 INFO - u'jsshell-linux-x86_64.zip'], 00:51:11 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:51:11 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:11 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:51:11 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:51:11 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:51:11 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:11 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:51:11 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:51:11 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')]} 00:51:11 INFO - https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:51:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:51:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:51:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:14 INFO - Downloaded 24030612 bytes. 00:51:14 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 00:51:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:51:14 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 00:51:15 INFO - Return code: 0 00:51:15 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 00:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:15 INFO - https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:51:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:51:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:51:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:18 INFO - Downloaded 24030612 bytes. 00:51:18 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 00:51:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:51:18 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 00:51:19 INFO - Return code: 0 00:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:19 INFO - https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:21 INFO - Downloaded 11132285 bytes. 00:51:21 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 00:51:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:21 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 00:51:21 INFO - Return code: 0 00:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:21 INFO - https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:51:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:51:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:51:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LOBWAqwSSH-hUaTwwYuIbA/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 00:51:24 INFO - Downloaded 56041325 bytes. 00:51:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:51:24 INFO - mkdir: /builds/slave/test-pgo/properties 00:51:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:51:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:51:24 INFO - Contents: 00:51:24 INFO - build_url:https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:51:24 INFO - Running post-action listener: _resource_record_post_action 00:51:24 INFO - Running post-action listener: set_extra_try_arguments 00:51:24 INFO - ##### 00:51:24 INFO - ##### Running populate-webroot step. 00:51:24 INFO - ##### 00:51:24 INFO - Running pre-action listener: _resource_record_pre_action 00:51:24 INFO - Running main action method: populate_webroot 00:51:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:51:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:51:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:51:24 INFO - '--tppagecycles', 00:51:24 INFO - '7'], 00:51:24 INFO - 'tests': ['tsvgm']}}, 00:51:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:51:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:51:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:51:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:51:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'tests': ['damp', 'tps']}, 00:51:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['damp', 'tps']}, 00:51:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:51:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:51:24 INFO - 'other': {'tests': ['a11yr', 00:51:24 INFO - 'ts_paint', 00:51:24 INFO - 'tpaint', 00:51:24 INFO - 'sessionrestore', 00:51:24 INFO - 'sessionrestore_no_auto_restore']}, 00:51:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['a11yr', 00:51:24 INFO - 'ts_paint', 00:51:24 INFO - 'tpaint', 00:51:24 INFO - 'sessionrestore', 00:51:24 INFO - 'sessionrestore_no_auto_restore']}, 00:51:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['a11yr', 00:51:24 INFO - 'ts_paint', 00:51:24 INFO - 'tpaint', 00:51:24 INFO - 'sessionrestore', 00:51:24 INFO - 'sessionrestore_no_auto_restore']}, 00:51:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['a11yr', 00:51:24 INFO - 'ts_paint', 00:51:24 INFO - 'tpaint', 00:51:24 INFO - 'sessionrestore', 00:51:24 INFO - 'sessionrestore_no_auto_restore']}, 00:51:24 INFO - 'other_l64': {'tests': ['a11yr', 00:51:24 INFO - 'ts_paint', 00:51:24 INFO - 'tpaint', 00:51:24 INFO - 'sessionrestore', 00:51:24 INFO - 'sessionrestore_no_auto_restore']}, 00:51:24 INFO - 'other_nol64': {'tests': ['a11yr', 00:51:24 INFO - 'ts_paint', 00:51:24 INFO - 'tpaint', 00:51:24 INFO - 'sessionrestore', 00:51:24 INFO - 'sessionrestore_no_auto_restore']}, 00:51:24 INFO - 'svgr': {'tests': ['tsvgx', 00:51:24 INFO - 'tsvgr_opacity', 00:51:24 INFO - 'tart', 00:51:24 INFO - 'tscrollx', 00:51:24 INFO - 'cart']}, 00:51:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['tsvgx', 00:51:24 INFO - 'tsvgr_opacity', 00:51:24 INFO - 'tart', 00:51:24 INFO - 'tscrollx', 00:51:24 INFO - 'cart']}, 00:51:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'tests': ['tp5o']}, 00:51:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'talos_options': ['--e10s'], 00:51:24 INFO - 'tests': ['tp5o']}, 00:51:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'talos_options': ['--xperf_path', 00:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:24 INFO - 'tests': ['tp5n']}, 00:51:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:24 INFO - 'talos_options': ['--e10s', 00:51:24 INFO - '--xperf_path', 00:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:24 INFO - 'tests': ['tp5n']}}, 00:51:24 INFO - 'talos.zip': {'path': '', 00:51:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:51:24 INFO - Running post-action listener: _resource_record_post_action 00:51:24 INFO - ##### 00:51:24 INFO - ##### Running create-virtualenv step. 00:51:24 INFO - ##### 00:51:24 INFO - Running pre-action listener: _resource_record_pre_action 00:51:24 INFO - Running main action method: create_virtualenv 00:51:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:51:24 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 00:51:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:51:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:51:24 INFO - Using real prefix '/usr' 00:51:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:51:25 INFO - Installing distribute.............................................................................................................................................................................................done. 00:51:27 INFO - Installing pip.................done. 00:51:27 INFO - Return code: 0 00:51:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:27 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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:27 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 00:51:27 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 00:51:27 INFO - Using env: {'DISPLAY': ':0', 00:51:27 INFO - 'HOME': '/home/cltbld', 00:51:27 INFO - 'LANG': 'en_US.UTF-8', 00:51:27 INFO - 'LANGUAGE': 'en_US:en', 00:51:27 INFO - 'LOGNAME': 'cltbld', 00:51:27 INFO - 'MAIL': '/var/mail/cltbld', 00:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:27 INFO - 'MOZ_NO_REMOTE': '1', 00:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:27 INFO - 'NO_EM_RESTART': '1', 00:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:27 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:27 INFO - 'SHELL': '/bin/bash', 00:51:27 INFO - 'SHLVL': '1', 00:51:27 INFO - 'TERM': 'linux', 00:51:27 INFO - 'TMOUT': '86400', 00:51:27 INFO - 'USER': 'cltbld', 00:51:27 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:27 INFO - '_': '/tools/buildbot/bin/python'} 00:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:27 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 00:51:27 INFO - Cleaning up... 00:51:27 INFO - Return code: 0 00:51:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:27 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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:27 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 00:51:27 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 00:51:27 INFO - Using env: {'DISPLAY': ':0', 00:51:27 INFO - 'HOME': '/home/cltbld', 00:51:27 INFO - 'LANG': 'en_US.UTF-8', 00:51:27 INFO - 'LANGUAGE': 'en_US:en', 00:51:27 INFO - 'LOGNAME': 'cltbld', 00:51:27 INFO - 'MAIL': '/var/mail/cltbld', 00:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:27 INFO - 'MOZ_NO_REMOTE': '1', 00:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:27 INFO - 'NO_EM_RESTART': '1', 00:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:27 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:27 INFO - 'SHELL': '/bin/bash', 00:51:27 INFO - 'SHLVL': '1', 00:51:27 INFO - 'TERM': 'linux', 00:51:27 INFO - 'TMOUT': '86400', 00:51:27 INFO - 'USER': 'cltbld', 00:51:27 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:27 INFO - '_': '/tools/buildbot/bin/python'} 00:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:27 INFO - Downloading/unpacking psutil>=0.7.1 00:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:29 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:51:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:51:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:29 INFO - Installing collected packages: psutil 00:51:29 INFO - Running setup.py install for psutil 00:51:29 INFO - building 'psutil._psutil_linux' extension 00:51:29 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 00:51:29 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 00:51:29 INFO - building 'psutil._psutil_posix' extension 00:51:29 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 00:51:29 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 00:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:30 INFO - Successfully installed psutil 00:51:30 INFO - Cleaning up... 00:51:30 INFO - Return code: 0 00:51:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:30 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 00:51:30 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 00:51:30 INFO - Using env: {'DISPLAY': ':0', 00:51:30 INFO - 'HOME': '/home/cltbld', 00:51:30 INFO - 'LANG': 'en_US.UTF-8', 00:51:30 INFO - 'LANGUAGE': 'en_US:en', 00:51:30 INFO - 'LOGNAME': 'cltbld', 00:51:30 INFO - 'MAIL': '/var/mail/cltbld', 00:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:30 INFO - 'MOZ_NO_REMOTE': '1', 00:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:30 INFO - 'NO_EM_RESTART': '1', 00:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:30 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:30 INFO - 'SHELL': '/bin/bash', 00:51:30 INFO - 'SHLVL': '1', 00:51:30 INFO - 'TERM': 'linux', 00:51:30 INFO - 'TMOUT': '86400', 00:51:30 INFO - 'USER': 'cltbld', 00:51:30 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:30 INFO - '_': '/tools/buildbot/bin/python'} 00:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:51:30 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 00:51:30 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 00:51:30 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 00:51:30 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 00:51:30 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 00:51:30 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 00:51:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:51:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:51:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:51:32 INFO - Installing collected packages: mozsystemmonitor 00:51:32 INFO - Running setup.py install for mozsystemmonitor 00:51:32 INFO - Successfully installed mozsystemmonitor 00:51:32 INFO - Cleaning up... 00:51:32 INFO - Return code: 0 00:51:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:32 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 00:51:32 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 00:51:32 INFO - Using env: {'DISPLAY': ':0', 00:51:32 INFO - 'HOME': '/home/cltbld', 00:51:32 INFO - 'LANG': 'en_US.UTF-8', 00:51:32 INFO - 'LANGUAGE': 'en_US:en', 00:51:32 INFO - 'LOGNAME': 'cltbld', 00:51:32 INFO - 'MAIL': '/var/mail/cltbld', 00:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:32 INFO - 'MOZ_NO_REMOTE': '1', 00:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:32 INFO - 'NO_EM_RESTART': '1', 00:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:32 INFO - 'SHELL': '/bin/bash', 00:51:32 INFO - 'SHLVL': '1', 00:51:32 INFO - 'TERM': 'linux', 00:51:32 INFO - 'TMOUT': '86400', 00:51:32 INFO - 'USER': 'cltbld', 00:51:32 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:32 INFO - '_': '/tools/buildbot/bin/python'} 00:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:32 INFO - Downloading/unpacking blobuploader==1.2.4 00:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:34 INFO - Downloading blobuploader-1.2.4.tar.gz 00:51:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:51:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:51:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:34 INFO - Downloading docopt-0.6.1.tar.gz 00:51:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:51:34 INFO - Installing collected packages: blobuploader, requests, docopt 00:51:34 INFO - Running setup.py install for blobuploader 00:51:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:51:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:51:35 INFO - Running setup.py install for requests 00:51:35 INFO - Running setup.py install for docopt 00:51:35 INFO - Successfully installed blobuploader requests docopt 00:51:35 INFO - Cleaning up... 00:51:35 INFO - Return code: 0 00:51:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:51:35 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')]} 00:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:35 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')]} 00:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:35 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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:35 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 00:51:35 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 00:51:35 INFO - Using env: {'DISPLAY': ':0', 00:51:35 INFO - 'HOME': '/home/cltbld', 00:51:35 INFO - 'LANG': 'en_US.UTF-8', 00:51:35 INFO - 'LANGUAGE': 'en_US:en', 00:51:35 INFO - 'LOGNAME': 'cltbld', 00:51:35 INFO - 'MAIL': '/var/mail/cltbld', 00:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:35 INFO - 'MOZ_NO_REMOTE': '1', 00:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:35 INFO - 'NO_EM_RESTART': '1', 00:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:35 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:35 INFO - 'SHELL': '/bin/bash', 00:51:35 INFO - 'SHLVL': '1', 00:51:35 INFO - 'TERM': 'linux', 00:51:35 INFO - 'TMOUT': '86400', 00:51:35 INFO - 'USER': 'cltbld', 00:51:35 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:35 INFO - '_': '/tools/buildbot/bin/python'} 00:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:35 INFO - Running setup.py (path:/tmp/pip-o7as6l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:35 INFO - Running setup.py (path:/tmp/pip-UrMQLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:35 INFO - Running setup.py (path:/tmp/pip-S1auG0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:35 INFO - Running setup.py (path:/tmp/pip-GbGDqo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:36 INFO - Running setup.py (path:/tmp/pip-fpzdTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:36 INFO - Running setup.py (path:/tmp/pip-hlmAQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:36 INFO - Running setup.py (path:/tmp/pip-yt7pd9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:36 INFO - Running setup.py (path:/tmp/pip-tqubXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:36 INFO - Running setup.py (path:/tmp/pip-hodurD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:36 INFO - Running setup.py (path:/tmp/pip-qte8nY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:36 INFO - Running setup.py (path:/tmp/pip-UB_Erj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:36 INFO - Running setup.py (path:/tmp/pip-c1WOWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:36 INFO - Running setup.py (path:/tmp/pip-oU4oGw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:36 INFO - Running setup.py (path:/tmp/pip-WGaBW5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:36 INFO - Running setup.py (path:/tmp/pip-0fJ9QN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:36 INFO - Running setup.py (path:/tmp/pip-PT18i3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:36 INFO - Running setup.py (path:/tmp/pip-F4Em1R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:51:36 INFO - Running setup.py install for manifestparser 00:51:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Running setup.py install for mozcrash 00:51:37 INFO - Running setup.py install for mozdebug 00:51:37 INFO - Running setup.py install for mozdevice 00:51:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Running setup.py install for mozfile 00:51:37 INFO - Running setup.py install for mozhttpd 00:51:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Running setup.py install for mozinfo 00:51:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Running setup.py install for mozInstall 00:51:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Running setup.py install for mozleak 00:51:37 INFO - Running setup.py install for mozlog 00:51:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:51:37 INFO - Running setup.py install for moznetwork 00:51:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:51:38 INFO - Running setup.py install for mozprocess 00:51:38 INFO - Running setup.py install for mozprofile 00:51:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:51:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:51:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:51:38 INFO - Running setup.py install for mozrunner 00:51:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:51:38 INFO - Running setup.py install for mozscreenshot 00:51:38 INFO - Running setup.py install for moztest 00:51:38 INFO - Running setup.py install for mozversion 00:51:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:51:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:51:38 INFO - Cleaning up... 00:51:38 INFO - Return code: 0 00:51:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:38 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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:38 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 00:51:38 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 00:51:38 INFO - Using env: {'DISPLAY': ':0', 00:51:38 INFO - 'HOME': '/home/cltbld', 00:51:38 INFO - 'LANG': 'en_US.UTF-8', 00:51:38 INFO - 'LANGUAGE': 'en_US:en', 00:51:38 INFO - 'LOGNAME': 'cltbld', 00:51:38 INFO - 'MAIL': '/var/mail/cltbld', 00:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:38 INFO - 'MOZ_NO_REMOTE': '1', 00:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:38 INFO - 'NO_EM_RESTART': '1', 00:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:38 INFO - 'SHELL': '/bin/bash', 00:51:38 INFO - 'SHLVL': '1', 00:51:38 INFO - 'TERM': 'linux', 00:51:38 INFO - 'TMOUT': '86400', 00:51:38 INFO - 'USER': 'cltbld', 00:51:38 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:38 INFO - '_': '/tools/buildbot/bin/python'} 00:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:38 INFO - Running setup.py (path:/tmp/pip-ldDnON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:39 INFO - Running setup.py (path:/tmp/pip-uOYkMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:39 INFO - Running setup.py (path:/tmp/pip-aAmXQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:39 INFO - Running setup.py (path:/tmp/pip-NtbVyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:39 INFO - Running setup.py (path:/tmp/pip-Ed_sdE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:39 INFO - Running setup.py (path:/tmp/pip-kWUJGq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:39 INFO - Running setup.py (path:/tmp/pip-3ze4EG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:39 INFO - Running setup.py (path:/tmp/pip-BR75HS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:39 INFO - Running setup.py (path:/tmp/pip-5tRTIK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:39 INFO - Running setup.py (path:/tmp/pip-hyjQkm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:39 INFO - Running setup.py (path:/tmp/pip-VxE2vZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:39 INFO - Running setup.py (path:/tmp/pip-Mo84ir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:39 INFO - Running setup.py (path:/tmp/pip-AfG2bY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:39 INFO - Running setup.py (path:/tmp/pip-525yVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:39 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)) 00:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:39 INFO - Running setup.py (path:/tmp/pip-vZvQNS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:40 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)) 00:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:40 INFO - Running setup.py (path:/tmp/pip-sVe4YC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:40 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)) 00:51:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:40 INFO - Running setup.py (path:/tmp/pip-WoBoTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:40 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)) 00:51:40 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)) 00:51:40 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)) 00:51:40 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)) 00:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:51:40 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)) 00:51:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:41 INFO - Downloading blessings-1.5.1.tar.gz 00:51:41 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 00:51:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:51:42 INFO - Installing collected packages: blessings 00:51:42 INFO - Running setup.py install for blessings 00:51:42 INFO - Successfully installed blessings 00:51:42 INFO - Cleaning up... 00:51:42 INFO - Return code: 0 00:51:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:51:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:51:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:51:42 INFO - Reading from file tmpfile_stdout 00:51:42 INFO - Current package versions: 00:51:42 INFO - argparse == 1.2.1 00:51:42 INFO - blessings == 1.5.1 00:51:42 INFO - blobuploader == 1.2.4 00:51:42 INFO - docopt == 0.6.1 00:51:42 INFO - manifestparser == 1.1 00:51:42 INFO - mozInstall == 1.12 00:51:42 INFO - mozcrash == 0.16 00:51:42 INFO - mozdebug == 0.1 00:51:42 INFO - mozdevice == 0.47 00:51:42 INFO - mozfile == 1.2 00:51:42 INFO - mozhttpd == 0.7 00:51:42 INFO - mozinfo == 0.9 00:51:42 INFO - mozleak == 0.1 00:51:42 INFO - mozlog == 3.1 00:51:42 INFO - moznetwork == 0.27 00:51:42 INFO - mozprocess == 0.22 00:51:42 INFO - mozprofile == 0.28 00:51:42 INFO - mozrunner == 6.11 00:51:42 INFO - mozscreenshot == 0.1 00:51:42 INFO - mozsystemmonitor == 0.0 00:51:42 INFO - moztest == 0.7 00:51:42 INFO - mozversion == 1.4 00:51:42 INFO - psutil == 3.1.1 00:51:42 INFO - requests == 1.2.3 00:51:42 INFO - wsgiref == 0.1.2 00:51:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:42 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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:42 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 00:51:42 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 00:51:42 INFO - Using env: {'DISPLAY': ':0', 00:51:42 INFO - 'HOME': '/home/cltbld', 00:51:42 INFO - 'LANG': 'en_US.UTF-8', 00:51:42 INFO - 'LANGUAGE': 'en_US:en', 00:51:42 INFO - 'LOGNAME': 'cltbld', 00:51:42 INFO - 'MAIL': '/var/mail/cltbld', 00:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:42 INFO - 'MOZ_NO_REMOTE': '1', 00:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:42 INFO - 'NO_EM_RESTART': '1', 00:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:42 INFO - 'SHELL': '/bin/bash', 00:51:42 INFO - 'SHLVL': '1', 00:51:42 INFO - 'TERM': 'linux', 00:51:42 INFO - 'TMOUT': '86400', 00:51:42 INFO - 'USER': 'cltbld', 00:51:42 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:42 INFO - '_': '/tools/buildbot/bin/python'} 00:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 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)) 00:51:42 INFO - Cleaning up... 00:51:42 INFO - Return code: 0 00:51:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:42 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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:42 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 00:51:42 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 00:51:42 INFO - Using env: {'DISPLAY': ':0', 00:51:42 INFO - 'HOME': '/home/cltbld', 00:51:42 INFO - 'LANG': 'en_US.UTF-8', 00:51:42 INFO - 'LANGUAGE': 'en_US:en', 00:51:42 INFO - 'LOGNAME': 'cltbld', 00:51:42 INFO - 'MAIL': '/var/mail/cltbld', 00:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:42 INFO - 'MOZ_NO_REMOTE': '1', 00:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:42 INFO - 'NO_EM_RESTART': '1', 00:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:42 INFO - 'SHELL': '/bin/bash', 00:51:42 INFO - 'SHLVL': '1', 00:51:42 INFO - 'TERM': 'linux', 00:51:42 INFO - 'TMOUT': '86400', 00:51:42 INFO - 'USER': 'cltbld', 00:51:42 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:42 INFO - '_': '/tools/buildbot/bin/python'} 00:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:42 INFO - Downloading/unpacking jsonschema 00:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:51:44 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 00:51:44 INFO - Downloading/unpacking functools32 (from jsonschema) 00:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:44 INFO - Downloading functools32-3.2.3-2.tar.gz 00:51:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:51:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:51:44 INFO - warning: no files found matching '*.txt' 00:51:44 INFO - no previously-included directories found matching 'build' 00:51:44 INFO - no previously-included directories found matching 'dist' 00:51:44 INFO - no previously-included directories found matching '.git*' 00:51:44 INFO - Installing collected packages: jsonschema, functools32 00:51:44 INFO - Running setup.py install for functools32 00:51:44 INFO - warning: no files found matching '*.txt' 00:51:44 INFO - no previously-included directories found matching 'build' 00:51:44 INFO - no previously-included directories found matching 'dist' 00:51:44 INFO - no previously-included directories found matching '.git*' 00:51:44 INFO - Successfully installed jsonschema functools32 00:51:44 INFO - Cleaning up... 00:51:45 INFO - Return code: 0 00:51:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:51:45 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')]} 00:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:45 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')]} 00:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:45 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 0x7fa822143f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, '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': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', '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 00:51:45 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 00:51:45 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 00:51:45 INFO - Using env: {'DISPLAY': ':0', 00:51:45 INFO - 'HOME': '/home/cltbld', 00:51:45 INFO - 'LANG': 'en_US.UTF-8', 00:51:45 INFO - 'LANGUAGE': 'en_US:en', 00:51:45 INFO - 'LOGNAME': 'cltbld', 00:51:45 INFO - 'MAIL': '/var/mail/cltbld', 00:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:45 INFO - 'MOZ_NO_REMOTE': '1', 00:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:45 INFO - 'NO_EM_RESTART': '1', 00:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:45 INFO - 'SHELL': '/bin/bash', 00:51:45 INFO - 'SHLVL': '1', 00:51:45 INFO - 'TERM': 'linux', 00:51:45 INFO - 'TMOUT': '86400', 00:51:45 INFO - 'USER': 'cltbld', 00:51:45 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:45 INFO - '_': '/tools/buildbot/bin/python'} 00:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:45 INFO - Downloading/unpacking flake8 00:51:45 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 00:51:45 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 00:51:45 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 00:51:45 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 00:51:45 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 00:51:45 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 00:51:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:51:47 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 00:51:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:51:47 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 00:51:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 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 00:51:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:51:47 INFO - no previously-included directories found matching 'docs/_build' 00:51:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:51:47 INFO - Running setup.py install for pep8 00:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:51:47 INFO - no previously-included directories found matching 'docs/_build' 00:51:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:51:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:51:47 INFO - Cleaning up... 00:51:47 INFO - Return code: 0 00:51:47 INFO - Running post-action listener: _resource_record_post_action 00:51:47 INFO - Running post-action listener: _start_resource_monitoring 00:51:47 INFO - Starting resource monitoring. 00:51:47 INFO - ##### 00:51:47 INFO - ##### Running install step. 00:51:47 INFO - ##### 00:51:47 INFO - Running pre-action listener: _resource_record_pre_action 00:51:47 INFO - Running main action method: install 00:51:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:51:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:51:48 INFO - Reading from file tmpfile_stdout 00:51:48 INFO - Detecting whether we're running mozinstall >=1.0... 00:51:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:51:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:51:48 INFO - Reading from file tmpfile_stdout 00:51:48 INFO - Output received: 00:51:48 INFO - Usage: mozinstall [options] installer 00:51:48 INFO - Options: 00:51:48 INFO - -h, --help show this help message and exit 00:51:48 INFO - -d DEST, --destination=DEST 00:51:48 INFO - Directory to install application into. [default: 00:51:48 INFO - "/builds/slave/test-pgo"] 00:51:48 INFO - --app=APP Application being installed. [default: firefox] 00:51:48 INFO - mkdir: /builds/slave/test-pgo/build/application 00:51:48 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'] 00:51:48 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 00:52:04 INFO - Reading from file tmpfile_stdout 00:52:04 INFO - Output received: 00:52:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:52:04 INFO - Running post-action listener: _resource_record_post_action 00:52:04 INFO - ##### 00:52:04 INFO - ##### Running run-tests step. 00:52:04 INFO - ##### 00:52:04 INFO - Running pre-action listener: _resource_record_pre_action 00:52:04 INFO - Running main action method: run_tests 00:52:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:52:04 INFO - Python 2.7.3 00:52:04 INFO - Return code: 0 00:52:04 INFO - grabbing minidump binary from tooltool 00:52: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')]} 00:52:04 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 0x25587f0>, '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 0x24c42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c4760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:52:04 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 00:52:04 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 00:52:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:52:04 INFO - Return code: 0 00:52:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:52:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:52:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:52:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:52:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:52:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:52:05 INFO - Return code: 0 00:52:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 00:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:52:05 INFO - Using env: {'DISPLAY': ':0', 00:52:05 INFO - 'HOME': '/home/cltbld', 00:52:05 INFO - 'LANG': 'en_US.UTF-8', 00:52:05 INFO - 'LANGUAGE': 'en_US:en', 00:52:05 INFO - 'LOGNAME': 'cltbld', 00:52:05 INFO - 'MAIL': '/var/mail/cltbld', 00:52:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:52:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:05 INFO - 'MOZ_NO_REMOTE': '1', 00:52:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:05 INFO - 'NO_EM_RESTART': '1', 00:52:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:52:05 INFO - 'PWD': '/builds/slave/test-pgo', 00:52:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:52:05 INFO - 'SHELL': '/bin/bash', 00:52:05 INFO - 'SHLVL': '1', 00:52:05 INFO - 'TERM': 'linux', 00:52:05 INFO - 'TMOUT': '86400', 00:52:05 INFO - 'USER': 'cltbld', 00:52:05 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628', 00:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:05 INFO - '_': '/tools/buildbot/bin/python'} 00:52:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:52:05 INFO - mozversion application_buildid: 20160111223014 00:52:05 INFO - mozversion application_changeset: c88ad0a6f5df36f6fd5ba16866252bdbb1b9d2ff 00:52:05 INFO - mozversion application_display_name: Nightly 00:52:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:52:05 INFO - mozversion application_name: Firefox 00:52:05 INFO - mozversion application_remotingname: firefox 00:52:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:52:05 INFO - mozversion application_vendor: Mozilla 00:52:05 INFO - mozversion application_version: 46.0a1 00:52:05 INFO - mozversion platform_buildid: 20160111223014 00:52:05 INFO - mozversion platform_changeset: c88ad0a6f5df36f6fd5ba16866252bdbb1b9d2ff 00:52:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:52:05 INFO - mozversion platform_version: 46.0a1 00:52:05 INFO - using testdate: 1452588725 00:52:05 INFO - actual date: 1452588725 00:52:05 INFO - starting webserver on 'localhost:37048' 00:52:05 INFO - SUITE-START | Running 3 tests 00:52:05 INFO - TEST-START | dromaeo_css 00:52:05 INFO - operating with platform_type : linux_ 00:52:05 INFO - Initialising browser for dromaeo_css test... 00:52:05 INFO - TEST-INFO | started process 17776 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxRulJw/profile http://localhost:37048/getInfo.html) 00:52:08 INFO - PROCESS | 17776 | 00:52:08 INFO - PROCESS | 17776 | (process:17858): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:52:09 INFO - PROCESS | 17776 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 00:52:09 INFO - PROCESS | 17776 | __metrics Screen width/height:1600/1200 00:52:09 INFO - PROCESS | 17776 | colorDepth:24 00:52:09 INFO - PROCESS | 17776 | Browser inner width/height: 1024/697 00:52:09 INFO - PROCESS | 17776 | __metrics 00:52:09 INFO - PROCESS | 17776 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:52:10 INFO - TEST-INFO | 17776: exit 0 00:52:10 INFO - Browser initialized. 00:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 00:52:10 INFO - TEST-INFO | started process 17907 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxRulJw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:52:11 INFO - PROCESS | 17907 | 00:52:11 INFO - PROCESS | 17907 | (process:17968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:52:22 INFO - PROCESS | 17907 | RSS: Main: 150589440 00:52:22 INFO - PROCESS | 17907 | 00:53:12 INFO - PROCESS | 17907 | 1452588792084 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] 00:55:20 INFO - PROCESS | 17907 | Cycle 1(1): loaded http://localhost:37048/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37048/tests/dromaeo/cssquery-ext.html) 00:55:22 INFO - PROCESS | 17907 | RSS: Main: 156860416 00:55:22 INFO - PROCESS | 17907 | 00:58:24 INFO - PROCESS | 17907 | Cycle 1(1): loaded http://localhost:37048/tests/dromaeo/cssquery-ext.html (next: http://localhost:37048/tests/dromaeo/cssquery-jquery.html) 00:58:24 INFO - PROCESS | 17907 | RSS: Main: 153690112 00:58:24 INFO - PROCESS | 17907 | 01:01:26 INFO - PROCESS | 17907 | Cycle 1(1): loaded http://localhost:37048/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37048/tests/dromaeo/cssquery-mootools.html) 01:01:26 INFO - PROCESS | 17907 | RSS: Main: 154095616 01:01:26 INFO - PROCESS | 17907 | 01:04:28 INFO - PROCESS | 17907 | Cycle 1(1): loaded http://localhost:37048/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37048/tests/dromaeo/cssquery-prototype.html) 01:04:29 INFO - PROCESS | 17907 | RSS: Main: 152829952 01:04:29 INFO - PROCESS | 17907 | 01:07:31 INFO - PROCESS | 17907 | Cycle 1(1): loaded http://localhost:37048/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37048/tests/dromaeo/cssquery-yui.html) 01:07:32 INFO - PROCESS | 17907 | RSS: Main: 154005504 01:07:32 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | Cycle 1(1): loaded http://localhost:37048/tests/dromaeo/cssquery-yui.html (next: http://localhost:37048/tests/dromaeo/cssquery-dojo.html) 01:10:34 INFO - PROCESS | 17907 | RSS: Main: 155799552 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | __start_tp_report 01:10:34 INFO - PROCESS | 17907 | _x_x_mozilla_page_load 01:10:34 INFO - PROCESS | 17907 | _x_x_mozilla_page_load_details 01:10:34 INFO - PROCESS | 17907 | |i|pagename|runs| 01:10:34 INFO - PROCESS | 17907 | |0;dojo.html;3193.7764356495054;3196.3287709580986;3205.5031470122126;3229.8708051677936;3248.935021299574;5061.44324124347;5147.330846989891;5194.454582268864;5211.244369566411;5272.945410917812;5180.119379705449;5201.765920533576;5212.5308722214995;5243.10867152584;5258.2638430619745;4755.405574303212;4766.499517550659;4893;4932.926006109893;4937.77779999899;4836.854894353158;4842.201036828937;4878.804847806084;4914.434839993411;4964.528369804862;4700.2479603263655;4725.716457012591;4762.404699412574;4794.808207671689;4795.664303498756;4783.521647835223;4790.401199850019;4809.1583972804965;4842.612590992712;4845.854624361275;4763.3807605011125;4790.281457781326;4815.085133824562;4825.758712064383;4859.1496488114435;4965.528274813887;4998.325226094504;5012.674176178573;5019.899602007976;5168.250603662485;5453.127499600085;5539.224508568804;5586.273784408041;5590.720463976785;5642.210090587321;5671.2060311556415;5683.119116536944;5683.74423150955;5683.744231509592;5701.116326969326;5212.061828870802;5275.366955965232;5316.149416093445;5321.547668448148;5359;5765.942340576625;5787.074068149076;5791.420857914175;5800.941990580124;5859.062549991981;5513.448655134454;5518.834434966958;5559.16612508127;5568.52667523257;5593;5583.525400340935;5620.887582248332;5667.319921609351;5679.4320567943705;5695.40198279183;5667.603267771216;5670.631408958405;5687.829365119053;5700.25896633435;5702.401247868997;5654.547636189095;5660.264165658438;5678.886422271531;5684.914726279109;5695.60130790849;4351.760653164107;4353.804078816461;4399.64802815774;4435.977820110878;4492.573205545468;3908.9609103909165;3911.6088391160656;3914.178022615226;3942.940855887164;3944.2900277950243;5261.710605916634;5262.447443018428;5286.735663216824;5293.973530132324;5305.840824775263;5581.441855814386;5595.440455954372;5644.379118296984;5679.403662615448;5690.487856092972;5279.41926388097;5310.336207974004;5313.628046036818;5329.680219186861;5331.1470164773455;4812.807487700523;4862.100511405401;4873.293372460973;4873.683210591371;4911.16510193268;5713.628614140068;5780.653160810365;5785.942140578624;5857.238558987305;5887.735051922674;5576.191452239484;5606.747696353592;5637.661740295432;5644.153376993484;5682.232898558807;5795.623284486495;5831.825045248649;5832.62087964281;5840.766369345349;5843.2403787507355;5423.3491980962535;5505.559555235492;5507.476789704971;5554.08357620988;5566.666000040011;5723.3418156912485;5738.540916726568;5740.827775166752;5745.023346031101;5747.626404283876;5555.055640541037;5562.7774889005605;5574.665520068809;5591.608587399006;5605.383407825055;5389.299391079135;5439.836804895859;5503.972480137573;5517.227588137584;5521.723913804374;5398.568114550905;5402.972985135049;5425.593080518898;5426.484483974016;5443.564514838724;5462.481064298885;5490.752916118704;5538.363088244903;5539.124220890084;5591.021571225101;5333.706646134345;5406.243125962447;5407.026735187704;5429.239906413184;5488.835334939959 01:10:34 INFO - PROCESS | 17907 | |1;ext.html;520.6589683757138;539.9217113518539;550.6806052489554;550.757666626684;555.7054760976682;35902.2819543609;37058;37104.62895371045;37131;37145.628543714585;39202;39771.602283977154;39897;39906;39984;8198.303144232732;8520.062793092755;8531.06158322584;8534.317254619615;8542.145785421439;8321.875171872427;8406.453580517278;8504.107068757785;8661.740147795545;8668.219860212579;8639.568021598894;8695.21743043126;8725.171108744691;8769.123087691243;8783.780405489882;8239.217274358956;8325.458845175044;8355.623996920123;8362.331013518964;8411.747647570583;8265.917340826574;8322.875156872651;8352.958235208846;8355.248027677539;8363.874541881876;39096.80451597752;39475.605243947764;39480.40779388312;39583.40624890629;39598.60401396007;3288.8684452621865;3297.884574039921;3298.4062868683627;3335.816530090844;3922.490076290064;29227.269318267212;29439;29561.408771824445;29623.851880740673;30059.098227053004;3822.3310920589065;4071.531773845986;4082.755034697928;4110.77390743509;4134.441850350195;248758.9999999982;249250;249481;251923;252422;41147;41655.375169372484;41662;53283;53432;42500.36249456261;42918.35622465666;42936.57063429388;42965;42965.35551966723;13046.217226966412;13122.475100995853;13153.934230328787;13201.141925774795;13234.338283086;10425.061744443037;10441.321314114559;10460.320079194827;10472;10527.894721052844;13780.862191378159;13977.301134943213;14029;14133.5053273137;14157.929210353883;5789.160571717078;5813.941860581424;5840.561957853178;5900.380460051719;5918.763249470059;944.1502647617062;951.857221416793;983.5672304186136;992.811365840488;1035.8243393748;28679.139625811258;31719.52420713691;33045.50431743526;33267.66732332694;33381;1006.3408467453829;1009.5911155981839;1036.0261354326908;1056.3292309383444;1119.8544189255344;16156.838431615768;16358.672826543403;16432.75350869738;16502.917485412738;16699.6660066798;369028;370251;372009;372066;373303;53186.734066330195;53770;53795.46204537905;53850.19224711633;53853.73073134609;1357.7759669654595;1373.1829561411143;1427.9714405711827;1516.385863725193;1548.001539007334;28934.855325723238;29717;29933.102006939826;29945.401091978474;29995.6541068688;42240.15519689651;42787;42827;42859.57140428556;42904.35643465413;294277;296073;296119;297190;297245;31542;41655.37516937188;41814.79092604639;43169.568304316555;43182.13635727331;34849.65150348464;34919.82540087283;35116.82441587776;35594.11014724652;36299.45550816687;34672.82663586666;34817;36137;36795.44806827953;37780.62219377771;36393.272134557694;36427;36891.81554092212;37011.44482832706;37224.06939826526;35481.82259088791;36645.26709465849;36655.26689466142;36661.81669091638;36665.633343666224;30468.695313046584;33547;33627.49558756572;34017;34117.65882341244;26727.732722672525;27537.449251015267;27616.585751213344;28321.867125314755;28518.57222141628 01:10:34 INFO - PROCESS | 17907 | |2;jquery.html;355.56443356887814;367.6140052944408;368.7510930122167;370.6441815856779;371.28898160023556;15876.682466350667;16627.251773670185;16731.414400495985;17331.30674773011;17628.91185544072;11081.2797168184;11130.443477826117;16551.668966620662;16560.254788534516;16565.171741412913;4634.791434385453;4981.476944920767;4995.325631039799;5007.949920500785;5026.29631851541;4277.615014648681;4876.2929375240565;4903.607711383099;4913.901721965559;4916.3608730864935;5376.4085950545605;5393.217983392406;5401.648892821973;5408.4591540845995;5409.080456322415;4901.730404827733;4965.652404331699;4978.6514943953935;5341.0920143575495;5373.382061062969;4767.118083154593;4778.880527986794;4790.784414701347;4809.591184749301;4811.518848115195;15126.773098403533;18963.715544266848;19534.70697939532;19573;19601.705974410394;2173.5652869426176;2200.064972386745;2240;2279.726432828071;2328.6507023946374;9310.255179585616;9679.08048735376;10403;12159.574414895436;12874.87125128746;1858.5794505543538;1933.0528041259681;1943.893085880276;2016.9294074707316;2019.2225992992658;50525;51523.96952060975;52828.47171528312;55076;55469.72265138689;9854.359466634645;9864.852027219598;9899.554520046615;9957.80084398308;10000.2999790014;12448.81326780099;12836.165649232957;12845.165064270792;12909.99895016274;12960.157589756636;6971.198312194061;7184.820379490555;7201.13586369639;7210.134783825974;7250.202477727551;6685.866282674417;6719.664016799238;6771.492138089663;6823.69293381799;6841.076454678654;4329.523752387235;4362.432883725095;4377.146456441027;4466.441694788152;4471.7987690553355;1852.1480119145074;1911.4074636862617;1923.8749481283671;1939.7575303087115;1958.4222654317011;854.6709516836063;884.7788052986754;924.2975338742604;927.4157280912982;958.5638534466801;14880.776788347966;15288.388464461297;15401.383944642088;16112.919435402748;16484.17795509822;939.220447028978;945.8486642137362;946.9621215151454;970.3450171134597;979.3829887171037;9462;9467.857982130274;9490.620375184915;9659.420434773936;9881.209503239723;514822;516627;535440;539972;540156;72790.63604681943;73448.63275683587;73961;74043.25956740472;75087.24912750912;1125.4091601909063;1127.3855748617023;1134.5802053240188;1146.6789298996293;1148.0643275730254;14245.715085698435;14370.568882933529;14407.639809004859;14473.348699308346;14588.34352454121;28211;30658.84670576633;32194.19514512156;34195.82902085473;34304.656953430145;35666.821665891504;35996.46005309975;36584.26831463409;37313.440298395006;37789;7148.320909513588;7356.926430735624;7465.06686664167;7512.248775122444;7534.736284230025;10762.569497220024;11209.15931305139;11388.202825802115;11455.484503197209;11533;8483.830323393375;8541.786455338666;9426.86877574668;9447.102525260088;9518;9320.906790932004;9496.148251090972;9746.122848943629;9827.606895724377;9991.350562213433;9657.875267441152;9840.606375745176;9906.157976572073;9955.303128780915;9957.253206009433;7440.888386674096;7560.357369623423;7589.848203036019;7593.5823529706395;7593.772186834404;9356.315863144699;9856.260780441353;9949.552270147717;10002.44986525748;10174.8473772892 01:10:34 INFO - PROCESS | 17907 | |3;mootools.html;1390.6662401023755;1432.4341884955443;1538.8076490438696;1726.007545661245;1730.0830559803308;7124.0738703968545;7145.964270178648;7301.34287914089;7375.668094935721;7380.594067326295;7219.133703955533;7237.203907570163;7296.927030729691;7316.743913963012;7352.889706654391;2211.9051069720513;2224.7219097612797;2225.5771403433378;2240.9439764005947;2243.8317126215516;2252.1329288223988;2269.047000259895;2289.370423133635;2293.140072472823;2298.2645553422913;2253.3690566641285;2257.255105815077;2267.965980510294;2272.1933713531707;2331.3122628824535;2238.3844442778286;2250.437390652337;2261.412032871449;2261.7398999115067;2261.97738022621;2262.490939538607;2279.87460689662;2288.7482376938524;2292.954140917189;2302.4474126209757;7260.41916646667;7288.781336559911;7292.8906066409045;7304.561726296439;7335.706571737124;4539.818407263706;4658.324542941288;4679.883002924954;4694.389729335198;4695.060987802453;3085.1361618746787;3143.701348371901;3191.856366463515;3201.0876900083363;3215.774895757298;1050.175612144463;1060.2154405739775;1099.1371773158032;1110.5113749949996;1176.1120354132574;9888.357256778287;9900;9956.651517196864;9967.10296073357;9972.900270997343;4105.774182419936;4166.208420400114;4245.830166793294;4260.4248426462655;4288.50682171548;8140.023197216254;8163.591820409075;8179.100298967109;8191.79520511992;8194.75415737517;4623.491415944243;4625.259958406638;4628.930566041512;4642.721436713808;4661.650376221797;4247.256730072225;4257;4293;4294.012377153273;4299.527052024275;3286.145602143412;3297.422950983568;3332.7667063305335;3345.6988871001727;3375.8818441354433;1045.4668119259234;1052.7789164275434;1055.773008803111;1057.2070946789909;1063.2663462211203;1045.3466583385384;1064.4624464645306;1071.1430855315716;1155.439611788282;1234.7221875078035;6836.965815170893;6893.896591551131;6898.344657257552;6908.1019467468905;6917.550359226634;1088.4884104470887;1106.618216715232;1124.8031594470935;1125.083057308291;1126.7014241226082;5450.863728406822;5511.972440137773;5514.283143191359;5522.66863988154;5566.944330556724;8592.828143437222;8740.388172827841;9085.682001129928;9152.084791520794;9168.083191680911;8955.641774329084;8967;8985.550722463851;9042.050584688513;9088.727338179866;6802.727890884309;6902.965485172643;6995.650217489105;7005.299470053056;7009.5794252344;6765.1205343305055;6827.93172068273;6843.452523798183;6848.417884479676;6872.45020398357;7736.7678969631;7750.922490775246;7902.130765615662;7904.6442910068035;7978.680852765824;7811.960940195263;7998.640061197377;8028.799280018046;8076.757697269091;8250.711225107092;6335;6385.840353991188;6386.265579458422;6432.581882177644;6549.9520076787485;6948.200956890022;6986.6855991481525;6990.860182796214;6996.475264355092;7021.824454388681;6655.500837437115;6672.099266598947;6697.966510167418;6766.492513061638;6894.379505844498;6349.079383489276;6490.6105633660245;6527.902081468686;6619.536632435684;6663.866722665616;6562.048502966947;6573.506986976092;6626.237982632059;6627.701753421204;6641.0038494226255;6062.454379105725;6072.908906366496;6078.513718902565;6102.2067131274425;6152.107944348134;6115.602485838406;6123.7550497981365;6171;6174.567780255339;6191.442770150708 01:10:34 INFO - PROCESS | 17907 | |4;prototype.html;339.179186368987;346.7867261634096;347.7478827849808;350.93858574749413;352.4853713578176;6129.387061293868;6141.416565426289;6157.076438534222;6195.101710252016;6330.461910737593;6118.69406529674;6131.7240724167405;6151.323354431009;6159.476444502211;6164.876702465948;4687.132880417117;4692.085043416535;4699.78850951708;4699.859004229861;4705.600023997964;4713.835015774449;4743.715377077369;4743.739094349809;4745.525447455261;4754.120487709767;4596.310553416997;4607.308903664461;4695.741734204617;4719.292106184065;4721.504242054586;4682.391289132391;4706.811727530895;4708.78810453527;4711.787969541362;4750.45369782476;4178.373244013392;4180.707350485437;4192.224438478891;4199.454070970784;4199.475065616798;5850.97074514629;5857.209276747627;5867.70661466925;5870.6477611343025;5897.970510147465;5469.644473109275;5543.805966791143;5555.944440555623;5557.305336832896;5562.332520097614;6539.2479864815205;6543.509236807258;6545.05096760967;6547.148870646833;6548;4650.790714417859;4661.370714953506;4665.766711664403;4671.299305104261;4677.438707355105;6654.334566543355;6761.4590832733265;6820.863582728367;6824.761133360358;6830.282820303846;4769.451513075971;4776.09254241693;4777.044591081728;4783.06730187617;4795.520447955247;4832.661713680079;4840.903181936412;4849.95150048495;4852.611791056707;4865.95134048662;5538.113901775777;5540.36285827127;5542.8337149885565;5558.416366281563;5564.4991950724625;6467.062275970052;6552.770653027216;6583.242927063353;6591.373819487141;6596;1704.624982503872;1713.323237321276;1727.974080388795;1728.0495727349908;1728.8530474909521;1166.611732038871;1168.6902970712767;1170.087331881134;1187.1986409173774;1188.506769690586;6216.968915155395;6224.346443623445;6225.968870155711;6227.470664993436;6247.843803904848;6700.095487109275;6719.428848547928;6736.326367363225;6759.2226893906845;6776.15298087739;6104.908426373608;6221.595596286227;6242.781502647476;6289.842753931189;6293.779717709858;3674.228412033503;3678.834452449646;3680.650338217865;3687.0966613179944;3701.3522633539023;7124.786256412316;7152.392046676091;7167.749128780468;7173.067501224912;7178.928210717826;6795.966020169867;6951.7914462566205;6974.860502790018;6978.965105174543;6986.825329366807;7108.822279442952;7115;7131.179914309817;7137.714491420285;7147.9285207148305;6731.124953755981;6731.1922569292;6770.695318710571;6771.695273712793;6810.387065164159;6565.507586930904;6731.831704207238;6741.595504269563;6741.966290168518;6745.797626071226;7106.715731370894;7110.6089165094345;7134.429245660231;7137.82155446118;7148.928510714826;4613.746243956614;4667.953320466752;4669.836555720533;4671.135839869499;4677.087967846237;6544.3782840630065;6751.831204219738;6779.6271205084195;6782.423494003065;6799.490038247052;6577.671116444063;6582.967085164543;6597.934020659732;6605.339466053356;6608.867822643424;6575.539712220098;6576.210854697276;6578.309277525791;6584.8024559263295;6586.5389422739945;6324.905126423199;6428.325025872216;6452.064450654722;6454.967725161532;6469.353064693493;6565.146530950946;6579.2104947404705;6596.944488881756;6609.074729537772;6626.27111017778;6355.110284560073;6421.614703117828;6444.645544495098;6459.644719540471;6465.515086368635 01:10:34 INFO - PROCESS | 17907 | |5;yui.html;745.6160077560056;823.4400607586839;830.1532436914343;846.4117438380324;857.3912522109304;12489.437975291112;12589.874101258996;12608;12614.558490452824;12703.491860325588;12616.432260548274;12666.24002559847;12806.615801525946;12816.359182040884;13128.146670466413;786.1509569664763;790.9446338756289;796.7052190689424;799.1768478467188;803.7387848949086;788.6687591211676;795.2127393880046;796.1202870827739;798.6885114805231;801.7434420985287;811.975640730776;818.6111596991411;819.7049062337554;819.9590020498981;820.4134044158426;807.321849646297;813.2558708781457;813.3818298093462;816.7753867686374;819.0171793847406;598.186466405688;598.6946657204813;604.6825416656246;604.7339170764849;606.654207101952;12526.060545459128;12558.309292988883;12599.118061735682;12614.432350544248;12646.49414023438;10450.372977621291;10628.94685526575;10841.945790271076;10878.510467029002;10989.06592939601;9443.480608566526;9516.809663806685;9572.56923438447;9631.566579503939;9683.225341972695;3362.8318584070944;3390.7287417006582;3469.6530346965355;3508.3509550732942;3543.0433782878476;44446.55553444489;44639.77680111579;45312.32031519497;50616.74691626518;50930;9945.751356216153;10217.33587316822;10279.845802312972;10460.476976151162;10603.045725884707;17610.94334339918;17808.198631061634;17865.7320140198;17867.642647146986;17936;7130.750423735144;7299.817504562322;7559.697612095454;7747.186545412763;7783.377329813601;4407.206702793528;4468;4505.5719706627815;4581.725096494221;4636.629069674418;2951.1884231836416;2962.851857407121;2973.152651494357;2984.880604775828;2991.5811786349927;551.2007588995972;553.6677993204125;562.2802812400134;567.9346875109333;574.0270241939955;524.2738806752599;536.9529417635626;643.6717274190103;652.670401447266;661.4873473058418;8330.333573314121;8545.102764209792;8549.487030778173;8565.14348565151;8718.084601116918;633.2369494758805;633.9524535659843;672.4116398151617;677.021703638238;703.6165289917008;3974.920501589952;4230.280852255124;4320.827166913351;4411.470623525198;4463.642908567307;50016.49983500191;50216.49783502191;50318.748406257735;50386.74806626017;57879;44218.77890610526;44279.89300267519;44604.55395446069;45551.544484555394;45707;44043.779781100886;46051;48848;49359.25961110586;50342.24486632703;8454.154584541497;8656.134386561294;8816.206541411304;8828.38201325901;9407.670731524364;34134;35543.46684799782;35944.281114378085;36625.45061824022;38527;42525.5747442534;42579;42713.1457370857;43196;43383;11465.770684586429;11575.479103440197;11596.36220007874;11607.477663505331;11659.941700291443;12266.815997759863;12391.380430978596;12450.564230251897;12651.177673451197;12989.805152922525;10808.491102705402;10833.187510936868;11028.889711102785;11233.213675042996;11768.52925882955;11359.984878556152;11641.767164656829;11825.467853946766;11827.586034488751;12111.939440302742;11039.45371775393;11192.552297908318;11258.549658013588;11293.943530282297;11550.653480395602;8627.266682332072;8870.64517419296;8904.376693631384;9129.634814607341;9217.44695318283;8502.008112374348;8687.739367818975;8869.366686519805;9477.857832132662;9659.32384733062 01:10:34 INFO - PROCESS | 17907 | __end_tp_report 01:10:34 INFO - PROCESS | 17907 | __start_cc_report 01:10:34 INFO - PROCESS | 17907 | _x_x_mozilla_cycle_collect,311 01:10:34 INFO - PROCESS | 17907 | __end_cc_report 01:10:34 INFO - PROCESS | 17907 | __startTimestamp1452589834873__endTimestamp 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | ------- Summary: start ------- 01:10:34 INFO - PROCESS | 17907 | Number of tests: 6 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | [#0] dojo.html Cycles:165 Average:5243.29 Median:5425.59 stddev:566.57 (10.4%) stddev-sans-first:545.01 01:10:34 INFO - PROCESS | 17907 | Values: 3193.8 3196.3 3205.5 3229.9 3248.9 5061.4 5147.3 5194.5 5211.2 5272.9 5180.1 5201.8 5212.5 5243.1 5258.3 4755.4 4766.5 4893.0 4932.9 4937.8 4836.9 4842.2 4878.8 4914.4 4964.5 4700.2 4725.7 4762.4 4794.8 4795.7 4783.5 4790.4 4809.2 4842.6 4845.9 4763.4 4790.3 4815.1 4825.8 4859.1 4965.5 4998.3 5012.7 5019.9 5168.3 5453.1 5539.2 5586.3 5590.7 5642.2 5671.2 5683.1 5683.7 5683.7 5701.1 5212.1 5275.4 5316.1 5321.5 5359.0 5765.9 5787.1 5791.4 5800.9 5859.1 5513.4 5518.8 5559.2 5568.5 5593.0 5583.5 5620.9 5667.3 5679.4 5695.4 5667.6 5670.6 5687.8 5700.3 5702.4 5654.5 5660.3 5678.9 5684.9 5695.6 4351.8 4353.8 4399.6 4436.0 4492.6 3909.0 3911.6 3914.2 3942.9 3944.3 5261.7 5262.4 5286.7 5294.0 5305.8 5581.4 5595.4 5644.4 5679.4 5690.5 5279.4 5310.3 5313.6 5329.7 5331.1 4812.8 4862.1 4873.3 4873.7 4911.2 5713.6 5780.7 5785.9 5857.2 5887.7 5576.2 5606.7 5637.7 5644.2 5682.2 5795.6 5831.8 5832.6 5840.8 5843.2 5423.3 5505.6 5507.5 5554.1 5566.7 5723.3 5738.5 5740.8 5745.0 5747.6 5555.1 5562.8 5574.7 5591.6 5605.4 5389.3 5439.8 5504.0 5517.2 5521.7 5398.6 5403.0 5425.6 5426.5 5443.6 5462.5 5490.8 5538.4 5539.1 5591.0 5333.7 5406.2 5407.0 5429.2 5488.8 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | [#1] ext.html Cycles:180 Average:46397.68 Median:203631.22 stddev:81315.62 (39.9%) stddev-sans-first:81470.78 01:10:34 INFO - PROCESS | 17907 | Values: 520.7 539.9 550.7 550.8 555.7 35902.3 37058.0 37104.6 37131.0 37145.6 39202.0 39771.6 39897.0 39906.0 39984.0 8198.3 8520.1 8531.1 8534.3 8542.1 8321.9 8406.5 8504.1 8661.7 8668.2 8639.6 8695.2 8725.2 8769.1 8783.8 8239.2 8325.5 8355.6 8362.3 8411.7 8265.9 8322.9 8353.0 8355.2 8363.9 39096.8 39475.6 39480.4 39583.4 39598.6 3288.9 3297.9 3298.4 3335.8 3922.5 29227.3 29439.0 29561.4 29623.9 30059.1 3822.3 4071.5 4082.8 4110.8 4134.4 248759.0 249250.0 249481.0 251923.0 252422.0 41147.0 41655.4 41662.0 53283.0 53432.0 42500.4 42918.4 42936.6 42965.0 42965.4 13046.2 13122.5 13153.9 13201.1 13234.3 10425.1 10441.3 10460.3 10472.0 10527.9 13780.9 13977.3 14029.0 14133.5 14157.9 5789.2 5813.9 5840.6 5900.4 5918.8 944.2 951.9 983.6 992.8 1035.8 28679.1 31719.5 33045.5 33267.7 33381.0 1006.3 1009.6 1036.0 1056.3 1119.9 16156.8 16358.7 16432.8 16502.9 16699.7 369028.0 370251.0 372009.0 372066.0 373303.0 53186.7 53770.0 53795.5 53850.2 53853.7 1357.8 1373.2 1428.0 1516.4 1548.0 28934.9 29717.0 29933.1 29945.4 29995.7 42240.2 42787.0 42827.0 42859.6 42904.4 294277.0 296073.0 296119.0 297190.0 297245.0 31542.0 41655.4 41814.8 43169.6 43182.1 34849.7 34919.8 35116.8 35594.1 36299.5 34672.8 34817.0 36137.0 36795.4 37780.6 36393.3 36427.0 36891.8 37011.4 37224.1 35481.8 36645.3 36655.3 36661.8 36665.6 30468.7 33547.0 33627.5 34017.0 34117.7 26727.7 27537.4 27616.6 28321.9 28518.6 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | [#2] jquery.html Cycles:180 Average:26819.57 Median:4908.75 stddev:86487.86 (1761.9%) stddev-sans-first:86707.65 01:10:34 INFO - PROCESS | 17907 | Values: 355.6 367.6 368.8 370.6 371.3 15876.7 16627.3 16731.4 17331.3 17628.9 11081.3 11130.4 16551.7 16560.3 16565.2 4634.8 4981.5 4995.3 5007.9 5026.3 4277.6 4876.3 4903.6 4913.9 4916.4 5376.4 5393.2 5401.6 5408.5 5409.1 4901.7 4965.7 4978.7 5341.1 5373.4 4767.1 4778.9 4790.8 4809.6 4811.5 15126.8 18963.7 19534.7 19573.0 19601.7 2173.6 2200.1 2240.0 2279.7 2328.7 9310.3 9679.1 10403.0 12159.6 12874.9 1858.6 1933.1 1943.9 2016.9 2019.2 50525.0 51524.0 52828.5 55076.0 55469.7 9854.4 9864.9 9899.6 9957.8 10000.3 12448.8 12836.2 12845.2 12910.0 12960.2 6971.2 7184.8 7201.1 7210.1 7250.2 6685.9 6719.7 6771.5 6823.7 6841.1 4329.5 4362.4 4377.1 4466.4 4471.8 1852.1 1911.4 1923.9 1939.8 1958.4 854.7 884.8 924.3 927.4 958.6 14880.8 15288.4 15401.4 16112.9 16484.2 939.2 945.8 947.0 970.3 979.4 9462.0 9467.9 9490.6 9659.4 9881.2 514822.0 516627.0 535440.0 539972.0 540156.0 72790.6 73448.6 73961.0 74043.3 75087.2 1125.4 1127.4 1134.6 1146.7 1148.1 14245.7 14370.6 14407.6 14473.3 14588.3 28211.0 30658.8 32194.2 34195.8 34304.7 35666.8 35996.5 36584.3 37313.4 37789.0 7148.3 7356.9 7465.1 7512.2 7534.7 10762.6 11209.2 11388.2 11455.5 11533.0 8483.8 8541.8 9426.9 9447.1 9518.0 9320.9 9496.1 9746.1 9827.6 9991.4 9657.9 9840.6 9906.2 9955.3 9957.3 7440.9 7560.4 7589.8 7593.6 7593.8 9356.3 9856.3 9949.6 10002.4 10174.8 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | [#3] mootools.html Cycles:180 Average:5196.07 Median:6137.93 stddev:2605.35 (42.4%) stddev-sans-first:2596.96 01:10:34 INFO - PROCESS | 17907 | Values: 1390.7 1432.4 1538.8 1726.0 1730.1 7124.1 7146.0 7301.3 7375.7 7380.6 7219.1 7237.2 7296.9 7316.7 7352.9 2211.9 2224.7 2225.6 2240.9 2243.8 2252.1 2269.0 2289.4 2293.1 2298.3 2253.4 2257.3 2268.0 2272.2 2331.3 2238.4 2250.4 2261.4 2261.7 2262.0 2262.5 2279.9 2288.7 2293.0 2302.4 7260.4 7288.8 7292.9 7304.6 7335.7 4539.8 4658.3 4679.9 4694.4 4695.1 3085.1 3143.7 3191.9 3201.1 3215.8 1050.2 1060.2 1099.1 1110.5 1176.1 9888.4 9900.0 9956.7 9967.1 9972.9 4105.8 4166.2 4245.8 4260.4 4288.5 8140.0 8163.6 8179.1 8191.8 8194.8 4623.5 4625.3 4628.9 4642.7 4661.7 4247.3 4257.0 4293.0 4294.0 4299.5 3286.1 3297.4 3332.8 3345.7 3375.9 1045.5 1052.8 1055.8 1057.2 1063.3 1045.3 1064.5 1071.1 1155.4 1234.7 6837.0 6893.9 6898.3 6908.1 6917.6 1088.5 1106.6 1124.8 1125.1 1126.7 5450.9 5512.0 5514.3 5522.7 5566.9 8592.8 8740.4 9085.7 9152.1 9168.1 8955.6 8967.0 8985.6 9042.1 9088.7 6802.7 6903.0 6995.7 7005.3 7009.6 6765.1 6827.9 6843.5 6848.4 6872.5 7736.8 7750.9 7902.1 7904.6 7978.7 7812.0 7998.6 8028.8 8076.8 8250.7 6335.0 6385.8 6386.3 6432.6 6550.0 6948.2 6986.7 6990.9 6996.5 7021.8 6655.5 6672.1 6698.0 6766.5 6894.4 6349.1 6490.6 6527.9 6619.5 6663.9 6562.0 6573.5 6626.2 6627.7 6641.0 6062.5 6072.9 6078.5 6102.2 6152.1 6115.6 6123.8 6171.0 6174.6 6191.4 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | [#4] prototype.html Cycles:180 Average:5512.16 Median:6219.28 stddev:1645.32 (26.5%) stddev-sans-first:1603.46 01:10:34 INFO - PROCESS | 17907 | Values: 339.2 346.8 347.7 350.9 352.5 6129.4 6141.4 6157.1 6195.1 6330.5 6118.7 6131.7 6151.3 6159.5 6164.9 4687.1 4692.1 4699.8 4699.9 4705.6 4713.8 4743.7 4743.7 4745.5 4754.1 4596.3 4607.3 4695.7 4719.3 4721.5 4682.4 4706.8 4708.8 4711.8 4750.5 4178.4 4180.7 4192.2 4199.5 4199.5 5851.0 5857.2 5867.7 5870.6 5898.0 5469.6 5543.8 5555.9 5557.3 5562.3 6539.2 6543.5 6545.1 6547.1 6548.0 4650.8 4661.4 4665.8 4671.3 4677.4 6654.3 6761.5 6820.9 6824.8 6830.3 4769.5 4776.1 4777.0 4783.1 4795.5 4832.7 4840.9 4850.0 4852.6 4866.0 5538.1 5540.4 5542.8 5558.4 5564.5 6467.1 6552.8 6583.2 6591.4 6596.0 1704.6 1713.3 1728.0 1728.0 1728.9 1166.6 1168.7 1170.1 1187.2 1188.5 6217.0 6224.3 6226.0 6227.5 6247.8 6700.1 6719.4 6736.3 6759.2 6776.2 6104.9 6221.6 6242.8 6289.8 6293.8 3674.2 3678.8 3680.7 3687.1 3701.4 7124.8 7152.4 7167.7 7173.1 7178.9 6796.0 6951.8 6974.9 6979.0 6986.8 7108.8 7115.0 7131.2 7137.7 7147.9 6731.1 6731.2 6770.7 6771.7 6810.4 6565.5 6731.8 6741.6 6742.0 6745.8 7106.7 7110.6 7134.4 7137.8 7148.9 4613.7 4668.0 4669.8 4671.1 4677.1 6544.4 6751.8 6779.6 6782.4 6799.5 6577.7 6583.0 6597.9 6605.3 6608.9 6575.5 6576.2 6578.3 6584.8 6586.5 6324.9 6428.3 6452.1 6455.0 6469.4 6565.1 6579.2 6596.9 6609.1 6626.3 6355.1 6421.6 6444.6 6459.6 6465.5 01:10:34 INFO - PROCESS | 17907 | 01:10:34 INFO - PROCESS | 17907 | [#5] yui.html Cycles:180 Average:13330.23 Median:25144.36 stddev:15134.22 (60.2%) stddev-sans-first:15147.17 01:10:34 INFO - PROCESS | 17907 | Values: 745.6 823.4 830.2 846.4 857.4 12489.4 12589.9 12608.0 12614.6 12703.5 12616.4 12666.2 12806.6 12816.4 13128.1 786.2 790.9 796.7 799.2 803.7 788.7 795.2 796.1 798.7 801.7 812.0 818.6 819.7 820.0 820.4 807.3 813.3 813.4 816.8 819.0 598.2 598.7 604.7 604.7 606.7 12526.1 12558.3 12599.1 12614.4 12646.5 10450.4 10628.9 10841.9 10878.5 10989.1 9443.5 9516.8 9572.6 9631.6 9683.2 3362.8 3390.7 3469.7 3508.4 3543.0 44446.6 44639.8 45312.3 50616.7 50930.0 9945.8 10217.3 10279.8 10460.5 10603.0 17610.9 17808.2 17865.7 17867.6 17936.0 7130.8 7299.8 7559.7 7747.2 7783.4 4407.2 4468.0 4505.6 4581.7 4636.6 2951.2 2962.9 2973.2 2984.9 2991.6 551.2 553.7 562.3 567.9 574.0 524.3 537.0 643.7 652.7 661.5 8330.3 8545.1 8549.5 8565.1 8718.1 633.2 634.0 672.4 677.0 703.6 3974.9 4230.3 4320.8 4411.5 4463.6 50016.5 50216.5 50318.7 50386.7 57879.0 44218.8 44279.9 44604.6 45551.5 45707.0 44043.8 46051.0 48848.0 49359.3 50342.2 8454.2 8656.1 8816.2 8828.4 9407.7 34134.0 35543.5 35944.3 36625.5 38527.0 42525.6 42579.0 42713.1 43196.0 43383.0 11465.8 11575.5 11596.4 11607.5 11659.9 12266.8 12391.4 12450.6 12651.2 12989.8 10808.5 10833.2 11028.9 11233.2 11768.5 11360.0 11641.8 11825.5 11827.6 12111.9 11039.5 11192.6 11258.5 11293.9 11550.7 8627.3 8870.6 8904.4 9129.6 9217.4 8502.0 8687.7 8869.4 9477.9 9659.3 01:10:34 INFO - PROCESS | 17907 | -------- Summary: end -------- 01:10:34 INFO - PROCESS | 17907 | 01:10:35 INFO - TEST-INFO | 17907: exit 0 01:10:35 INFO - TEST-OK | dromaeo_css | took 1110025ms 01:10:35 INFO - TEST-START | kraken 01:10:35 INFO - operating with platform_type : linux_ 01:10:35 INFO - Initialising browser for kraken test... 01:10:35 INFO - TEST-INFO | started process 18147 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgaa8Lm/profile http://localhost:37048/getInfo.html) 01:10:38 INFO - PROCESS | 18147 | 01:10:38 INFO - PROCESS | 18147 | (process:18218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:10:38 INFO - PROCESS | 18147 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:10:39 INFO - PROCESS | 18147 | __metrics Screen width/height:1600/1200 01:10:39 INFO - PROCESS | 18147 | colorDepth:24 01:10:39 INFO - PROCESS | 18147 | Browser inner width/height: 1024/697 01:10:39 INFO - PROCESS | 18147 | __metrics 01:10:39 INFO - PROCESS | 18147 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:10:40 INFO - TEST-INFO | 18147: exit 0 01:10:40 INFO - Browser initialized. 01:10:40 INFO - Running cycle 1/1 for kraken test... 01:10:40 INFO - TEST-INFO | started process 18267 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgaa8Lm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:10:41 INFO - PROCESS | 18267 | 01:10:41 INFO - PROCESS | 18267 | (process:18327): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:10:52 INFO - PROCESS | 18267 | RSS: Main: 150302720 01:10:52 INFO - PROCESS | 18267 | 01:10:54 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37048/tests/kraken/driver.html?testName=audio-beat-detection) 01:10:55 INFO - PROCESS | 18267 | RSS: Main: 151023616 01:10:55 INFO - PROCESS | 18267 | 01:10:58 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37048/tests/kraken/driver.html?testName=audio-dft) 01:10:58 INFO - PROCESS | 18267 | RSS: Main: 151937024 01:10:58 INFO - PROCESS | 18267 | 01:11:01 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37048/tests/kraken/driver.html?testName=audio-fft) 01:11:02 INFO - PROCESS | 18267 | RSS: Main: 145436672 01:11:02 INFO - PROCESS | 18267 | 01:11:04 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37048/tests/kraken/driver.html?testName=audio-oscillator) 01:11:05 INFO - PROCESS | 18267 | RSS: Main: 146829312 01:11:05 INFO - PROCESS | 18267 | 01:11:07 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37048/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:11:07 INFO - PROCESS | 18267 | RSS: Main: 147230720 01:11:07 INFO - PROCESS | 18267 | 01:11:10 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37048/tests/kraken/driver.html?testName=imaging-darkroom) 01:11:11 INFO - PROCESS | 18267 | RSS: Main: 147820544 01:11:11 INFO - PROCESS | 18267 | 01:11:14 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37048/tests/kraken/driver.html?testName=imaging-desaturate) 01:11:15 INFO - PROCESS | 18267 | RSS: Main: 149168128 01:11:15 INFO - PROCESS | 18267 | 01:11:18 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37048/tests/kraken/driver.html?testName=json-parse-financial) 01:11:18 INFO - PROCESS | 18267 | RSS: Main: 147079168 01:11:18 INFO - PROCESS | 18267 | 01:11:20 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37048/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:11:20 INFO - PROCESS | 18267 | RSS: Main: 149004288 01:11:20 INFO - PROCESS | 18267 | 01:11:22 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:11:23 INFO - PROCESS | 18267 | RSS: Main: 148840448 01:11:23 INFO - PROCESS | 18267 | 01:11:25 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:11:26 INFO - PROCESS | 18267 | RSS: Main: 149204992 01:11:26 INFO - PROCESS | 18267 | 01:11:28 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:11:29 INFO - PROCESS | 18267 | RSS: Main: 148938752 01:11:29 INFO - PROCESS | 18267 | 01:11:31 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:11:32 INFO - PROCESS | 18267 | RSS: Main: 149295104 01:11:32 INFO - PROCESS | 18267 | 01:11:33 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:37048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37048/tests/kraken/driver.html?testName=ai-astar) 01:11:34 INFO - PROCESS | 18267 | RSS: Main: 150048768 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | __start_tp_report 01:11:34 INFO - PROCESS | 18267 | _x_x_mozilla_page_load 01:11:34 INFO - PROCESS | 18267 | _x_x_mozilla_page_load_details 01:11:34 INFO - PROCESS | 18267 | |i|pagename|runs| 01:11:34 INFO - PROCESS | 18267 | |0;ai-astar;111;107;112;110;112;123;111;111;111;111 01:11:34 INFO - PROCESS | 18267 | |1;audio-beat-detection;151;124;151;172;128;153;158;143;166;131 01:11:34 INFO - PROCESS | 18267 | |2;audio-dft;165;165;163;163;163;163;163;168;167;163 01:11:34 INFO - PROCESS | 18267 | |3;audio-fft;72;78;77;75;75;72;72;149;72;72 01:11:34 INFO - PROCESS | 18267 | |4;audio-oscillator;98;97;135;98;97;96;137;95;96;142 01:11:34 INFO - PROCESS | 18267 | |5;imaging-gaussian-blur;110;111;110;109;109;110;110;110;110;109 01:11:34 INFO - PROCESS | 18267 | |6;imaging-darkroom;146;147;146;147;146;146;147;146;147;147 01:11:34 INFO - PROCESS | 18267 | |7;imaging-desaturate;96;97;96;97;96;96;96;95;95;96 01:11:34 INFO - PROCESS | 18267 | |8;json-parse-financial;58;61;59;58;58;60;61;59;57;57 01:11:34 INFO - PROCESS | 18267 | |9;json-stringify-tinderbox;68;73;68;69;67;68;69;70;69;68 01:11:34 INFO - PROCESS | 18267 | |10;stanford-crypto-aes;84;84;87;85;87;85;86;84;87;86 01:11:34 INFO - PROCESS | 18267 | |11;stanford-crypto-ccm;119;118;128;118;124;119;121;119;120;134 01:11:34 INFO - PROCESS | 18267 | |12;stanford-crypto-pbkdf2;141;154;152;148;153;144;152;156;153;150 01:11:34 INFO - PROCESS | 18267 | |13;stanford-crypto-sha256-iterative;69;67;68;68;68;67;73;69;68;70 01:11:34 INFO - PROCESS | 18267 | __end_tp_report 01:11:34 INFO - PROCESS | 18267 | __start_cc_report 01:11:34 INFO - PROCESS | 18267 | _x_x_mozilla_cycle_collect,746 01:11:34 INFO - PROCESS | 18267 | __end_cc_report 01:11:34 INFO - PROCESS | 18267 | __startTimestamp1452589894241__endTimestamp 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | ------- Summary: start ------- 01:11:34 INFO - PROCESS | 18267 | Number of tests: 14 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.15 (3.7%) stddev-sans-first:4.39 01:11:34 INFO - PROCESS | 18267 | Values: 111.0 107.0 112.0 110.0 112.0 123.0 111.0 111.0 111.0 111.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:152.00 stddev:16.10 (10.6%) stddev-sans-first:17.03 01:11:34 INFO - PROCESS | 18267 | Values: 151.0 124.0 151.0 172.0 128.0 153.0 158.0 143.0 166.0 131.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 01:11:34 INFO - PROCESS | 18267 | Values: 165.0 165.0 163.0 163.0 163.0 163.0 163.0 168.0 167.0 163.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#3] audio-fft Cycles:10 Average:81.40 Median:73.50 stddev:23.86 (32.5%) stddev-sans-first:25.07 01:11:34 INFO - PROCESS | 18267 | Values: 72.0 78.0 77.0 75.0 75.0 72.0 72.0 149.0 72.0 72.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.50 stddev:20.04 (20.8%) stddev-sans-first:20.84 01:11:34 INFO - PROCESS | 18267 | Values: 98.0 97.0 135.0 98.0 97.0 96.0 137.0 95.0 96.0 142.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 01:11:34 INFO - PROCESS | 18267 | Values: 110.0 111.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:11:34 INFO - PROCESS | 18267 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:11:34 INFO - PROCESS | 18267 | Values: 96.0 97.0 96.0 97.0 96.0 96.0 96.0 95.0 95.0 96.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:1.48 (2.5%) stddev-sans-first:1.54 01:11:34 INFO - PROCESS | 18267 | Values: 58.0 61.0 59.0 58.0 58.0 60.0 61.0 59.0 57.0 57.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 01:11:34 INFO - PROCESS | 18267 | Values: 68.0 73.0 68.0 69.0 67.0 68.0 69.0 70.0 69.0 68.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.27 (1.5%) stddev-sans-first:1.22 01:11:34 INFO - PROCESS | 18267 | Values: 84.0 84.0 87.0 85.0 87.0 85.0 86.0 84.0 87.0 86.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:120.50 stddev:5.25 (4.4%) stddev-sans-first:5.45 01:11:34 INFO - PROCESS | 18267 | Values: 119.0 118.0 128.0 118.0 124.0 119.0 121.0 119.0 120.0 134.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:152.50 stddev:4.69 (3.1%) stddev-sans-first:3.57 01:11:34 INFO - PROCESS | 18267 | Values: 141.0 154.0 152.0 148.0 153.0 144.0 152.0 156.0 153.0 150.0 01:11:34 INFO - PROCESS | 18267 | 01:11:34 INFO - PROCESS | 18267 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.77 (2.6%) stddev-sans-first:1.87 01:11:34 INFO - PROCESS | 18267 | Values: 69.0 67.0 68.0 68.0 68.0 67.0 73.0 69.0 68.0 70.0 01:11:34 INFO - PROCESS | 18267 | -------- Summary: end -------- 01:11:34 INFO - PROCESS | 18267 | 01:11:35 INFO - TEST-INFO | 18267: exit 0 01:11:35 INFO - TEST-OK | kraken | took 59553ms 01:11:35 INFO - TEST-START | v8_7 01:11:35 INFO - operating with platform_type : linux_ 01:11:35 INFO - Initialising browser for v8_7 test... 01:11:35 INFO - TEST-INFO | started process 18556 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbQAEnk/profile http://localhost:37048/getInfo.html) 01:11:38 INFO - PROCESS | 18556 | 01:11:38 INFO - PROCESS | 18556 | (process:18628): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:11:38 INFO - PROCESS | 18556 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:11:38 INFO - PROCESS | 18556 | __metrics Screen width/height:1600/1200 01:11:38 INFO - PROCESS | 18556 | colorDepth:24 01:11:38 INFO - PROCESS | 18556 | Browser inner width/height: 1024/697 01:11:38 INFO - PROCESS | 18556 | __metrics 01:11:39 INFO - PROCESS | 18556 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:11:39 INFO - TEST-INFO | 18556: exit 0 01:11:39 INFO - Browser initialized. 01:11:39 INFO - Running cycle 1/1 for v8_7 test... 01:11:39 INFO - TEST-INFO | started process 18677 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbQAEnk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:11:41 INFO - PROCESS | 18677 | 01:11:41 INFO - PROCESS | 18677 | (process:18736): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:11:51 INFO - PROCESS | 18677 | RSS: Main: 150409216 01:11:51 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | Cycle 1(1): loaded http://localhost:37048/tests/v8_7/run.html (next: http://localhost:37048/tests/v8_7/run.html) 01:12:14 INFO - PROCESS | 18677 | RSS: Main: 145559552 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | __start_tp_report 01:12:14 INFO - PROCESS | 18677 | _x_x_mozilla_page_load 01:12:14 INFO - PROCESS | 18677 | _x_x_mozilla_page_load_details 01:12:14 INFO - PROCESS | 18677 | |i|pagename|runs| 01:12:14 INFO - PROCESS | 18677 | |0;Richards;167.19612104999163 01:12:14 INFO - PROCESS | 18677 | |1;DeltaBlue;188.7504718761797 01:12:14 INFO - PROCESS | 18677 | |2;Encrypt;280.42624789680315 01:12:14 INFO - PROCESS | 18677 | |3;Decrypt;5213.541666666667 01:12:14 INFO - PROCESS | 18677 | |4;RayTrace;1069.51871657754 01:12:14 INFO - PROCESS | 18677 | |5;Earley;712.2507122507122 01:12:14 INFO - PROCESS | 18677 | |6;Boyer;12268.292682926829 01:12:14 INFO - PROCESS | 18677 | |7;RegExp;41408.163265306124 01:12:14 INFO - PROCESS | 18677 | |8;Splay;567.2149744753261 01:12:14 INFO - PROCESS | 18677 | |9;NavierStokes;4826.923076923077 01:12:14 INFO - PROCESS | 18677 | __end_tp_report 01:12:14 INFO - PROCESS | 18677 | __startTimestamp1452589934307__endTimestamp 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | ------- Summary: start ------- 01:12:14 INFO - PROCESS | 18677 | Number of tests: 10 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 167.2 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#1] DeltaBlue Cycles:1 Average:188.75 Median:188.75 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 188.8 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 280.4 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 5213.5 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 1069.5 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#5] Earley Cycles:1 Average:712.25 Median:712.25 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 712.3 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 12268.3 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#7] RegExp Cycles:1 Average:41408.16 Median:41408.16 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 41408.2 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#8] Splay Cycles:1 Average:567.21 Median:567.21 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 567.2 01:12:14 INFO - PROCESS | 18677 | 01:12:14 INFO - PROCESS | 18677 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 01:12:14 INFO - PROCESS | 18677 | Values: 4826.9 01:12:14 INFO - PROCESS | 18677 | -------- Summary: end -------- 01:12:14 INFO - PROCESS | 18677 | 01:12:15 INFO - TEST-INFO | 18677: exit 0 01:12:15 INFO - TEST-OK | v8_7 | took 39992ms 01:12:15 INFO - SUITE-END | took 1209s 01:12:15 INFO - Completed test suite (00:20:09) 01:12:15 INFO - Working with test: dromaeo_css 01:12:15 INFO - Generating results file: dromaeo_css 01:12:15 INFO - Working with test: kraken 01:12:15 INFO - Generating results file: kraken 01:12:15 INFO - javascript benchmark 01:12:15 INFO - Working with test: v8_7 01:12:15 INFO - Generating results file: v8_7 01:12:15 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:12:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 01:12:15 INFO - process_Request line: dromaeo_css 6804.14 graph.html#tests=[[72,63,43]] 01:12:15 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:12:15 INFO - process_Request line: kraken 1520.90 graph.html#tests=[[232,63,43]] 01:12:15 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:12:15 INFO - process_Request line: v8_7 20473.31 graph.html#tests=[[230,63,43]] 01:12:15 INFO - RETURN: dromaeo_css: 6804.14 01:12:15 INFO - RETURN: kraken: 1520.90 01:12:15 INFO - RETURN: v8_7: 20473.31 01:12:15 INFO - javascript benchmark 01:12:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3193.7764356495054, 3196.3287709580986, 3205.5031470122126, 3229.8708051677936, 3248.935021299574, 5061.44324124347, 5147.330846989891, 5194.454582268864, 5211.244369566411, 5272.945410917812, 5180.119379705449, 5201.765920533576, 5212.5308722214995, 5243.10867152584, 5258.2638430619745, 4755.405574303212, 4766.499517550659, 4893.0, 4932.926006109893, 4937.77779999899, 4836.854894353158, 4842.201036828937, 4878.804847806084, 4914.434839993411, 4964.528369804862, 4700.2479603263655, 4725.716457012591, 4762.404699412574, 4794.808207671689, 4795.664303498756, 4783.521647835223, 4790.401199850019, 4809.1583972804965, 4842.612590992712, 4845.854624361275, 4763.3807605011125, 4790.281457781326, 4815.085133824562, 4825.758712064383, 4859.1496488114435, 4965.528274813887, 4998.325226094504, 5012.674176178573, 5019.899602007976, 5168.250603662485, 5453.127499600085, 5539.224508568804, 5586.273784408041, 5590.720463976785, 5642.210090587321, 5671.2060311556415, 5683.119116536944, 5683.74423150955, 5683.744231509592, 5701.116326969326, 5212.061828870802, 5275.366955965232, 5316.149416093445, 5321.547668448148, 5359.0, 5765.942340576625, 5787.074068149076, 5791.420857914175, 5800.941990580124, 5859.062549991981, 5513.448655134454, 5518.834434966958, 5559.16612508127, 5568.52667523257, 5593.0, 5583.525400340935, 5620.887582248332, 5667.319921609351, 5679.4320567943705, 5695.40198279183, 5667.603267771216, 5670.631408958405, 5687.829365119053, 5700.25896633435, 5702.401247868997, 5654.547636189095, 5660.264165658438, 5678.886422271531, 5684.914726279109, 5695.60130790849, 4351.760653164107, 4353.804078816461, 4399.64802815774, 4435.977820110878, 4492.573205545468, 3908.9609103909165, 3911.6088391160656, 3914.178022615226, 3942.940855887164, 3944.2900277950243, 5261.710605916634, 5262.447443018428, 5286.735663216824, 5293.973530132324, 5305.840824775263, 5581.441855814386, 5595.440455954372, 5644.379118296984, 5679.403662615448, 5690.487856092972, 5279.41926388097, 5310.336207974004, 5313.628046036818, 5329.680219186861, 5331.1470164773455, 4812.807487700523, 4862.100511405401, 4873.293372460973, 4873.683210591371, 4911.16510193268, 5713.628614140068, 5780.653160810365, 5785.942140578624, 5857.238558987305, 5887.735051922674, 5576.191452239484, 5606.747696353592, 5637.661740295432, 5644.153376993484, 5682.232898558807, 5795.623284486495, 5831.825045248649, 5832.62087964281, 5840.766369345349, 5843.2403787507355, 5423.3491980962535, 5505.559555235492, 5507.476789704971, 5554.08357620988, 5566.666000040011, 5723.3418156912485, 5738.540916726568, 5740.827775166752, 5745.023346031101, 5747.626404283876, 5555.055640541037, 5562.7774889005605, 5574.665520068809, 5591.608587399006, 5605.383407825055, 5389.299391079135, 5439.836804895859, 5503.972480137573, 5517.227588137584, 5521.723913804374, 5398.568114550905, 5402.972985135049, 5425.593080518898, 5426.484483974016, 5443.564514838724, 5462.481064298885, 5490.752916118704, 5538.363088244903, 5539.124220890084, 5591.021571225101, 5333.706646134345, 5406.243125962447, 5407.026735187704, 5429.239906413184, 5488.835334939959], "unit": "score", "name": "dojo.html", "value": 5207.774442083694}, {"lowerIsBetter": false, "replicates": [520.6589683757138, 539.9217113518539, 550.6806052489554, 550.757666626684, 555.7054760976682, 35902.2819543609, 37058.0, 37104.62895371045, 37131.0, 37145.628543714585, 39202.0, 39771.602283977154, 39897.0, 39906.0, 39984.0, 8198.303144232732, 8520.062793092755, 8531.06158322584, 8534.317254619615, 8542.145785421439, 8321.875171872427, 8406.453580517278, 8504.107068757785, 8661.740147795545, 8668.219860212579, 8639.568021598894, 8695.21743043126, 8725.171108744691, 8769.123087691243, 8783.780405489882, 8239.217274358956, 8325.458845175044, 8355.623996920123, 8362.331013518964, 8411.747647570583, 8265.917340826574, 8322.875156872651, 8352.958235208846, 8355.248027677539, 8363.874541881876, 39096.80451597752, 39475.605243947764, 39480.40779388312, 39583.40624890629, 39598.60401396007, 3288.8684452621865, 3297.884574039921, 3298.4062868683627, 3335.816530090844, 3922.490076290064, 29227.269318267212, 29439.0, 29561.408771824445, 29623.851880740673, 30059.098227053004, 3822.3310920589065, 4071.531773845986, 4082.755034697928, 4110.77390743509, 4134.441850350195, 248758.9999999982, 249250.0, 249481.0, 251923.0, 252422.0, 41147.0, 41655.375169372484, 41662.0, 53283.0, 53432.0, 42500.36249456261, 42918.35622465666, 42936.57063429388, 42965.0, 42965.35551966723, 13046.217226966412, 13122.475100995853, 13153.934230328787, 13201.141925774795, 13234.338283086, 10425.061744443037, 10441.321314114559, 10460.320079194827, 10472.0, 10527.894721052844, 13780.862191378159, 13977.301134943213, 14029.0, 14133.5053273137, 14157.929210353883, 5789.160571717078, 5813.941860581424, 5840.561957853178, 5900.380460051719, 5918.763249470059, 944.1502647617062, 951.857221416793, 983.5672304186136, 992.811365840488, 1035.8243393748, 28679.139625811258, 31719.52420713691, 33045.50431743526, 33267.66732332694, 33381.0, 1006.3408467453829, 1009.5911155981839, 1036.0261354326908, 1056.3292309383444, 1119.8544189255344, 16156.838431615768, 16358.672826543403, 16432.75350869738, 16502.917485412738, 16699.6660066798, 369028.0, 370251.0, 372009.0, 372066.0, 373303.0, 53186.734066330195, 53770.0, 53795.46204537905, 53850.19224711633, 53853.73073134609, 1357.7759669654595, 1373.1829561411143, 1427.9714405711827, 1516.385863725193, 1548.001539007334, 28934.855325723238, 29717.0, 29933.102006939826, 29945.401091978474, 29995.6541068688, 42240.15519689651, 42787.0, 42827.0, 42859.57140428556, 42904.35643465413, 294277.0, 296073.0, 296119.0, 297190.0, 297245.0, 31542.0, 41655.37516937188, 41814.79092604639, 43169.568304316555, 43182.13635727331, 34849.65150348464, 34919.82540087283, 35116.82441587776, 35594.11014724652, 36299.45550816687, 34672.82663586666, 34817.0, 36137.0, 36795.44806827953, 37780.62219377771, 36393.272134557694, 36427.0, 36891.81554092212, 37011.44482832706, 37224.06939826526, 35481.82259088791, 36645.26709465849, 36655.26689466142, 36661.81669091638, 36665.633343666224, 30468.695313046584, 33547.0, 33627.49558756572, 34017.0, 34117.65882341244, 26727.732722672525, 27537.449251015267, 27616.585751213344, 28321.867125314755, 28518.57222141628], "unit": "score", "name": "ext.html", "value": 17861.081726867786}, {"lowerIsBetter": false, "replicates": [355.56443356887814, 367.6140052944408, 368.7510930122167, 370.6441815856779, 371.28898160023556, 15876.682466350667, 16627.251773670185, 16731.414400495985, 17331.30674773011, 17628.91185544072, 11081.2797168184, 11130.443477826117, 16551.668966620662, 16560.254788534516, 16565.171741412913, 4634.791434385453, 4981.476944920767, 4995.325631039799, 5007.949920500785, 5026.29631851541, 4277.615014648681, 4876.2929375240565, 4903.607711383099, 4913.901721965559, 4916.3608730864935, 5376.4085950545605, 5393.217983392406, 5401.648892821973, 5408.4591540845995, 5409.080456322415, 4901.730404827733, 4965.652404331699, 4978.6514943953935, 5341.0920143575495, 5373.382061062969, 4767.118083154593, 4778.880527986794, 4790.784414701347, 4809.591184749301, 4811.518848115195, 15126.773098403533, 18963.715544266848, 19534.70697939532, 19573.0, 19601.705974410394, 2173.5652869426176, 2200.064972386745, 2240.0, 2279.726432828071, 2328.6507023946374, 9310.255179585616, 9679.08048735376, 10403.0, 12159.574414895436, 12874.87125128746, 1858.5794505543538, 1933.0528041259681, 1943.893085880276, 2016.9294074707316, 2019.2225992992658, 50525.0, 51523.96952060975, 52828.47171528312, 55076.0, 55469.72265138689, 9854.359466634645, 9864.852027219598, 9899.554520046615, 9957.80084398308, 10000.2999790014, 12448.81326780099, 12836.165649232957, 12845.165064270792, 12909.99895016274, 12960.157589756636, 6971.198312194061, 7184.820379490555, 7201.13586369639, 7210.134783825974, 7250.202477727551, 6685.866282674417, 6719.664016799238, 6771.492138089663, 6823.69293381799, 6841.076454678654, 4329.523752387235, 4362.432883725095, 4377.146456441027, 4466.441694788152, 4471.7987690553355, 1852.1480119145074, 1911.4074636862617, 1923.8749481283671, 1939.7575303087115, 1958.4222654317011, 854.6709516836063, 884.7788052986754, 924.2975338742604, 927.4157280912982, 958.5638534466801, 14880.776788347966, 15288.388464461297, 15401.383944642088, 16112.919435402748, 16484.17795509822, 939.220447028978, 945.8486642137362, 946.9621215151454, 970.3450171134597, 979.3829887171037, 9462.0, 9467.857982130274, 9490.620375184915, 9659.420434773936, 9881.209503239723, 514822.0, 516627.0, 535440.0, 539972.0, 540156.0, 72790.63604681943, 73448.63275683587, 73961.0, 74043.25956740472, 75087.24912750912, 1125.4091601909063, 1127.3855748617023, 1134.5802053240188, 1146.6789298996293, 1148.0643275730254, 14245.715085698435, 14370.568882933529, 14407.639809004859, 14473.348699308346, 14588.34352454121, 28211.0, 30658.84670576633, 32194.19514512156, 34195.82902085473, 34304.656953430145, 35666.821665891504, 35996.46005309975, 36584.26831463409, 37313.440298395006, 37789.0, 7148.320909513588, 7356.926430735624, 7465.06686664167, 7512.248775122444, 7534.736284230025, 10762.569497220024, 11209.15931305139, 11388.202825802115, 11455.484503197209, 11533.0, 8483.830323393375, 8541.786455338666, 9426.86877574668, 9447.102525260088, 9518.0, 9320.906790932004, 9496.148251090972, 9746.122848943629, 9827.606895724377, 9991.350562213433, 9657.875267441152, 9840.606375745176, 9906.157976572073, 9955.303128780915, 9957.253206009433, 7440.888386674096, 7560.357369623423, 7589.848203036019, 7593.5823529706395, 7593.772186834404, 9356.315863144699, 9856.260780441353, 9949.552270147717, 10002.44986525748, 10174.8473772892], "unit": "score", "name": "jquery.html", "value": 8022.139213645461}, {"lowerIsBetter": false, "replicates": [1390.6662401023755, 1432.4341884955443, 1538.8076490438696, 1726.007545661245, 1730.0830559803308, 7124.0738703968545, 7145.964270178648, 7301.34287914089, 7375.668094935721, 7380.594067326295, 7219.133703955533, 7237.203907570163, 7296.927030729691, 7316.743913963012, 7352.889706654391, 2211.9051069720513, 2224.7219097612797, 2225.5771403433378, 2240.9439764005947, 2243.8317126215516, 2252.1329288223988, 2269.047000259895, 2289.370423133635, 2293.140072472823, 2298.2645553422913, 2253.3690566641285, 2257.255105815077, 2267.965980510294, 2272.1933713531707, 2331.3122628824535, 2238.3844442778286, 2250.437390652337, 2261.412032871449, 2261.7398999115067, 2261.97738022621, 2262.490939538607, 2279.87460689662, 2288.7482376938524, 2292.954140917189, 2302.4474126209757, 7260.41916646667, 7288.781336559911, 7292.8906066409045, 7304.561726296439, 7335.706571737124, 4539.818407263706, 4658.324542941288, 4679.883002924954, 4694.389729335198, 4695.060987802453, 3085.1361618746787, 3143.701348371901, 3191.856366463515, 3201.0876900083363, 3215.774895757298, 1050.175612144463, 1060.2154405739775, 1099.1371773158032, 1110.5113749949996, 1176.1120354132574, 9888.357256778287, 9900.0, 9956.651517196864, 9967.10296073357, 9972.900270997343, 4105.774182419936, 4166.208420400114, 4245.830166793294, 4260.4248426462655, 4288.50682171548, 8140.023197216254, 8163.591820409075, 8179.100298967109, 8191.79520511992, 8194.75415737517, 4623.491415944243, 4625.259958406638, 4628.930566041512, 4642.721436713808, 4661.650376221797, 4247.256730072225, 4257.0, 4293.0, 4294.012377153273, 4299.527052024275, 3286.145602143412, 3297.422950983568, 3332.7667063305335, 3345.6988871001727, 3375.8818441354433, 1045.4668119259234, 1052.7789164275434, 1055.773008803111, 1057.2070946789909, 1063.2663462211203, 1045.3466583385384, 1064.4624464645306, 1071.1430855315716, 1155.439611788282, 1234.7221875078035, 6836.965815170893, 6893.896591551131, 6898.344657257552, 6908.1019467468905, 6917.550359226634, 1088.4884104470887, 1106.618216715232, 1124.8031594470935, 1125.083057308291, 1126.7014241226082, 5450.863728406822, 5511.972440137773, 5514.283143191359, 5522.66863988154, 5566.944330556724, 8592.828143437222, 8740.388172827841, 9085.682001129928, 9152.084791520794, 9168.083191680911, 8955.641774329084, 8967.0, 8985.550722463851, 9042.050584688513, 9088.727338179866, 6802.727890884309, 6902.965485172643, 6995.650217489105, 7005.299470053056, 7009.5794252344, 6765.1205343305055, 6827.93172068273, 6843.452523798183, 6848.417884479676, 6872.45020398357, 7736.7678969631, 7750.922490775246, 7902.130765615662, 7904.6442910068035, 7978.680852765824, 7811.960940195263, 7998.640061197377, 8028.799280018046, 8076.757697269091, 8250.711225107092, 6335.0, 6385.840353991188, 6386.265579458422, 6432.581882177644, 6549.9520076787485, 6948.200956890022, 6986.6855991481525, 6990.860182796214, 6996.475264355092, 7021.824454388681, 6655.500837437115, 6672.099266598947, 6697.966510167418, 6766.492513061638, 6894.379505844498, 6349.079383489276, 6490.6105633660245, 6527.902081468686, 6619.536632435684, 6663.866722665616, 6562.048502966947, 6573.506986976092, 6626.237982632059, 6627.701753421204, 6641.0038494226255, 6062.454379105725, 6072.908906366496, 6078.513718902565, 6102.2067131274425, 6152.107944348134, 6115.602485838406, 6123.7550497981365, 6171.0, 6174.567780255339, 6191.442770150708], "unit": "score", "name": "mootools.html", "value": 4323.358734967231}, {"lowerIsBetter": false, "replicates": [339.179186368987, 346.7867261634096, 347.7478827849808, 350.93858574749413, 352.4853713578176, 6129.387061293868, 6141.416565426289, 6157.076438534222, 6195.101710252016, 6330.461910737593, 6118.69406529674, 6131.7240724167405, 6151.323354431009, 6159.476444502211, 6164.876702465948, 4687.132880417117, 4692.085043416535, 4699.78850951708, 4699.859004229861, 4705.600023997964, 4713.835015774449, 4743.715377077369, 4743.739094349809, 4745.525447455261, 4754.120487709767, 4596.310553416997, 4607.308903664461, 4695.741734204617, 4719.292106184065, 4721.504242054586, 4682.391289132391, 4706.811727530895, 4708.78810453527, 4711.787969541362, 4750.45369782476, 4178.373244013392, 4180.707350485437, 4192.224438478891, 4199.454070970784, 4199.475065616798, 5850.97074514629, 5857.209276747627, 5867.70661466925, 5870.6477611343025, 5897.970510147465, 5469.644473109275, 5543.805966791143, 5555.944440555623, 5557.305336832896, 5562.332520097614, 6539.2479864815205, 6543.509236807258, 6545.05096760967, 6547.148870646833, 6548.0, 4650.790714417859, 4661.370714953506, 4665.766711664403, 4671.299305104261, 4677.438707355105, 6654.334566543355, 6761.4590832733265, 6820.863582728367, 6824.761133360358, 6830.282820303846, 4769.451513075971, 4776.09254241693, 4777.044591081728, 4783.06730187617, 4795.520447955247, 4832.661713680079, 4840.903181936412, 4849.95150048495, 4852.611791056707, 4865.95134048662, 5538.113901775777, 5540.36285827127, 5542.8337149885565, 5558.416366281563, 5564.4991950724625, 6467.062275970052, 6552.770653027216, 6583.242927063353, 6591.373819487141, 6596.0, 1704.624982503872, 1713.323237321276, 1727.974080388795, 1728.0495727349908, 1728.8530474909521, 1166.611732038871, 1168.6902970712767, 1170.087331881134, 1187.1986409173774, 1188.506769690586, 6216.968915155395, 6224.346443623445, 6225.968870155711, 6227.470664993436, 6247.843803904848, 6700.095487109275, 6719.428848547928, 6736.326367363225, 6759.2226893906845, 6776.15298087739, 6104.908426373608, 6221.595596286227, 6242.781502647476, 6289.842753931189, 6293.779717709858, 3674.228412033503, 3678.834452449646, 3680.650338217865, 3687.0966613179944, 3701.3522633539023, 7124.786256412316, 7152.392046676091, 7167.749128780468, 7173.067501224912, 7178.928210717826, 6795.966020169867, 6951.7914462566205, 6974.860502790018, 6978.965105174543, 6986.825329366807, 7108.822279442952, 7115.0, 7131.179914309817, 7137.714491420285, 7147.9285207148305, 6731.124953755981, 6731.1922569292, 6770.695318710571, 6771.695273712793, 6810.387065164159, 6565.507586930904, 6731.831704207238, 6741.595504269563, 6741.966290168518, 6745.797626071226, 7106.715731370894, 7110.6089165094345, 7134.429245660231, 7137.82155446118, 7148.928510714826, 4613.746243956614, 4667.953320466752, 4669.836555720533, 4671.135839869499, 4677.087967846237, 6544.3782840630065, 6751.831204219738, 6779.6271205084195, 6782.423494003065, 6799.490038247052, 6577.671116444063, 6582.967085164543, 6597.934020659732, 6605.339466053356, 6608.867822643424, 6575.539712220098, 6576.210854697276, 6578.309277525791, 6584.8024559263295, 6586.5389422739945, 6324.905126423199, 6428.325025872216, 6452.064450654722, 6454.967725161532, 6469.353064693493, 6565.146530950946, 6579.2104947404705, 6596.944488881756, 6609.074729537772, 6626.27111017778, 6355.110284560073, 6421.614703117828, 6444.645544495098, 6459.644719540471, 6465.515086368635], "unit": "score", "name": "prototype.html", "value": 4981.88809565345}, {"lowerIsBetter": false, "replicates": [745.6160077560056, 823.4400607586839, 830.1532436914343, 846.4117438380324, 857.3912522109304, 12489.437975291112, 12589.874101258996, 12608.0, 12614.558490452824, 12703.491860325588, 12616.432260548274, 12666.24002559847, 12806.615801525946, 12816.359182040884, 13128.146670466413, 786.1509569664763, 790.9446338756289, 796.7052190689424, 799.1768478467188, 803.7387848949086, 788.6687591211676, 795.2127393880046, 796.1202870827739, 798.6885114805231, 801.7434420985287, 811.975640730776, 818.6111596991411, 819.7049062337554, 819.9590020498981, 820.4134044158426, 807.321849646297, 813.2558708781457, 813.3818298093462, 816.7753867686374, 819.0171793847406, 598.186466405688, 598.6946657204813, 604.6825416656246, 604.7339170764849, 606.654207101952, 12526.060545459128, 12558.309292988883, 12599.118061735682, 12614.432350544248, 12646.49414023438, 10450.372977621291, 10628.94685526575, 10841.945790271076, 10878.510467029002, 10989.06592939601, 9443.480608566526, 9516.809663806685, 9572.56923438447, 9631.566579503939, 9683.225341972695, 3362.8318584070944, 3390.7287417006582, 3469.6530346965355, 3508.3509550732942, 3543.0433782878476, 44446.55553444489, 44639.77680111579, 45312.32031519497, 50616.74691626518, 50930.0, 9945.751356216153, 10217.33587316822, 10279.845802312972, 10460.476976151162, 10603.045725884707, 17610.94334339918, 17808.198631061634, 17865.7320140198, 17867.642647146986, 17936.0, 7130.750423735144, 7299.817504562322, 7559.697612095454, 7747.186545412763, 7783.377329813601, 4407.206702793528, 4468.0, 4505.5719706627815, 4581.725096494221, 4636.629069674418, 2951.1884231836416, 2962.851857407121, 2973.152651494357, 2984.880604775828, 2991.5811786349927, 551.2007588995972, 553.6677993204125, 562.2802812400134, 567.9346875109333, 574.0270241939955, 524.2738806752599, 536.9529417635626, 643.6717274190103, 652.670401447266, 661.4873473058418, 8330.333573314121, 8545.102764209792, 8549.487030778173, 8565.14348565151, 8718.084601116918, 633.2369494758805, 633.9524535659843, 672.4116398151617, 677.021703638238, 703.6165289917008, 3974.920501589952, 4230.280852255124, 4320.827166913351, 4411.470623525198, 4463.642908567307, 50016.49983500191, 50216.49783502191, 50318.748406257735, 50386.74806626017, 57879.0, 44218.77890610526, 44279.89300267519, 44604.55395446069, 45551.544484555394, 45707.0, 44043.779781100886, 46051.0, 48848.0, 49359.25961110586, 50342.24486632703, 8454.154584541497, 8656.134386561294, 8816.206541411304, 8828.38201325901, 9407.670731524364, 34134.0, 35543.46684799782, 35944.281114378085, 36625.45061824022, 38527.0, 42525.5747442534, 42579.0, 42713.1457370857, 43196.0, 43383.0, 11465.770684586429, 11575.479103440197, 11596.36220007874, 11607.477663505331, 11659.941700291443, 12266.815997759863, 12391.380430978596, 12450.564230251897, 12651.177673451197, 12989.805152922525, 10808.491102705402, 10833.187510936868, 11028.889711102785, 11233.213675042996, 11768.52925882955, 11359.984878556152, 11641.767164656829, 11825.467853946766, 11827.586034488751, 12111.939440302742, 11039.45371775393, 11192.552297908318, 11258.549658013588, 11293.943530282297, 11550.653480395602, 8627.266682332072, 8870.64517419296, 8904.376693631384, 9129.634814607341, 9217.44695318283, 8502.008112374348, 8687.739367818975, 8869.366686519805, 9477.857832132662, 9659.32384733062], "unit": "score", "name": "yui.html", "value": 6173.58556469888}], "name": "dromaeo_css", "value": 6804.1405948558295}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 110.0, 112.0, 123.0, 111.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 151.0, 172.0, 128.0, 153.0, 158.0, 143.0, 166.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [165.0, 165.0, 163.0, 163.0, 163.0, 163.0, 163.0, 168.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 78.0, 77.0, 75.0, 75.0, 72.0, 72.0, 149.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 135.0, 98.0, 97.0, 96.0, 137.0, 95.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 59.0, 58.0, 58.0, 60.0, 61.0, 59.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [68.0, 73.0, 68.0, 69.0, 67.0, 68.0, 69.0, 70.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 87.0, 85.0, 87.0, 85.0, 86.0, 84.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 128.0, 118.0, 124.0, 119.0, 121.0, 119.0, 120.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 152.0, 148.0, 153.0, 144.0, 152.0, 156.0, 153.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 73.0, 69.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1520.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [188.7504718761797], "unit": "score", "name": "DeltaBlue", "value": 350.2931640000001}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1069.51871657754], "unit": "score", "name": "RayTrace", "value": 691.889715}, {"lowerIsBetter": false, "replicates": [712.2507122507122], "unit": "score", "name": "Earley", "value": 935.7140519999998}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [41408.163265306124], "unit": "score", "name": "RegExp", "value": 22.000130606209943}, {"lowerIsBetter": false, "replicates": [567.2149744753261], "unit": "score", "name": "Splay", "value": 143.66863300000006}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20473.31238256226}]} 01:12:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20473.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1520.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6804.14"}}} 01:12:15 INFO - Return code: 0 01:12:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:12:15 INFO - # TBPL SUCCESS # 01:12:15 INFO - Running post-action listener: _resource_record_post_action 01:12:15 INFO - Running post-run listener: _resource_record_post_run 01:12:16 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 12288; Write bytes: 563523584; Read time: 288; Write time: 389836 01:12:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 239452160; Read time: 220; Write time: 202832 01:12:16 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 8192; Write bytes: 324071424; Read time: 68; Write time: 187004 01:12:16 INFO - Running post-run listener: _upload_blobber_files 01:12:16 INFO - Blob upload gear active. 01:12:16 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:12:16 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:12:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:12:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:12:17 INFO - (blobuploader) - INFO - Open directory for files ... 01:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:18 INFO - (blobuploader) - INFO - Done attempting. 01:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:18 INFO - (blobuploader) - INFO - Done attempting. 01:12:18 INFO - (blobuploader) - INFO - Iteration through files over. 01:12:19 INFO - Return code: 0 01:12:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:12:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:12:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5344cc99e21172beae5571ad8d1250498588bf858140ea0abb8a4c3909e8a19149b08bd93b59ebc0f3ec0731a4edc589289faac4e28b380527bb1cd776c29851", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6f426cd1bf76524d0b7dfd62ee7db4a1cf23c3facedef26af0277f275e99b44573f131042dbc9d71f69fec7f8520411e5611e0d9357df5487aebc4f4d269bf1b"} 01:12:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:12:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:12:19 INFO - Contents: 01:12:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5344cc99e21172beae5571ad8d1250498588bf858140ea0abb8a4c3909e8a19149b08bd93b59ebc0f3ec0731a4edc589289faac4e28b380527bb1cd776c29851", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6f426cd1bf76524d0b7dfd62ee7db4a1cf23c3facedef26af0277f275e99b44573f131042dbc9d71f69fec7f8520411e5611e0d9357df5487aebc4f4d269bf1b"} 01:12:19 INFO - Copying logs to upload dir... 01:12:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.840119 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-12 01:12:17.797236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 01:12:17.800853) ========= 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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5344cc99e21172beae5571ad8d1250498588bf858140ea0abb8a4c3909e8a19149b08bd93b59ebc0f3ec0731a4edc589289faac4e28b380527bb1cd776c29851", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6f426cd1bf76524d0b7dfd62ee7db4a1cf23c3facedef26af0277f275e99b44573f131042dbc9d71f69fec7f8520411e5611e0d9357df5487aebc4f4d269bf1b"} build_url:https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/LOBWAqwSSH-hUaTwwYuIbA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5344cc99e21172beae5571ad8d1250498588bf858140ea0abb8a4c3909e8a19149b08bd93b59ebc0f3ec0731a4edc589289faac4e28b380527bb1cd776c29851", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6f426cd1bf76524d0b7dfd62ee7db4a1cf23c3facedef26af0277f275e99b44573f131042dbc9d71f69fec7f8520411e5611e0d9357df5487aebc4f4d269bf1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 01:12:17.825846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:12:17.826153) ========= 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=0274524eba3bdaad075c2247000001d4-1452588668.574718-1775583628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:12:17.911770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 01:12:17.912106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 01:12:17.912479) ========= ========= Total master_lag: 0.23 =========