builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1452275789.05 results: success (0) buildid: 20160108073153 builduid: 59dd9ac8fb6f4c0ab5c6ecc5f606f35a revision: 3f780f4b14acab29b16bc4141a44180a8af9dd08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.053502) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.054262) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.054645) ========= 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=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006401 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.085843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.086216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.104512) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.104838) ========= 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=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004683 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.169069) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.169394) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.169884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.170246) ========= 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=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 09:56:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.7M=0.001s 2016-01-08 09:56:29 (12.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156960 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.345926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.346318) ========= 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=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.397757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.398219) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f780f4b14acab29b16bc4141a44180a8af9dd08 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3f780f4b14acab29b16bc4141a44180a8af9dd08 --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=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 09:56:30,010 truncating revision to first 12 chars 2016-01-08 09:56:30,010 Setting DEBUG logging. 2016-01-08 09:56:30,011 attempt 1/10 2016-01-08 09:56:30,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f780f4b14ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 09:56:30,252 unpacking tar archive at: mozilla-central-3f780f4b14ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.956031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.956416) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.966083) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.966417) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.967236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-08 09:56:29.967566) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:30 INFO - MultiFileLogger online at 20160108 09:56:30 in /builds/slave/test-pgo 09:56:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:56:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:56:30 INFO - {'append_to_log': False, 09:56:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:56:30 INFO - 'blob_upload_branch': 'Firefox', 09:56:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:56:30 INFO - 'branch': 'Firefox', 09:56:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:30 INFO - 'config_files': ('talos/linux_config.py',), 09:56:30 INFO - 'default_actions': ('clobber', 09:56:30 INFO - 'read-buildbot-config', 09:56:30 INFO - 'download-and-extract', 09:56:30 INFO - 'populate-webroot', 09:56:30 INFO - 'create-virtualenv', 09:56:30 INFO - 'install', 09:56:30 INFO - 'run-tests'), 09:56:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:30 INFO - 'download_minidump_stackwalk': True, 09:56:30 INFO - 'download_symbols': 'ondemand', 09:56:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:30 INFO - 'installer_path': 'installer.exe', 09:56:30 INFO - 'log_level': 'info', 09:56:30 INFO - 'log_name': 'talos', 09:56:30 INFO - 'log_to_console': True, 09:56:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:30 INFO - 'opt_config_files': (), 09:56:30 INFO - 'pip_index': False, 09:56:30 INFO - 'sps_profile': False, 09:56:30 INFO - 'sps_profile_interval': 0, 09:56:30 INFO - 'suite': 'dromaeojs-e10s', 09:56:30 INFO - 'system_bits': '32', 09:56:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:30 INFO - 'title': 'talos-linux64-ix-044', 09:56:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:30 INFO - 'use_talos_json': True, 09:56:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:56:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:30 INFO - 'work_dir': 'build'} 09:56:30 INFO - ##### 09:56:30 INFO - ##### Running clobber step. 09:56:30 INFO - ##### 09:56:30 INFO - Running pre-action listener: _resource_record_pre_action 09:56:30 INFO - Running main action method: clobber 09:56:30 INFO - rmtree: /builds/slave/test-pgo/build 09:56:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:56:31 INFO - Running post-action listener: _resource_record_post_action 09:56:31 INFO - ##### 09:56:31 INFO - ##### Running read-buildbot-config step. 09:56:31 INFO - ##### 09:56:31 INFO - Running pre-action listener: _resource_record_pre_action 09:56:31 INFO - Running main action method: read_buildbot_config 09:56:31 INFO - Using buildbot properties: 09:56:31 INFO - { 09:56:31 INFO - "project": "", 09:56:31 INFO - "product": "firefox", 09:56:31 INFO - "script_repo_revision": "production", 09:56:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:56:31 INFO - "repository": "", 09:56:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:56:31 INFO - "buildid": "20160108073153", 09:56:31 INFO - "pgo_build": "True", 09:56:31 INFO - "basedir": "/builds/slave/test-pgo", 09:56:31 INFO - "buildnumber": 294, 09:56:31 INFO - "slavename": "talos-linux64-ix-044", 09:56:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:56:31 INFO - "platform": "ubuntu64_hw", 09:56:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:56:31 INFO - "branch": "mozilla-central", 09:56:31 INFO - "repo_path": "mozilla-central", 09:56:31 INFO - "revision": "3f780f4b14acab29b16bc4141a44180a8af9dd08", 09:56:31 INFO - "stage_platform": "linux64-pgo", 09:56:31 INFO - "builduid": "59dd9ac8fb6f4c0ab5c6ecc5f606f35a", 09:56:31 INFO - "slavebuilddir": "test" 09:56:31 INFO - } 09:56:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:56:31 INFO - Running post-action listener: _resource_record_post_action 09:56:31 INFO - ##### 09:56:31 INFO - ##### Running download-and-extract step. 09:56:31 INFO - ##### 09:56:31 INFO - Running pre-action listener: _resource_record_pre_action 09:56:31 INFO - Running main action method: download_and_extract 09:56:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:31 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:56:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json 09:56:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json 09:56:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:56:31 INFO - Downloaded 1302 bytes. 09:56:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:56:31 INFO - Using the following test package requirements: 09:56:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:56:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:31 INFO - u'jsshell-linux-x86_64.zip'], 09:56:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:56:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:56:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:56:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:56:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:56:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:31 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:35 INFO - Downloaded 24028131 bytes. 09:56:35 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 09:56:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:35 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 09:56:36 INFO - Return code: 0 09:56:36 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 09:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:36 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:49 INFO - Downloaded 24028131 bytes. 09:56:49 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 09:56:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:49 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 09:56:50 INFO - Return code: 0 09:56:50 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')]} 09:56:50 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:51 INFO - Downloaded 11132285 bytes. 09:56:51 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 09:56:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:51 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 09:56:51 INFO - Return code: 0 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:51 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:56 INFO - Downloaded 55928647 bytes. 09:56:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:56 INFO - mkdir: /builds/slave/test-pgo/properties 09:56:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:56:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:56:56 INFO - Contents: 09:56:56 INFO - build_url:https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:56 INFO - Running post-action listener: _resource_record_post_action 09:56:56 INFO - Running post-action listener: set_extra_try_arguments 09:56:56 INFO - ##### 09:56:56 INFO - ##### Running populate-webroot step. 09:56:56 INFO - ##### 09:56:56 INFO - Running pre-action listener: _resource_record_pre_action 09:56:56 INFO - Running main action method: populate_webroot 09:56:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:56 INFO - '--tppagecycles', 09:56:56 INFO - '7'], 09:56:56 INFO - 'tests': ['tsvgm']}}, 09:56:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:56:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'tests': ['damp', 'tps']}, 09:56:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['damp', 'tps']}, 09:56:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:56:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:56 INFO - 'other': {'tests': ['a11yr', 09:56:56 INFO - 'ts_paint', 09:56:56 INFO - 'tpaint', 09:56:56 INFO - 'sessionrestore', 09:56:56 INFO - 'sessionrestore_no_auto_restore']}, 09:56:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['a11yr', 09:56:56 INFO - 'ts_paint', 09:56:56 INFO - 'tpaint', 09:56:56 INFO - 'sessionrestore', 09:56:56 INFO - 'sessionrestore_no_auto_restore']}, 09:56:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['a11yr', 09:56:56 INFO - 'ts_paint', 09:56:56 INFO - 'tpaint', 09:56:56 INFO - 'sessionrestore', 09:56:56 INFO - 'sessionrestore_no_auto_restore']}, 09:56:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['a11yr', 09:56:56 INFO - 'ts_paint', 09:56:56 INFO - 'tpaint', 09:56:56 INFO - 'sessionrestore', 09:56:56 INFO - 'sessionrestore_no_auto_restore']}, 09:56:56 INFO - 'other_l64': {'tests': ['a11yr', 09:56:56 INFO - 'ts_paint', 09:56:56 INFO - 'tpaint', 09:56:56 INFO - 'sessionrestore', 09:56:56 INFO - 'sessionrestore_no_auto_restore']}, 09:56:56 INFO - 'other_nol64': {'tests': ['a11yr', 09:56:56 INFO - 'ts_paint', 09:56:56 INFO - 'tpaint', 09:56:56 INFO - 'sessionrestore', 09:56:56 INFO - 'sessionrestore_no_auto_restore']}, 09:56:56 INFO - 'svgr': {'tests': ['tsvgx', 09:56:56 INFO - 'tsvgr_opacity', 09:56:56 INFO - 'tart', 09:56:56 INFO - 'tscrollx', 09:56:56 INFO - 'cart']}, 09:56:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['tsvgx', 09:56:56 INFO - 'tsvgr_opacity', 09:56:56 INFO - 'tart', 09:56:56 INFO - 'tscrollx', 09:56:56 INFO - 'cart']}, 09:56:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'tests': ['tp5o']}, 09:56:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'talos_options': ['--e10s'], 09:56:56 INFO - 'tests': ['tp5o']}, 09:56:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'talos_options': ['--xperf_path', 09:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:56 INFO - 'tests': ['tp5n']}, 09:56:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:56 INFO - 'talos_options': ['--e10s', 09:56:56 INFO - '--xperf_path', 09:56:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:56 INFO - 'tests': ['tp5n']}}, 09:56:56 INFO - 'talos.zip': {'path': '', 09:56:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:56 INFO - Running post-action listener: _resource_record_post_action 09:56:56 INFO - ##### 09:56:56 INFO - ##### Running create-virtualenv step. 09:56:56 INFO - ##### 09:56:56 INFO - Running pre-action listener: _resource_record_pre_action 09:56:56 INFO - Running main action method: create_virtualenv 09:56:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:56:56 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 09:56:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:56:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:56 INFO - Using real prefix '/usr' 09:56:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:56:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:59 INFO - Installing pip.................done. 09:56:59 INFO - Return code: 0 09:56:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:59 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:56:59 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 09:56:59 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 09:56:59 INFO - Using env: {'DISPLAY': ':0', 09:56:59 INFO - 'HOME': '/home/cltbld', 09:56:59 INFO - 'LANG': 'en_US.UTF-8', 09:56:59 INFO - 'LANGUAGE': 'en_US:en', 09:56:59 INFO - 'LOGNAME': 'cltbld', 09:56:59 INFO - 'MAIL': '/var/mail/cltbld', 09:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:59 INFO - 'MOZ_NO_REMOTE': '1', 09:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:59 INFO - 'NO_EM_RESTART': '1', 09:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:59 INFO - 'SHELL': '/bin/bash', 09:56:59 INFO - 'SHLVL': '1', 09:56:59 INFO - 'TERM': 'linux', 09:56:59 INFO - 'TMOUT': '86400', 09:56:59 INFO - 'USER': 'cltbld', 09:56:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:59 INFO - '_': '/tools/buildbot/bin/python'} 09:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:59 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 09:56:59 INFO - Cleaning up... 09:56:59 INFO - Return code: 0 09:56:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:59 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:56:59 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 09:56:59 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 09:56:59 INFO - Using env: {'DISPLAY': ':0', 09:56:59 INFO - 'HOME': '/home/cltbld', 09:56:59 INFO - 'LANG': 'en_US.UTF-8', 09:56:59 INFO - 'LANGUAGE': 'en_US:en', 09:56:59 INFO - 'LOGNAME': 'cltbld', 09:56:59 INFO - 'MAIL': '/var/mail/cltbld', 09:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:59 INFO - 'MOZ_NO_REMOTE': '1', 09:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:59 INFO - 'NO_EM_RESTART': '1', 09:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:59 INFO - 'SHELL': '/bin/bash', 09:56:59 INFO - 'SHLVL': '1', 09:56:59 INFO - 'TERM': 'linux', 09:56:59 INFO - 'TMOUT': '86400', 09:56:59 INFO - 'USER': 'cltbld', 09:56:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:59 INFO - '_': '/tools/buildbot/bin/python'} 09:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:59 INFO - Downloading/unpacking psutil>=0.7.1 09:56:59 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 09:56:59 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 09:56:59 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 09:56:59 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 09:56:59 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 09:56:59 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 09:57:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:01 INFO - Installing collected packages: psutil 09:57:01 INFO - Running setup.py install for psutil 09:57:01 INFO - building 'psutil._psutil_linux' extension 09:57:01 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 09:57:01 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 09:57:01 INFO - building 'psutil._psutil_posix' extension 09:57:01 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 09:57:01 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 09:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:01 INFO - Successfully installed psutil 09:57:01 INFO - Cleaning up... 09:57:01 INFO - Return code: 0 09:57:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:01 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:57:01 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 09:57:01 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 09:57:01 INFO - Using env: {'DISPLAY': ':0', 09:57:01 INFO - 'HOME': '/home/cltbld', 09:57:01 INFO - 'LANG': 'en_US.UTF-8', 09:57:01 INFO - 'LANGUAGE': 'en_US:en', 09:57:01 INFO - 'LOGNAME': 'cltbld', 09:57:01 INFO - 'MAIL': '/var/mail/cltbld', 09:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:01 INFO - 'MOZ_NO_REMOTE': '1', 09:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:01 INFO - 'NO_EM_RESTART': '1', 09:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:01 INFO - 'SHELL': '/bin/bash', 09:57:01 INFO - 'SHLVL': '1', 09:57:01 INFO - 'TERM': 'linux', 09:57:01 INFO - 'TMOUT': '86400', 09:57:01 INFO - 'USER': 'cltbld', 09:57:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:01 INFO - '_': '/tools/buildbot/bin/python'} 09:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:03 INFO - Installing collected packages: mozsystemmonitor 09:57:03 INFO - Running setup.py install for mozsystemmonitor 09:57:03 INFO - Successfully installed mozsystemmonitor 09:57:03 INFO - Cleaning up... 09:57:03 INFO - Return code: 0 09:57:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:57:03 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 09:57:03 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 09:57:03 INFO - Using env: {'DISPLAY': ':0', 09:57:03 INFO - 'HOME': '/home/cltbld', 09:57:03 INFO - 'LANG': 'en_US.UTF-8', 09:57:03 INFO - 'LANGUAGE': 'en_US:en', 09:57:03 INFO - 'LOGNAME': 'cltbld', 09:57:03 INFO - 'MAIL': '/var/mail/cltbld', 09:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:03 INFO - 'MOZ_NO_REMOTE': '1', 09:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:03 INFO - 'NO_EM_RESTART': '1', 09:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:03 INFO - 'SHELL': '/bin/bash', 09:57:03 INFO - 'SHLVL': '1', 09:57:03 INFO - 'TERM': 'linux', 09:57:03 INFO - 'TMOUT': '86400', 09:57:03 INFO - 'USER': 'cltbld', 09:57:03 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:03 INFO - '_': '/tools/buildbot/bin/python'} 09:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:57:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:57:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:06 INFO - Downloading docopt-0.6.1.tar.gz 09:57:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:06 INFO - Running setup.py install for blobuploader 09:57:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:57:06 INFO - Running setup.py install for requests 09:57:07 INFO - Running setup.py install for docopt 09:57:07 INFO - Successfully installed blobuploader requests docopt 09:57:07 INFO - Cleaning up... 09:57:07 INFO - Return code: 0 09:57:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:07 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')]} 09:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:07 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')]} 09:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:07 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:57:07 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 09:57:07 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 09:57:07 INFO - Using env: {'DISPLAY': ':0', 09:57:07 INFO - 'HOME': '/home/cltbld', 09:57:07 INFO - 'LANG': 'en_US.UTF-8', 09:57:07 INFO - 'LANGUAGE': 'en_US:en', 09:57:07 INFO - 'LOGNAME': 'cltbld', 09:57:07 INFO - 'MAIL': '/var/mail/cltbld', 09:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:07 INFO - 'MOZ_NO_REMOTE': '1', 09:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:07 INFO - 'NO_EM_RESTART': '1', 09:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:07 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:07 INFO - 'SHELL': '/bin/bash', 09:57:07 INFO - 'SHLVL': '1', 09:57:07 INFO - 'TERM': 'linux', 09:57:07 INFO - 'TMOUT': '86400', 09:57:07 INFO - 'USER': 'cltbld', 09:57:07 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:07 INFO - '_': '/tools/buildbot/bin/python'} 09:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:07 INFO - Running setup.py (path:/tmp/pip-Y5vRmP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:07 INFO - Running setup.py (path:/tmp/pip-aHgUsj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:07 INFO - Running setup.py (path:/tmp/pip-gN9PP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:07 INFO - Running setup.py (path:/tmp/pip-DMN86B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:07 INFO - Running setup.py (path:/tmp/pip-rzlXEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:07 INFO - Running setup.py (path:/tmp/pip-IW08Ns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:07 INFO - Running setup.py (path:/tmp/pip-AyQBp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:07 INFO - Running setup.py (path:/tmp/pip-wWn265-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:07 INFO - Running setup.py (path:/tmp/pip-cGrZOK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:08 INFO - Running setup.py (path:/tmp/pip-O5BxS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:08 INFO - Running setup.py (path:/tmp/pip-IkloeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:08 INFO - Running setup.py (path:/tmp/pip-IIY8br-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:08 INFO - Running setup.py (path:/tmp/pip-6oATGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:08 INFO - Running setup.py (path:/tmp/pip-VsF7uK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:08 INFO - Running setup.py (path:/tmp/pip-_yFuxe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:08 INFO - Running setup.py (path:/tmp/pip-fNVa7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:08 INFO - Running setup.py (path:/tmp/pip-8Qbv3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:08 INFO - Running setup.py install for manifestparser 09:57:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Running setup.py install for mozcrash 09:57:08 INFO - Running setup.py install for mozdebug 09:57:08 INFO - Running setup.py install for mozdevice 09:57:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozfile 09:57:09 INFO - Running setup.py install for mozhttpd 09:57:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozinfo 09:57:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozInstall 09:57:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozleak 09:57:09 INFO - Running setup.py install for mozlog 09:57:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for moznetwork 09:57:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozprocess 09:57:09 INFO - Running setup.py install for mozprofile 09:57:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozrunner 09:57:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:57:10 INFO - Running setup.py install for mozscreenshot 09:57:10 INFO - Running setup.py install for moztest 09:57:10 INFO - Running setup.py install for mozversion 09:57:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:57:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:10 INFO - Cleaning up... 09:57:10 INFO - Return code: 0 09:57:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57: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')]} 09:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:10 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:57:10 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 09:57:10 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 09:57:10 INFO - Using env: {'DISPLAY': ':0', 09:57:10 INFO - 'HOME': '/home/cltbld', 09:57:10 INFO - 'LANG': 'en_US.UTF-8', 09:57:10 INFO - 'LANGUAGE': 'en_US:en', 09:57:10 INFO - 'LOGNAME': 'cltbld', 09:57:10 INFO - 'MAIL': '/var/mail/cltbld', 09:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:10 INFO - 'MOZ_NO_REMOTE': '1', 09:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:10 INFO - 'NO_EM_RESTART': '1', 09:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:10 INFO - 'SHELL': '/bin/bash', 09:57:10 INFO - 'SHLVL': '1', 09:57:10 INFO - 'TERM': 'linux', 09:57:10 INFO - 'TMOUT': '86400', 09:57:10 INFO - 'USER': 'cltbld', 09:57:10 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:10 INFO - '_': '/tools/buildbot/bin/python'} 09:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:10 INFO - Running setup.py (path:/tmp/pip-jsueHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:10 INFO - Running setup.py (path:/tmp/pip-WgMztt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:10 INFO - Running setup.py (path:/tmp/pip-6Cbx3T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:10 INFO - Running setup.py (path:/tmp/pip-bZC5Ci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:10 INFO - Running setup.py (path:/tmp/pip-kjBR7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:10 INFO - Running setup.py (path:/tmp/pip-7gfHqw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:11 INFO - Running setup.py (path:/tmp/pip-prDFIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:11 INFO - Running setup.py (path:/tmp/pip-VK2Yv6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:11 INFO - Running setup.py (path:/tmp/pip-F8rysg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:11 INFO - Running setup.py (path:/tmp/pip-FUFiLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:11 INFO - Running setup.py (path:/tmp/pip-epho7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:11 INFO - Running setup.py (path:/tmp/pip-d75BQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:11 INFO - Running setup.py (path:/tmp/pip-BU0R1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:11 INFO - Running setup.py (path:/tmp/pip-irHxX_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:11 INFO - Running setup.py (path:/tmp/pip-E2DXzZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:11 INFO - Running setup.py (path:/tmp/pip-BFi0RB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:11 INFO - Running setup.py (path:/tmp/pip-XjZmho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:13 INFO - Downloading blessings-1.5.1.tar.gz 09:57:13 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 09:57:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:13 INFO - Installing collected packages: blessings 09:57:13 INFO - Running setup.py install for blessings 09:57:13 INFO - Successfully installed blessings 09:57:13 INFO - Cleaning up... 09:57:13 INFO - Return code: 0 09:57:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:57:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:57:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:57:13 INFO - Reading from file tmpfile_stdout 09:57:13 INFO - Current package versions: 09:57:13 INFO - argparse == 1.2.1 09:57:13 INFO - blessings == 1.5.1 09:57:13 INFO - blobuploader == 1.2.4 09:57:13 INFO - docopt == 0.6.1 09:57:13 INFO - manifestparser == 1.1 09:57:13 INFO - mozInstall == 1.12 09:57:13 INFO - mozcrash == 0.16 09:57:13 INFO - mozdebug == 0.1 09:57:13 INFO - mozdevice == 0.47 09:57:13 INFO - mozfile == 1.2 09:57:13 INFO - mozhttpd == 0.7 09:57:13 INFO - mozinfo == 0.9 09:57:13 INFO - mozleak == 0.1 09:57:13 INFO - mozlog == 3.1 09:57:13 INFO - moznetwork == 0.27 09:57:13 INFO - mozprocess == 0.22 09:57:13 INFO - mozprofile == 0.28 09:57:13 INFO - mozrunner == 6.11 09:57:13 INFO - mozscreenshot == 0.1 09:57:13 INFO - mozsystemmonitor == 0.0 09:57:13 INFO - moztest == 0.7 09:57:13 INFO - mozversion == 1.4 09:57:13 INFO - psutil == 3.1.1 09:57:13 INFO - requests == 1.2.3 09:57:13 INFO - wsgiref == 0.1.2 09:57:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:57:13 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 09:57:13 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 09:57:13 INFO - Using env: {'DISPLAY': ':0', 09:57:13 INFO - 'HOME': '/home/cltbld', 09:57:13 INFO - 'LANG': 'en_US.UTF-8', 09:57:13 INFO - 'LANGUAGE': 'en_US:en', 09:57:13 INFO - 'LOGNAME': 'cltbld', 09:57:13 INFO - 'MAIL': '/var/mail/cltbld', 09:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:13 INFO - 'MOZ_NO_REMOTE': '1', 09:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:13 INFO - 'NO_EM_RESTART': '1', 09:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:13 INFO - 'SHELL': '/bin/bash', 09:57:13 INFO - 'SHLVL': '1', 09:57:13 INFO - 'TERM': 'linux', 09:57:13 INFO - 'TMOUT': '86400', 09:57:13 INFO - 'USER': 'cltbld', 09:57:13 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:13 INFO - '_': '/tools/buildbot/bin/python'} 09:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 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)) 09:57:14 INFO - Cleaning up... 09:57:14 INFO - Return code: 0 09:57:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:57:14 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')]} 09:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:14 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')]} 09:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:14 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:57:14 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 09:57:14 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 09:57:14 INFO - Using env: {'DISPLAY': ':0', 09:57:14 INFO - 'HOME': '/home/cltbld', 09:57:14 INFO - 'LANG': 'en_US.UTF-8', 09:57:14 INFO - 'LANGUAGE': 'en_US:en', 09:57:14 INFO - 'LOGNAME': 'cltbld', 09:57:14 INFO - 'MAIL': '/var/mail/cltbld', 09:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:14 INFO - 'MOZ_NO_REMOTE': '1', 09:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:14 INFO - 'NO_EM_RESTART': '1', 09:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:14 INFO - 'SHELL': '/bin/bash', 09:57:14 INFO - 'SHLVL': '1', 09:57:14 INFO - 'TERM': 'linux', 09:57:14 INFO - 'TMOUT': '86400', 09:57:14 INFO - 'USER': 'cltbld', 09:57:14 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:14 INFO - '_': '/tools/buildbot/bin/python'} 09:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:14 INFO - Downloading/unpacking jsonschema 09:57:14 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 09:57:14 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 09:57:14 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 09:57:14 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 09:57:14 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 09:57:14 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 09:57:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:16 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 09:57:16 INFO - Downloading/unpacking functools32 (from jsonschema) 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:57:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:16 INFO - warning: no files found matching '*.txt' 09:57:16 INFO - no previously-included directories found matching 'build' 09:57:16 INFO - no previously-included directories found matching 'dist' 09:57:16 INFO - no previously-included directories found matching '.git*' 09:57:16 INFO - Installing collected packages: jsonschema, functools32 09:57:16 INFO - Running setup.py install for functools32 09:57:16 INFO - warning: no files found matching '*.txt' 09:57:16 INFO - no previously-included directories found matching 'build' 09:57:16 INFO - no previously-included directories found matching 'dist' 09:57:16 INFO - no previously-included directories found matching '.git*' 09:57:16 INFO - Successfully installed jsonschema functools32 09:57:16 INFO - Cleaning up... 09:57:16 INFO - Return code: 0 09:57:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:16 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 0x7f65ebb39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', '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 09:57:16 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 09:57:16 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 09:57:16 INFO - Using env: {'DISPLAY': ':0', 09:57:16 INFO - 'HOME': '/home/cltbld', 09:57:16 INFO - 'LANG': 'en_US.UTF-8', 09:57:16 INFO - 'LANGUAGE': 'en_US:en', 09:57:16 INFO - 'LOGNAME': 'cltbld', 09:57:16 INFO - 'MAIL': '/var/mail/cltbld', 09:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:16 INFO - 'MOZ_NO_REMOTE': '1', 09:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:16 INFO - 'NO_EM_RESTART': '1', 09:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:16 INFO - 'SHELL': '/bin/bash', 09:57:16 INFO - 'SHLVL': '1', 09:57:16 INFO - 'TERM': 'linux', 09:57:16 INFO - 'TMOUT': '86400', 09:57:16 INFO - 'USER': 'cltbld', 09:57:16 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:16 INFO - '_': '/tools/buildbot/bin/python'} 09:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:16 INFO - Downloading/unpacking flake8 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:57:18 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 09:57:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:57:18 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 09:57:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:57:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:19 INFO - no previously-included directories found matching 'docs/_build' 09:57:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:57:19 INFO - Running setup.py install for pep8 09:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:19 INFO - no previously-included directories found matching 'docs/_build' 09:57:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:57:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:57:19 INFO - Cleaning up... 09:57:19 INFO - Return code: 0 09:57:19 INFO - Running post-action listener: _resource_record_post_action 09:57:19 INFO - Running post-action listener: _start_resource_monitoring 09:57:19 INFO - Starting resource monitoring. 09:57:19 INFO - ##### 09:57:19 INFO - ##### Running install step. 09:57:19 INFO - ##### 09:57:19 INFO - Running pre-action listener: _resource_record_pre_action 09:57:19 INFO - Running main action method: install 09:57:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:57:19 INFO - Reading from file tmpfile_stdout 09:57:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:57:19 INFO - Reading from file tmpfile_stdout 09:57:19 INFO - Output received: 09:57:19 INFO - Usage: mozinstall [options] installer 09:57:19 INFO - Options: 09:57:19 INFO - -h, --help show this help message and exit 09:57:19 INFO - -d DEST, --destination=DEST 09:57:19 INFO - Directory to install application into. [default: 09:57:19 INFO - "/builds/slave/test-pgo"] 09:57:19 INFO - --app=APP Application being installed. [default: firefox] 09:57:19 INFO - mkdir: /builds/slave/test-pgo/build/application 09:57:19 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'] 09:57:19 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 09:57:35 INFO - Reading from file tmpfile_stdout 09:57:35 INFO - Output received: 09:57:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:57:35 INFO - Running post-action listener: _resource_record_post_action 09:57:35 INFO - ##### 09:57:35 INFO - ##### Running run-tests step. 09:57:35 INFO - ##### 09:57:35 INFO - Running pre-action listener: _resource_record_pre_action 09:57:35 INFO - Running main action method: run_tests 09:57:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:57:35 INFO - Python 2.7.3 09:57:35 INFO - Return code: 0 09:57:35 INFO - grabbing minidump binary from tooltool 09:57: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')]} 09:57:35 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 0x112f840>, '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 0x109c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:57:35 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 09:57:35 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 09:57:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:35 INFO - Return code: 0 09:57:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:57:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:57:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:57:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:57:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:57:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:57:36 INFO - Return code: 0 09:57:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 09:57:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 09:57:36 INFO - Using env: {'DISPLAY': ':0', 09:57:36 INFO - 'HOME': '/home/cltbld', 09:57:36 INFO - 'LANG': 'en_US.UTF-8', 09:57:36 INFO - 'LANGUAGE': 'en_US:en', 09:57:36 INFO - 'LOGNAME': 'cltbld', 09:57:36 INFO - 'MAIL': '/var/mail/cltbld', 09:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:36 INFO - 'MOZ_NO_REMOTE': '1', 09:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:36 INFO - 'NO_EM_RESTART': '1', 09:57:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:57:36 INFO - 'SHELL': '/bin/bash', 09:57:36 INFO - 'SHLVL': '1', 09:57:36 INFO - 'TERM': 'linux', 09:57:36 INFO - 'TMOUT': '86400', 09:57:36 INFO - 'USER': 'cltbld', 09:57:36 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012', 09:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:36 INFO - '_': '/tools/buildbot/bin/python'} 09:57:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 09:57:37 INFO - mozversion application_buildid: 20160108073153 09:57:37 INFO - mozversion application_changeset: 3f780f4b14acab29b16bc4141a44180a8af9dd08 09:57:37 INFO - mozversion application_display_name: Nightly 09:57:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:37 INFO - mozversion application_name: Firefox 09:57:37 INFO - mozversion application_remotingname: firefox 09:57:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:57:37 INFO - mozversion application_vendor: Mozilla 09:57:37 INFO - mozversion application_version: 46.0a1 09:57:37 INFO - mozversion platform_buildid: 20160108073153 09:57:37 INFO - mozversion platform_changeset: 3f780f4b14acab29b16bc4141a44180a8af9dd08 09:57:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:57:37 INFO - mozversion platform_version: 46.0a1 09:57:37 INFO - using testdate: 1452275857 09:57:37 INFO - actual date: 1452275857 09:57:37 INFO - starting webserver on 'localhost:33658' 09:57:37 INFO - SUITE-START | Running 3 tests 09:57:37 INFO - TEST-START | dromaeo_css 09:57:37 INFO - operating with platform_type : linux_ 09:57:37 INFO - Initialising browser for dromaeo_css test... 09:57:37 INFO - TEST-INFO | started process 19845 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZuCKDb/profile http://localhost:33658/getInfo.html) 09:57:41 INFO - PROCESS | 19845 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 09:57:41 INFO - PROCESS | 19845 | __metrics Screen width/height:1600/1200 09:57:41 INFO - PROCESS | 19845 | colorDepth:24 09:57:41 INFO - PROCESS | 19845 | Browser inner width/height: 1024/697 09:57:41 INFO - PROCESS | 19845 | __metrics 09:57:41 INFO - PROCESS | 19845 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:57:42 INFO - TEST-INFO | 19845: exit 0 09:57:42 INFO - Browser initialized. 09:57:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:42 INFO - TEST-INFO | started process 19977 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZuCKDb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:54 INFO - PROCESS | 19977 | RSS: Main: 150892544 09:57:54 INFO - PROCESS | 19977 | 09:58:44 INFO - PROCESS | 19977 | 1452275924082 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] 10:00:52 INFO - PROCESS | 19977 | Cycle 1(1): loaded http://localhost:33658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33658/tests/dromaeo/cssquery-ext.html) 10:00:54 INFO - PROCESS | 19977 | RSS: Main: 157179904 10:00:54 INFO - PROCESS | 19977 | 10:03:56 INFO - PROCESS | 19977 | Cycle 1(1): loaded http://localhost:33658/tests/dromaeo/cssquery-ext.html (next: http://localhost:33658/tests/dromaeo/cssquery-jquery.html) 10:03:56 INFO - PROCESS | 19977 | RSS: Main: 153931776 10:03:56 INFO - PROCESS | 19977 | 10:06:58 INFO - PROCESS | 19977 | Cycle 1(1): loaded http://localhost:33658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33658/tests/dromaeo/cssquery-mootools.html) 10:06:59 INFO - PROCESS | 19977 | RSS: Main: 155611136 10:06:59 INFO - PROCESS | 19977 | 10:10:00 INFO - PROCESS | 19977 | Cycle 1(1): loaded http://localhost:33658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33658/tests/dromaeo/cssquery-prototype.html) 10:10:01 INFO - PROCESS | 19977 | RSS: Main: 153034752 10:10:01 INFO - PROCESS | 19977 | 10:13:03 INFO - PROCESS | 19977 | Cycle 1(1): loaded http://localhost:33658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33658/tests/dromaeo/cssquery-yui.html) 10:13:04 INFO - PROCESS | 19977 | RSS: Main: 153370624 10:13:04 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | Cycle 1(1): loaded http://localhost:33658/tests/dromaeo/cssquery-yui.html (next: http://localhost:33658/tests/dromaeo/cssquery-dojo.html) 10:16:06 INFO - PROCESS | 19977 | RSS: Main: 155455488 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | __start_tp_report 10:16:06 INFO - PROCESS | 19977 | _x_x_mozilla_page_load 10:16:06 INFO - PROCESS | 19977 | _x_x_mozilla_page_load_details 10:16:06 INFO - PROCESS | 19977 | |i|pagename|runs| 10:16:06 INFO - PROCESS | 19977 | |0;dojo.html;3114.4238315911552;3152.38528486945;3190.856411461487;3196.0571631368744;3204.6955539223763;5018.2723505091835;5102.923456148161;5127.692338459695;5135.691858488489;5203.271541984116;5104.770285337159;5105.5149760772665;5109.463506331828;5111.207762796773;5130.589552835764;4658.464276608191;4667.6732628716;4734.597559207472;4735.124002059612;4738.170820106485;4744.5967092797155;4764.237721964487;4812.566868981791;4878.34142390778;4896.412430508344;4837.105135549935;4862.708237505743;4894.853154405374;4899.118158731427;4951.752412379385;4753.263244197155;4824.228123500223;4834.105690447243;4842.055799119174;4887.242477416006;4708.340832283483;4736.242201247784;4741.83403580873;4750.239961606127;4786.401699787527;4994.800207991676;5023.949760502384;5039.218921067204;5063.26582645518;5065.822696205652;5519.889602207973;5520.447955204488;5521.337439507245;5546.27898373213;5566.888662226733;5498.670079795185;5609.186667933127;5609.5518008753115;5621.550275977912;5655.886882262332;5116.232565115225;5142.820001299974;5162.1224391853475;5223.817166399196;5321.068812957717;5739.569532285095;5745.626534275342;5761.5102716269585;5774.307083150049;5812.680302583399;5452.890942181134;5458.61789674719;5461.371942226695;5480.150576660624;5486.945130548724;5522.944770552243;5551.028570000234;5587.05020146576;5608.10270356741;5621.634593751393;5623.268975033219;5634.323881134208;5643.548516118701;5650.660960342392;5685.914711279334;5629.915551266734;5639.069553523623;5642.181883626851;5650.85872853182;5660.745266463019;4200.5169405518145;4283.7429754214845;4285.957140428618;4368.453943257093;4388.407564978751;3900.7659540427667;3918.1575961168487;3921.215756848642;3958.366661334173;3962.227365663668;5274.815381461707;5287.444818294024;5296.09966305729;5296.443873393316;5298.443663415363;5417.133258678671;5512.779488820403;5587.664740115606;5665.291838520185;5688.089905615082;5238.947610523922;5239.869003274948;5249.973750131225;5268.420473747885;5281.709505977131;4789.568938795525;4791.209450440639;4795.18481858078;4801.207800712843;4821.54195351441;5624.409437009137;5722.856928576735;5799.217105690762;5849.151872978395;5904.852378690567;5428.972855135699;5450.672959622435;5474.479924407175;5479.780808767764;5513;5667.40492248308;5698.686572238566;5698.772049117989;5701.515371193495;5705.486506214461;5416.891662166813;5546.611737178358;5555.444455554412;5605.691686957093;5650.943490565206;5556.499915007668;5569.777208911598;5591.6365436246515;5591.832245032656;5609.887802244014;5247.081760691787;5306.151015837602;5361.678299302054;5407.026735187704;5454.372747134131;5442.564594832483;5471.398146203835;5482.780688772564;5490.368607610176;5550.195221692913;5307.628466007497;5351.224072509543;5352.5985551084605;5358.33020872391;5404.297441332602;5357.410684824744;5402.162664786964;5416.025115479251;5471.261379713687;5475;5307.283516725192;5333.333333333333;5340.813071542478;5341.732913354239;5382.246485491956 10:16:06 INFO - PROCESS | 19977 | |1;ext.html;515.8890838469729;529.3171808367207;539.8893226888486;544.213611331626;557.6514678326046;34072.4889126663;34968.82515587418;35189.64810351896;35243.11892202696;35452.11369715758;38709.806450967706;38780.612193878056;38979.41530877039;39199.21601567974;39397.80301098498;8375.120612335693;8561.101084386144;8590.914090859105;8621.655133794671;8624.956875215616;8288.005439347256;8382.371322150833;8454.196851299148;8605.268552173073;8621;8567.057623661392;8613.612387442548;8621.741347759546;8682.175193356621;8693.434926729742;8546.572671366437;8603.139686031409;8673.089325620813;8673.479591224484;8678.305735541142;8398.202170793766;8473.830523389559;8523.06246312905;8572.185642364027;8575;37568.43647345292;38449;38470.42294365587;38507.22985540301;38508.80745596254;3237.2877966847254;3285.1951271938287;3401.1327111586634;3514.4728290756593;3548.8288864674596;27126.728732712618;27336.309598204185;27441.31396715078;27618.585721214196;27990.300242493897;3914.354131568288;3934.2328245992044;3938.9803050984847;4046.9392959105344;4123.793810309502;246223;246726;247620;248522;250834.74582627154;50607.74696126496;51722.48277517252;57511.42488575145;59037.40962590405;60258.09612855811;57425.42574574201;57730.13404798931;57814.7109264451;57888.684452621426;58319;14611.488597899235;14684.853151468562;14709.55871323862;14714.264286785618;14792.630184245265;10378.792424151474;10495.632652857113;10535.315204511682;10555.947220264003;10631.308964917256;19622;19840.50398740014;19888;19914.701279480818;20091.899540502203;7119.181294151135;7238.855222895618;7271.854562908712;7306.123265208209;7346.081739782528;969.0842154164247;984.3503287829998;995.233670074039;1040.70339953113;1067.2262609607972;27451.45097098047;27476;27894.860525697648;27964.860175698992;28154.85922570415;1038.7922415516775;1069.6149386220955;1079.6707004363745;1136.4545018391218;1145.2727518025947;14530;14707;14774.704505910036;14781.187034713193;14939.701205976036;318628;321847;322993;323076;323400;48842.75578622084;49144.26283605749;49257;49449;49519.75240123848;1286.6204469681466;1286.6461723026055;1292.5540688462465;1303.1855090568395;1306.8235788168477;26636.8668156658;26839;27974;28779.28051798722;29343.559846601893;44308.11383772371;45260.77369613262;45344.31983520316;45369;45473;235157;236763;237430;237691;237843;30129;30761.230969225053;30856.228594285323;31274.21814454657;31368.17686408143;37183.25633487261;37974.43038354482;39554.20891582095;39676.80161599174;40287.1942561153;32950.069782111364;33379;34022.82988585041;34388;34602.307953841286;33313.967057468224;33340.83329583434;34457.13857153491;34478.82760586181;34491;33659.32681346311;33670.49494257637;33907.15232119217;33920.83039584885;34096.31807363888;28339.60910884027;31263.374732504766;31544.684553155093;31556.842215788773;31693.683063169072;23693.526129477657;24099.277021689377;31259.53110703387;32326.35347292994;33310.66689333076 10:16:06 INFO - PROCESS | 19977 | |2;jquery.html;349.5420998491976;354.1800731307024;354.2507596433544;354.7605366377695;354.84564214566666;15524.689506209883;15929.44246951357;16380.426685066024;17275.568110797238;17291.91354043228;10538.051575358235;10638.2021348399;10653.201009924267;12327.075469339812;15398.30707618157;4762.285657151438;4808.350872632185;4902;5383.650062745928;5419.5393391561765;5379.784808607651;5421.427785942072;5423.050966080939;5438.891222175574;5441.102218134023;4866.537678920497;4876.146674331978;5063.341765570471;5099.541041306282;5112.079825631385;5025.698458092526;5041;5072.4673909239555;5203.219517072469;5899.970500147515;5230.555402790767;5231.843044708665;5235.136202526579;5244.895102097937;5246.7638956247065;17657.911710441367;18583.163757630802;19256.422307330802;19293.42119736396;19308.938008409674;1920.7022911448748;1921.3659492367485;1973.930912418073;2066.4523901166203;2188.7045248891354;9312.115349041831;9370.484623345714;10028.799424011551;10577;12742.745145097138;435.6036007233434;439.1699687590425;1755.2403764920953;1772.7252275897256;1802.9819701802944;48832.755836220946;49724.50275497199;52399;53908.46091539074;54747;9688.273379496566;9967.850482242773;10117.140043096419;10131.949340253399;10164.440955747357;13129.73740525184;13196.406161722745;13236.404361803741;13253.204807711569;13259;7289.271072892669;7407.0382313216705;7452.217517160729;7479.289467500579;7513.586752728543;7065.116860392451;7152.92847071533;7171.067761191011;7174.497785154989;7221.386182174469;4340.52254252032;4414.80133393998;4426.623736982328;4442.955570444319;4475.149721552894;1684.6209602839508;1722.2508208929155;1775.2898840463918;1802.098621219835;1822.261983896524;820.2207902492656;859.7162936231028;908.1826356279402;972.9075737804898;1012.1953047327393;14799.260036998323;15780.289886955115;16231.26959286835;16661.750073748903;16945.32218711238;905.4160066756905;908.3641450984205;912.8767616371705;962.7063745557532;1011.5094179323022;9206.401583897159;9422;9504.097110774464;9565.760855978657;9664.420134791935;527280;533555;534971;550529.4629375986;553072;66918;69462.30537694659;70446;71347.6432617844;72012;1105.2926127278547;1128.6106293328623;1131.219458573598;1132.5356603792407;1141.178351586856;15067.397304108152;15091.849081509483;15105.39578416851;15166.469173578871;15519.45681901128;32069;32443.513347300282;33048;33914.32171356608;34070;39279.80360098181;39962.400563992145;40953.36186552505;46906.76546617245;47136.52863471321;6909.89635155463;7095.46783991213;7156.248593897774;7175.820604484929;7403.8149046274275;8833.469991800512;10464.686059418229;10958.178136639943;11007.394593297446;11261.66215013551;8788.384813063025;8943.821123577622;9293;9699.9030009699;9833.803323933338;9458.290628202774;9582.808343833223;9762.267829912927;9863.520471929269;9989.450580218157;9559.187469065208;9719.805603887742;9880.901190987997;9917.950410247902;9937.850932236166;7197.388222000979;7359.8160045999275;7367;7386.556806591621;7525.887111693439;9558.091981261769;9943.105120539187;9953.552090155816;10133;10154.492275386054 10:16:06 INFO - PROCESS | 19977 | |3;mootools.html;1420.6732451536147;1427.6716355238295;1542.8688561472275;1704.9232784524695;1727.058752979626;7293.671784769685;7465.888011679829;7504.6247687615605;7673.577953212571;7678.193789652083;7530.9246907530905;7545.69817207311;7578.50739701919;7585.431092668045;7608.657610407531;2226.4100013496436;2266.320103968811;2271.693321401606;2272.7045484087043;2273.5680220758086;2263.9434014149615;2300.6894069300597;2336.1122773346187;2347.0377145370403;2351.4709190432186;2207.580559693661;2280.5096904165603;2289.255991802671;2298.115225638133;2307.284741730061;2285.405794493435;2296.391456264075;2310.722713274409;2312.433453803812;2316.0388438797963;2282.760310167425;2299.908003679851;2304.0783686525356;2305.204704376987;2305.884705764705;7448.441366897504;7461.962690186569;7469.439792015566;7476.738314158978;7499.700011999568;4579.4504659440745;4672.065586882637;4677;4684.976575117103;4719.4100737407825;3080.7830906791914;3126.765492588065;3169.9841500792577;3198.616166060064;3224.5485632011537;1048.4338457233084;1075.3547871277171;1102.1127991966544;1104.5857803323754;1117.944102794857;10292.588296468133;10329;10337.793244135075;10394.896051039468;10399.94800025995;3945.723799334019;4003.579624139482;4082.4692789937117;4094.058366575645;4094.959050409517;8272.875906861402;8289.58552072394;8325.542095184703;8328.208820162075;8329.5418751968;4569.885752856205;4619.6073333766335;4627.1439783640135;4633.166030114544;4634.281686338623;4277.721948073366;4297.828086876552;4301.526832048472;4309.870703878889;4318.784060796947;3238.9676103238667;3274.3287626036604;3277.9344413111603;3280.458724310462;3314.038928710695;1004.542932965499;1024.9077583017415;1025.6564051042835;1025.9794804103876;1031.6904928521415;1028.3161697471098;1029.917606591471;1056.8902652215143;1143.9256448330832;1269.593730006389;6742.898856517156;6748.696308666122;6777.186737591521;6811.931880681229;6812.591244525344;1163.9301641901513;1190.14309697018;1199.3044034459992;1212.8362671039474;1223.1010207497482;5189.455107213764;5199.1161502544655;5210.166373380241;5226.268322434862;5258.237555554423;8519.74440766778;9189.494577798152;9223.985361610217;9271.95364023189;9304.395214311047;9061.637534498546;9063.13900179482;9084;9171.266298696088;9325.813483730288;6815.7614483493835;6988.231294557595;7041.4718896082995;7057.823554411181;7176.928230717626;6675.332466753286;6742.662866856539;6744.763933262312;6761.797146085429;6789.660516974032;7956.5226086435;8178.345732341518;8197.71308004217;8254.628541715518;8298.626561804855;8083.3533317333295;8210.178982101743;8234.794130146794;8276.172382761675;8307.750767476986;6594.241662208908;6699.732010719516;6720.294369091175;6731.730730770911;6734.225564060196;7265.600391978492;7344.816379590553;7361.558306501627;7380.335769780745;7406.851862962818;6850.588964662136;6990;6996.125484314461;7013.228544860163;7119.359257666835;6422.42198202164;6550.115734375799;6627.5360724750735;6652.234992975869;6875.656217189221;6442.291347951816;6495.642739649365;6511.446527045065;6519.119918810899;6559.27847936717;6064.302605200459;6074.362191969956;6095.420935011167;6109.816705498843;6163.260408750979;6058.303295121117;6103.42017508336;6105.9084113737445;6116.633002019893;6119.785807496716 10:16:06 INFO - PROCESS | 19977 | |4;prototype.html;342.5273123090136;345.3059350705082;351.64132584763524;353.3322021379592;354.6595268542201;6125.203723515942;6218.937810621893;6286.905696414552;6288.8742225155465;6355.396237357455;6183.721732522036;6222.346653601363;6224.377562243773;6231.968840155804;6246.531510136735;4733.739644319561;4738.9526104739025;4748.5251474852585;4749.501302363254;4753.786079626425;4728.810847566093;4734.952650473486;4755.9286610700865;4758.643101767381;4773.785179666906;4526.547345265463;4600.102979918917;4617.976910115462;4619.74591397473;4635.443746750378;4569.497355290915;4604.723716577016;4614.377059097029;4642.3500709900645;4655.045715628288;4016.2168377166463;4017.9397309040387;4027;4027.81874815634;4043.3530635098537;5859.150423188614;5891.027980383275;5907.6750778707155;5915.408459154093;5922.822315330547;5294.68231906083;5423.945760542383;5437.564994800407;5501.284832971728;5524.779008839641;6559.47524198063;6574.408303252682;6598.571092878948;6602.603843769341;6605.141331626905;4547.522510136421;4548.931766023512;4561;4573.199690054261;4583.2666773316105;6765.8646827063185;6823.147106611674;6864.553804002724;6880.58716477013;6914.412274956584;4679.666295105946;4682.227432473672;4683.367745354333;4691.741954192552;4697.060587882437;4748.762561871962;4751.524847515221;4759.976200118977;4762.4285085789925;4769.165396055676;5474.343078830566;5490.176473529003;5507.9449205507435;5517.089680202802;5523.558115350762;6397.232332120176;6600.570962887397;6616.933830661728;6661.433778128913;6669.566478178903;1661.4018953176846;1664.9250783714763;1671.6907372136193;1675.6397374564526;1681.125814576438;1108.1799468393492;1117.7205698575356;1121.8036843552509;1129.1136457880525;1130.46867972053;6261.7182226799905;6287.842803929939;6299.212598425197;6305.432511074026;6311.305756366796;6771.661416929134;6775.186977562724;6776.728930842711;6779.830504237433;6788.796336109925;6197.783077592263;6225.28409232944;6270.122182894398;6303.401176888188;6360.650164241011;3697.020289623252;3707.258548290353;3720.9069773255887;3725.844988053712;3726.906827329284;7142.285771422816;7153.213146553875;7153.284671532909;7154.177269614061;7165.355118039297;6924.134483189601;6966.756163534252;7010.544314619533;7015.193252775996;7049.189343225492;7120.71517139319;7127.5723456593805;7149.857002859913;7155.534890232118;7172.677229524684;6818;6818.147731533559;6818.693158807965;6831.11195544576;6839.62382068991;6573.408393244631;6772.627505487246;6784.7964561063245;6796.524243302922;6822.965885170543;7147.53541019832;7153.892691609526;7154.821129471805;7156.320149585781;7159.391451726661;4604.815807367801;4615.0539139477;4646.767661616973;4650.34895114691;4650.720956742606;6746.595204287759;6882.449404047564;6892.207396149306;6906.136732908387;6937.861242775217;6670.39966403026;6673.766418175341;6673.933260667525;6674.399304062657;6682.465402767864;6645.468362531083;6647.434968027772;6658.1344425224415;6669.233038200669;6703.3296670332575;6341.778037768656;6529.9020514691365;6562.50781191403;6571.934280657323;6580.7038683260325;6693.8326541834895;6702.899456508254;6716.059751634873;6737.29258427858;6748.055272261985;6396.168498095218;6474.967625161844;6507.804765857032;6539.313372095861;6556.2788093310655 10:16:06 INFO - PROCESS | 19977 | |5;yui.html;781.9452638315316;836.6662526394236;844.8014716541612;856.4047986649274;857.3012994409555;12915.870841291584;13006.28465434402;13063.216207027574;13771.173729576232;14055.367508462119;13666.248356340397;13688.452461901512;13693.109947853407;13757.79363309551;13763.17420954741;780.1769133564088;786.4259090863673;789.3842802613971;792.3581898662073;802.3621221129216;801.3268854162502;804.569555287921;805.3597390074875;805.5448671500612;810.2464707821723;834.1158372125566;835.841190173865;836.3894357119307;836.4395854777283;836.5315423362906;833.8165603567267;834.9415540912169;835.4527784301292;836.2766207230732;838.5513750143705;612.4457366083701;615.4922189193888;615.6829232945037;616.3620652624556;617.6757202468694;13166.736665266737;13254.536091236856;13268;13278.601641950758;13283;12089.335086570236;12258.1419300649;12478.688032799162;12561.937190314082;12684.175528590613;10284.897151028543;10294.536745846455;10298;10339;10363.533640986097;3598.223321153163;3607.640413556368;3640.0899775056237;3657.122290650251;3717.182219911615;43167.35248971268;44424.555754442365;44656;44694.55305446936;44966.55033449689;9661.71014869555;9821.410715357102;10056.547455364525;10160.13638840692;10198.541065651914;16872.325106995584;16893.83106168947;16896.662066758843;16948.915255423643;17000.57498562546;7431.777046688608;7442.702291908263;7445.287583855744;7514.39884809214;7649.9617501912135;4337.956620433818;4338.414314067561;4353.586409291112;4354.56454354562;4413.889652758707;3027.818330900153;3037.1951432870305;3039.240189952512;3041.680623534497;3045.6040714706946;557.8744782424003;563.0737436916249;563.9069553523705;566.9971650141805;595.1548800703013;501.0255053920163;552.5551930695748;589.908564172554;628.0767272109991;628.2210059526154;7730.149683534807;7909.841803163905;7942.563159026309;8079.111297757242;8095.036062791755;583.3699604427209;596.6956852005421;606.7967230977672;607.4957785038407;640.1645852162972;3619.4751760995036;3854.2676891390547;3923.803809809498;3940.9605903941165;3951.249262640089;49896;51146;51989.48010519922;52015.21977170346;52257.477425226025;43674.7816260923;43860.561394385644;43930;46972.29541556879;47038;41698.58301417008;41773.58226417697;42096.789516052224;44265;44307.77846110749;8639.395242333228;8741.562921854009;8767.517786521803;8893.4663920165;9015.188633023059;32234.35531289408;32489;33294.667053329154;33416.66583334136;34132.658673412945;41156;41286;41951.58048419599;42072.3689144657;42816.357754633085;9726.610935562498;9947.05502977216;10055.949720251352;10518.789624207626;10692.465376731288;12026.218295810744;12101.69745756363;12149.635510934686;12237.449314780679;12278.570250041206;11052.802073210301;11261.268017578832;11338.943305283421;11351.602693905674;11385.658430247106;11092.223544351818;11108.888911110786;11474.483648236017;11503.194776365573;11767;11004.339739615649;11197.104231661611;11269.549218031514;11598.362090085126;11724.413779311171;9253.444793312423;9369.25045996305;9474.952625237105;9671.806563868542;9729.756756080871;8857.335699822668;8961.865572016555;9158;9327.440353578808;9694.418334899929 10:16:06 INFO - PROCESS | 19977 | __end_tp_report 10:16:06 INFO - PROCESS | 19977 | __start_cc_report 10:16:06 INFO - PROCESS | 19977 | _x_x_mozilla_cycle_collect,310 10:16:06 INFO - PROCESS | 19977 | __end_cc_report 10:16:06 INFO - PROCESS | 19977 | __startTimestamp1452276966954__endTimestamp 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | ------- Summary: start ------- 10:16:06 INFO - PROCESS | 19977 | Number of tests: 6 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | [#0] dojo.html Cycles:165 Average:5183.72 Median:5351.22 stddev:554.85 (10.4%) stddev-sans-first:532.28 10:16:06 INFO - PROCESS | 19977 | Values: 3114.4 3152.4 3190.9 3196.1 3204.7 5018.3 5102.9 5127.7 5135.7 5203.3 5104.8 5105.5 5109.5 5111.2 5130.6 4658.5 4667.7 4734.6 4735.1 4738.2 4744.6 4764.2 4812.6 4878.3 4896.4 4837.1 4862.7 4894.9 4899.1 4951.8 4753.3 4824.2 4834.1 4842.1 4887.2 4708.3 4736.2 4741.8 4750.2 4786.4 4994.8 5023.9 5039.2 5063.3 5065.8 5519.9 5520.4 5521.3 5546.3 5566.9 5498.7 5609.2 5609.6 5621.6 5655.9 5116.2 5142.8 5162.1 5223.8 5321.1 5739.6 5745.6 5761.5 5774.3 5812.7 5452.9 5458.6 5461.4 5480.2 5486.9 5522.9 5551.0 5587.1 5608.1 5621.6 5623.3 5634.3 5643.5 5650.7 5685.9 5629.9 5639.1 5642.2 5650.9 5660.7 4200.5 4283.7 4286.0 4368.5 4388.4 3900.8 3918.2 3921.2 3958.4 3962.2 5274.8 5287.4 5296.1 5296.4 5298.4 5417.1 5512.8 5587.7 5665.3 5688.1 5238.9 5239.9 5250.0 5268.4 5281.7 4789.6 4791.2 4795.2 4801.2 4821.5 5624.4 5722.9 5799.2 5849.2 5904.9 5429.0 5450.7 5474.5 5479.8 5513.0 5667.4 5698.7 5698.8 5701.5 5705.5 5416.9 5546.6 5555.4 5605.7 5650.9 5556.5 5569.8 5591.6 5591.8 5609.9 5247.1 5306.2 5361.7 5407.0 5454.4 5442.6 5471.4 5482.8 5490.4 5550.2 5307.6 5351.2 5352.6 5358.3 5404.3 5357.4 5402.2 5416.0 5471.3 5475.0 5307.3 5333.3 5340.8 5341.7 5382.2 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | [#1] ext.html Cycles:180 Average:43419.60 Median:34242.16 stddev:70918.50 (207.1%) stddev-sans-first:71044.28 10:16:06 INFO - PROCESS | 19977 | Values: 515.9 529.3 539.9 544.2 557.7 34072.5 34968.8 35189.6 35243.1 35452.1 38709.8 38780.6 38979.4 39199.2 39397.8 8375.1 8561.1 8590.9 8621.7 8625.0 8288.0 8382.4 8454.2 8605.3 8621.0 8567.1 8613.6 8621.7 8682.2 8693.4 8546.6 8603.1 8673.1 8673.5 8678.3 8398.2 8473.8 8523.1 8572.2 8575.0 37568.4 38449.0 38470.4 38507.2 38508.8 3237.3 3285.2 3401.1 3514.5 3548.8 27126.7 27336.3 27441.3 27618.6 27990.3 3914.4 3934.2 3939.0 4046.9 4123.8 246223.0 246726.0 247620.0 248522.0 250834.7 50607.7 51722.5 57511.4 59037.4 60258.1 57425.4 57730.1 57814.7 57888.7 58319.0 14611.5 14684.9 14709.6 14714.3 14792.6 10378.8 10495.6 10535.3 10555.9 10631.3 19622.0 19840.5 19888.0 19914.7 20091.9 7119.2 7238.9 7271.9 7306.1 7346.1 969.1 984.4 995.2 1040.7 1067.2 27451.5 27476.0 27894.9 27964.9 28154.9 1038.8 1069.6 1079.7 1136.5 1145.3 14530.0 14707.0 14774.7 14781.2 14939.7 318628.0 321847.0 322993.0 323076.0 323400.0 48842.8 49144.3 49257.0 49449.0 49519.8 1286.6 1286.6 1292.6 1303.2 1306.8 26636.9 26839.0 27974.0 28779.3 29343.6 44308.1 45260.8 45344.3 45369.0 45473.0 235157.0 236763.0 237430.0 237691.0 237843.0 30129.0 30761.2 30856.2 31274.2 31368.2 37183.3 37974.4 39554.2 39676.8 40287.2 32950.1 33379.0 34022.8 34388.0 34602.3 33314.0 33340.8 34457.1 34478.8 34491.0 33659.3 33670.5 33907.2 33920.8 34096.3 28339.6 31263.4 31544.7 31556.8 31693.7 23693.5 24099.3 31259.5 32326.4 33310.7 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | [#2] jquery.html Cycles:180 Average:27125.82 Median:27375.10 stddev:88159.72 (322.0%) stddev-sans-first:88384.11 10:16:06 INFO - PROCESS | 19977 | Values: 349.5 354.2 354.3 354.8 354.8 15524.7 15929.4 16380.4 17275.6 17291.9 10538.1 10638.2 10653.2 12327.1 15398.3 4762.3 4808.4 4902.0 5383.7 5419.5 5379.8 5421.4 5423.1 5438.9 5441.1 4866.5 4876.1 5063.3 5099.5 5112.1 5025.7 5041.0 5072.5 5203.2 5900.0 5230.6 5231.8 5235.1 5244.9 5246.8 17657.9 18583.2 19256.4 19293.4 19308.9 1920.7 1921.4 1973.9 2066.5 2188.7 9312.1 9370.5 10028.8 10577.0 12742.7 435.6 439.2 1755.2 1772.7 1803.0 48832.8 49724.5 52399.0 53908.5 54747.0 9688.3 9967.9 10117.1 10131.9 10164.4 13129.7 13196.4 13236.4 13253.2 13259.0 7289.3 7407.0 7452.2 7479.3 7513.6 7065.1 7152.9 7171.1 7174.5 7221.4 4340.5 4414.8 4426.6 4443.0 4475.1 1684.6 1722.3 1775.3 1802.1 1822.3 820.2 859.7 908.2 972.9 1012.2 14799.3 15780.3 16231.3 16661.8 16945.3 905.4 908.4 912.9 962.7 1011.5 9206.4 9422.0 9504.1 9565.8 9664.4 527280.0 533555.0 534971.0 550529.5 553072.0 66918.0 69462.3 70446.0 71347.6 72012.0 1105.3 1128.6 1131.2 1132.5 1141.2 15067.4 15091.8 15105.4 15166.5 15519.5 32069.0 32443.5 33048.0 33914.3 34070.0 39279.8 39962.4 40953.4 46906.8 47136.5 6909.9 7095.5 7156.2 7175.8 7403.8 8833.5 10464.7 10958.2 11007.4 11261.7 8788.4 8943.8 9293.0 9699.9 9833.8 9458.3 9582.8 9762.3 9863.5 9989.5 9559.2 9719.8 9880.9 9918.0 9937.9 7197.4 7359.8 7367.0 7386.6 7525.9 9558.1 9943.1 9953.6 10133.0 10154.5 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | [#3] mootools.html Cycles:180 Average:5264.03 Median:6061.30 stddev:2684.90 (44.3%) stddev-sans-first:2676.89 10:16:06 INFO - PROCESS | 19977 | Values: 1420.7 1427.7 1542.9 1704.9 1727.1 7293.7 7465.9 7504.6 7673.6 7678.2 7530.9 7545.7 7578.5 7585.4 7608.7 2226.4 2266.3 2271.7 2272.7 2273.6 2263.9 2300.7 2336.1 2347.0 2351.5 2207.6 2280.5 2289.3 2298.1 2307.3 2285.4 2296.4 2310.7 2312.4 2316.0 2282.8 2299.9 2304.1 2305.2 2305.9 7448.4 7462.0 7469.4 7476.7 7499.7 4579.5 4672.1 4677.0 4685.0 4719.4 3080.8 3126.8 3170.0 3198.6 3224.5 1048.4 1075.4 1102.1 1104.6 1117.9 10292.6 10329.0 10337.8 10394.9 10399.9 3945.7 4003.6 4082.5 4094.1 4095.0 8272.9 8289.6 8325.5 8328.2 8329.5 4569.9 4619.6 4627.1 4633.2 4634.3 4277.7 4297.8 4301.5 4309.9 4318.8 3239.0 3274.3 3277.9 3280.5 3314.0 1004.5 1024.9 1025.7 1026.0 1031.7 1028.3 1029.9 1056.9 1143.9 1269.6 6742.9 6748.7 6777.2 6811.9 6812.6 1163.9 1190.1 1199.3 1212.8 1223.1 5189.5 5199.1 5210.2 5226.3 5258.2 8519.7 9189.5 9224.0 9272.0 9304.4 9061.6 9063.1 9084.0 9171.3 9325.8 6815.8 6988.2 7041.5 7057.8 7176.9 6675.3 6742.7 6744.8 6761.8 6789.7 7956.5 8178.3 8197.7 8254.6 8298.6 8083.4 8210.2 8234.8 8276.2 8307.8 6594.2 6699.7 6720.3 6731.7 6734.2 7265.6 7344.8 7361.6 7380.3 7406.9 6850.6 6990.0 6996.1 7013.2 7119.4 6422.4 6550.1 6627.5 6652.2 6875.7 6442.3 6495.6 6511.4 6519.1 6559.3 6064.3 6074.4 6095.4 6109.8 6163.3 6058.3 6103.4 6105.9 6116.6 6119.8 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | [#4] prototype.html Cycles:180 Average:5524.70 Median:6278.51 stddev:1683.67 (26.8%) stddev-sans-first:1642.85 10:16:06 INFO - PROCESS | 19977 | Values: 342.5 345.3 351.6 353.3 354.7 6125.2 6218.9 6286.9 6288.9 6355.4 6183.7 6222.3 6224.4 6232.0 6246.5 4733.7 4739.0 4748.5 4749.5 4753.8 4728.8 4735.0 4755.9 4758.6 4773.8 4526.5 4600.1 4618.0 4619.7 4635.4 4569.5 4604.7 4614.4 4642.4 4655.0 4016.2 4017.9 4027.0 4027.8 4043.4 5859.2 5891.0 5907.7 5915.4 5922.8 5294.7 5423.9 5437.6 5501.3 5524.8 6559.5 6574.4 6598.6 6602.6 6605.1 4547.5 4548.9 4561.0 4573.2 4583.3 6765.9 6823.1 6864.6 6880.6 6914.4 4679.7 4682.2 4683.4 4691.7 4697.1 4748.8 4751.5 4760.0 4762.4 4769.2 5474.3 5490.2 5507.9 5517.1 5523.6 6397.2 6600.6 6616.9 6661.4 6669.6 1661.4 1664.9 1671.7 1675.6 1681.1 1108.2 1117.7 1121.8 1129.1 1130.5 6261.7 6287.8 6299.2 6305.4 6311.3 6771.7 6775.2 6776.7 6779.8 6788.8 6197.8 6225.3 6270.1 6303.4 6360.7 3697.0 3707.3 3720.9 3725.8 3726.9 7142.3 7153.2 7153.3 7154.2 7165.4 6924.1 6966.8 7010.5 7015.2 7049.2 7120.7 7127.6 7149.9 7155.5 7172.7 6818.0 6818.1 6818.7 6831.1 6839.6 6573.4 6772.6 6784.8 6796.5 6823.0 7147.5 7153.9 7154.8 7156.3 7159.4 4604.8 4615.1 4646.8 4650.3 4650.7 6746.6 6882.4 6892.2 6906.1 6937.9 6670.4 6673.8 6673.9 6674.4 6682.5 6645.5 6647.4 6658.1 6669.2 6703.3 6341.8 6529.9 6562.5 6571.9 6580.7 6693.8 6702.9 6716.1 6737.3 6748.1 6396.2 6475.0 6507.8 6539.3 6556.3 10:16:06 INFO - PROCESS | 19977 | 10:16:06 INFO - PROCESS | 19977 | [#5] yui.html Cycles:180 Average:13038.93 Median:43895.28 stddev:14454.50 (32.9%) stddev-sans-first:14465.74 10:16:06 INFO - PROCESS | 19977 | Values: 781.9 836.7 844.8 856.4 857.3 12915.9 13006.3 13063.2 13771.2 14055.4 13666.2 13688.5 13693.1 13757.8 13763.2 780.2 786.4 789.4 792.4 802.4 801.3 804.6 805.4 805.5 810.2 834.1 835.8 836.4 836.4 836.5 833.8 834.9 835.5 836.3 838.6 612.4 615.5 615.7 616.4 617.7 13166.7 13254.5 13268.0 13278.6 13283.0 12089.3 12258.1 12478.7 12561.9 12684.2 10284.9 10294.5 10298.0 10339.0 10363.5 3598.2 3607.6 3640.1 3657.1 3717.2 43167.4 44424.6 44656.0 44694.6 44966.6 9661.7 9821.4 10056.5 10160.1 10198.5 16872.3 16893.8 16896.7 16948.9 17000.6 7431.8 7442.7 7445.3 7514.4 7650.0 4338.0 4338.4 4353.6 4354.6 4413.9 3027.8 3037.2 3039.2 3041.7 3045.6 557.9 563.1 563.9 567.0 595.2 501.0 552.6 589.9 628.1 628.2 7730.1 7909.8 7942.6 8079.1 8095.0 583.4 596.7 606.8 607.5 640.2 3619.5 3854.3 3923.8 3941.0 3951.2 49896.0 51146.0 51989.5 52015.2 52257.5 43674.8 43860.6 43930.0 46972.3 47038.0 41698.6 41773.6 42096.8 44265.0 44307.8 8639.4 8741.6 8767.5 8893.5 9015.2 32234.4 32489.0 33294.7 33416.7 34132.7 41156.0 41286.0 41951.6 42072.4 42816.4 9726.6 9947.1 10055.9 10518.8 10692.5 12026.2 12101.7 12149.6 12237.4 12278.6 11052.8 11261.3 11338.9 11351.6 11385.7 11092.2 11108.9 11474.5 11503.2 11767.0 11004.3 11197.1 11269.5 11598.4 11724.4 9253.4 9369.3 9475.0 9671.8 9729.8 8857.3 8961.9 9158.0 9327.4 9694.4 10:16:06 INFO - PROCESS | 19977 | -------- Summary: end -------- 10:16:06 INFO - PROCESS | 19977 | 10:16:07 INFO - TEST-INFO | 19977: exit 0 10:16:07 INFO - TEST-OK | dromaeo_css | took 1110641ms 10:16:07 INFO - TEST-START | kraken 10:16:07 INFO - operating with platform_type : linux_ 10:16:07 INFO - Initialising browser for kraken test... 10:16:07 INFO - TEST-INFO | started process 20219 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV6dDlQ/profile http://localhost:33658/getInfo.html) 10:16:11 INFO - PROCESS | 20219 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 10:16:12 INFO - PROCESS | 20219 | __metrics Screen width/height:1600/1200 10:16:12 INFO - PROCESS | 20219 | colorDepth:24 10:16:12 INFO - PROCESS | 20219 | Browser inner width/height: 1024/697 10:16:12 INFO - PROCESS | 20219 | __metrics 10:16:12 INFO - PROCESS | 20219 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:16:13 INFO - TEST-INFO | 20219: exit 0 10:16:13 INFO - Browser initialized. 10:16:13 INFO - Running cycle 1/1 for kraken test... 10:16:13 INFO - TEST-INFO | started process 20338 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV6dDlQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:25 INFO - PROCESS | 20338 | RSS: Main: 150999040 10:16:25 INFO - PROCESS | 20338 | 10:16:27 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33658/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:28 INFO - PROCESS | 20338 | RSS: Main: 152756224 10:16:28 INFO - PROCESS | 20338 | 10:16:30 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33658/tests/kraken/driver.html?testName=audio-dft) 10:16:31 INFO - PROCESS | 20338 | RSS: Main: 150872064 10:16:31 INFO - PROCESS | 20338 | 10:16:34 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33658/tests/kraken/driver.html?testName=audio-fft) 10:16:35 INFO - PROCESS | 20338 | RSS: Main: 146538496 10:16:35 INFO - PROCESS | 20338 | 10:16:37 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33658/tests/kraken/driver.html?testName=audio-oscillator) 10:16:37 INFO - PROCESS | 20338 | RSS: Main: 147279872 10:16:37 INFO - PROCESS | 20338 | 10:16:40 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:40 INFO - PROCESS | 20338 | RSS: Main: 147173376 10:16:40 INFO - PROCESS | 20338 | 10:16:43 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33658/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:44 INFO - PROCESS | 20338 | RSS: Main: 146251776 10:16:44 INFO - PROCESS | 20338 | 10:16:47 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33658/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:48 INFO - PROCESS | 20338 | RSS: Main: 148717568 10:16:48 INFO - PROCESS | 20338 | 10:16:51 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33658/tests/kraken/driver.html?testName=json-parse-financial) 10:16:51 INFO - PROCESS | 20338 | RSS: Main: 148254720 10:16:51 INFO - PROCESS | 20338 | 10:16:53 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:53 INFO - PROCESS | 20338 | RSS: Main: 148750336 10:16:53 INFO - PROCESS | 20338 | 10:16:55 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:56 INFO - PROCESS | 20338 | RSS: Main: 148983808 10:16:56 INFO - PROCESS | 20338 | 10:16:58 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:58 INFO - PROCESS | 20338 | RSS: Main: 149155840 10:16:58 INFO - PROCESS | 20338 | 10:17:01 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:02 INFO - PROCESS | 20338 | RSS: Main: 149676032 10:17:02 INFO - PROCESS | 20338 | 10:17:04 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:05 INFO - PROCESS | 20338 | RSS: Main: 148758528 10:17:05 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | Cycle 1(1): loaded http://localhost:33658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33658/tests/kraken/driver.html?testName=ai-astar) 10:17:07 INFO - PROCESS | 20338 | RSS: Main: 149557248 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | __start_tp_report 10:17:07 INFO - PROCESS | 20338 | _x_x_mozilla_page_load 10:17:07 INFO - PROCESS | 20338 | _x_x_mozilla_page_load_details 10:17:07 INFO - PROCESS | 20338 | |i|pagename|runs| 10:17:07 INFO - PROCESS | 20338 | |0;ai-astar;117;106;112;110;113;123;113;111;111;113 10:17:07 INFO - PROCESS | 20338 | |1;audio-beat-detection;161;128;157;169;128;158;156;130;162;136 10:17:07 INFO - PROCESS | 20338 | |2;audio-dft;161;162;161;163;161;161;164;171;166;163 10:17:07 INFO - PROCESS | 20338 | |3;audio-fft;75;74;77;76;74;74;133;73;72;72 10:17:07 INFO - PROCESS | 20338 | |4;audio-oscillator;97;96;146;96;96;97;142;96;96;140 10:17:07 INFO - PROCESS | 20338 | |5;imaging-gaussian-blur;109;110;110;110;109;111;110;110;110;110 10:17:07 INFO - PROCESS | 20338 | |6;imaging-darkroom;146;147;147;147;146;146;146;147;146;147 10:17:07 INFO - PROCESS | 20338 | |7;imaging-desaturate;96;97;102;97;96;97;96;95;96;96 10:17:07 INFO - PROCESS | 20338 | |8;json-parse-financial;57;57;59;57;58;58;56;62;55;59 10:17:07 INFO - PROCESS | 20338 | |9;json-stringify-tinderbox;68;68;66;67;67;68;67;68;69;68 10:17:07 INFO - PROCESS | 20338 | |10;stanford-crypto-aes;86;87;89;89;88;88;87;94;89;96 10:17:07 INFO - PROCESS | 20338 | |11;stanford-crypto-ccm;119;123;117;141;122;125;124;127;129;118 10:17:07 INFO - PROCESS | 20338 | |12;stanford-crypto-pbkdf2;145;150;155;156;161;161;157;161;158;145 10:17:07 INFO - PROCESS | 20338 | |13;stanford-crypto-sha256-iterative;70;70;73;71;72;68;71;70;68;71 10:17:07 INFO - PROCESS | 20338 | __end_tp_report 10:17:07 INFO - PROCESS | 20338 | __start_cc_report 10:17:07 INFO - PROCESS | 20338 | _x_x_mozilla_cycle_collect,733 10:17:07 INFO - PROCESS | 20338 | __end_cc_report 10:17:07 INFO - PROCESS | 20338 | __startTimestamp1452277027293__endTimestamp 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | ------- Summary: start ------- 10:17:07 INFO - PROCESS | 20338 | Number of tests: 14 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:4.51 (4.0%) stddev-sans-first:4.53 10:17:07 INFO - PROCESS | 20338 | Values: 117.0 106.0 112.0 110.0 113.0 123.0 113.0 111.0 111.0 113.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:157.50 stddev:16.04 (10.2%) stddev-sans-first:16.37 10:17:07 INFO - PROCESS | 20338 | Values: 161.0 128.0 157.0 169.0 128.0 158.0 156.0 130.0 162.0 136.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:3.16 (1.9%) stddev-sans-first:3.24 10:17:07 INFO - PROCESS | 20338 | Values: 161.0 162.0 161.0 163.0 161.0 161.0 164.0 171.0 166.0 163.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.00 stddev:18.69 (25.3%) stddev-sans-first:19.74 10:17:07 INFO - PROCESS | 20338 | Values: 75.0 74.0 77.0 76.0 74.0 74.0 133.0 73.0 72.0 72.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:22.45 (23.4%) stddev-sans-first:23.30 10:17:07 INFO - PROCESS | 20338 | Values: 97.0 96.0 146.0 96.0 96.0 97.0 142.0 96.0 96.0 140.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 10:17:07 INFO - PROCESS | 20338 | Values: 109.0 110.0 110.0 110.0 109.0 111.0 110.0 110.0 110.0 110.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:17:07 INFO - PROCESS | 20338 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.93 (2.0%) stddev-sans-first:2.03 10:17:07 INFO - PROCESS | 20338 | Values: 96.0 97.0 102.0 97.0 96.0 97.0 96.0 95.0 96.0 96.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.93 (3.3%) stddev-sans-first:2.03 10:17:07 INFO - PROCESS | 20338 | Values: 57.0 57.0 59.0 57.0 58.0 58.0 56.0 62.0 55.0 59.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 10:17:07 INFO - PROCESS | 20338 | Values: 68.0 68.0 66.0 67.0 67.0 68.0 67.0 68.0 69.0 68.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:89.00 stddev:3.20 (3.6%) stddev-sans-first:3.16 10:17:07 INFO - PROCESS | 20338 | Values: 86.0 87.0 89.0 89.0 88.0 88.0 87.0 94.0 89.0 96.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:124.50 stddev:6.96 (5.6%) stddev-sans-first:7.10 10:17:07 INFO - PROCESS | 20338 | Values: 119.0 123.0 117.0 141.0 122.0 125.0 124.0 127.0 129.0 118.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:157.50 stddev:6.21 (3.9%) stddev-sans-first:5.45 10:17:07 INFO - PROCESS | 20338 | Values: 145.0 150.0 155.0 156.0 161.0 161.0 157.0 161.0 158.0 145.0 10:17:07 INFO - PROCESS | 20338 | 10:17:07 INFO - PROCESS | 20338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:1.58 (2.2%) stddev-sans-first:1.67 10:17:07 INFO - PROCESS | 20338 | Values: 70.0 70.0 73.0 71.0 72.0 68.0 71.0 70.0 68.0 71.0 10:17:07 INFO - PROCESS | 20338 | -------- Summary: end -------- 10:17:07 INFO - PROCESS | 20338 | 10:17:08 INFO - TEST-INFO | 20338: exit 0 10:17:08 INFO - TEST-OK | kraken | took 60587ms 10:17:08 INFO - TEST-START | v8_7 10:17:08 INFO - operating with platform_type : linux_ 10:17:08 INFO - Initialising browser for v8_7 test... 10:17:08 INFO - TEST-INFO | started process 20628 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGXR1Pe/profile http://localhost:33658/getInfo.html) 10:17:12 INFO - PROCESS | 20628 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 10:17:12 INFO - PROCESS | 20628 | __metrics Screen width/height:1600/1200 10:17:12 INFO - PROCESS | 20628 | colorDepth:24 10:17:12 INFO - PROCESS | 20628 | Browser inner width/height: 1024/697 10:17:12 INFO - PROCESS | 20628 | __metrics 10:17:13 INFO - PROCESS | 20628 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:17:13 INFO - TEST-INFO | 20628: exit 0 10:17:13 INFO - Browser initialized. 10:17:13 INFO - Running cycle 1/1 for v8_7 test... 10:17:13 INFO - TEST-INFO | started process 20750 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGXR1Pe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:25 INFO - PROCESS | 20750 | RSS: Main: 150360064 10:17:25 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | Cycle 1(1): loaded http://localhost:33658/tests/v8_7/run.html (next: http://localhost:33658/tests/v8_7/run.html) 10:17:48 INFO - PROCESS | 20750 | RSS: Main: 145592320 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | __start_tp_report 10:17:48 INFO - PROCESS | 20750 | _x_x_mozilla_page_load 10:17:48 INFO - PROCESS | 20750 | _x_x_mozilla_page_load_details 10:17:48 INFO - PROCESS | 20750 | |i|pagename|runs| 10:17:48 INFO - PROCESS | 20750 | |0;Richards;166.75004168751042 10:17:48 INFO - PROCESS | 20750 | |1;DeltaBlue;189.75332068311195 10:17:48 INFO - PROCESS | 20750 | |2;Encrypt;283.68794326241135 10:17:48 INFO - PROCESS | 20750 | |3;Decrypt;5312.169312169312 10:17:48 INFO - PROCESS | 20750 | |4;RayTrace;1117.31843575419 10:17:48 INFO - PROCESS | 20750 | |5;Earley;722.7436823104694 10:17:48 INFO - PROCESS | 20750 | |6;Boyer;12195.121951219513 10:17:48 INFO - PROCESS | 20750 | |7;RegExp;41081.63265306123 10:17:48 INFO - PROCESS | 20750 | |8;Splay;568.5048322910744 10:17:48 INFO - PROCESS | 20750 | |9;NavierStokes;4826.923076923077 10:17:48 INFO - PROCESS | 20750 | __end_tp_report 10:17:48 INFO - PROCESS | 20750 | __startTimestamp1452277068453__endTimestamp 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | ------- Summary: start ------- 10:17:48 INFO - PROCESS | 20750 | Number of tests: 10 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 166.8 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#1] DeltaBlue Cycles:1 Average:189.75 Median:189.75 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 189.8 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#2] Encrypt Cycles:1 Average:283.69 Median:283.69 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 283.7 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#3] Decrypt Cycles:1 Average:5312.17 Median:5312.17 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 5312.2 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#4] RayTrace Cycles:1 Average:1117.32 Median:1117.32 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 1117.3 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#5] Earley Cycles:1 Average:722.74 Median:722.74 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 722.7 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 12195.1 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#7] RegExp Cycles:1 Average:41081.63 Median:41081.63 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 41081.6 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#8] Splay Cycles:1 Average:568.50 Median:568.50 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 568.5 10:17:48 INFO - PROCESS | 20750 | 10:17:48 INFO - PROCESS | 20750 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:17:48 INFO - PROCESS | 20750 | Values: 4826.9 10:17:48 INFO - PROCESS | 20750 | -------- Summary: end -------- 10:17:48 INFO - PROCESS | 20750 | 10:17:49 INFO - TEST-INFO | 20750: exit 0 10:17:49 INFO - TEST-OK | v8_7 | took 41035ms 10:17:49 INFO - SUITE-END | took 1212s 10:17:49 INFO - Completed test suite (00:20:12) 10:17:49 INFO - Working with test: dromaeo_css 10:17:49 INFO - Generating results file: dromaeo_css 10:17:49 INFO - Working with test: kraken 10:17:49 INFO - Generating results file: kraken 10:17:49 INFO - javascript benchmark 10:17:49 INFO - Working with test: v8_7 10:17:49 INFO - Generating results file: v8_7 10:17:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:49 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:17:49 INFO - process_Request line: dromaeo_css 6772.91 graph.html#tests=[[72,1,43]] 10:17:49 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:49 INFO - process_Request line: kraken 1532.60 graph.html#tests=[[232,1,43]] 10:17:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:49 INFO - process_Request line: v8_7 20310.14 graph.html#tests=[[230,1,43]] 10:17:49 INFO - RETURN: dromaeo_css: 6772.91 10:17:49 INFO - RETURN: kraken: 1532.60 10:17:49 INFO - RETURN: v8_7: 20310.14 10:17:49 INFO - javascript benchmark 10:17:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.4238315911552, 3152.38528486945, 3190.856411461487, 3196.0571631368744, 3204.6955539223763, 5018.2723505091835, 5102.923456148161, 5127.692338459695, 5135.691858488489, 5203.271541984116, 5104.770285337159, 5105.5149760772665, 5109.463506331828, 5111.207762796773, 5130.589552835764, 4658.464276608191, 4667.6732628716, 4734.597559207472, 4735.124002059612, 4738.170820106485, 4744.5967092797155, 4764.237721964487, 4812.566868981791, 4878.34142390778, 4896.412430508344, 4837.105135549935, 4862.708237505743, 4894.853154405374, 4899.118158731427, 4951.752412379385, 4753.263244197155, 4824.228123500223, 4834.105690447243, 4842.055799119174, 4887.242477416006, 4708.340832283483, 4736.242201247784, 4741.83403580873, 4750.239961606127, 4786.401699787527, 4994.800207991676, 5023.949760502384, 5039.218921067204, 5063.26582645518, 5065.822696205652, 5519.889602207973, 5520.447955204488, 5521.337439507245, 5546.27898373213, 5566.888662226733, 5498.670079795185, 5609.186667933127, 5609.5518008753115, 5621.550275977912, 5655.886882262332, 5116.232565115225, 5142.820001299974, 5162.1224391853475, 5223.817166399196, 5321.068812957717, 5739.569532285095, 5745.626534275342, 5761.5102716269585, 5774.307083150049, 5812.680302583399, 5452.890942181134, 5458.61789674719, 5461.371942226695, 5480.150576660624, 5486.945130548724, 5522.944770552243, 5551.028570000234, 5587.05020146576, 5608.10270356741, 5621.634593751393, 5623.268975033219, 5634.323881134208, 5643.548516118701, 5650.660960342392, 5685.914711279334, 5629.915551266734, 5639.069553523623, 5642.181883626851, 5650.85872853182, 5660.745266463019, 4200.5169405518145, 4283.7429754214845, 4285.957140428618, 4368.453943257093, 4388.407564978751, 3900.7659540427667, 3918.1575961168487, 3921.215756848642, 3958.366661334173, 3962.227365663668, 5274.815381461707, 5287.444818294024, 5296.09966305729, 5296.443873393316, 5298.443663415363, 5417.133258678671, 5512.779488820403, 5587.664740115606, 5665.291838520185, 5688.089905615082, 5238.947610523922, 5239.869003274948, 5249.973750131225, 5268.420473747885, 5281.709505977131, 4789.568938795525, 4791.209450440639, 4795.18481858078, 4801.207800712843, 4821.54195351441, 5624.409437009137, 5722.856928576735, 5799.217105690762, 5849.151872978395, 5904.852378690567, 5428.972855135699, 5450.672959622435, 5474.479924407175, 5479.780808767764, 5513.0, 5667.40492248308, 5698.686572238566, 5698.772049117989, 5701.515371193495, 5705.486506214461, 5416.891662166813, 5546.611737178358, 5555.444455554412, 5605.691686957093, 5650.943490565206, 5556.499915007668, 5569.777208911598, 5591.6365436246515, 5591.832245032656, 5609.887802244014, 5247.081760691787, 5306.151015837602, 5361.678299302054, 5407.026735187704, 5454.372747134131, 5442.564594832483, 5471.398146203835, 5482.780688772564, 5490.368607610176, 5550.195221692913, 5307.628466007497, 5351.224072509543, 5352.5985551084605, 5358.33020872391, 5404.297441332602, 5357.410684824744, 5402.162664786964, 5416.025115479251, 5471.261379713687, 5475.0, 5307.283516725192, 5333.333333333333, 5340.813071542478, 5341.732913354239, 5382.246485491956], "unit": "score", "name": "dojo.html", "value": 5149.243924658057}, {"lowerIsBetter": false, "replicates": [515.8890838469729, 529.3171808367207, 539.8893226888486, 544.213611331626, 557.6514678326046, 34072.4889126663, 34968.82515587418, 35189.64810351896, 35243.11892202696, 35452.11369715758, 38709.806450967706, 38780.612193878056, 38979.41530877039, 39199.21601567974, 39397.80301098498, 8375.120612335693, 8561.101084386144, 8590.914090859105, 8621.655133794671, 8624.956875215616, 8288.005439347256, 8382.371322150833, 8454.196851299148, 8605.268552173073, 8621.0, 8567.057623661392, 8613.612387442548, 8621.741347759546, 8682.175193356621, 8693.434926729742, 8546.572671366437, 8603.139686031409, 8673.089325620813, 8673.479591224484, 8678.305735541142, 8398.202170793766, 8473.830523389559, 8523.06246312905, 8572.185642364027, 8575.0, 37568.43647345292, 38449.0, 38470.42294365587, 38507.22985540301, 38508.80745596254, 3237.2877966847254, 3285.1951271938287, 3401.1327111586634, 3514.4728290756593, 3548.8288864674596, 27126.728732712618, 27336.309598204185, 27441.31396715078, 27618.585721214196, 27990.300242493897, 3914.354131568288, 3934.2328245992044, 3938.9803050984847, 4046.9392959105344, 4123.793810309502, 246223.0, 246726.0, 247620.0, 248522.0, 250834.74582627154, 50607.74696126496, 51722.48277517252, 57511.42488575145, 59037.40962590405, 60258.09612855811, 57425.42574574201, 57730.13404798931, 57814.7109264451, 57888.684452621426, 58319.0, 14611.488597899235, 14684.853151468562, 14709.55871323862, 14714.264286785618, 14792.630184245265, 10378.792424151474, 10495.632652857113, 10535.315204511682, 10555.947220264003, 10631.308964917256, 19622.0, 19840.50398740014, 19888.0, 19914.701279480818, 20091.899540502203, 7119.181294151135, 7238.855222895618, 7271.854562908712, 7306.123265208209, 7346.081739782528, 969.0842154164247, 984.3503287829998, 995.233670074039, 1040.70339953113, 1067.2262609607972, 27451.45097098047, 27476.0, 27894.860525697648, 27964.860175698992, 28154.85922570415, 1038.7922415516775, 1069.6149386220955, 1079.6707004363745, 1136.4545018391218, 1145.2727518025947, 14530.0, 14707.0, 14774.704505910036, 14781.187034713193, 14939.701205976036, 318628.0, 321847.0, 322993.0, 323076.0, 323400.0, 48842.75578622084, 49144.26283605749, 49257.0, 49449.0, 49519.75240123848, 1286.6204469681466, 1286.6461723026055, 1292.5540688462465, 1303.1855090568395, 1306.8235788168477, 26636.8668156658, 26839.0, 27974.0, 28779.28051798722, 29343.559846601893, 44308.11383772371, 45260.77369613262, 45344.31983520316, 45369.0, 45473.0, 235157.0, 236763.0, 237430.0, 237691.0, 237843.0, 30129.0, 30761.230969225053, 30856.228594285323, 31274.21814454657, 31368.17686408143, 37183.25633487261, 37974.43038354482, 39554.20891582095, 39676.80161599174, 40287.1942561153, 32950.069782111364, 33379.0, 34022.82988585041, 34388.0, 34602.307953841286, 33313.967057468224, 33340.83329583434, 34457.13857153491, 34478.82760586181, 34491.0, 33659.32681346311, 33670.49494257637, 33907.15232119217, 33920.83039584885, 34096.31807363888, 28339.60910884027, 31263.374732504766, 31544.684553155093, 31556.842215788773, 31693.683063169072, 23693.526129477657, 24099.277021689377, 31259.53110703387, 32326.35347292994, 33310.66689333076], "unit": "score", "name": "ext.html", "value": 17786.07352057668}, {"lowerIsBetter": false, "replicates": [349.5420998491976, 354.1800731307024, 354.2507596433544, 354.7605366377695, 354.84564214566666, 15524.689506209883, 15929.44246951357, 16380.426685066024, 17275.568110797238, 17291.91354043228, 10538.051575358235, 10638.2021348399, 10653.201009924267, 12327.075469339812, 15398.30707618157, 4762.285657151438, 4808.350872632185, 4902.0, 5383.650062745928, 5419.5393391561765, 5379.784808607651, 5421.427785942072, 5423.050966080939, 5438.891222175574, 5441.102218134023, 4866.537678920497, 4876.146674331978, 5063.341765570471, 5099.541041306282, 5112.079825631385, 5025.698458092526, 5041.0, 5072.4673909239555, 5203.219517072469, 5899.970500147515, 5230.555402790767, 5231.843044708665, 5235.136202526579, 5244.895102097937, 5246.7638956247065, 17657.911710441367, 18583.163757630802, 19256.422307330802, 19293.42119736396, 19308.938008409674, 1920.7022911448748, 1921.3659492367485, 1973.930912418073, 2066.4523901166203, 2188.7045248891354, 9312.115349041831, 9370.484623345714, 10028.799424011551, 10577.0, 12742.745145097138, 435.6036007233434, 439.1699687590425, 1755.2403764920953, 1772.7252275897256, 1802.9819701802944, 48832.755836220946, 49724.50275497199, 52399.0, 53908.46091539074, 54747.0, 9688.273379496566, 9967.850482242773, 10117.140043096419, 10131.949340253399, 10164.440955747357, 13129.73740525184, 13196.406161722745, 13236.404361803741, 13253.204807711569, 13259.0, 7289.271072892669, 7407.0382313216705, 7452.217517160729, 7479.289467500579, 7513.586752728543, 7065.116860392451, 7152.92847071533, 7171.067761191011, 7174.497785154989, 7221.386182174469, 4340.52254252032, 4414.80133393998, 4426.623736982328, 4442.955570444319, 4475.149721552894, 1684.6209602839508, 1722.2508208929155, 1775.2898840463918, 1802.098621219835, 1822.261983896524, 820.2207902492656, 859.7162936231028, 908.1826356279402, 972.9075737804898, 1012.1953047327393, 14799.260036998323, 15780.289886955115, 16231.26959286835, 16661.750073748903, 16945.32218711238, 905.4160066756905, 908.3641450984205, 912.8767616371705, 962.7063745557532, 1011.5094179323022, 9206.401583897159, 9422.0, 9504.097110774464, 9565.760855978657, 9664.420134791935, 527280.0, 533555.0, 534971.0, 550529.4629375986, 553072.0, 66918.0, 69462.30537694659, 70446.0, 71347.6432617844, 72012.0, 1105.2926127278547, 1128.6106293328623, 1131.219458573598, 1132.5356603792407, 1141.178351586856, 15067.397304108152, 15091.849081509483, 15105.39578416851, 15166.469173578871, 15519.45681901128, 32069.0, 32443.513347300282, 33048.0, 33914.32171356608, 34070.0, 39279.80360098181, 39962.400563992145, 40953.36186552505, 46906.76546617245, 47136.52863471321, 6909.89635155463, 7095.46783991213, 7156.248593897774, 7175.820604484929, 7403.8149046274275, 8833.469991800512, 10464.686059418229, 10958.178136639943, 11007.394593297446, 11261.66215013551, 8788.384813063025, 8943.821123577622, 9293.0, 9699.9030009699, 9833.803323933338, 9458.290628202774, 9582.808343833223, 9762.267829912927, 9863.520471929269, 9989.450580218157, 9559.187469065208, 9719.805603887742, 9880.901190987997, 9917.950410247902, 9937.850932236166, 7197.388222000979, 7359.8160045999275, 7367.0, 7386.556806591621, 7525.887111693439, 9558.091981261769, 9943.105120539187, 9953.552090155816, 10133.0, 10154.492275386054], "unit": "score", "name": "jquery.html", "value": 7909.750323455323}, {"lowerIsBetter": false, "replicates": [1420.6732451536147, 1427.6716355238295, 1542.8688561472275, 1704.9232784524695, 1727.058752979626, 7293.671784769685, 7465.888011679829, 7504.6247687615605, 7673.577953212571, 7678.193789652083, 7530.9246907530905, 7545.69817207311, 7578.50739701919, 7585.431092668045, 7608.657610407531, 2226.4100013496436, 2266.320103968811, 2271.693321401606, 2272.7045484087043, 2273.5680220758086, 2263.9434014149615, 2300.6894069300597, 2336.1122773346187, 2347.0377145370403, 2351.4709190432186, 2207.580559693661, 2280.5096904165603, 2289.255991802671, 2298.115225638133, 2307.284741730061, 2285.405794493435, 2296.391456264075, 2310.722713274409, 2312.433453803812, 2316.0388438797963, 2282.760310167425, 2299.908003679851, 2304.0783686525356, 2305.204704376987, 2305.884705764705, 7448.441366897504, 7461.962690186569, 7469.439792015566, 7476.738314158978, 7499.700011999568, 4579.4504659440745, 4672.065586882637, 4677.0, 4684.976575117103, 4719.4100737407825, 3080.7830906791914, 3126.765492588065, 3169.9841500792577, 3198.616166060064, 3224.5485632011537, 1048.4338457233084, 1075.3547871277171, 1102.1127991966544, 1104.5857803323754, 1117.944102794857, 10292.588296468133, 10329.0, 10337.793244135075, 10394.896051039468, 10399.94800025995, 3945.723799334019, 4003.579624139482, 4082.4692789937117, 4094.058366575645, 4094.959050409517, 8272.875906861402, 8289.58552072394, 8325.542095184703, 8328.208820162075, 8329.5418751968, 4569.885752856205, 4619.6073333766335, 4627.1439783640135, 4633.166030114544, 4634.281686338623, 4277.721948073366, 4297.828086876552, 4301.526832048472, 4309.870703878889, 4318.784060796947, 3238.9676103238667, 3274.3287626036604, 3277.9344413111603, 3280.458724310462, 3314.038928710695, 1004.542932965499, 1024.9077583017415, 1025.6564051042835, 1025.9794804103876, 1031.6904928521415, 1028.3161697471098, 1029.917606591471, 1056.8902652215143, 1143.9256448330832, 1269.593730006389, 6742.898856517156, 6748.696308666122, 6777.186737591521, 6811.931880681229, 6812.591244525344, 1163.9301641901513, 1190.14309697018, 1199.3044034459992, 1212.8362671039474, 1223.1010207497482, 5189.455107213764, 5199.1161502544655, 5210.166373380241, 5226.268322434862, 5258.237555554423, 8519.74440766778, 9189.494577798152, 9223.985361610217, 9271.95364023189, 9304.395214311047, 9061.637534498546, 9063.13900179482, 9084.0, 9171.266298696088, 9325.813483730288, 6815.7614483493835, 6988.231294557595, 7041.4718896082995, 7057.823554411181, 7176.928230717626, 6675.332466753286, 6742.662866856539, 6744.763933262312, 6761.797146085429, 6789.660516974032, 7956.5226086435, 8178.345732341518, 8197.71308004217, 8254.628541715518, 8298.626561804855, 8083.3533317333295, 8210.178982101743, 8234.794130146794, 8276.172382761675, 8307.750767476986, 6594.241662208908, 6699.732010719516, 6720.294369091175, 6731.730730770911, 6734.225564060196, 7265.600391978492, 7344.816379590553, 7361.558306501627, 7380.335769780745, 7406.851862962818, 6850.588964662136, 6990.0, 6996.125484314461, 7013.228544860163, 7119.359257666835, 6422.42198202164, 6550.115734375799, 6627.5360724750735, 6652.234992975869, 6875.656217189221, 6442.291347951816, 6495.642739649365, 6511.446527045065, 6519.119918810899, 6559.27847936717, 6064.302605200459, 6074.362191969956, 6095.420935011167, 6109.816705498843, 6163.260408750979, 6058.303295121117, 6103.42017508336, 6105.9084113737445, 6116.633002019893, 6119.785807496716], "unit": "score", "name": "mootools.html", "value": 4362.871727872583}, {"lowerIsBetter": false, "replicates": [342.5273123090136, 345.3059350705082, 351.64132584763524, 353.3322021379592, 354.6595268542201, 6125.203723515942, 6218.937810621893, 6286.905696414552, 6288.8742225155465, 6355.396237357455, 6183.721732522036, 6222.346653601363, 6224.377562243773, 6231.968840155804, 6246.531510136735, 4733.739644319561, 4738.9526104739025, 4748.5251474852585, 4749.501302363254, 4753.786079626425, 4728.810847566093, 4734.952650473486, 4755.9286610700865, 4758.643101767381, 4773.785179666906, 4526.547345265463, 4600.102979918917, 4617.976910115462, 4619.74591397473, 4635.443746750378, 4569.497355290915, 4604.723716577016, 4614.377059097029, 4642.3500709900645, 4655.045715628288, 4016.2168377166463, 4017.9397309040387, 4027.0, 4027.81874815634, 4043.3530635098537, 5859.150423188614, 5891.027980383275, 5907.6750778707155, 5915.408459154093, 5922.822315330547, 5294.68231906083, 5423.945760542383, 5437.564994800407, 5501.284832971728, 5524.779008839641, 6559.47524198063, 6574.408303252682, 6598.571092878948, 6602.603843769341, 6605.141331626905, 4547.522510136421, 4548.931766023512, 4561.0, 4573.199690054261, 4583.2666773316105, 6765.8646827063185, 6823.147106611674, 6864.553804002724, 6880.58716477013, 6914.412274956584, 4679.666295105946, 4682.227432473672, 4683.367745354333, 4691.741954192552, 4697.060587882437, 4748.762561871962, 4751.524847515221, 4759.976200118977, 4762.4285085789925, 4769.165396055676, 5474.343078830566, 5490.176473529003, 5507.9449205507435, 5517.089680202802, 5523.558115350762, 6397.232332120176, 6600.570962887397, 6616.933830661728, 6661.433778128913, 6669.566478178903, 1661.4018953176846, 1664.9250783714763, 1671.6907372136193, 1675.6397374564526, 1681.125814576438, 1108.1799468393492, 1117.7205698575356, 1121.8036843552509, 1129.1136457880525, 1130.46867972053, 6261.7182226799905, 6287.842803929939, 6299.212598425197, 6305.432511074026, 6311.305756366796, 6771.661416929134, 6775.186977562724, 6776.728930842711, 6779.830504237433, 6788.796336109925, 6197.783077592263, 6225.28409232944, 6270.122182894398, 6303.401176888188, 6360.650164241011, 3697.020289623252, 3707.258548290353, 3720.9069773255887, 3725.844988053712, 3726.906827329284, 7142.285771422816, 7153.213146553875, 7153.284671532909, 7154.177269614061, 7165.355118039297, 6924.134483189601, 6966.756163534252, 7010.544314619533, 7015.193252775996, 7049.189343225492, 7120.71517139319, 7127.5723456593805, 7149.857002859913, 7155.534890232118, 7172.677229524684, 6818.0, 6818.147731533559, 6818.693158807965, 6831.11195544576, 6839.62382068991, 6573.408393244631, 6772.627505487246, 6784.7964561063245, 6796.524243302922, 6822.965885170543, 7147.53541019832, 7153.892691609526, 7154.821129471805, 7156.320149585781, 7159.391451726661, 4604.815807367801, 4615.0539139477, 4646.767661616973, 4650.34895114691, 4650.720956742606, 6746.595204287759, 6882.449404047564, 6892.207396149306, 6906.136732908387, 6937.861242775217, 6670.39966403026, 6673.766418175341, 6673.933260667525, 6674.399304062657, 6682.465402767864, 6645.468362531083, 6647.434968027772, 6658.1344425224415, 6669.233038200669, 6703.3296670332575, 6341.778037768656, 6529.9020514691365, 6562.50781191403, 6571.934280657323, 6580.7038683260325, 6693.8326541834895, 6702.899456508254, 6716.059751634873, 6737.29258427858, 6748.055272261985, 6396.168498095218, 6474.967625161844, 6507.804765857032, 6539.313372095861, 6556.2788093310655], "unit": "score", "name": "prototype.html", "value": 4978.004317163912}, {"lowerIsBetter": false, "replicates": [781.9452638315316, 836.6662526394236, 844.8014716541612, 856.4047986649274, 857.3012994409555, 12915.870841291584, 13006.28465434402, 13063.216207027574, 13771.173729576232, 14055.367508462119, 13666.248356340397, 13688.452461901512, 13693.109947853407, 13757.79363309551, 13763.17420954741, 780.1769133564088, 786.4259090863673, 789.3842802613971, 792.3581898662073, 802.3621221129216, 801.3268854162502, 804.569555287921, 805.3597390074875, 805.5448671500612, 810.2464707821723, 834.1158372125566, 835.841190173865, 836.3894357119307, 836.4395854777283, 836.5315423362906, 833.8165603567267, 834.9415540912169, 835.4527784301292, 836.2766207230732, 838.5513750143705, 612.4457366083701, 615.4922189193888, 615.6829232945037, 616.3620652624556, 617.6757202468694, 13166.736665266737, 13254.536091236856, 13268.0, 13278.601641950758, 13283.0, 12089.335086570236, 12258.1419300649, 12478.688032799162, 12561.937190314082, 12684.175528590613, 10284.897151028543, 10294.536745846455, 10298.0, 10339.0, 10363.533640986097, 3598.223321153163, 3607.640413556368, 3640.0899775056237, 3657.122290650251, 3717.182219911615, 43167.35248971268, 44424.555754442365, 44656.0, 44694.55305446936, 44966.55033449689, 9661.71014869555, 9821.410715357102, 10056.547455364525, 10160.13638840692, 10198.541065651914, 16872.325106995584, 16893.83106168947, 16896.662066758843, 16948.915255423643, 17000.57498562546, 7431.777046688608, 7442.702291908263, 7445.287583855744, 7514.39884809214, 7649.9617501912135, 4337.956620433818, 4338.414314067561, 4353.586409291112, 4354.56454354562, 4413.889652758707, 3027.818330900153, 3037.1951432870305, 3039.240189952512, 3041.680623534497, 3045.6040714706946, 557.8744782424003, 563.0737436916249, 563.9069553523705, 566.9971650141805, 595.1548800703013, 501.0255053920163, 552.5551930695748, 589.908564172554, 628.0767272109991, 628.2210059526154, 7730.149683534807, 7909.841803163905, 7942.563159026309, 8079.111297757242, 8095.036062791755, 583.3699604427209, 596.6956852005421, 606.7967230977672, 607.4957785038407, 640.1645852162972, 3619.4751760995036, 3854.2676891390547, 3923.803809809498, 3940.9605903941165, 3951.249262640089, 49896.0, 51146.0, 51989.48010519922, 52015.21977170346, 52257.477425226025, 43674.7816260923, 43860.561394385644, 43930.0, 46972.29541556879, 47038.0, 41698.58301417008, 41773.58226417697, 42096.789516052224, 44265.0, 44307.77846110749, 8639.395242333228, 8741.562921854009, 8767.517786521803, 8893.4663920165, 9015.188633023059, 32234.35531289408, 32489.0, 33294.667053329154, 33416.66583334136, 34132.658673412945, 41156.0, 41286.0, 41951.58048419599, 42072.3689144657, 42816.357754633085, 9726.610935562498, 9947.05502977216, 10055.949720251352, 10518.789624207626, 10692.465376731288, 12026.218295810744, 12101.69745756363, 12149.635510934686, 12237.449314780679, 12278.570250041206, 11052.802073210301, 11261.268017578832, 11338.943305283421, 11351.602693905674, 11385.658430247106, 11092.223544351818, 11108.888911110786, 11474.483648236017, 11503.194776365573, 11767.0, 11004.339739615649, 11197.104231661611, 11269.549218031514, 11598.362090085126, 11724.413779311171, 9253.444793312423, 9369.25045996305, 9474.952625237105, 9671.806563868542, 9729.756756080871, 8857.335699822668, 8961.865572016555, 9158.0, 9327.440353578808, 9694.418334899929], "unit": "score", "name": "yui.html", "value": 6134.805510005957}], "name": "dromaeo_css", "value": 6772.908719689887}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 106.0, 112.0, 110.0, 113.0, 123.0, 113.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [161.0, 128.0, 157.0, 169.0, 128.0, 158.0, 156.0, 130.0, 162.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 164.0, 171.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 77.0, 76.0, 74.0, 74.0, 133.0, 73.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 146.0, 96.0, 96.0, 97.0, 142.0, 96.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 102.0, 97.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 59.0, 57.0, 58.0, 58.0, 56.0, 62.0, 55.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 89.0, 89.0, 88.0, 88.0, 87.0, 94.0, 89.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [119.0, 123.0, 117.0, 141.0, 122.0, 125.0, 124.0, 127.0, 129.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [145.0, 150.0, 155.0, 156.0, 161.0, 161.0, 157.0, 161.0, 158.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 73.0, 71.0, 72.0, 68.0, 71.0, 70.0, 68.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1532.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [189.75332068311195], "unit": "score", "name": "DeltaBlue", "value": 348.44186000000013}, {"lowerIsBetter": false, "replicates": [283.68794326241135], "unit": "score", "name": "Encrypt", "value": 938.2880249999996}, {"lowerIsBetter": false, "replicates": [5312.169312169312], "unit": "score", "name": "Decrypt", "value": 50.107777888446215}, {"lowerIsBetter": false, "replicates": [1117.31843575419], "unit": "score", "name": "RayTrace", "value": 662.290155}, {"lowerIsBetter": false, "replicates": [722.7436823104694], "unit": "score", "name": "Earley", "value": 922.1291258741261}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [41081.63265306123], "unit": "score", "name": "RegExp", "value": 22.174995032290095}, {"lowerIsBetter": false, "replicates": [568.5048322910744], "unit": "score", "name": "Splay", "value": 143.34266900000006}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20310.139687615203}]} 10:17:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20310.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1532.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6772.91"}}} 10:17:49 INFO - Return code: 0 10:17:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:17:49 INFO - # TBPL SUCCESS # 10:17:49 INFO - Running post-action listener: _resource_record_post_action 10:17:49 INFO - Running post-run listener: _resource_record_post_run 10:17:50 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 561274880; Read time: 0; Write time: 374696 10:17:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 177143808; Read time: 0; Write time: 130232 10:17:50 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 321937408; Read time: 0; Write time: 206772 10:17:50 INFO - Running post-run listener: _upload_blobber_files 10:17:50 INFO - Blob upload gear active. 10:17:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:17:50 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 10:17:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:17:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:17:51 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:17:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:52 INFO - (blobuploader) - INFO - Done attempting. 10:17:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:17:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:17:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:53 INFO - (blobuploader) - INFO - Done attempting. 10:17:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:53 INFO - Return code: 0 10:17:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:17:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3a952c2467445fef892bd6b4ad86aebf8a4c7237960e6e90ee326b8c552c5506680a9adda83a06af4344068f786bef01b8b124680a8669b753421ff4e5fe46d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5dc52220641449e767f9bd223153c1cd915b5339041e61cbee4ac486e8db595b30a92f1f12249d377ed18f94d3b3073892776f9706887c10c37a005b27e922f"} 10:17:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:17:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:17:53 INFO - Contents: 10:17:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3a952c2467445fef892bd6b4ad86aebf8a4c7237960e6e90ee326b8c552c5506680a9adda83a06af4344068f786bef01b8b124680a8669b753421ff4e5fe46d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5dc52220641449e767f9bd223153c1cd915b5339041e61cbee4ac486e8db595b30a92f1f12249d377ed18f94d3b3073892776f9706887c10c37a005b27e922f"} 10:17:53 INFO - Copying logs to upload dir... 10:17:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.713047 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-08 10:17:52.902797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:52.906354) ========= 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=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 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/Firefox/sha512/b3a952c2467445fef892bd6b4ad86aebf8a4c7237960e6e90ee326b8c552c5506680a9adda83a06af4344068f786bef01b8b124680a8669b753421ff4e5fe46d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5dc52220641449e767f9bd223153c1cd915b5339041e61cbee4ac486e8db595b30a92f1f12249d377ed18f94d3b3073892776f9706887c10c37a005b27e922f"} build_url:https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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/Firefox/sha512/b3a952c2467445fef892bd6b4ad86aebf8a4c7237960e6e90ee326b8c552c5506680a9adda83a06af4344068f786bef01b8b124680a8669b753421ff4e5fe46d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5dc52220641449e767f9bd223153c1cd915b5339041e61cbee4ac486e8db595b30a92f1f12249d377ed18f94d3b3073892776f9706887c10c37a005b27e922f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:52.933508) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:52.933828) ========= 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=574dc5aafe09851ec43d388c000001b6-1452272532.729121-1764817012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:52.982543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 10:17:52.982843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 10:17:52.986148) ========= ========= Total master_lag: 0.43 =========