builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1452697249.71 results: success (0) buildid: 20160113043018 builduid: 08ee6dc53ff34769a794fc8f70502209 revision: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.712561) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.713056) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.713359) ========= 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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004581 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.735370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.735698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.784847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.785246) ========= 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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.834128) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.837534) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.838138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.838439) ========= 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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 07:00:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-13 07:00:51 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.013955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.014263) ========= 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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020784 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.066752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.067103) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 --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 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 --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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 07:00:51,545 truncating revision to first 12 chars 2016-01-13 07:00:51,545 Setting DEBUG logging. 2016-01-13 07:00:51,545 attempt 1/10 2016-01-13 07:00:51,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/531d1f6d1cde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 07:00:51,813 unpacking tar archive at: mozilla-central-531d1f6d1cde/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.626278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.629731) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.641116) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.641492) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.641921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-01-13 07:00:50.642213) ========= /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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:52 INFO - MultiFileLogger online at 20160113 07:00:52 in /builds/slave/test-pgo 07:00:52 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 07:00:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:00:52 INFO - {'append_to_log': False, 07:00:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:00:52 INFO - 'blob_upload_branch': 'Firefox', 07:00:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:00:52 INFO - 'branch': 'Firefox', 07:00:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:52 INFO - 'config_files': ('talos/linux_config.py',), 07:00:52 INFO - 'default_actions': ('clobber', 07:00:52 INFO - 'read-buildbot-config', 07:00:52 INFO - 'download-and-extract', 07:00:52 INFO - 'populate-webroot', 07:00:52 INFO - 'create-virtualenv', 07:00:52 INFO - 'install', 07:00:52 INFO - 'run-tests'), 07:00:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:52 INFO - 'download_minidump_stackwalk': True, 07:00:52 INFO - 'download_symbols': 'ondemand', 07:00:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:52 INFO - 'installer_path': 'installer.exe', 07:00:52 INFO - 'log_level': 'info', 07:00:52 INFO - 'log_name': 'talos', 07:00:52 INFO - 'log_to_console': True, 07:00:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:52 INFO - 'opt_config_files': (), 07:00:52 INFO - 'pip_index': False, 07:00:52 INFO - 'sps_profile': False, 07:00:52 INFO - 'sps_profile_interval': 0, 07:00:52 INFO - 'suite': 'dromaeojs-e10s', 07:00:52 INFO - 'system_bits': '32', 07:00:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:52 INFO - 'title': 'talos-linux64-ix-063', 07:00:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:52 INFO - 'use_talos_json': True, 07:00:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:00:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:52 INFO - 'work_dir': 'build'} 07:00:52 INFO - ##### 07:00:52 INFO - ##### Running clobber step. 07:00:52 INFO - ##### 07:00:52 INFO - Running pre-action listener: _resource_record_pre_action 07:00:52 INFO - Running main action method: clobber 07:00:52 INFO - rmtree: /builds/slave/test-pgo/build 07:00:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:00:52 INFO - Running post-action listener: _resource_record_post_action 07:00:52 INFO - ##### 07:00:52 INFO - ##### Running read-buildbot-config step. 07:00:52 INFO - ##### 07:00:52 INFO - Running pre-action listener: _resource_record_pre_action 07:00:52 INFO - Running main action method: read_buildbot_config 07:00:52 INFO - Using buildbot properties: 07:00:52 INFO - { 07:00:52 INFO - "project": "", 07:00:52 INFO - "product": "firefox", 07:00:52 INFO - "script_repo_revision": "production", 07:00:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:00:52 INFO - "repository": "", 07:00:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:00:52 INFO - "buildid": "20160113043018", 07:00:52 INFO - "pgo_build": "True", 07:00:52 INFO - "basedir": "/builds/slave/test-pgo", 07:00:52 INFO - "buildnumber": 70, 07:00:52 INFO - "slavename": "talos-linux64-ix-063", 07:00:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:00:52 INFO - "platform": "ubuntu64_hw", 07:00:52 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:00:52 INFO - "branch": "mozilla-central", 07:00:52 INFO - "repo_path": "mozilla-central", 07:00:52 INFO - "revision": "531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601", 07:00:52 INFO - "stage_platform": "linux64-pgo", 07:00:52 INFO - "builduid": "08ee6dc53ff34769a794fc8f70502209", 07:00:52 INFO - "slavebuilddir": "test" 07:00:52 INFO - } 07:00:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:00:52 INFO - Running post-action listener: _resource_record_post_action 07:00:52 INFO - ##### 07:00:52 INFO - ##### Running download-and-extract step. 07:00:52 INFO - ##### 07:00:52 INFO - Running pre-action listener: _resource_record_pre_action 07:00:52 INFO - Running main action method: download_and_extract 07:00:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:00:52 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')]} 07:00:52 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json 07:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json 07:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:00:53 INFO - Downloaded 1448 bytes. 07:00:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:00:53 INFO - Using the following test package requirements: 07:00:53 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:53 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:53 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:00:53 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'jsshell-linux-x86_64.zip'], 07:00:53 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:53 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:53 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:00:53 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:00:53 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:53 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:53 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:53 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:01:08 INFO - Downloaded 24029033 bytes. 07:01:08 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 07:01:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:08 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 07:01:09 INFO - Return code: 0 07:01:09 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 07:01:09 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')]} 07:01:09 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:01:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:01:27 INFO - Downloaded 24029033 bytes. 07:01:27 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 07:01:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:27 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 07:01:28 INFO - Return code: 0 07:01:28 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')]} 07:01:28 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:01:31 INFO - Downloaded 11132279 bytes. 07:01:31 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 07:01:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:31 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 07:01:31 INFO - Return code: 0 07:01: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')]} 07:01:31 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:01:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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 07:01:35 INFO - Downloaded 55876391 bytes. 07:01:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:35 INFO - mkdir: /builds/slave/test-pgo/properties 07:01:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:01:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:01:35 INFO - Contents: 07:01:35 INFO - build_url:https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:01:35 INFO - Running post-action listener: _resource_record_post_action 07:01:35 INFO - Running post-action listener: set_extra_try_arguments 07:01:35 INFO - ##### 07:01:35 INFO - ##### Running populate-webroot step. 07:01:35 INFO - ##### 07:01:35 INFO - Running pre-action listener: _resource_record_pre_action 07:01:35 INFO - Running main action method: populate_webroot 07:01:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:01:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:01:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:01:35 INFO - '--tppagecycles', 07:01:35 INFO - '7'], 07:01:35 INFO - 'tests': ['tsvgm']}}, 07:01:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:01:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:01:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:01:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:01:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'tests': ['damp', 'tps']}, 07:01:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['damp', 'tps']}, 07:01:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:01:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:01:35 INFO - 'other': {'tests': ['a11yr', 07:01:35 INFO - 'ts_paint', 07:01:35 INFO - 'tpaint', 07:01:35 INFO - 'sessionrestore', 07:01:35 INFO - 'sessionrestore_no_auto_restore']}, 07:01:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['a11yr', 07:01:35 INFO - 'ts_paint', 07:01:35 INFO - 'tpaint', 07:01:35 INFO - 'sessionrestore', 07:01:35 INFO - 'sessionrestore_no_auto_restore']}, 07:01:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['a11yr', 07:01:35 INFO - 'ts_paint', 07:01:35 INFO - 'tpaint', 07:01:35 INFO - 'sessionrestore', 07:01:35 INFO - 'sessionrestore_no_auto_restore']}, 07:01:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['a11yr', 07:01:35 INFO - 'ts_paint', 07:01:35 INFO - 'tpaint', 07:01:35 INFO - 'sessionrestore', 07:01:35 INFO - 'sessionrestore_no_auto_restore']}, 07:01:35 INFO - 'other_l64': {'tests': ['a11yr', 07:01:35 INFO - 'ts_paint', 07:01:35 INFO - 'tpaint', 07:01:35 INFO - 'sessionrestore', 07:01:35 INFO - 'sessionrestore_no_auto_restore']}, 07:01:35 INFO - 'other_nol64': {'tests': ['a11yr', 07:01:35 INFO - 'ts_paint', 07:01:35 INFO - 'tpaint', 07:01:35 INFO - 'sessionrestore', 07:01:35 INFO - 'sessionrestore_no_auto_restore']}, 07:01:35 INFO - 'svgr': {'tests': ['tsvgx', 07:01:35 INFO - 'tsvgr_opacity', 07:01:35 INFO - 'tart', 07:01:35 INFO - 'tscrollx', 07:01:35 INFO - 'cart']}, 07:01:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['tsvgx', 07:01:35 INFO - 'tsvgr_opacity', 07:01:35 INFO - 'tart', 07:01:35 INFO - 'tscrollx', 07:01:35 INFO - 'cart']}, 07:01:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'tests': ['tp5o']}, 07:01:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'talos_options': ['--e10s'], 07:01:35 INFO - 'tests': ['tp5o']}, 07:01:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'talos_options': ['--xperf_path', 07:01:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:35 INFO - 'tests': ['tp5n']}, 07:01:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:35 INFO - 'talos_options': ['--e10s', 07:01:35 INFO - '--xperf_path', 07:01:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:35 INFO - 'tests': ['tp5n']}}, 07:01:35 INFO - 'talos.zip': {'path': '', 07:01:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:01:35 INFO - Running post-action listener: _resource_record_post_action 07:01:35 INFO - ##### 07:01:35 INFO - ##### Running create-virtualenv step. 07:01:35 INFO - ##### 07:01:35 INFO - Running pre-action listener: _resource_record_pre_action 07:01:35 INFO - Running main action method: create_virtualenv 07:01:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:01:35 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 07:01:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:01:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:01:35 INFO - Using real prefix '/usr' 07:01:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:01:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:01:37 INFO - Installing pip.................done. 07:01:37 INFO - Return code: 0 07:01:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:01:37 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')]} 07:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:37 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')]} 07:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:37 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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:37 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 07:01:37 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 07:01:37 INFO - Using env: {'DISPLAY': ':0', 07:01:37 INFO - 'HOME': '/home/cltbld', 07:01:37 INFO - 'LANG': 'en_US.UTF-8', 07:01:37 INFO - 'LANGUAGE': 'en_US:en', 07:01:37 INFO - 'LOGNAME': 'cltbld', 07:01:37 INFO - 'MAIL': '/var/mail/cltbld', 07:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:37 INFO - 'MOZ_NO_REMOTE': '1', 07:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:37 INFO - 'NO_EM_RESTART': '1', 07:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:37 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:37 INFO - 'SHELL': '/bin/bash', 07:01:37 INFO - 'SHLVL': '1', 07:01:37 INFO - 'TERM': 'linux', 07:01:37 INFO - 'TMOUT': '86400', 07:01:37 INFO - 'USER': 'cltbld', 07:01:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:37 INFO - '_': '/tools/buildbot/bin/python'} 07:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:38 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 07:01:38 INFO - Cleaning up... 07:01:38 INFO - Return code: 0 07:01:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:38 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 07:01:38 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 07:01:38 INFO - Using env: {'DISPLAY': ':0', 07:01:38 INFO - 'HOME': '/home/cltbld', 07:01:38 INFO - 'LANG': 'en_US.UTF-8', 07:01:38 INFO - 'LANGUAGE': 'en_US:en', 07:01:38 INFO - 'LOGNAME': 'cltbld', 07:01:38 INFO - 'MAIL': '/var/mail/cltbld', 07:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:38 INFO - 'MOZ_NO_REMOTE': '1', 07:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:38 INFO - 'NO_EM_RESTART': '1', 07:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:38 INFO - 'SHELL': '/bin/bash', 07:01:38 INFO - 'SHLVL': '1', 07:01:38 INFO - 'TERM': 'linux', 07:01:38 INFO - 'TMOUT': '86400', 07:01:38 INFO - 'USER': 'cltbld', 07:01:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:38 INFO - '_': '/tools/buildbot/bin/python'} 07:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:38 INFO - Downloading/unpacking psutil>=0.7.1 07:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:01:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:01:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:01:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:01:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:01:40 INFO - Installing collected packages: psutil 07:01:40 INFO - Running setup.py install for psutil 07:01:40 INFO - building 'psutil._psutil_linux' extension 07:01:40 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 07:01:40 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 07:01:40 INFO - building 'psutil._psutil_posix' extension 07:01:40 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 07:01:40 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 07:01:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:01:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:01:40 INFO - Successfully installed psutil 07:01:40 INFO - Cleaning up... 07:01:40 INFO - Return code: 0 07:01:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:40 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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:40 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 07:01:40 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 07:01:40 INFO - Using env: {'DISPLAY': ':0', 07:01:40 INFO - 'HOME': '/home/cltbld', 07:01:40 INFO - 'LANG': 'en_US.UTF-8', 07:01:40 INFO - 'LANGUAGE': 'en_US:en', 07:01:40 INFO - 'LOGNAME': 'cltbld', 07:01:40 INFO - 'MAIL': '/var/mail/cltbld', 07:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:40 INFO - 'MOZ_NO_REMOTE': '1', 07:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:40 INFO - 'NO_EM_RESTART': '1', 07:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:40 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:40 INFO - 'SHELL': '/bin/bash', 07:01:40 INFO - 'SHLVL': '1', 07:01:40 INFO - 'TERM': 'linux', 07:01:40 INFO - 'TMOUT': '86400', 07:01:40 INFO - 'USER': 'cltbld', 07:01:40 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:40 INFO - '_': '/tools/buildbot/bin/python'} 07:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:01:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:01:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:01:42 INFO - Installing collected packages: mozsystemmonitor 07:01:42 INFO - Running setup.py install for mozsystemmonitor 07:01:42 INFO - Successfully installed mozsystemmonitor 07:01:42 INFO - Cleaning up... 07:01:42 INFO - Return code: 0 07:01:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:01:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:01:42 INFO - Using env: {'DISPLAY': ':0', 07:01:42 INFO - 'HOME': '/home/cltbld', 07:01:42 INFO - 'LANG': 'en_US.UTF-8', 07:01:42 INFO - 'LANGUAGE': 'en_US:en', 07:01:42 INFO - 'LOGNAME': 'cltbld', 07:01:42 INFO - 'MAIL': '/var/mail/cltbld', 07:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:42 INFO - 'MOZ_NO_REMOTE': '1', 07:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:42 INFO - 'NO_EM_RESTART': '1', 07:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:42 INFO - 'SHELL': '/bin/bash', 07:01:42 INFO - 'SHLVL': '1', 07:01:42 INFO - 'TERM': 'linux', 07:01:42 INFO - 'TMOUT': '86400', 07:01:42 INFO - 'USER': 'cltbld', 07:01:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:42 INFO - '_': '/tools/buildbot/bin/python'} 07:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:01:43 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 07:01:43 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 07:01:43 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 07:01:43 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 07:01:43 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 07:01:43 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 07:01:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:01:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:01:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:01:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:01:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:45 INFO - Downloading docopt-0.6.1.tar.gz 07:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:01:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:01:45 INFO - Running setup.py install for blobuploader 07:01:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:01:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:01:45 INFO - Running setup.py install for requests 07:01:45 INFO - Running setup.py install for docopt 07:01:46 INFO - Successfully installed blobuploader requests docopt 07:01:46 INFO - Cleaning up... 07:01:46 INFO - Return code: 0 07:01:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:01:46 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')]} 07:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:46 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')]} 07:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:46 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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:46 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 07:01:46 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 07:01:46 INFO - Using env: {'DISPLAY': ':0', 07:01:46 INFO - 'HOME': '/home/cltbld', 07:01:46 INFO - 'LANG': 'en_US.UTF-8', 07:01:46 INFO - 'LANGUAGE': 'en_US:en', 07:01:46 INFO - 'LOGNAME': 'cltbld', 07:01:46 INFO - 'MAIL': '/var/mail/cltbld', 07:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:46 INFO - 'MOZ_NO_REMOTE': '1', 07:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:46 INFO - 'NO_EM_RESTART': '1', 07:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:46 INFO - 'SHELL': '/bin/bash', 07:01:46 INFO - 'SHLVL': '1', 07:01:46 INFO - 'TERM': 'linux', 07:01:46 INFO - 'TMOUT': '86400', 07:01:46 INFO - 'USER': 'cltbld', 07:01:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:46 INFO - '_': '/tools/buildbot/bin/python'} 07:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:01:46 INFO - Running setup.py (path:/tmp/pip-vUV9kL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:01:46 INFO - Running setup.py (path:/tmp/pip-5XjFiP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:01:46 INFO - Running setup.py (path:/tmp/pip-okRx2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:01:46 INFO - Running setup.py (path:/tmp/pip-hCMda1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:01:46 INFO - Running setup.py (path:/tmp/pip-u06CfV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:01:46 INFO - Running setup.py (path:/tmp/pip-fcc6Yq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:01:46 INFO - Running setup.py (path:/tmp/pip-oF6MDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:01:46 INFO - Running setup.py (path:/tmp/pip-Gu41JU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:01:46 INFO - Running setup.py (path:/tmp/pip-EPWjXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:01:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:01:46 INFO - Running setup.py (path:/tmp/pip-Km1zus-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:01:47 INFO - Running setup.py (path:/tmp/pip-ibpU6_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:01:47 INFO - Running setup.py (path:/tmp/pip-HOsT_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:01:47 INFO - Running setup.py (path:/tmp/pip-VTIHJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:01:47 INFO - Running setup.py (path:/tmp/pip-4mSDXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:01:47 INFO - Running setup.py (path:/tmp/pip-CL594N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:01:47 INFO - Running setup.py (path:/tmp/pip-P6_pvs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:01:47 INFO - Running setup.py (path:/tmp/pip-_6aFJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:01:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:01:47 INFO - Running setup.py install for manifestparser 07:01:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:01:47 INFO - Running setup.py install for mozcrash 07:01:47 INFO - Running setup.py install for mozdebug 07:01:47 INFO - Running setup.py install for mozdevice 07:01:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:01:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Running setup.py install for mozfile 07:01:48 INFO - Running setup.py install for mozhttpd 07:01:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Running setup.py install for mozinfo 07:01:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Running setup.py install for mozInstall 07:01:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Running setup.py install for mozleak 07:01:48 INFO - Running setup.py install for mozlog 07:01:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Running setup.py install for moznetwork 07:01:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Running setup.py install for mozprocess 07:01:48 INFO - Running setup.py install for mozprofile 07:01:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:01:48 INFO - Running setup.py install for mozrunner 07:01:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:01:49 INFO - Running setup.py install for mozscreenshot 07:01:49 INFO - Running setup.py install for moztest 07:01:49 INFO - Running setup.py install for mozversion 07:01:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:01:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:01:49 INFO - Cleaning up... 07:01:49 INFO - Return code: 0 07:01:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:49 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 07:01:49 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 07:01:49 INFO - Using env: {'DISPLAY': ':0', 07:01:49 INFO - 'HOME': '/home/cltbld', 07:01:49 INFO - 'LANG': 'en_US.UTF-8', 07:01:49 INFO - 'LANGUAGE': 'en_US:en', 07:01:49 INFO - 'LOGNAME': 'cltbld', 07:01:49 INFO - 'MAIL': '/var/mail/cltbld', 07:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:49 INFO - 'MOZ_NO_REMOTE': '1', 07:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:49 INFO - 'NO_EM_RESTART': '1', 07:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:49 INFO - 'SHELL': '/bin/bash', 07:01:49 INFO - 'SHLVL': '1', 07:01:49 INFO - 'TERM': 'linux', 07:01:49 INFO - 'TMOUT': '86400', 07:01:49 INFO - 'USER': 'cltbld', 07:01:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:49 INFO - '_': '/tools/buildbot/bin/python'} 07:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:01:49 INFO - Running setup.py (path:/tmp/pip-NvrnFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:01:49 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)) 07:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:01:49 INFO - Running setup.py (path:/tmp/pip-y5fksb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:01:49 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)) 07:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:01:49 INFO - Running setup.py (path:/tmp/pip-XEPKY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:01:49 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)) 07:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:01:49 INFO - Running setup.py (path:/tmp/pip-o9h4MI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:01:49 INFO - Running setup.py (path:/tmp/pip-BPS867-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:01:49 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)) 07:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:01:49 INFO - Running setup.py (path:/tmp/pip-_VDEBP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:01:50 INFO - Running setup.py (path:/tmp/pip-FlLNZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:01:50 INFO - Running setup.py (path:/tmp/pip-meGXXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:01:50 INFO - Running setup.py (path:/tmp/pip-5mulv_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:01:50 INFO - Running setup.py (path:/tmp/pip-a6SBKp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:01:50 INFO - Running setup.py (path:/tmp/pip-U4gWKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:01:50 INFO - Running setup.py (path:/tmp/pip-AnYVjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:01:50 INFO - Running setup.py (path:/tmp/pip-yIVFjk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:01:50 INFO - Running setup.py (path:/tmp/pip-blEZEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:01:50 INFO - Running setup.py (path:/tmp/pip-bBHn11-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:01:50 INFO - Running setup.py (path:/tmp/pip-Vq44a9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:01:50 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)) 07:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:01:50 INFO - Running setup.py (path:/tmp/pip-bpg8Yp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:01:50 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)) 07:01:50 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)) 07:01:50 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)) 07:01:50 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)) 07:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:50 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 07:01:52 INFO - Downloading blessings-1.5.1.tar.gz 07:01:52 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 07:01:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:01:52 INFO - Installing collected packages: blessings 07:01:52 INFO - Running setup.py install for blessings 07:01:52 INFO - Successfully installed blessings 07:01:52 INFO - Cleaning up... 07:01:52 INFO - Return code: 0 07:01:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:01:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:01:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:01:52 INFO - Reading from file tmpfile_stdout 07:01:52 INFO - Current package versions: 07:01:52 INFO - argparse == 1.2.1 07:01:52 INFO - blessings == 1.5.1 07:01:52 INFO - blobuploader == 1.2.4 07:01:52 INFO - docopt == 0.6.1 07:01:52 INFO - manifestparser == 1.1 07:01:52 INFO - mozInstall == 1.12 07:01:52 INFO - mozcrash == 0.16 07:01:52 INFO - mozdebug == 0.1 07:01:52 INFO - mozdevice == 0.48 07:01:52 INFO - mozfile == 1.2 07:01:52 INFO - mozhttpd == 0.7 07:01:52 INFO - mozinfo == 0.9 07:01:52 INFO - mozleak == 0.1 07:01:52 INFO - mozlog == 3.1 07:01:52 INFO - moznetwork == 0.27 07:01:52 INFO - mozprocess == 0.22 07:01:52 INFO - mozprofile == 0.28 07:01:52 INFO - mozrunner == 6.11 07:01:52 INFO - mozscreenshot == 0.1 07:01:52 INFO - mozsystemmonitor == 0.0 07:01:52 INFO - moztest == 0.7 07:01:52 INFO - mozversion == 1.4 07:01:52 INFO - psutil == 3.1.1 07:01:52 INFO - requests == 1.2.3 07:01:52 INFO - wsgiref == 0.1.2 07:01:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:01:52 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')]} 07:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:52 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')]} 07:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:52 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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:52 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 07:01:52 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 07:01:52 INFO - Using env: {'DISPLAY': ':0', 07:01:52 INFO - 'HOME': '/home/cltbld', 07:01:52 INFO - 'LANG': 'en_US.UTF-8', 07:01:52 INFO - 'LANGUAGE': 'en_US:en', 07:01:52 INFO - 'LOGNAME': 'cltbld', 07:01:52 INFO - 'MAIL': '/var/mail/cltbld', 07:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:52 INFO - 'MOZ_NO_REMOTE': '1', 07:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:52 INFO - 'NO_EM_RESTART': '1', 07:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:52 INFO - 'SHELL': '/bin/bash', 07:01:52 INFO - 'SHLVL': '1', 07:01:52 INFO - 'TERM': 'linux', 07:01:52 INFO - 'TMOUT': '86400', 07:01:52 INFO - 'USER': 'cltbld', 07:01:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:52 INFO - '_': '/tools/buildbot/bin/python'} 07:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 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)) 07:01:53 INFO - Cleaning up... 07:01:53 INFO - Return code: 0 07:01:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:01:53 INFO - Using env: {'DISPLAY': ':0', 07:01:53 INFO - 'HOME': '/home/cltbld', 07:01:53 INFO - 'LANG': 'en_US.UTF-8', 07:01:53 INFO - 'LANGUAGE': 'en_US:en', 07:01:53 INFO - 'LOGNAME': 'cltbld', 07:01:53 INFO - 'MAIL': '/var/mail/cltbld', 07:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:53 INFO - 'MOZ_NO_REMOTE': '1', 07:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:53 INFO - 'NO_EM_RESTART': '1', 07:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:53 INFO - 'SHELL': '/bin/bash', 07:01:53 INFO - 'SHLVL': '1', 07:01:53 INFO - 'TERM': 'linux', 07:01:53 INFO - 'TMOUT': '86400', 07:01:53 INFO - 'USER': 'cltbld', 07:01:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:53 INFO - '_': '/tools/buildbot/bin/python'} 07:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:53 INFO - Downloading/unpacking jsonschema 07:01:53 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 07:01:53 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 07:01:53 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 07:01:53 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 07:01:53 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 07:01:53 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 07:01:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:01:55 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 07:01:55 INFO - Downloading/unpacking functools32 (from jsonschema) 07:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:01:55 INFO - warning: no files found matching '*.txt' 07:01:55 INFO - no previously-included directories found matching 'build' 07:01:55 INFO - no previously-included directories found matching 'dist' 07:01:55 INFO - no previously-included directories found matching '.git*' 07:01:55 INFO - Installing collected packages: jsonschema, functools32 07:01:55 INFO - Running setup.py install for functools32 07:01:55 INFO - warning: no files found matching '*.txt' 07:01:55 INFO - no previously-included directories found matching 'build' 07:01:55 INFO - no previously-included directories found matching 'dist' 07:01:55 INFO - no previously-included directories found matching '.git*' 07:01:55 INFO - Successfully installed jsonschema functools32 07:01:55 INFO - Cleaning up... 07:01:55 INFO - Return code: 0 07:01:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:55 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 0x7fa7322fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeff360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, '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': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', '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 07:01:55 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 07:01:55 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 07:01:55 INFO - Using env: {'DISPLAY': ':0', 07:01:55 INFO - 'HOME': '/home/cltbld', 07:01:55 INFO - 'LANG': 'en_US.UTF-8', 07:01:55 INFO - 'LANGUAGE': 'en_US:en', 07:01:55 INFO - 'LOGNAME': 'cltbld', 07:01:55 INFO - 'MAIL': '/var/mail/cltbld', 07:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:55 INFO - 'MOZ_NO_REMOTE': '1', 07:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:55 INFO - 'NO_EM_RESTART': '1', 07:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:55 INFO - 'SHELL': '/bin/bash', 07:01:55 INFO - 'SHLVL': '1', 07:01:55 INFO - 'TERM': 'linux', 07:01:55 INFO - 'TMOUT': '86400', 07:01:55 INFO - 'USER': 'cltbld', 07:01:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:55 INFO - '_': '/tools/buildbot/bin/python'} 07:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:55 INFO - Downloading/unpacking flake8 07:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:01:57 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 07:01:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:01:57 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 07:01:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:57 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 07:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:01:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:58 INFO - no previously-included directories found matching 'docs/_build' 07:01:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:01:58 INFO - Running setup.py install for pep8 07:01:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:58 INFO - no previously-included directories found matching 'docs/_build' 07:01:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:01:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:01:58 INFO - Cleaning up... 07:01:58 INFO - Return code: 0 07:01:58 INFO - Running post-action listener: _resource_record_post_action 07:01:58 INFO - Running post-action listener: _start_resource_monitoring 07:01:58 INFO - Starting resource monitoring. 07:01:58 INFO - ##### 07:01:58 INFO - ##### Running install step. 07:01:58 INFO - ##### 07:01:58 INFO - Running pre-action listener: _resource_record_pre_action 07:01:58 INFO - Running main action method: install 07:01:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:01:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:01:58 INFO - Reading from file tmpfile_stdout 07:01:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:01:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:01:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:01:58 INFO - Reading from file tmpfile_stdout 07:01:58 INFO - Output received: 07:01:58 INFO - Usage: mozinstall [options] installer 07:01:58 INFO - Options: 07:01:58 INFO - -h, --help show this help message and exit 07:01:58 INFO - -d DEST, --destination=DEST 07:01:58 INFO - Directory to install application into. [default: 07:01:58 INFO - "/builds/slave/test-pgo"] 07:01:58 INFO - --app=APP Application being installed. [default: firefox] 07:01:58 INFO - mkdir: /builds/slave/test-pgo/build/application 07:01:58 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'] 07:01:58 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 07:02:14 INFO - Reading from file tmpfile_stdout 07:02:14 INFO - Output received: 07:02:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:02:14 INFO - Running post-action listener: _resource_record_post_action 07:02:14 INFO - ##### 07:02:14 INFO - ##### Running run-tests step. 07:02:14 INFO - ##### 07:02:14 INFO - Running pre-action listener: _resource_record_pre_action 07:02:14 INFO - Running main action method: run_tests 07:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:02:14 INFO - Python 2.7.3 07:02:14 INFO - Return code: 0 07:02:14 INFO - grabbing minidump binary from tooltool 07:02: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')]} 07:02:14 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 0xf8e540>, '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 0xf8f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:02:14 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 07:02:14 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 07:02:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:02:14 INFO - Return code: 0 07:02:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:02:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:02:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:02:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:02:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:02:15 INFO - Return code: 0 07:02:15 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/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:02:15 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/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 07:02:15 INFO - Using env: {'DISPLAY': ':0', 07:02:15 INFO - 'HOME': '/home/cltbld', 07:02:15 INFO - 'LANG': 'en_US.UTF-8', 07:02:15 INFO - 'LANGUAGE': 'en_US:en', 07:02:15 INFO - 'LOGNAME': 'cltbld', 07:02:15 INFO - 'MAIL': '/var/mail/cltbld', 07:02:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:02:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:15 INFO - 'MOZ_NO_REMOTE': '1', 07:02:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:15 INFO - 'NO_EM_RESTART': '1', 07:02:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:02:15 INFO - 'SHELL': '/bin/bash', 07:02:15 INFO - 'SHLVL': '1', 07:02:15 INFO - 'TERM': 'linux', 07:02:15 INFO - 'TMOUT': '86400', 07:02:15 INFO - 'USER': 'cltbld', 07:02:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255', 07:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:15 INFO - '_': '/tools/buildbot/bin/python'} 07:02:15 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/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:02:16 INFO - mozversion application_buildid: 20160113043018 07:02:16 INFO - mozversion application_changeset: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 07:02:16 INFO - mozversion application_display_name: Nightly 07:02:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:02:16 INFO - mozversion application_name: Firefox 07:02:16 INFO - mozversion application_remotingname: firefox 07:02:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:02:16 INFO - mozversion application_vendor: Mozilla 07:02:16 INFO - mozversion application_version: 46.0a1 07:02:16 INFO - mozversion platform_buildid: 20160113043018 07:02:16 INFO - mozversion platform_changeset: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 07:02:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:02:16 INFO - mozversion platform_version: 46.0a1 07:02:16 INFO - using testdate: 1452697336 07:02:16 INFO - actual date: 1452697336 07:02:16 INFO - starting webserver on 'localhost:49377' 07:02:16 INFO - SUITE-START | Running 3 tests 07:02:16 INFO - TEST-START | dromaeo_css 07:02:16 INFO - operating with platform_type : linux_ 07:02:16 INFO - Initialising browser for dromaeo_css test... 07:02:16 INFO - TEST-INFO | started process 13968 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpImAgWq/profile http://localhost:49377/getInfo.html) 07:02:19 INFO - PROCESS | 13968 | 07:02:19 INFO - PROCESS | 13968 | (process:14048): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:02:20 INFO - PROCESS | 13968 | __metrics Screen width/height:1600/1200 07:02:20 INFO - PROCESS | 13968 | colorDepth:24 07:02:20 INFO - PROCESS | 13968 | Browser inner width/height: 1024/697 07:02:20 INFO - PROCESS | 13968 | __metrics 07:02:20 INFO - PROCESS | 13968 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:02:21 INFO - TEST-INFO | 13968: exit 0 07:02:21 INFO - Browser initialized. 07:02:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:02:21 INFO - TEST-INFO | started process 14097 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpImAgWq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:22 INFO - PROCESS | 14097 | 07:02:22 INFO - PROCESS | 14097 | (process:14154): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:02:33 INFO - PROCESS | 14097 | RSS: Main: 151142400 07:02:33 INFO - PROCESS | 14097 | 07:03:23 INFO - PROCESS | 14097 | 1452697403099 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] 07:05:31 INFO - PROCESS | 14097 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49377/tests/dromaeo/cssquery-ext.html) 07:05:32 INFO - PROCESS | 14097 | RSS: Main: 157032448 07:05:32 INFO - PROCESS | 14097 | 07:08:35 INFO - PROCESS | 14097 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-ext.html (next: http://localhost:49377/tests/dromaeo/cssquery-jquery.html) 07:08:35 INFO - PROCESS | 14097 | RSS: Main: 151343104 07:08:35 INFO - PROCESS | 14097 | 07:11:37 INFO - PROCESS | 14097 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49377/tests/dromaeo/cssquery-mootools.html) 07:11:37 INFO - PROCESS | 14097 | RSS: Main: 152244224 07:11:37 INFO - PROCESS | 14097 | 07:14:39 INFO - PROCESS | 14097 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49377/tests/dromaeo/cssquery-prototype.html) 07:14:40 INFO - PROCESS | 14097 | RSS: Main: 150618112 07:14:40 INFO - PROCESS | 14097 | 07:17:42 INFO - PROCESS | 14097 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49377/tests/dromaeo/cssquery-yui.html) 07:17:43 INFO - PROCESS | 14097 | RSS: Main: 150126592 07:17:43 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | Cycle 1(1): loaded http://localhost:49377/tests/dromaeo/cssquery-yui.html (next: http://localhost:49377/tests/dromaeo/cssquery-dojo.html) 07:20:45 INFO - PROCESS | 14097 | RSS: Main: 153223168 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | __start_tp_report 07:20:45 INFO - PROCESS | 14097 | _x_x_mozilla_page_load 07:20:45 INFO - PROCESS | 14097 | _x_x_mozilla_page_load_details 07:20:45 INFO - PROCESS | 14097 | |i|pagename|runs| 07:20:45 INFO - PROCESS | 14097 | |0;dojo.html;3104.5964024676773;3119.9860045485193;3163.9683603163967;3164.14568066622;3240.4329242382582;5188.610854185932;5293.0207911536345;5305.4164041955355;5311.628186026975;5374.328208973879;5158;5209.453007434222;5260.368755749316;5274.5780337573;5379.058664733676;4907.779149938261;4916.2871383649435;4983.451820299782;5008.824691135811;5011.248312753098;4722.929156062662;4912.115819152551;4948.678335908173;4970.6520543561965;4992.87517812054;4860.586850117745;4876.731779752112;4884.609231261491;4885.5358740919555;4930.852074437773;4849.2726091086615;4857.82997595086;4866.902661946777;4870.172070747982;4902.19113846215;4689.390379250675;4748.3589715388325;4755.904881902377;4847.3698419205275;4887.706737595756;5012.448630650625;5198.610104242197;5216;5221.921671174935;5243.659162154486;5738.081906894877;5761.3950535194035;5763.884722305573;5767.942320576783;5773.595848290622;5624.578156638268;5699.800506982236;5769;5779.624324418899;5790.7683692652245;5264.315638966948;5265.0259701955265;5270;5274.815381461631;5390.676559406448;5829.591928565044;5833.854153646193;5856.238688970407;5880.558958078162;5904.9704751475965;5560.972195139079;5646.0683987141665;5653.80211692597;5661.46216109469;5663.575231857627;5564.165375193753;5631.71841407928;5691.146328050742;5747.741351639186;5754.05058165398;5741.598088133874;5741.770329186786;5747.3103227612955;5756.65460072397;5785.82642520725;5662.518685911661;5703.74333155009;5714.885702285931;5727.828165155052;5730.885382292331;4308.9569104309185;4372.912541749147;4404.273294906305;4440.489343725513;4479.977600111979;3939.2318497892634;3939.4878665773267;3946.1713040261293;3976.343903255988;3983.6215559521797;5306.442823503554;5321.973390133025;5325.094733895247;5325.547328477045;5331.813386531453;5538.224648549206;5616.550675945915;5657.349404818498;5669.4047125051275;5776.826695199151;5292.9735351323;5294.7617357219015;5297.311349524537;5298.867528311823;5304.946950530445;4828.879278018007;4865.683730557503;4873.147199240118;4877.926831097537;4913.434954980152;5777.566682498829;5872.148538461985;5933.792317268875;5989.550783691154;6051;5642.379338272704;5701.629394089371;5710.5717071219;5734.283214598176;5738.139279108167;5732.7706891723865;5896.970515147397;5906.911396328973;5910.349861515316;5911.793087241926;5552.083906155601;5576.888462230814;5590.357108932525;5611.775528978795;5668.149777533403;5557.610967232416;5621.775128994795;5628.74670639814;5712.714364281853;5734.3978882218435;5464.836054918359;5490.450954904637;5558.055130627884;5570.58220633446;5573.888522229614;5427.6472029317965;5499.5371430277555;5506.174073888788;5522.861928451821;5626.1842032905815;5487.176923461513;5492;5492.533134683436;5511.035568775528;5522.723863806874;5609.411011843861;5615.8876822464135;5654.971725141512;5659.85850353728;5704.743286552198;5379.246905433164;5399.163129714901;5553.444655534414;5580.051391263576;5595.35653399848 07:20:45 INFO - PROCESS | 14097 | |1;ext.html;528.6167528541805;529.8145649022841;563.6336381352121;566.1846940405818;575.3383608849823;34651.65348346516;36100.63899361005;36137.81931090348;36181;36188.45717314242;39048;39613.40579891304;39945;40030.7998460008;40068.39897401534;8426.494410335368;8586.914130858673;8588.184122508352;8601.827963440728;8651.783705407384;8308.70919517817;8324.708635197769;8360.916390836075;8522.360822938304;8536.78658033548;8538.957305213466;8582.656693732244;8608.870866937;8609.741707748746;8629.137086291383;8521.872171917395;8522.82954340916;8531.573421328909;8546.52994085322;8624.568771561397;8516.233538981522;8535.402521823475;8647.567621618893;8648.1784230498;8661.220490155916;38432.61567384318;39307.21385572272;39376;39404.60595394038;39456.60543394558;3148.8583013764437;3171.175494371457;3209.518572214163;3237.530558069067;3531.823408829574;29661.851690741623;29844.8507757462;29851.850740746373;30342.241443963856;31008.379832403225;3830.5977872323283;3895.2793733159456;3961.900952476211;3980.20395920817;4104.809605214484;251002;253604;254138;254181;254455;42038.15923681571;56254.71872640611;56731.43268567262;56741.71629141828;56774;40360.59639403627;40584.39123413151;40737.18525629471;40808.38787418191;40935;13485.932570337282;13756.037077404686;13778.379972901244;13827.446902124004;13861.4455421782;10703.62537311206;10721.195910306602;10770.623028193975;10777.892221077846;10797.190210734227;14293.428262869576;14473.927630361992;14510.564683059525;14557.92721036388;14595.41618335276;5781.566382521328;5927.792527261611;5984.820455386345;5989.670568118795;6049.637021778707;885.0618344554792;910.3354551177678;965.1458459263462;976.2824324121765;1060.411471633251;28207.858960705064;28225.858870705924;28365.574516382272;28533.429331413256;28607.713922860505;968.7917097823861;994;1008.9899101009042;1023.1661196125134;1103.2056919018294;13629.25039122838;13721.313934303245;13782.65543361404;13891.374888130058;13904.791428128587;358066;367998;368799;369972;370113;51055.48944510507;51382;51586.74206629018;51591.74204128955;51662.483375165764;1333.1601091312411;1334.252818421687;1338.2773302416585;1360.3266383140408;1382.0325771959467;25845;26326;27033;27044.45911081807;27047.1885843425;37848;38340.61659383371;38509;42134.57865421429;42164.78917605515;287516;287623;288159;288302;288529;32194.195145120622;41684.166316674105;41922.58077419309;41945.79027104845;42435.15129697327;37627;38050.2389952205;38235.23529529449;38392.61607384002;38692.6130738689;35204.647953520136;35593.28813423665;36250.09374765652;36382.27235455223;37941.62058379381;33121.171970700925;33263.83368083144;33486.832565837016;33494;33957.49063764095;32321;32499.512507311938;32576.83711581427;32633;32728.509072363457;30437.239069022566;30680.846595766878;30950.380992380477;32956.83521582377;33435.66564334326;25678.614820778075;27318.453630927666;27713.168604941882;27735.722642774123;27840.582391264554 07:20:45 INFO - PROCESS | 14097 | |2;jquery.html;358.80086551963666;361.9485394927734;362.7025838812175;364.27145708582833;365.81709145427277;16202.270897809598;16422.507324780247;17173.398931037416;17175.91412042941;18165.182566784493;10779.191560632964;10911.478541156805;15780.684386312267;16219.107949062796;16243.675126497463;4748.525147485249;5099.286099946011;5302.469753024705;5311.62818602698;5319.946800531984;4731;5230.320058392404;5298.761555729982;5447.754851031713;5448.863778405532;3777.5655799583124;3879.922401551967;5336.30628018357;5583.106702927533;5589.944100558983;5398.460153984609;5457.345118585756;5474.233607294982;5476.452354764551;5505.862353441156;4890.3642526471685;5061.291419201315;5110.897782044375;5111.1566591512355;5124.461931497213;17784.288628454848;18486.53783655406;18905.810941890544;18934.810651893582;20080.79919200804;1944.1640094759248;1978.2087165133917;1981.8810871347766;2059.109971577933;2172;9061;9177.265818734486;9496.620135194653;9583.472908990003;9612.375195612263;1710.3158736505372;1748.2482532511015;1843.2258451450289;1856.693645548483;1894.7915729269769;55779.442205577834;56401.435985640026;58008.70995645037;58254.12618810721;58482.707586462224;9810.460424676712;10046.146077583488;10142.391456512632;10185.388876667424;10214.897851021395;13111.803322950163;13120.475180992844;13169.407376668072;13224.933875330755;13309.800352994713;7202.92797072033;7237;7241.239669834592;7261.491695581364;7329.8900516492295;6840.726370945206;6843.213030501456;6902.792916212522;6913.446924246048;6915.827104322331;4260.68044896634;4298.849540266076;4311.267084595564;4333.826646934151;4352.2818734909015;1750.2386461889118;1785.8303461171167;1789.5078853315442;1801.92792288307;1812.2026308424252;395.3437294091794;402.2498041153287;823.9835203295901;1018.23123541727;1048.6015314180563;9787.16809071237;10258.948705256575;10338.666772541432;10687.198460115522;10789.352638841694;424.683610710023;430.39529461107196;449.7144313360974;458.6262196309997;460.3026414981306;5758.74085666146;5795.420457954171;5831.358550559435;5890.1164825276555;9212;487675;490675;495246;498975;520043.9346348016;45001.324980125326;45486.54513454889;55044.44955550393;69188.30811691919;72675.2732472679;1122.315387613555;1149.3563604381573;1151.9654410367534;1166.5800311887713;1186.7626474705094;14110.717785644434;14558.272086395426;14961.775573366625;15037.097774133586;15078.170700611572;22149.224777132724;30433.239169020067;30846.537301940938;31293.061208163792;31399;37082.8145859269;37624.62375376211;37868.62131378651;38389.80805095957;38808.80595597117;7246;7424.777256682308;7506.624668766649;7652.311291983749;7661.233876612294;10147.79704405893;11196.216264861381;11379.260348077349;11581.710457238636;11612.361320127475;8780.648774048967;9352.719418417459;9367.00255918127;9393.295502837178;9599.184069353903;2977.553366994968;6085.687438773238;6407.615543067431;9775.364601300893;9885.752856178366;8949.552522373986;9034.2320902724;9437.480938548446;9628;9778.706638800848;7397;7427.145878223857;7511.098668159856;7526.09686837583;7557.584332861746;8860.556972151238;9025.187733104052;9264.629414823601;9486.241100712065;9487.051294870458 07:20:45 INFO - PROCESS | 14097 | |3;mootools.html;1421.1757180835116;1457.6501639606495;1619.044763589482;1771.3268957796035;1783.964320713585;7641.3122818946285;7760.961195194023;7887;7939.206079392058;7979.401544884136;7832.56920869352;7897.842043159133;7957.363410927126;7964.5221286722835;7966.24320689535;2318.13070098713;2352;2353.2469609724894;2353.305774796431;2356.352003199117;2368.6802281692007;2369.3958040699686;2397.376682062659;2400.4238982644215;2404.5551572959057;2272.8863556822093;2310.0413328468667;2330.8601483910934;2336.380859072339;2345.847519911209;2324.1168356024773;2328.8253380996325;2347.3310106619615;2348.5068135691527;2349.1543044503965;2345.1909091363455;2398.688170537819;2399.808015358767;2402.6636270922086;2408.7832095111526;7793.688252469894;7826.804329891741;7834.294913457816;7838.843223135563;7843.568603726792;4855.6601037927;4923.704577725348;4940.703557786508;4942.110420124376;4997.450280469146;3113.3617608390227;3152.7320177784686;3206.951895721566;3229.289556297611;3237.9676203238137;972.6644307713827;982.8574856645746;1019.2152042926979;1026.9743256418574;1924.490010147312;10878.292910960841;10948.3978381189;10997.780044399227;11044.392558409285;11062.446877656084;4175.665946724254;4234.02617397994;4313.633341165973;4489.618382437464;4502.077074199847;8749.737507874774;8825.470471771714;8838.955805220932;8856.202941735146;8864.556772161366;4779.211430113992;4831.9275210871865;4836.274558816135;4838.830640927621;4862.17343051682;4417.271150260235;4442.444694413199;4461.643068554507;4477.776111194427;4493.685442019093;3477.94783078254;3499.825008749552;3543.8582456701442;3547.0777597824235;3565.536480257602;1079.3146352066337;1094.6497120921229;1107.5680484611007;1109.8945600167972;1130.66645339625;1275.1329096214663;1288.7229245712217;1317.9785666108842;1318.4462525739214;1334.0861509865772;7393.445491588152;7492;7520.736774212876;7528.887066694004;7543.9622801886735;1144.4849817582121;1146.8681101673249;1153.3022521374614;1165.3823473559028;1177.952881884715;5683.658980461103;5784.623999440023;5816.069428891442;5830.038043722739;5853.414658534198;9451.385659932082;9724.173445257233;9916.950415247878;9953;9977.950110249401;9601.279904007228;9654.662086826927;9736.123748862636;9782.461964592016;9786.657466988621;7132.750353737698;7400.740974065882;7454.701811927571;7459.142198647117;7514.812129696692;7035.6833942471685;7155.642217889189;7162.176349719641;7184.425245980414;7208.639568021473;8290.29532489721;8465.195806398382;8502.489850608983;8524.573771311534;8682.609282582425;8595.699150529701;8643.567821608769;8685;8686;8691.348148888732;6738.8652226956165;6806.217285012287;6873.20958089826;6882.311768823078;6908.032875397549;7392.778216653509;7488.513246638951;7495.625218738932;7526.397888169043;7547.0943486781935;6778.4577233822165;6970.7862490815005;7064.15230172362;7231.096112985877;7388.889166662397;6856.760013399507;6866.553674011173;6990.161180658353;7026.824329391806;7050.647467626701;7065.964670176616;7071.681774320271;7115.1106111736035;7168.068151140527;7170.569765814068;6350.142730731292;6519.250286217146;6528.281888992112;6533.281339052795;6547.279799222177;6555.508336874658;6575.671216439063;6593.835154121185;6616.900746488903;6634.203895532567 07:20:45 INFO - PROCESS | 14097 | |4;prototype.html;324.16204112369525;332.3966999895189;339.04558667351404;340.8909149072296;346.98785542506;6227.626342419452;6293.181886354779;6357.968210158949;6373.426391624753;6450.7742229022;6181.07283907413;6280.685965701719;6295.874082518359;6298.338674439186;6314.210723659543;4790.832320868771;4791.496892826247;4792.113459010076;4795.256735206049;4801.8079276828885;4818.927716084261;4820.614350851941;4821.662483626147;4821.831235906744;4827.51724827518;4688.695234809744;4768.5946694531;4777;4777.713337199762;4783.186858234091;4756.1914474539235;4756.66703330767;4766.928496072562;4780.211265141247;4781.832635857728;4158.272302347077;4187.937180942288;4189.539150693421;4193.119444916571;4193.643540299078;6024;6041;6047.15339852421;6048.516118710492;6049.4253045961;5472.26124473195;5545.805896793633;5582.134769110794;5582.609217354787;5586.078297080977;6559.6064236145985;6559.868802623921;6568.868622627569;6590.7477579259785;6598.5051121165625;4626.884327891796;4640.071985602893;4640.396748422717;4652.278896770972;4663.533646635343;6866.244713081557;6969.756058537927;7021.964890175567;7033.929660703378;7047.788566342967;4772.76136193189;4775.283707443911;4775.641826863;4776.116418462596;4791.736454495036;4825.638077144228;4846;4847.75761211938;4856.1987272099705;4857.6599638025;5582.91625625616;5588.804391846266;5598.992181407386;5599.888002239933;5613.578981576398;6625.17185351831;6715.597064176165;6742;6744.460443164535;6751.189857217166;1667.991660041692;1703.1994962367667;1707.9487615371559;1712.8715346348824;1721.440531827136;1107.1640911112058;1145.5074318043155;1146.2549342926998;1154.7113221694576;1155.6013175454455;6176.197094377792;6184.690765461709;6220.440160385587;6220.595661282002;6227.283862355796;6765.424938880152;6822.113125293779;6834.350736680008;6853.143357080365;6858;6024.427679370453;6198.566100372931;6200.286966998853;6201.7519299228425;6206.565540412218;3703.2593481303848;3715.052661571282;3718.0704823794053;3723.2181241938956;3727.683146932541;7148.785536433916;7151.070360853056;7155.105611798525;7156.248593897566;7188.17336006366;6872.140982377203;6945.479089068239;6956.234814170437;6957.782388082065;6991.475639327071;7299.744508942162;7319.74380896666;7329.780106596811;7381.114266287972;7384.040074790243;6982.6159561222585;7037.401820845285;7040.401565866959;7044.15470143586;7069.681864316221;6728.192616886005;6865.41643960249;6871.587704737732;6874.553154044971;6875.690593923186;7306.41548676094;7313.561186328838;7341.596212208166;7349.338559529454;7359.1169059713175;4684.039771846831;4762.976185119052;4763.0235801661265;4768.189407800613;4772.928406073842;6904;7007.649617519206;7026.332498412643;7030;7042.577445353295;6729.394354508117;6781.457483401415;6783.89824152648;6785.660716964231;6786.966065169642;6717.697703603252;6764.458843292623;6780.016897549926;6782.0505129280955;6791.385316653025;6487.837804054936;6641.1034510342415;6642.236142843635;6643.1031810704935;6645.534812563074;6763.830904227434;6809.65951702403;6816.522843400914;6818.624975626388;6830.897536536857;6578.440832529289;6603.405693487609;6611.008348747726;6621.635810030302;6623.768168114286 07:20:45 INFO - PROCESS | 14097 | |5;yui.html;666.3303380102996;716.4733920568382;721.1706537481892;723.2008630463338;813.8331642013386;12970.546030888921;13174.27541485219;13253.006024548162;13267.734645307088;13282.203067815914;12794;12811.295378754165;12914.354282285894;13210.867891321084;13311.733765324687;801.4790386248926;815.5188438821094;823.9093699693044;830.7756905635505;832.4089896173724;804.3725893802814;806.7257132574923;808.7856717969743;812.4150611559668;813.8697808350665;833.8207285433631;833.9874901876477;838.6100463284572;841.970531031414;843.9156084391542;823.189158678701;829.5769157729571;830.0495932157676;833.0960907415462;838.8741688746676;610.563447135296;612.1857928954524;619.1981384107592;620.011082323693;624.7500999600151;13085.28030958297;13138;13160.07879448439;13263.403146858414;13274.070815042951;12081.758364832742;12109.818352724717;12239.32683702405;12370;12595.370231488481;10514.947425262824;10570.15438764897;10614.681559553226;11098.223124381297;11143.498542565523;3621.981890090559;3637.5453068366455;3649.3978493548534;3775.2826962876966;3778.6977041836585;44276;44420.55579444196;44558.33162502533;44751.32873006907;44815.77592112051;9321.533923303808;9363.204127649225;9376.109269619375;9491.76270593227;9692.321537492307;16360.590985225464;16552.668946621;16573.6685266294;16574.751378729088;16625.251863666163;7409.592472414069;7446;7466.813329666802;7506.962465187748;7697.538147711043;4290.01029042993;4301.942395189341;4302.65578753699;4313.61177494027;4399.318105693623;3098.7056229658597;3103.239706271978;3106.394253120665;3110.3623757130185;3126.124685088179;564.3143580549652;572.6106247751569;575.4705670782889;578.9015867302569;581.8487193329764;507.4874376879378;514.1721827857147;519.828456609318;521.569704993382;554.2739011894431;7858.1356050834365;8007.319377852948;8117.391195660349;8236.605809624358;8260.586970651444;528.4187393866716;574.7327492715907;650.5608714117951;663.8506336074441;693.4244577001077;3417.2482053948092;3789.597848795908;3794.2032173243374;3951.703622228287;4001.1197536541913;53850;54095.45904540983;54193;54708.72645636746;54855.725721371135;48527.75736121297;48890.511094889305;48938.510614894105;49295.507044929094;49705;44473.11053778971;44490.77754611206;44661.10677786426;45474.54525454703;45725;7447.404207663482;7591.3547348475995;7777.844443110993;7829.491083079582;7873.685052597832;31678.36643267168;32257.51613725749;32936.01191964245;33252.66747332496;33444.66221351216;39807.60192398155;42305;42700.359494606986;43065.354019689104;43283.783581081894;9370.718878433658;9746.610135594497;9802.9019709802;10155.593776248867;10508.42203678805;11132.519378885321;11192.1605879561;11198.440077995905;11376.658700239006;11408.54365825391;9946.45294508809;10207.693769186937;10347.534360953925;10543.94728026355;10656.467176641292;10223.335483193569;10318.122959548222;10475.214358922958;10481.528331224961;10692.251542391958;9968.55141518619;10585.9470702646;10613.416262105658;10624.468776560987;10965.629296337958;8275.793105172419;8563.871541927001;8588.398812083095;8691;9240.075992400707;8428.536430496382;8862.689805856764;9050.547472626211;9444.150026497648;9465.242780577399 07:20:45 INFO - PROCESS | 14097 | __end_tp_report 07:20:45 INFO - PROCESS | 14097 | __start_cc_report 07:20:45 INFO - PROCESS | 14097 | _x_x_mozilla_cycle_collect,331 07:20:45 INFO - PROCESS | 14097 | __end_cc_report 07:20:45 INFO - PROCESS | 14097 | __startTimestamp1452698445901__endTimestamp 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | ------- Summary: start ------- 07:20:45 INFO - PROCESS | 14097 | Number of tests: 6 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | [#0] dojo.html Cycles:165 Average:5293.49 Median:5492.53 stddev:585.50 (10.7%) stddev-sans-first:561.56 07:20:45 INFO - PROCESS | 14097 | Values: 3104.6 3120.0 3164.0 3164.1 3240.4 5188.6 5293.0 5305.4 5311.6 5374.3 5158.0 5209.5 5260.4 5274.6 5379.1 4907.8 4916.3 4983.5 5008.8 5011.2 4722.9 4912.1 4948.7 4970.7 4992.9 4860.6 4876.7 4884.6 4885.5 4930.9 4849.3 4857.8 4866.9 4870.2 4902.2 4689.4 4748.4 4755.9 4847.4 4887.7 5012.4 5198.6 5216.0 5221.9 5243.7 5738.1 5761.4 5763.9 5767.9 5773.6 5624.6 5699.8 5769.0 5779.6 5790.8 5264.3 5265.0 5270.0 5274.8 5390.7 5829.6 5833.9 5856.2 5880.6 5905.0 5561.0 5646.1 5653.8 5661.5 5663.6 5564.2 5631.7 5691.1 5747.7 5754.1 5741.6 5741.8 5747.3 5756.7 5785.8 5662.5 5703.7 5714.9 5727.8 5730.9 4309.0 4372.9 4404.3 4440.5 4480.0 3939.2 3939.5 3946.2 3976.3 3983.6 5306.4 5322.0 5325.1 5325.5 5331.8 5538.2 5616.6 5657.3 5669.4 5776.8 5293.0 5294.8 5297.3 5298.9 5304.9 4828.9 4865.7 4873.1 4877.9 4913.4 5777.6 5872.1 5933.8 5989.6 6051.0 5642.4 5701.6 5710.6 5734.3 5738.1 5732.8 5897.0 5906.9 5910.3 5911.8 5552.1 5576.9 5590.4 5611.8 5668.1 5557.6 5621.8 5628.7 5712.7 5734.4 5464.8 5490.5 5558.1 5570.6 5573.9 5427.6 5499.5 5506.2 5522.9 5626.2 5487.2 5492.0 5492.5 5511.0 5522.7 5609.4 5615.9 5655.0 5659.9 5704.7 5379.2 5399.2 5553.4 5580.1 5595.4 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | [#1] ext.html Cycles:180 Average:45725.85 Median:368398.50 stddev:80455.66 (21.8%) stddev-sans-first:80609.79 07:20:45 INFO - PROCESS | 14097 | Values: 528.6 529.8 563.6 566.2 575.3 34651.7 36100.6 36137.8 36181.0 36188.5 39048.0 39613.4 39945.0 40030.8 40068.4 8426.5 8586.9 8588.2 8601.8 8651.8 8308.7 8324.7 8360.9 8522.4 8536.8 8539.0 8582.7 8608.9 8609.7 8629.1 8521.9 8522.8 8531.6 8546.5 8624.6 8516.2 8535.4 8647.6 8648.2 8661.2 38432.6 39307.2 39376.0 39404.6 39456.6 3148.9 3171.2 3209.5 3237.5 3531.8 29661.9 29844.9 29851.9 30342.2 31008.4 3830.6 3895.3 3961.9 3980.2 4104.8 251002.0 253604.0 254138.0 254181.0 254455.0 42038.2 56254.7 56731.4 56741.7 56774.0 40360.6 40584.4 40737.2 40808.4 40935.0 13485.9 13756.0 13778.4 13827.4 13861.4 10703.6 10721.2 10770.6 10777.9 10797.2 14293.4 14473.9 14510.6 14557.9 14595.4 5781.6 5927.8 5984.8 5989.7 6049.6 885.1 910.3 965.1 976.3 1060.4 28207.9 28225.9 28365.6 28533.4 28607.7 968.8 994.0 1009.0 1023.2 1103.2 13629.3 13721.3 13782.7 13891.4 13904.8 358066.0 367998.0 368799.0 369972.0 370113.0 51055.5 51382.0 51586.7 51591.7 51662.5 1333.2 1334.3 1338.3 1360.3 1382.0 25845.0 26326.0 27033.0 27044.5 27047.2 37848.0 38340.6 38509.0 42134.6 42164.8 287516.0 287623.0 288159.0 288302.0 288529.0 32194.2 41684.2 41922.6 41945.8 42435.2 37627.0 38050.2 38235.2 38392.6 38692.6 35204.6 35593.3 36250.1 36382.3 37941.6 33121.2 33263.8 33486.8 33494.0 33957.5 32321.0 32499.5 32576.8 32633.0 32728.5 30437.2 30680.8 30950.4 32956.8 33435.7 25678.6 27318.5 27713.2 27735.7 27840.6 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | [#2] jquery.html Cycles:180 Average:25230.31 Median:459.46 stddev:81394.84 (17715.2%) stddev-sans-first:81601.74 07:20:45 INFO - PROCESS | 14097 | Values: 358.8 361.9 362.7 364.3 365.8 16202.3 16422.5 17173.4 17175.9 18165.2 10779.2 10911.5 15780.7 16219.1 16243.7 4748.5 5099.3 5302.5 5311.6 5319.9 4731.0 5230.3 5298.8 5447.8 5448.9 3777.6 3879.9 5336.3 5583.1 5589.9 5398.5 5457.3 5474.2 5476.5 5505.9 4890.4 5061.3 5110.9 5111.2 5124.5 17784.3 18486.5 18905.8 18934.8 20080.8 1944.2 1978.2 1981.9 2059.1 2172.0 9061.0 9177.3 9496.6 9583.5 9612.4 1710.3 1748.2 1843.2 1856.7 1894.8 55779.4 56401.4 58008.7 58254.1 58482.7 9810.5 10046.1 10142.4 10185.4 10214.9 13111.8 13120.5 13169.4 13224.9 13309.8 7202.9 7237.0 7241.2 7261.5 7329.9 6840.7 6843.2 6902.8 6913.4 6915.8 4260.7 4298.8 4311.3 4333.8 4352.3 1750.2 1785.8 1789.5 1801.9 1812.2 395.3 402.2 824.0 1018.2 1048.6 9787.2 10258.9 10338.7 10687.2 10789.4 424.7 430.4 449.7 458.6 460.3 5758.7 5795.4 5831.4 5890.1 9212.0 487675.0 490675.0 495246.0 498975.0 520043.9 45001.3 45486.5 55044.4 69188.3 72675.3 1122.3 1149.4 1152.0 1166.6 1186.8 14110.7 14558.3 14961.8 15037.1 15078.2 22149.2 30433.2 30846.5 31293.1 31399.0 37082.8 37624.6 37868.6 38389.8 38808.8 7246.0 7424.8 7506.6 7652.3 7661.2 10147.8 11196.2 11379.3 11581.7 11612.4 8780.6 9352.7 9367.0 9393.3 9599.2 2977.6 6085.7 6407.6 9775.4 9885.8 8949.6 9034.2 9437.5 9628.0 9778.7 7397.0 7427.1 7511.1 7526.1 7557.6 8860.6 9025.2 9264.6 9486.2 9487.1 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | [#3] mootools.html Cycles:180 Average:5553.35 Median:6530.78 stddev:2847.86 (43.6%) stddev-sans-first:2838.91 07:20:45 INFO - PROCESS | 14097 | Values: 1421.2 1457.7 1619.0 1771.3 1784.0 7641.3 7761.0 7887.0 7939.2 7979.4 7832.6 7897.8 7957.4 7964.5 7966.2 2318.1 2352.0 2353.2 2353.3 2356.4 2368.7 2369.4 2397.4 2400.4 2404.6 2272.9 2310.0 2330.9 2336.4 2345.8 2324.1 2328.8 2347.3 2348.5 2349.2 2345.2 2398.7 2399.8 2402.7 2408.8 7793.7 7826.8 7834.3 7838.8 7843.6 4855.7 4923.7 4940.7 4942.1 4997.5 3113.4 3152.7 3207.0 3229.3 3238.0 972.7 982.9 1019.2 1027.0 1924.5 10878.3 10948.4 10997.8 11044.4 11062.4 4175.7 4234.0 4313.6 4489.6 4502.1 8749.7 8825.5 8839.0 8856.2 8864.6 4779.2 4831.9 4836.3 4838.8 4862.2 4417.3 4442.4 4461.6 4477.8 4493.7 3477.9 3499.8 3543.9 3547.1 3565.5 1079.3 1094.6 1107.6 1109.9 1130.7 1275.1 1288.7 1318.0 1318.4 1334.1 7393.4 7492.0 7520.7 7528.9 7544.0 1144.5 1146.9 1153.3 1165.4 1178.0 5683.7 5784.6 5816.1 5830.0 5853.4 9451.4 9724.2 9917.0 9953.0 9978.0 9601.3 9654.7 9736.1 9782.5 9786.7 7132.8 7400.7 7454.7 7459.1 7514.8 7035.7 7155.6 7162.2 7184.4 7208.6 8290.3 8465.2 8502.5 8524.6 8682.6 8595.7 8643.6 8685.0 8686.0 8691.3 6738.9 6806.2 6873.2 6882.3 6908.0 7392.8 7488.5 7495.6 7526.4 7547.1 6778.5 6970.8 7064.2 7231.1 7388.9 6856.8 6866.6 6990.2 7026.8 7050.6 7066.0 7071.7 7115.1 7168.1 7170.6 6350.1 6519.3 6528.3 6533.3 6547.3 6555.5 6575.7 6593.8 6616.9 6634.2 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | [#4] prototype.html Cycles:180 Average:5604.49 Median:6227.46 stddev:1700.28 (27.3%) stddev-sans-first:1658.21 07:20:45 INFO - PROCESS | 14097 | Values: 324.2 332.4 339.0 340.9 347.0 6227.6 6293.2 6358.0 6373.4 6450.8 6181.1 6280.7 6295.9 6298.3 6314.2 4790.8 4791.5 4792.1 4795.3 4801.8 4818.9 4820.6 4821.7 4821.8 4827.5 4688.7 4768.6 4777.0 4777.7 4783.2 4756.2 4756.7 4766.9 4780.2 4781.8 4158.3 4187.9 4189.5 4193.1 4193.6 6024.0 6041.0 6047.2 6048.5 6049.4 5472.3 5545.8 5582.1 5582.6 5586.1 6559.6 6559.9 6568.9 6590.7 6598.5 4626.9 4640.1 4640.4 4652.3 4663.5 6866.2 6969.8 7022.0 7033.9 7047.8 4772.8 4775.3 4775.6 4776.1 4791.7 4825.6 4846.0 4847.8 4856.2 4857.7 5582.9 5588.8 5599.0 5599.9 5613.6 6625.2 6715.6 6742.0 6744.5 6751.2 1668.0 1703.2 1707.9 1712.9 1721.4 1107.2 1145.5 1146.3 1154.7 1155.6 6176.2 6184.7 6220.4 6220.6 6227.3 6765.4 6822.1 6834.4 6853.1 6858.0 6024.4 6198.6 6200.3 6201.8 6206.6 3703.3 3715.1 3718.1 3723.2 3727.7 7148.8 7151.1 7155.1 7156.2 7188.2 6872.1 6945.5 6956.2 6957.8 6991.5 7299.7 7319.7 7329.8 7381.1 7384.0 6982.6 7037.4 7040.4 7044.2 7069.7 6728.2 6865.4 6871.6 6874.6 6875.7 7306.4 7313.6 7341.6 7349.3 7359.1 4684.0 4763.0 4763.0 4768.2 4772.9 6904.0 7007.6 7026.3 7030.0 7042.6 6729.4 6781.5 6783.9 6785.7 6787.0 6717.7 6764.5 6780.0 6782.1 6791.4 6487.8 6641.1 6642.2 6643.1 6645.5 6763.8 6809.7 6816.5 6818.6 6830.9 6578.4 6603.4 6611.0 6621.6 6623.8 07:20:45 INFO - PROCESS | 14097 | 07:20:45 INFO - PROCESS | 14097 | [#5] yui.html Cycles:180 Average:13087.19 Median:48709.13 stddev:15096.35 (31.0%) stddev-sans-first:15109.88 07:20:45 INFO - PROCESS | 14097 | Values: 666.3 716.5 721.2 723.2 813.8 12970.5 13174.3 13253.0 13267.7 13282.2 12794.0 12811.3 12914.4 13210.9 13311.7 801.5 815.5 823.9 830.8 832.4 804.4 806.7 808.8 812.4 813.9 833.8 834.0 838.6 842.0 843.9 823.2 829.6 830.0 833.1 838.9 610.6 612.2 619.2 620.0 624.8 13085.3 13138.0 13160.1 13263.4 13274.1 12081.8 12109.8 12239.3 12370.0 12595.4 10514.9 10570.2 10614.7 11098.2 11143.5 3622.0 3637.5 3649.4 3775.3 3778.7 44276.0 44420.6 44558.3 44751.3 44815.8 9321.5 9363.2 9376.1 9491.8 9692.3 16360.6 16552.7 16573.7 16574.8 16625.3 7409.6 7446.0 7466.8 7507.0 7697.5 4290.0 4301.9 4302.7 4313.6 4399.3 3098.7 3103.2 3106.4 3110.4 3126.1 564.3 572.6 575.5 578.9 581.8 507.5 514.2 519.8 521.6 554.3 7858.1 8007.3 8117.4 8236.6 8260.6 528.4 574.7 650.6 663.9 693.4 3417.2 3789.6 3794.2 3951.7 4001.1 53850.0 54095.5 54193.0 54708.7 54855.7 48527.8 48890.5 48938.5 49295.5 49705.0 44473.1 44490.8 44661.1 45474.5 45725.0 7447.4 7591.4 7777.8 7829.5 7873.7 31678.4 32257.5 32936.0 33252.7 33444.7 39807.6 42305.0 42700.4 43065.4 43283.8 9370.7 9746.6 9802.9 10155.6 10508.4 11132.5 11192.2 11198.4 11376.7 11408.5 9946.5 10207.7 10347.5 10543.9 10656.5 10223.3 10318.1 10475.2 10481.5 10692.3 9968.6 10585.9 10613.4 10624.5 10965.6 8275.8 8563.9 8588.4 8691.0 9240.1 8428.5 8862.7 9050.5 9444.2 9465.2 07:20:45 INFO - PROCESS | 14097 | -------- Summary: end -------- 07:20:45 INFO - PROCESS | 14097 | 07:20:46 INFO - TEST-INFO | 14097: exit 0 07:20:46 INFO - TEST-OK | dromaeo_css | took 1110534ms 07:20:46 INFO - TEST-START | kraken 07:20:46 INFO - operating with platform_type : linux_ 07:20:46 INFO - Initialising browser for kraken test... 07:20:46 INFO - TEST-INFO | started process 14331 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcXWeg0/profile http://localhost:49377/getInfo.html) 07:20:50 INFO - PROCESS | 14331 | 07:20:50 INFO - PROCESS | 14331 | (process:14405): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:20:50 INFO - PROCESS | 14331 | __metrics Screen width/height:1600/1200 07:20:50 INFO - PROCESS | 14331 | colorDepth:24 07:20:50 INFO - PROCESS | 14331 | Browser inner width/height: 1024/697 07:20:50 INFO - PROCESS | 14331 | __metrics 07:20:51 INFO - PROCESS | 14331 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:20:51 INFO - TEST-INFO | 14331: exit 0 07:20:51 INFO - Browser initialized. 07:20:51 INFO - Running cycle 1/1 for kraken test... 07:20:51 INFO - TEST-INFO | started process 14454 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcXWeg0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:53 INFO - PROCESS | 14454 | 07:20:53 INFO - PROCESS | 14454 | (process:14513): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:21:03 INFO - PROCESS | 14454 | RSS: Main: 150700032 07:21:03 INFO - PROCESS | 14454 | 07:21:06 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-beat-detection) 07:21:06 INFO - PROCESS | 14454 | RSS: Main: 151777280 07:21:06 INFO - PROCESS | 14454 | 07:21:09 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-dft) 07:21:10 INFO - PROCESS | 14454 | RSS: Main: 154357760 07:21:10 INFO - PROCESS | 14454 | 07:21:12 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-fft) 07:21:13 INFO - PROCESS | 14454 | RSS: Main: 145584128 07:21:13 INFO - PROCESS | 14454 | 07:21:15 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49377/tests/kraken/driver.html?testName=audio-oscillator) 07:21:16 INFO - PROCESS | 14454 | RSS: Main: 146997248 07:21:16 INFO - PROCESS | 14454 | 07:21:18 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:21:19 INFO - PROCESS | 14454 | RSS: Main: 147075072 07:21:19 INFO - PROCESS | 14454 | 07:21:22 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49377/tests/kraken/driver.html?testName=imaging-darkroom) 07:21:22 INFO - PROCESS | 14454 | RSS: Main: 148144128 07:21:22 INFO - PROCESS | 14454 | 07:21:26 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49377/tests/kraken/driver.html?testName=imaging-desaturate) 07:21:26 INFO - PROCESS | 14454 | RSS: Main: 148377600 07:21:26 INFO - PROCESS | 14454 | 07:21:29 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49377/tests/kraken/driver.html?testName=json-parse-financial) 07:21:30 INFO - PROCESS | 14454 | RSS: Main: 151044096 07:21:30 INFO - PROCESS | 14454 | 07:21:31 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:21:32 INFO - PROCESS | 14454 | RSS: Main: 150904832 07:21:32 INFO - PROCESS | 14454 | 07:21:34 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:21:34 INFO - PROCESS | 14454 | RSS: Main: 149708800 07:21:34 INFO - PROCESS | 14454 | 07:21:36 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:21:37 INFO - PROCESS | 14454 | RSS: Main: 150740992 07:21:37 INFO - PROCESS | 14454 | 07:21:39 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:21:40 INFO - PROCESS | 14454 | RSS: Main: 150638592 07:21:40 INFO - PROCESS | 14454 | 07:21:42 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:21:43 INFO - PROCESS | 14454 | RSS: Main: 151261184 07:21:43 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:49377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49377/tests/kraken/driver.html?testName=ai-astar) 07:21:45 INFO - PROCESS | 14454 | RSS: Main: 150204416 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | __start_tp_report 07:21:45 INFO - PROCESS | 14454 | _x_x_mozilla_page_load 07:21:45 INFO - PROCESS | 14454 | _x_x_mozilla_page_load_details 07:21:45 INFO - PROCESS | 14454 | |i|pagename|runs| 07:21:45 INFO - PROCESS | 14454 | |0;ai-astar;111;105;111;110;112;124;110;110;111;112 07:21:45 INFO - PROCESS | 14454 | |1;audio-beat-detection;157;126;154;161;126;150;152;127;166;126 07:21:45 INFO - PROCESS | 14454 | |2;audio-dft;163;163;163;162;163;161;164;167;170;165 07:21:45 INFO - PROCESS | 14454 | |3;audio-fft;72;75;74;72;75;73;148;73;74;74 07:21:45 INFO - PROCESS | 14454 | |4;audio-oscillator;97;97;141;95;97;96;143;97;100;145 07:21:45 INFO - PROCESS | 14454 | |5;imaging-gaussian-blur;110;110;110;111;109;111;111;110;110;109 07:21:45 INFO - PROCESS | 14454 | |6;imaging-darkroom;146;146;146;147;148;147;147;146;147;147 07:21:45 INFO - PROCESS | 14454 | |7;imaging-desaturate;97;96;96;96;96;97;96;96;97;97 07:21:45 INFO - PROCESS | 14454 | |8;json-parse-financial;59;61;59;60;60;59;59;65;58;58 07:21:45 INFO - PROCESS | 14454 | |9;json-stringify-tinderbox;67;68;67;67;67;68;67;67;67;68 07:21:45 INFO - PROCESS | 14454 | |10;stanford-crypto-aes;84;85;85;83;83;83;82;82;82;83 07:21:45 INFO - PROCESS | 14454 | |11;stanford-crypto-ccm;117;117;120;122;127;118;121;120;113;116 07:21:45 INFO - PROCESS | 14454 | |12;stanford-crypto-pbkdf2;147;147;162;146;146;133;146;142;142;143 07:21:45 INFO - PROCESS | 14454 | |13;stanford-crypto-sha256-iterative;68;70;68;66;68;68;68;71;66;67 07:21:45 INFO - PROCESS | 14454 | __end_tp_report 07:21:45 INFO - PROCESS | 14454 | __start_cc_report 07:21:45 INFO - PROCESS | 14454 | _x_x_mozilla_cycle_collect,740 07:21:45 INFO - PROCESS | 14454 | __end_cc_report 07:21:45 INFO - PROCESS | 14454 | __startTimestamp1452698505369__endTimestamp 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | ------- Summary: start ------- 07:21:45 INFO - PROCESS | 14454 | Number of tests: 14 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.79 (4.3%) stddev-sans-first:5.07 07:21:45 INFO - PROCESS | 14454 | Values: 111.0 105.0 111.0 110.0 112.0 124.0 110.0 110.0 111.0 112.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:153.00 stddev:16.33 (10.7%) stddev-sans-first:16.68 07:21:45 INFO - PROCESS | 14454 | Values: 157.0 126.0 154.0 161.0 126.0 150.0 152.0 127.0 166.0 126.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.64 (1.6%) stddev-sans-first:2.77 07:21:45 INFO - PROCESS | 14454 | Values: 163.0 163.0 163.0 162.0 163.0 161.0 164.0 167.0 170.0 165.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:23.57 (31.8%) stddev-sans-first:24.77 07:21:45 INFO - PROCESS | 14454 | Values: 72.0 75.0 74.0 72.0 75.0 73.0 148.0 73.0 74.0 74.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:96.50 stddev:22.28 (23.1%) stddev-sans-first:23.06 07:21:45 INFO - PROCESS | 14454 | Values: 97.0 97.0 141.0 95.0 97.0 96.0 143.0 97.0 100.0 145.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 07:21:45 INFO - PROCESS | 14454 | Values: 110.0 110.0 110.0 111.0 109.0 111.0 111.0 110.0 110.0 109.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 07:21:45 INFO - PROCESS | 14454 | Values: 146.0 146.0 146.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:21:45 INFO - PROCESS | 14454 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 97.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:59.50 stddev:2.04 (3.4%) stddev-sans-first:2.15 07:21:45 INFO - PROCESS | 14454 | Values: 59.0 61.0 59.0 60.0 60.0 59.0 59.0 65.0 58.0 58.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 07:21:45 INFO - PROCESS | 14454 | Values: 67.0 68.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.14 (1.4%) stddev-sans-first:1.17 07:21:45 INFO - PROCESS | 14454 | Values: 84.0 85.0 85.0 83.0 83.0 83.0 82.0 82.0 82.0 83.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:120.00 stddev:3.84 (3.2%) stddev-sans-first:4.00 07:21:45 INFO - PROCESS | 14454 | Values: 117.0 117.0 120.0 122.0 127.0 118.0 121.0 120.0 113.0 116.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:146.00 stddev:7.18 (4.9%) stddev-sans-first:7.60 07:21:45 INFO - PROCESS | 14454 | Values: 147.0 147.0 162.0 146.0 146.0 133.0 146.0 142.0 142.0 143.0 07:21:45 INFO - PROCESS | 14454 | 07:21:45 INFO - PROCESS | 14454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.66 07:21:45 INFO - PROCESS | 14454 | Values: 68.0 70.0 68.0 66.0 68.0 68.0 68.0 71.0 66.0 67.0 07:21:45 INFO - PROCESS | 14454 | -------- Summary: end -------- 07:21:45 INFO - PROCESS | 14454 | 07:21:46 INFO - TEST-INFO | 14454: exit 0 07:21:46 INFO - TEST-OK | kraken | took 59686ms 07:21:46 INFO - TEST-START | v8_7 07:21:46 INFO - operating with platform_type : linux_ 07:21:46 INFO - Initialising browser for v8_7 test... 07:21:46 INFO - TEST-INFO | started process 14742 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvZK7Jt/profile http://localhost:49377/getInfo.html) 07:21:49 INFO - PROCESS | 14742 | 07:21:49 INFO - PROCESS | 14742 | (process:14816): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:21:50 INFO - PROCESS | 14742 | __metrics Screen width/height:1600/1200 07:21:50 INFO - PROCESS | 14742 | colorDepth:24 07:21:50 INFO - PROCESS | 14742 | Browser inner width/height: 1024/697 07:21:50 INFO - PROCESS | 14742 | __metrics 07:21:50 INFO - PROCESS | 14742 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:21:51 INFO - TEST-INFO | 14742: exit 0 07:21:51 INFO - Browser initialized. 07:21:51 INFO - Running cycle 1/1 for v8_7 test... 07:21:51 INFO - TEST-INFO | started process 14865 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvZK7Jt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:52 INFO - PROCESS | 14865 | 07:21:52 INFO - PROCESS | 14865 | (process:14925): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:22:03 INFO - PROCESS | 14865 | RSS: Main: 150765568 07:22:03 INFO - PROCESS | 14865 | 07:22:25 INFO - PROCESS | 14865 | Cycle 1(1): loaded http://localhost:49377/tests/v8_7/run.html (next: http://localhost:49377/tests/v8_7/run.html) 07:22:26 INFO - PROCESS | 14865 | RSS: Main: 145584128 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | __start_tp_report 07:22:26 INFO - PROCESS | 14865 | _x_x_mozilla_page_load 07:22:26 INFO - PROCESS | 14865 | _x_x_mozilla_page_load_details 07:22:26 INFO - PROCESS | 14865 | |i|pagename|runs| 07:22:26 INFO - PROCESS | 14865 | |0;Richards;169.4053870913095 07:22:26 INFO - PROCESS | 14865 | |1;DeltaBlue;188.1821603312006 07:22:26 INFO - PROCESS | 14865 | |2;Encrypt;279.9552071668533 07:22:26 INFO - PROCESS | 14865 | |3;Decrypt;5235.602094240838 07:22:26 INFO - PROCESS | 14865 | |4;RayTrace;1066.0980810234541 07:22:26 INFO - PROCESS | 14865 | |5;Earley;709.4259390503189 07:22:26 INFO - PROCESS | 14865 | |6;Boyer;12407.407407407407 07:22:26 INFO - PROCESS | 14865 | |7;RegExp;41306.12244897959 07:22:26 INFO - PROCESS | 14865 | |8;Splay;587.8894767783656 07:22:26 INFO - PROCESS | 14865 | |9;NavierStokes;4840.579710144928 07:22:26 INFO - PROCESS | 14865 | __end_tp_report 07:22:26 INFO - PROCESS | 14865 | __startTimestamp1452698546094__endTimestamp 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | ------- Summary: start ------- 07:22:26 INFO - PROCESS | 14865 | Number of tests: 10 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#0] Richards Cycles:1 Average:169.41 Median:169.41 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 169.4 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#1] DeltaBlue Cycles:1 Average:188.18 Median:188.18 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 188.2 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 280.0 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 5235.6 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 1066.1 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#5] Earley Cycles:1 Average:709.43 Median:709.43 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 709.4 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 12407.4 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#7] RegExp Cycles:1 Average:41306.12 Median:41306.12 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 41306.1 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#8] Splay Cycles:1 Average:587.89 Median:587.89 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 587.9 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - PROCESS | 14865 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:22:26 INFO - PROCESS | 14865 | Values: 4840.6 07:22:26 INFO - PROCESS | 14865 | -------- Summary: end -------- 07:22:26 INFO - PROCESS | 14865 | 07:22:26 INFO - TEST-INFO | 14865: exit 0 07:22:26 INFO - TEST-OK | v8_7 | took 40706ms 07:22:26 INFO - SUITE-END | took 1210s 07:22:27 INFO - Completed test suite (00:20:11) 07:22:27 INFO - Working with test: dromaeo_css 07:22:27 INFO - Generating results file: dromaeo_css 07:22:27 INFO - Working with test: kraken 07:22:27 INFO - Generating results file: kraken 07:22:27 INFO - javascript benchmark 07:22:27 INFO - Working with test: v8_7 07:22:27 INFO - Generating results file: v8_7 07:22:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:22:27 INFO - process_Request line: dromaeo_css 6766.58 graph.html#tests=[[72,1,43]] 07:22:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:27 INFO - process_Request line: kraken 1508.00 graph.html#tests=[[232,1,43]] 07:22:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:27 INFO - process_Request line: v8_7 20365.74 graph.html#tests=[[230,1,43]] 07:22:27 INFO - RETURN: dromaeo_css: 6766.58 07:22:27 INFO - RETURN: kraken: 1508.00 07:22:27 INFO - RETURN: v8_7: 20365.74 07:22:27 INFO - javascript benchmark 07:22:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3104.5964024676773, 3119.9860045485193, 3163.9683603163967, 3164.14568066622, 3240.4329242382582, 5188.610854185932, 5293.0207911536345, 5305.4164041955355, 5311.628186026975, 5374.328208973879, 5158.0, 5209.453007434222, 5260.368755749316, 5274.5780337573, 5379.058664733676, 4907.779149938261, 4916.2871383649435, 4983.451820299782, 5008.824691135811, 5011.248312753098, 4722.929156062662, 4912.115819152551, 4948.678335908173, 4970.6520543561965, 4992.87517812054, 4860.586850117745, 4876.731779752112, 4884.609231261491, 4885.5358740919555, 4930.852074437773, 4849.2726091086615, 4857.82997595086, 4866.902661946777, 4870.172070747982, 4902.19113846215, 4689.390379250675, 4748.3589715388325, 4755.904881902377, 4847.3698419205275, 4887.706737595756, 5012.448630650625, 5198.610104242197, 5216.0, 5221.921671174935, 5243.659162154486, 5738.081906894877, 5761.3950535194035, 5763.884722305573, 5767.942320576783, 5773.595848290622, 5624.578156638268, 5699.800506982236, 5769.0, 5779.624324418899, 5790.7683692652245, 5264.315638966948, 5265.0259701955265, 5270.0, 5274.815381461631, 5390.676559406448, 5829.591928565044, 5833.854153646193, 5856.238688970407, 5880.558958078162, 5904.9704751475965, 5560.972195139079, 5646.0683987141665, 5653.80211692597, 5661.46216109469, 5663.575231857627, 5564.165375193753, 5631.71841407928, 5691.146328050742, 5747.741351639186, 5754.05058165398, 5741.598088133874, 5741.770329186786, 5747.3103227612955, 5756.65460072397, 5785.82642520725, 5662.518685911661, 5703.74333155009, 5714.885702285931, 5727.828165155052, 5730.885382292331, 4308.9569104309185, 4372.912541749147, 4404.273294906305, 4440.489343725513, 4479.977600111979, 3939.2318497892634, 3939.4878665773267, 3946.1713040261293, 3976.343903255988, 3983.6215559521797, 5306.442823503554, 5321.973390133025, 5325.094733895247, 5325.547328477045, 5331.813386531453, 5538.224648549206, 5616.550675945915, 5657.349404818498, 5669.4047125051275, 5776.826695199151, 5292.9735351323, 5294.7617357219015, 5297.311349524537, 5298.867528311823, 5304.946950530445, 4828.879278018007, 4865.683730557503, 4873.147199240118, 4877.926831097537, 4913.434954980152, 5777.566682498829, 5872.148538461985, 5933.792317268875, 5989.550783691154, 6051.0, 5642.379338272704, 5701.629394089371, 5710.5717071219, 5734.283214598176, 5738.139279108167, 5732.7706891723865, 5896.970515147397, 5906.911396328973, 5910.349861515316, 5911.793087241926, 5552.083906155601, 5576.888462230814, 5590.357108932525, 5611.775528978795, 5668.149777533403, 5557.610967232416, 5621.775128994795, 5628.74670639814, 5712.714364281853, 5734.3978882218435, 5464.836054918359, 5490.450954904637, 5558.055130627884, 5570.58220633446, 5573.888522229614, 5427.6472029317965, 5499.5371430277555, 5506.174073888788, 5522.861928451821, 5626.1842032905815, 5487.176923461513, 5492.0, 5492.533134683436, 5511.035568775528, 5522.723863806874, 5609.411011843861, 5615.8876822464135, 5654.971725141512, 5659.85850353728, 5704.743286552198, 5379.246905433164, 5399.163129714901, 5553.444655534414, 5580.051391263576, 5595.35653399848], "unit": "score", "name": "dojo.html", "value": 5255.572954939839}, {"lowerIsBetter": false, "replicates": [528.6167528541805, 529.8145649022841, 563.6336381352121, 566.1846940405818, 575.3383608849823, 34651.65348346516, 36100.63899361005, 36137.81931090348, 36181.0, 36188.45717314242, 39048.0, 39613.40579891304, 39945.0, 40030.7998460008, 40068.39897401534, 8426.494410335368, 8586.914130858673, 8588.184122508352, 8601.827963440728, 8651.783705407384, 8308.70919517817, 8324.708635197769, 8360.916390836075, 8522.360822938304, 8536.78658033548, 8538.957305213466, 8582.656693732244, 8608.870866937, 8609.741707748746, 8629.137086291383, 8521.872171917395, 8522.82954340916, 8531.573421328909, 8546.52994085322, 8624.568771561397, 8516.233538981522, 8535.402521823475, 8647.567621618893, 8648.1784230498, 8661.220490155916, 38432.61567384318, 39307.21385572272, 39376.0, 39404.60595394038, 39456.60543394558, 3148.8583013764437, 3171.175494371457, 3209.518572214163, 3237.530558069067, 3531.823408829574, 29661.851690741623, 29844.8507757462, 29851.850740746373, 30342.241443963856, 31008.379832403225, 3830.5977872323283, 3895.2793733159456, 3961.900952476211, 3980.20395920817, 4104.809605214484, 251002.0, 253604.0, 254138.0, 254181.0, 254455.0, 42038.15923681571, 56254.71872640611, 56731.43268567262, 56741.71629141828, 56774.0, 40360.59639403627, 40584.39123413151, 40737.18525629471, 40808.38787418191, 40935.0, 13485.932570337282, 13756.037077404686, 13778.379972901244, 13827.446902124004, 13861.4455421782, 10703.62537311206, 10721.195910306602, 10770.623028193975, 10777.892221077846, 10797.190210734227, 14293.428262869576, 14473.927630361992, 14510.564683059525, 14557.92721036388, 14595.41618335276, 5781.566382521328, 5927.792527261611, 5984.820455386345, 5989.670568118795, 6049.637021778707, 885.0618344554792, 910.3354551177678, 965.1458459263462, 976.2824324121765, 1060.411471633251, 28207.858960705064, 28225.858870705924, 28365.574516382272, 28533.429331413256, 28607.713922860505, 968.7917097823861, 994.0, 1008.9899101009042, 1023.1661196125134, 1103.2056919018294, 13629.25039122838, 13721.313934303245, 13782.65543361404, 13891.374888130058, 13904.791428128587, 358066.0, 367998.0, 368799.0, 369972.0, 370113.0, 51055.48944510507, 51382.0, 51586.74206629018, 51591.74204128955, 51662.483375165764, 1333.1601091312411, 1334.252818421687, 1338.2773302416585, 1360.3266383140408, 1382.0325771959467, 25845.0, 26326.0, 27033.0, 27044.45911081807, 27047.1885843425, 37848.0, 38340.61659383371, 38509.0, 42134.57865421429, 42164.78917605515, 287516.0, 287623.0, 288159.0, 288302.0, 288529.0, 32194.195145120622, 41684.166316674105, 41922.58077419309, 41945.79027104845, 42435.15129697327, 37627.0, 38050.2389952205, 38235.23529529449, 38392.61607384002, 38692.6130738689, 35204.647953520136, 35593.28813423665, 36250.09374765652, 36382.27235455223, 37941.62058379381, 33121.171970700925, 33263.83368083144, 33486.832565837016, 33494.0, 33957.49063764095, 32321.0, 32499.512507311938, 32576.83711581427, 32633.0, 32728.509072363457, 30437.239069022566, 30680.846595766878, 30950.380992380477, 32956.83521582377, 33435.66564334326, 25678.614820778075, 27318.453630927666, 27713.168604941882, 27735.722642774123, 27840.582391264554], "unit": "score", "name": "ext.html", "value": 17534.30927193008}, {"lowerIsBetter": false, "replicates": [358.80086551963666, 361.9485394927734, 362.7025838812175, 364.27145708582833, 365.81709145427277, 16202.270897809598, 16422.507324780247, 17173.398931037416, 17175.91412042941, 18165.182566784493, 10779.191560632964, 10911.478541156805, 15780.684386312267, 16219.107949062796, 16243.675126497463, 4748.525147485249, 5099.286099946011, 5302.469753024705, 5311.62818602698, 5319.946800531984, 4731.0, 5230.320058392404, 5298.761555729982, 5447.754851031713, 5448.863778405532, 3777.5655799583124, 3879.922401551967, 5336.30628018357, 5583.106702927533, 5589.944100558983, 5398.460153984609, 5457.345118585756, 5474.233607294982, 5476.452354764551, 5505.862353441156, 4890.3642526471685, 5061.291419201315, 5110.897782044375, 5111.1566591512355, 5124.461931497213, 17784.288628454848, 18486.53783655406, 18905.810941890544, 18934.810651893582, 20080.79919200804, 1944.1640094759248, 1978.2087165133917, 1981.8810871347766, 2059.109971577933, 2172.0, 9061.0, 9177.265818734486, 9496.620135194653, 9583.472908990003, 9612.375195612263, 1710.3158736505372, 1748.2482532511015, 1843.2258451450289, 1856.693645548483, 1894.7915729269769, 55779.442205577834, 56401.435985640026, 58008.70995645037, 58254.12618810721, 58482.707586462224, 9810.460424676712, 10046.146077583488, 10142.391456512632, 10185.388876667424, 10214.897851021395, 13111.803322950163, 13120.475180992844, 13169.407376668072, 13224.933875330755, 13309.800352994713, 7202.92797072033, 7237.0, 7241.239669834592, 7261.491695581364, 7329.8900516492295, 6840.726370945206, 6843.213030501456, 6902.792916212522, 6913.446924246048, 6915.827104322331, 4260.68044896634, 4298.849540266076, 4311.267084595564, 4333.826646934151, 4352.2818734909015, 1750.2386461889118, 1785.8303461171167, 1789.5078853315442, 1801.92792288307, 1812.2026308424252, 395.3437294091794, 402.2498041153287, 823.9835203295901, 1018.23123541727, 1048.6015314180563, 9787.16809071237, 10258.948705256575, 10338.666772541432, 10687.198460115522, 10789.352638841694, 424.683610710023, 430.39529461107196, 449.7144313360974, 458.6262196309997, 460.3026414981306, 5758.74085666146, 5795.420457954171, 5831.358550559435, 5890.1164825276555, 9212.0, 487675.0, 490675.0, 495246.0, 498975.0, 520043.9346348016, 45001.324980125326, 45486.54513454889, 55044.44955550393, 69188.30811691919, 72675.2732472679, 1122.315387613555, 1149.3563604381573, 1151.9654410367534, 1166.5800311887713, 1186.7626474705094, 14110.717785644434, 14558.272086395426, 14961.775573366625, 15037.097774133586, 15078.170700611572, 22149.224777132724, 30433.239169020067, 30846.537301940938, 31293.061208163792, 31399.0, 37082.8145859269, 37624.62375376211, 37868.62131378651, 38389.80805095957, 38808.80595597117, 7246.0, 7424.777256682308, 7506.624668766649, 7652.311291983749, 7661.233876612294, 10147.79704405893, 11196.216264861381, 11379.260348077349, 11581.710457238636, 11612.361320127475, 8780.648774048967, 9352.719418417459, 9367.00255918127, 9393.295502837178, 9599.184069353903, 2977.553366994968, 6085.687438773238, 6407.615543067431, 9775.364601300893, 9885.752856178366, 8949.552522373986, 9034.2320902724, 9437.480938548446, 9628.0, 9778.706638800848, 7397.0, 7427.145878223857, 7511.098668159856, 7526.09686837583, 7557.584332861746, 8860.556972151238, 9025.187733104052, 9264.629414823601, 9486.241100712065, 9487.051294870458], "unit": "score", "name": "jquery.html", "value": 7452.984238448227}, {"lowerIsBetter": false, "replicates": [1421.1757180835116, 1457.6501639606495, 1619.044763589482, 1771.3268957796035, 1783.964320713585, 7641.3122818946285, 7760.961195194023, 7887.0, 7939.206079392058, 7979.401544884136, 7832.56920869352, 7897.842043159133, 7957.363410927126, 7964.5221286722835, 7966.24320689535, 2318.13070098713, 2352.0, 2353.2469609724894, 2353.305774796431, 2356.352003199117, 2368.6802281692007, 2369.3958040699686, 2397.376682062659, 2400.4238982644215, 2404.5551572959057, 2272.8863556822093, 2310.0413328468667, 2330.8601483910934, 2336.380859072339, 2345.847519911209, 2324.1168356024773, 2328.8253380996325, 2347.3310106619615, 2348.5068135691527, 2349.1543044503965, 2345.1909091363455, 2398.688170537819, 2399.808015358767, 2402.6636270922086, 2408.7832095111526, 7793.688252469894, 7826.804329891741, 7834.294913457816, 7838.843223135563, 7843.568603726792, 4855.6601037927, 4923.704577725348, 4940.703557786508, 4942.110420124376, 4997.450280469146, 3113.3617608390227, 3152.7320177784686, 3206.951895721566, 3229.289556297611, 3237.9676203238137, 972.6644307713827, 982.8574856645746, 1019.2152042926979, 1026.9743256418574, 1924.490010147312, 10878.292910960841, 10948.3978381189, 10997.780044399227, 11044.392558409285, 11062.446877656084, 4175.665946724254, 4234.02617397994, 4313.633341165973, 4489.618382437464, 4502.077074199847, 8749.737507874774, 8825.470471771714, 8838.955805220932, 8856.202941735146, 8864.556772161366, 4779.211430113992, 4831.9275210871865, 4836.274558816135, 4838.830640927621, 4862.17343051682, 4417.271150260235, 4442.444694413199, 4461.643068554507, 4477.776111194427, 4493.685442019093, 3477.94783078254, 3499.825008749552, 3543.8582456701442, 3547.0777597824235, 3565.536480257602, 1079.3146352066337, 1094.6497120921229, 1107.5680484611007, 1109.8945600167972, 1130.66645339625, 1275.1329096214663, 1288.7229245712217, 1317.9785666108842, 1318.4462525739214, 1334.0861509865772, 7393.445491588152, 7492.0, 7520.736774212876, 7528.887066694004, 7543.9622801886735, 1144.4849817582121, 1146.8681101673249, 1153.3022521374614, 1165.3823473559028, 1177.952881884715, 5683.658980461103, 5784.623999440023, 5816.069428891442, 5830.038043722739, 5853.414658534198, 9451.385659932082, 9724.173445257233, 9916.950415247878, 9953.0, 9977.950110249401, 9601.279904007228, 9654.662086826927, 9736.123748862636, 9782.461964592016, 9786.657466988621, 7132.750353737698, 7400.740974065882, 7454.701811927571, 7459.142198647117, 7514.812129696692, 7035.6833942471685, 7155.642217889189, 7162.176349719641, 7184.425245980414, 7208.639568021473, 8290.29532489721, 8465.195806398382, 8502.489850608983, 8524.573771311534, 8682.609282582425, 8595.699150529701, 8643.567821608769, 8685.0, 8686.0, 8691.348148888732, 6738.8652226956165, 6806.217285012287, 6873.20958089826, 6882.311768823078, 6908.032875397549, 7392.778216653509, 7488.513246638951, 7495.625218738932, 7526.397888169043, 7547.0943486781935, 6778.4577233822165, 6970.7862490815005, 7064.15230172362, 7231.096112985877, 7388.889166662397, 6856.760013399507, 6866.553674011173, 6990.161180658353, 7026.824329391806, 7050.647467626701, 7065.964670176616, 7071.681774320271, 7115.1106111736035, 7168.068151140527, 7170.569765814068, 6350.142730731292, 6519.250286217146, 6528.281888992112, 6533.281339052795, 6547.279799222177, 6555.508336874658, 6575.671216439063, 6593.835154121185, 6616.900746488903, 6634.203895532567], "unit": "score", "name": "mootools.html", "value": 4596.605152886295}, {"lowerIsBetter": false, "replicates": [324.16204112369525, 332.3966999895189, 339.04558667351404, 340.8909149072296, 346.98785542506, 6227.626342419452, 6293.181886354779, 6357.968210158949, 6373.426391624753, 6450.7742229022, 6181.07283907413, 6280.685965701719, 6295.874082518359, 6298.338674439186, 6314.210723659543, 4790.832320868771, 4791.496892826247, 4792.113459010076, 4795.256735206049, 4801.8079276828885, 4818.927716084261, 4820.614350851941, 4821.662483626147, 4821.831235906744, 4827.51724827518, 4688.695234809744, 4768.5946694531, 4777.0, 4777.713337199762, 4783.186858234091, 4756.1914474539235, 4756.66703330767, 4766.928496072562, 4780.211265141247, 4781.832635857728, 4158.272302347077, 4187.937180942288, 4189.539150693421, 4193.119444916571, 4193.643540299078, 6024.0, 6041.0, 6047.15339852421, 6048.516118710492, 6049.4253045961, 5472.26124473195, 5545.805896793633, 5582.134769110794, 5582.609217354787, 5586.078297080977, 6559.6064236145985, 6559.868802623921, 6568.868622627569, 6590.7477579259785, 6598.5051121165625, 4626.884327891796, 4640.071985602893, 4640.396748422717, 4652.278896770972, 4663.533646635343, 6866.244713081557, 6969.756058537927, 7021.964890175567, 7033.929660703378, 7047.788566342967, 4772.76136193189, 4775.283707443911, 4775.641826863, 4776.116418462596, 4791.736454495036, 4825.638077144228, 4846.0, 4847.75761211938, 4856.1987272099705, 4857.6599638025, 5582.91625625616, 5588.804391846266, 5598.992181407386, 5599.888002239933, 5613.578981576398, 6625.17185351831, 6715.597064176165, 6742.0, 6744.460443164535, 6751.189857217166, 1667.991660041692, 1703.1994962367667, 1707.9487615371559, 1712.8715346348824, 1721.440531827136, 1107.1640911112058, 1145.5074318043155, 1146.2549342926998, 1154.7113221694576, 1155.6013175454455, 6176.197094377792, 6184.690765461709, 6220.440160385587, 6220.595661282002, 6227.283862355796, 6765.424938880152, 6822.113125293779, 6834.350736680008, 6853.143357080365, 6858.0, 6024.427679370453, 6198.566100372931, 6200.286966998853, 6201.7519299228425, 6206.565540412218, 3703.2593481303848, 3715.052661571282, 3718.0704823794053, 3723.2181241938956, 3727.683146932541, 7148.785536433916, 7151.070360853056, 7155.105611798525, 7156.248593897566, 7188.17336006366, 6872.140982377203, 6945.479089068239, 6956.234814170437, 6957.782388082065, 6991.475639327071, 7299.744508942162, 7319.74380896666, 7329.780106596811, 7381.114266287972, 7384.040074790243, 6982.6159561222585, 7037.401820845285, 7040.401565866959, 7044.15470143586, 7069.681864316221, 6728.192616886005, 6865.41643960249, 6871.587704737732, 6874.553154044971, 6875.690593923186, 7306.41548676094, 7313.561186328838, 7341.596212208166, 7349.338559529454, 7359.1169059713175, 4684.039771846831, 4762.976185119052, 4763.0235801661265, 4768.189407800613, 4772.928406073842, 6904.0, 7007.649617519206, 7026.332498412643, 7030.0, 7042.577445353295, 6729.394354508117, 6781.457483401415, 6783.89824152648, 6785.660716964231, 6786.966065169642, 6717.697703603252, 6764.458843292623, 6780.016897549926, 6782.0505129280955, 6791.385316653025, 6487.837804054936, 6641.1034510342415, 6642.236142843635, 6643.1031810704935, 6645.534812563074, 6763.830904227434, 6809.65951702403, 6816.522843400914, 6818.624975626388, 6830.897536536857, 6578.440832529289, 6603.405693487609, 6611.008348747726, 6621.635810030302, 6623.768168114286], "unit": "score", "name": "prototype.html", "value": 5046.383941128733}, {"lowerIsBetter": false, "replicates": [666.3303380102996, 716.4733920568382, 721.1706537481892, 723.2008630463338, 813.8331642013386, 12970.546030888921, 13174.27541485219, 13253.006024548162, 13267.734645307088, 13282.203067815914, 12794.0, 12811.295378754165, 12914.354282285894, 13210.867891321084, 13311.733765324687, 801.4790386248926, 815.5188438821094, 823.9093699693044, 830.7756905635505, 832.4089896173724, 804.3725893802814, 806.7257132574923, 808.7856717969743, 812.4150611559668, 813.8697808350665, 833.8207285433631, 833.9874901876477, 838.6100463284572, 841.970531031414, 843.9156084391542, 823.189158678701, 829.5769157729571, 830.0495932157676, 833.0960907415462, 838.8741688746676, 610.563447135296, 612.1857928954524, 619.1981384107592, 620.011082323693, 624.7500999600151, 13085.28030958297, 13138.0, 13160.07879448439, 13263.403146858414, 13274.070815042951, 12081.758364832742, 12109.818352724717, 12239.32683702405, 12370.0, 12595.370231488481, 10514.947425262824, 10570.15438764897, 10614.681559553226, 11098.223124381297, 11143.498542565523, 3621.981890090559, 3637.5453068366455, 3649.3978493548534, 3775.2826962876966, 3778.6977041836585, 44276.0, 44420.55579444196, 44558.33162502533, 44751.32873006907, 44815.77592112051, 9321.533923303808, 9363.204127649225, 9376.109269619375, 9491.76270593227, 9692.321537492307, 16360.590985225464, 16552.668946621, 16573.6685266294, 16574.751378729088, 16625.251863666163, 7409.592472414069, 7446.0, 7466.813329666802, 7506.962465187748, 7697.538147711043, 4290.01029042993, 4301.942395189341, 4302.65578753699, 4313.61177494027, 4399.318105693623, 3098.7056229658597, 3103.239706271978, 3106.394253120665, 3110.3623757130185, 3126.124685088179, 564.3143580549652, 572.6106247751569, 575.4705670782889, 578.9015867302569, 581.8487193329764, 507.4874376879378, 514.1721827857147, 519.828456609318, 521.569704993382, 554.2739011894431, 7858.1356050834365, 8007.319377852948, 8117.391195660349, 8236.605809624358, 8260.586970651444, 528.4187393866716, 574.7327492715907, 650.5608714117951, 663.8506336074441, 693.4244577001077, 3417.2482053948092, 3789.597848795908, 3794.2032173243374, 3951.703622228287, 4001.1197536541913, 53850.0, 54095.45904540983, 54193.0, 54708.72645636746, 54855.725721371135, 48527.75736121297, 48890.511094889305, 48938.510614894105, 49295.507044929094, 49705.0, 44473.11053778971, 44490.77754611206, 44661.10677786426, 45474.54525454703, 45725.0, 7447.404207663482, 7591.3547348475995, 7777.844443110993, 7829.491083079582, 7873.685052597832, 31678.36643267168, 32257.51613725749, 32936.01191964245, 33252.66747332496, 33444.66221351216, 39807.60192398155, 42305.0, 42700.359494606986, 43065.354019689104, 43283.783581081894, 9370.718878433658, 9746.610135594497, 9802.9019709802, 10155.593776248867, 10508.42203678805, 11132.519378885321, 11192.1605879561, 11198.440077995905, 11376.658700239006, 11408.54365825391, 9946.45294508809, 10207.693769186937, 10347.534360953925, 10543.94728026355, 10656.467176641292, 10223.335483193569, 10318.122959548222, 10475.214358922958, 10481.528331224961, 10692.251542391958, 9968.55141518619, 10585.9470702646, 10613.416262105658, 10624.468776560987, 10965.629296337958, 8275.793105172419, 8563.871541927001, 8588.398812083095, 8691.0, 9240.075992400707, 8428.536430496382, 8862.689805856764, 9050.547472626211, 9444.150026497648, 9465.242780577399], "unit": "score", "name": "yui.html", "value": 6024.546220833152}], "name": "dromaeo_css", "value": 6766.576471154236}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 110.0, 112.0, 124.0, 110.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 154.0, 161.0, 126.0, 150.0, 152.0, 127.0, 166.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 163.0, 161.0, 164.0, 167.0, 170.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 74.0, 72.0, 75.0, 73.0, 148.0, 73.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 95.0, 97.0, 96.0, 143.0, 97.0, 100.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 109.0, 111.0, 111.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 59.0, 60.0, 60.0, 59.0, 59.0, 65.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 83.0, 83.0, 83.0, 82.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 120.0, 122.0, 127.0, 118.0, 121.0, 120.0, 113.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 162.0, 146.0, 146.0, 133.0, 146.0, 142.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 66.0, 68.0, 68.0, 68.0, 71.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1508.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.4053870913095], "unit": "score", "name": "Richards", "value": 208.38770599999992}, {"lowerIsBetter": false, "replicates": [188.1821603312006], "unit": "score", "name": "DeltaBlue", "value": 351.351052}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [709.4259390503189], "unit": "score", "name": "Earley", "value": 939.439853146853}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [41306.12244897959], "unit": "score", "name": "RegExp", "value": 22.05447875494071}, {"lowerIsBetter": false, "replicates": [587.8894767783656], "unit": "score", "name": "Splay", "value": 138.616191}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20365.735973822266}]} 07:22:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20365.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1508.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6766.58"}}} 07:22:27 INFO - Return code: 0 07:22:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:22:27 INFO - # TBPL SUCCESS # 07:22:27 INFO - Running post-action listener: _resource_record_post_action 07:22:27 INFO - Running post-run listener: _resource_record_post_run 07:22:28 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 554680320; Read time: 0; Write time: 503096 07:22:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234070016; Read time: 0; Write time: 218404 07:22:28 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 314613760; Read time: 0; Write time: 284468 07:22:28 INFO - Running post-run listener: _upload_blobber_files 07:22:28 INFO - Blob upload gear active. 07:22:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:22:28 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 07:22:28 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'] 07:22:28 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 07:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 07:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:29 INFO - (blobuploader) - INFO - Done attempting. 07:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:30 INFO - (blobuploader) - INFO - Done attempting. 07:22:30 INFO - (blobuploader) - INFO - Iteration through files over. 07:22:30 INFO - Return code: 0 07:22:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:22:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:22:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/affebf386a8707c7a8a4d094148ee46d1c06544d37e71feafd507903ecfe81fec8edfd96f0462c6b081bc6bca630db25b5726758cbcaf283bf0d00be91ef9c0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e03142dc37284c5b00b933ab7511b22db7f702e4b6589bd7b03d877098342d14fe955d0075241e722200778ac008b8c3ac059123f35b0873f5847ea2232e79d"} 07:22:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:22:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:22:30 INFO - Contents: 07:22:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/affebf386a8707c7a8a4d094148ee46d1c06544d37e71feafd507903ecfe81fec8edfd96f0462c6b081bc6bca630db25b5726758cbcaf283bf0d00be91ef9c0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e03142dc37284c5b00b933ab7511b22db7f702e4b6589bd7b03d877098342d14fe955d0075241e722200778ac008b8c3ac059123f35b0873f5847ea2232e79d"} 07:22:30 INFO - Copying logs to upload dir... 07:22:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1298.560151 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-01-13 07:22:29.205727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 07:22:29.208873) ========= 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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 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/affebf386a8707c7a8a4d094148ee46d1c06544d37e71feafd507903ecfe81fec8edfd96f0462c6b081bc6bca630db25b5726758cbcaf283bf0d00be91ef9c0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e03142dc37284c5b00b933ab7511b22db7f702e4b6589bd7b03d877098342d14fe955d0075241e722200778ac008b8c3ac059123f35b0873f5847ea2232e79d"} build_url:https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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/affebf386a8707c7a8a4d094148ee46d1c06544d37e71feafd507903ecfe81fec8edfd96f0462c6b081bc6bca630db25b5726758cbcaf283bf0d00be91ef9c0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e03142dc37284c5b00b933ab7511b22db7f702e4b6589bd7b03d877098342d14fe955d0075241e722200778ac008b8c3ac059123f35b0873f5847ea2232e79d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 07:22:29.233489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:22:29.233803) ========= 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=33d5923976266a1c518c4bf7000001ab-1452697209.531096-24012255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:22:29.317273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 07:22:29.317596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 07:22:29.318150) ========= ========= Total master_lag: 0.23 =========