builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1452491549.61 results: success (0) buildid: 20160110193521 builduid: 23a35881b2764afea56aef0202627a84 revision: 5c34826911da061621bfa8fd2b5c50bfb35176e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.606978) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.608162) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.608675) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006410 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.649088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.649416) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.700131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.700557) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.750271) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.750587) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.750987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.751311) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 21:52:30-- 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% 92.4M=0s 2016-01-10 21:52:30 (92.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168315 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.938576) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.938901) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020028 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:29.989353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-10 21:52:29.989711) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5c34826911da061621bfa8fd2b5c50bfb35176e3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5c34826911da061621bfa8fd2b5c50bfb35176e3 --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=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 21:52:30,747 truncating revision to first 12 chars 2016-01-10 21:52:30,747 Setting DEBUG logging. 2016-01-10 21:52:30,747 attempt 1/10 2016-01-10 21:52:30,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5c34826911da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 21:52:32,087 unpacking tar archive at: mozilla-inbound-5c34826911da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.637927 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-10 21:52:31.655809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:31.656603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:31.667961) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:31.668255) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 21:52:31.668733) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 42 secs) (at 2016-01-10 21:52:31.669067) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:52:32 INFO - MultiFileLogger online at 20160110 21:52:32 in /builds/slave/test-pgo 21:52:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:52:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:52:32 INFO - {'append_to_log': False, 21:52:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:52:32 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:52:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:52:32 INFO - 'branch': 'Mozilla-Inbound', 21:52:32 INFO - 'buildbot_json_path': 'buildprops.json', 21:52:32 INFO - 'config_files': ('talos/linux_config.py',), 21:52:32 INFO - 'default_actions': ('clobber', 21:52:32 INFO - 'read-buildbot-config', 21:52:32 INFO - 'download-and-extract', 21:52:32 INFO - 'populate-webroot', 21:52:32 INFO - 'create-virtualenv', 21:52:32 INFO - 'install', 21:52:32 INFO - 'run-tests'), 21:52:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:52:32 INFO - 'download_minidump_stackwalk': True, 21:52:32 INFO - 'download_symbols': 'ondemand', 21:52:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:52:32 INFO - 'tooltool.py': '/tools/tooltool.py', 21:52:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:52:32 INFO - '/tools/misc-python/virtualenv.py')}, 21:52:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:52:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:52:32 INFO - 'installer_path': 'installer.exe', 21:52:32 INFO - 'log_level': 'info', 21:52:32 INFO - 'log_name': 'talos', 21:52:32 INFO - 'log_to_console': True, 21:52:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:52:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:52:32 INFO - 'opt_config_files': (), 21:52:32 INFO - 'pip_index': False, 21:52:32 INFO - 'sps_profile': False, 21:52:32 INFO - 'sps_profile_interval': 0, 21:52:32 INFO - 'suite': 'dromaeojs', 21:52:32 INFO - 'system_bits': '32', 21:52:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:52:32 INFO - 'title': 'talos-linux64-ix-067', 21:52:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:52:32 INFO - 'use_talos_json': True, 21:52:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:52:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:52:32 INFO - 'work_dir': 'build'} 21:52:32 INFO - ##### 21:52:32 INFO - ##### Running clobber step. 21:52:32 INFO - ##### 21:52:32 INFO - Running pre-action listener: _resource_record_pre_action 21:52:32 INFO - Running main action method: clobber 21:52:32 INFO - rmtree: /builds/slave/test-pgo/build 21:52:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:52:32 INFO - Running post-action listener: _resource_record_post_action 21:52:32 INFO - ##### 21:52:32 INFO - ##### Running read-buildbot-config step. 21:52:32 INFO - ##### 21:52:32 INFO - Running pre-action listener: _resource_record_pre_action 21:52:32 INFO - Running main action method: read_buildbot_config 21:52:32 INFO - Using buildbot properties: 21:52:32 INFO - { 21:52:32 INFO - "project": "", 21:52:32 INFO - "product": "firefox", 21:52:32 INFO - "script_repo_revision": "production", 21:52:32 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:52:32 INFO - "repository": "", 21:52:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:52:32 INFO - "buildid": "20160110193521", 21:52:32 INFO - "pgo_build": "True", 21:52:32 INFO - "basedir": "/builds/slave/test-pgo", 21:52:32 INFO - "buildnumber": 613, 21:52:32 INFO - "slavename": "talos-linux64-ix-067", 21:52:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:52:32 INFO - "platform": "ubuntu64_hw", 21:52:32 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:52:32 INFO - "branch": "mozilla-inbound", 21:52:32 INFO - "repo_path": "integration/mozilla-inbound", 21:52:32 INFO - "revision": "5c34826911da061621bfa8fd2b5c50bfb35176e3", 21:52:32 INFO - "stage_platform": "linux64-pgo", 21:52:32 INFO - "builduid": "23a35881b2764afea56aef0202627a84", 21:52:32 INFO - "slavebuilddir": "test" 21:52:32 INFO - } 21:52:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:52:32 INFO - Running post-action listener: _resource_record_post_action 21:52:32 INFO - ##### 21:52:32 INFO - ##### Running download-and-extract step. 21:52:32 INFO - ##### 21:52:32 INFO - Running pre-action listener: _resource_record_pre_action 21:52:32 INFO - Running main action method: download_and_extract 21:52:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:32 INFO - https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/test_packages.json 21:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/test_packages.json 21:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:53:02 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/test_packages.json: timed out 21:53:02 INFO - retry: attempt #1 caught exception: timed out 21:53:02 INFO - retry: Failed, sleeping 30 seconds before retrying 21:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #2 21:53:35 INFO - Downloaded 1302 bytes. 21:53:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:53:35 INFO - Using the following test package requirements: 21:53:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:53:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:35 INFO - u'jsshell-linux-x86_64.zip'], 21:53:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:53:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:53:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:53:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:53:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:53:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:35 INFO - https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:53:39 INFO - Downloaded 24028682 bytes. 21:53:39 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 21:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:39 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 21:53:40 INFO - Return code: 0 21:53:40 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 21:53: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')]} 21:53:40 INFO - https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:53:58 INFO - Downloaded 24028682 bytes. 21:53:58 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 21:53:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:58 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 21:53:59 INFO - Return code: 0 21:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:59 INFO - https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:53:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:53:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:54:06 INFO - Downloaded 11132285 bytes. 21:54:06 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 21:54:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:06 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 21:54:06 INFO - Return code: 0 21:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:06 INFO - https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:54:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:54:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:54:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGc36MzXQjGWa1bcn06O4A/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 21:54:13 INFO - Downloaded 55922387 bytes. 21:54:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:54:13 INFO - mkdir: /builds/slave/test-pgo/properties 21:54:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:54:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:54:13 INFO - Contents: 21:54:13 INFO - build_url:https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:54:13 INFO - Running post-action listener: _resource_record_post_action 21:54:13 INFO - Running post-action listener: set_extra_try_arguments 21:54:13 INFO - ##### 21:54:13 INFO - ##### Running populate-webroot step. 21:54:13 INFO - ##### 21:54:13 INFO - Running pre-action listener: _resource_record_pre_action 21:54:13 INFO - Running main action method: populate_webroot 21:54:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:54:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:54:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:54:13 INFO - '--tppagecycles', 21:54:13 INFO - '7'], 21:54:13 INFO - 'tests': ['tsvgm']}}, 21:54:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:54:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:54:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:54:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:54:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'tests': ['damp', 'tps']}, 21:54:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['damp', 'tps']}, 21:54:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:54:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:54:13 INFO - 'other': {'tests': ['a11yr', 21:54:13 INFO - 'ts_paint', 21:54:13 INFO - 'tpaint', 21:54:13 INFO - 'sessionrestore', 21:54:13 INFO - 'sessionrestore_no_auto_restore']}, 21:54:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['a11yr', 21:54:13 INFO - 'ts_paint', 21:54:13 INFO - 'tpaint', 21:54:13 INFO - 'sessionrestore', 21:54:13 INFO - 'sessionrestore_no_auto_restore']}, 21:54:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['a11yr', 21:54:13 INFO - 'ts_paint', 21:54:13 INFO - 'tpaint', 21:54:13 INFO - 'sessionrestore', 21:54:13 INFO - 'sessionrestore_no_auto_restore']}, 21:54:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['a11yr', 21:54:13 INFO - 'ts_paint', 21:54:13 INFO - 'tpaint', 21:54:13 INFO - 'sessionrestore', 21:54:13 INFO - 'sessionrestore_no_auto_restore']}, 21:54:13 INFO - 'other_l64': {'tests': ['a11yr', 21:54:13 INFO - 'ts_paint', 21:54:13 INFO - 'tpaint', 21:54:13 INFO - 'sessionrestore', 21:54:13 INFO - 'sessionrestore_no_auto_restore']}, 21:54:13 INFO - 'other_nol64': {'tests': ['a11yr', 21:54:13 INFO - 'ts_paint', 21:54:13 INFO - 'tpaint', 21:54:13 INFO - 'sessionrestore', 21:54:13 INFO - 'sessionrestore_no_auto_restore']}, 21:54:13 INFO - 'svgr': {'tests': ['tsvgx', 21:54:13 INFO - 'tsvgr_opacity', 21:54:13 INFO - 'tart', 21:54:13 INFO - 'tscrollx', 21:54:13 INFO - 'cart']}, 21:54:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['tsvgx', 21:54:13 INFO - 'tsvgr_opacity', 21:54:13 INFO - 'tart', 21:54:13 INFO - 'tscrollx', 21:54:13 INFO - 'cart']}, 21:54:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'tests': ['tp5o']}, 21:54:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'talos_options': ['--e10s'], 21:54:13 INFO - 'tests': ['tp5o']}, 21:54:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'talos_options': ['--xperf_path', 21:54:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:13 INFO - 'tests': ['tp5n']}, 21:54:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:13 INFO - 'talos_options': ['--e10s', 21:54:13 INFO - '--xperf_path', 21:54:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:13 INFO - 'tests': ['tp5n']}}, 21:54:13 INFO - 'talos.zip': {'path': '', 21:54:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:54:13 INFO - Running post-action listener: _resource_record_post_action 21:54:13 INFO - ##### 21:54:13 INFO - ##### Running create-virtualenv step. 21:54:13 INFO - ##### 21:54:13 INFO - Running pre-action listener: _resource_record_pre_action 21:54:13 INFO - Running main action method: create_virtualenv 21:54:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:54:13 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 21:54:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:54:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:54:13 INFO - Using real prefix '/usr' 21:54:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:54:14 INFO - Installing distribute.............................................................................................................................................................................................done. 21:54:16 INFO - Installing pip.................done. 21:54:16 INFO - Return code: 0 21:54:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:54:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:54:16 INFO - Using env: {'DISPLAY': ':0', 21:54:16 INFO - 'HOME': '/home/cltbld', 21:54:16 INFO - 'LANG': 'en_US.UTF-8', 21:54:16 INFO - 'LANGUAGE': 'en_US:en', 21:54:16 INFO - 'LOGNAME': 'cltbld', 21:54:16 INFO - 'MAIL': '/var/mail/cltbld', 21:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:16 INFO - 'MOZ_NO_REMOTE': '1', 21:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:16 INFO - 'NO_EM_RESTART': '1', 21:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:16 INFO - 'SHELL': '/bin/bash', 21:54:16 INFO - 'SHLVL': '1', 21:54:16 INFO - 'TERM': 'linux', 21:54:16 INFO - 'TMOUT': '86400', 21:54:16 INFO - 'USER': 'cltbld', 21:54:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:16 INFO - '_': '/tools/buildbot/bin/python'} 21:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:16 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 21:54:16 INFO - Cleaning up... 21:54:16 INFO - Return code: 0 21:54:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:54:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:54:16 INFO - Using env: {'DISPLAY': ':0', 21:54:16 INFO - 'HOME': '/home/cltbld', 21:54:16 INFO - 'LANG': 'en_US.UTF-8', 21:54:16 INFO - 'LANGUAGE': 'en_US:en', 21:54:16 INFO - 'LOGNAME': 'cltbld', 21:54:16 INFO - 'MAIL': '/var/mail/cltbld', 21:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:16 INFO - 'MOZ_NO_REMOTE': '1', 21:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:16 INFO - 'NO_EM_RESTART': '1', 21:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:16 INFO - 'SHELL': '/bin/bash', 21:54:16 INFO - 'SHLVL': '1', 21:54:16 INFO - 'TERM': 'linux', 21:54:16 INFO - 'TMOUT': '86400', 21:54:16 INFO - 'USER': 'cltbld', 21:54:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:16 INFO - '_': '/tools/buildbot/bin/python'} 21:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:16 INFO - Downloading/unpacking psutil>=0.7.1 21:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:18 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:54:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:54:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:18 INFO - Installing collected packages: psutil 21:54:18 INFO - Running setup.py install for psutil 21:54:18 INFO - building 'psutil._psutil_linux' extension 21:54:18 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 21:54:18 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 21:54:18 INFO - building 'psutil._psutil_posix' extension 21:54:18 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 21:54:18 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 21:54:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:18 INFO - Successfully installed psutil 21:54:18 INFO - Cleaning up... 21:54:18 INFO - Return code: 0 21:54:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:18 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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:18 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 21:54:18 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 21:54:18 INFO - Using env: {'DISPLAY': ':0', 21:54:18 INFO - 'HOME': '/home/cltbld', 21:54:18 INFO - 'LANG': 'en_US.UTF-8', 21:54:18 INFO - 'LANGUAGE': 'en_US:en', 21:54:18 INFO - 'LOGNAME': 'cltbld', 21:54:18 INFO - 'MAIL': '/var/mail/cltbld', 21:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:18 INFO - 'MOZ_NO_REMOTE': '1', 21:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:18 INFO - 'NO_EM_RESTART': '1', 21:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:18 INFO - 'SHELL': '/bin/bash', 21:54:18 INFO - 'SHLVL': '1', 21:54:18 INFO - 'TERM': 'linux', 21:54:18 INFO - 'TMOUT': '86400', 21:54:18 INFO - 'USER': 'cltbld', 21:54:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:18 INFO - '_': '/tools/buildbot/bin/python'} 21:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:54:19 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 21:54:19 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 21:54:19 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 21:54:19 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 21:54:19 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 21:54:19 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 21:54:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:54:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:54:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:54:20 INFO - Installing collected packages: mozsystemmonitor 21:54:20 INFO - Running setup.py install for mozsystemmonitor 21:54:20 INFO - Successfully installed mozsystemmonitor 21:54:20 INFO - Cleaning up... 21:54:20 INFO - Return code: 0 21:54:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:20 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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:20 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 21:54:20 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 21:54:20 INFO - Using env: {'DISPLAY': ':0', 21:54:20 INFO - 'HOME': '/home/cltbld', 21:54:20 INFO - 'LANG': 'en_US.UTF-8', 21:54:20 INFO - 'LANGUAGE': 'en_US:en', 21:54:20 INFO - 'LOGNAME': 'cltbld', 21:54:20 INFO - 'MAIL': '/var/mail/cltbld', 21:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:20 INFO - 'MOZ_NO_REMOTE': '1', 21:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:20 INFO - 'NO_EM_RESTART': '1', 21:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:20 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:20 INFO - 'SHELL': '/bin/bash', 21:54:20 INFO - 'SHLVL': '1', 21:54:20 INFO - 'TERM': 'linux', 21:54:20 INFO - 'TMOUT': '86400', 21:54:20 INFO - 'USER': 'cltbld', 21:54:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:20 INFO - '_': '/tools/buildbot/bin/python'} 21:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:21 INFO - Downloading/unpacking blobuploader==1.2.4 21:54:21 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 21:54:21 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 21:54:21 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 21:54:21 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 21:54:21 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 21:54:21 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 21:54:22 INFO - Downloading blobuploader-1.2.4.tar.gz 21:54:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:54:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:54:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:54:22 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 21:54:22 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 21:54:22 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 21:54:22 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 21:54:22 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 21:54:22 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 21:54:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:54:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:54:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:54:23 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 21:54:23 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 21:54:23 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 21:54:23 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 21:54:23 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 21:54:23 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 21:54:23 INFO - Downloading docopt-0.6.1.tar.gz 21:54:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:54:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:54:23 INFO - Installing collected packages: blobuploader, requests, docopt 21:54:23 INFO - Running setup.py install for blobuploader 21:54:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:54:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:54:23 INFO - Running setup.py install for requests 21:54:23 INFO - Running setup.py install for docopt 21:54:24 INFO - Successfully installed blobuploader requests docopt 21:54:24 INFO - Cleaning up... 21:54:24 INFO - Return code: 0 21:54:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:24 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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:24 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 21:54:24 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 21:54:24 INFO - Using env: {'DISPLAY': ':0', 21:54:24 INFO - 'HOME': '/home/cltbld', 21:54:24 INFO - 'LANG': 'en_US.UTF-8', 21:54:24 INFO - 'LANGUAGE': 'en_US:en', 21:54:24 INFO - 'LOGNAME': 'cltbld', 21:54:24 INFO - 'MAIL': '/var/mail/cltbld', 21:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:24 INFO - 'MOZ_NO_REMOTE': '1', 21:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:24 INFO - 'NO_EM_RESTART': '1', 21:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:24 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:24 INFO - 'SHELL': '/bin/bash', 21:54:24 INFO - 'SHLVL': '1', 21:54:24 INFO - 'TERM': 'linux', 21:54:24 INFO - 'TMOUT': '86400', 21:54:24 INFO - 'USER': 'cltbld', 21:54:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:24 INFO - '_': '/tools/buildbot/bin/python'} 21:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:24 INFO - Running setup.py (path:/tmp/pip-53pPTk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:24 INFO - Running setup.py (path:/tmp/pip-7LSS2W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:24 INFO - Running setup.py (path:/tmp/pip-U42MU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:24 INFO - Running setup.py (path:/tmp/pip-pvdBBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:24 INFO - Running setup.py (path:/tmp/pip-AexA2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:24 INFO - Running setup.py (path:/tmp/pip-9F1khY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:24 INFO - Running setup.py (path:/tmp/pip-XlBMEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:24 INFO - Running setup.py (path:/tmp/pip-62NyFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:24 INFO - Running setup.py (path:/tmp/pip-56CIp9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:25 INFO - Running setup.py (path:/tmp/pip-cnnu7g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:25 INFO - Running setup.py (path:/tmp/pip-CKqfyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:25 INFO - Running setup.py (path:/tmp/pip-qlsGZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:25 INFO - Running setup.py (path:/tmp/pip-Dps1xd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:25 INFO - Running setup.py (path:/tmp/pip-AQzm61-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:25 INFO - Running setup.py (path:/tmp/pip-wjDzWe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:25 INFO - Running setup.py (path:/tmp/pip-WtVcyF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:25 INFO - Running setup.py (path:/tmp/pip-R9jmII-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:54:25 INFO - Running setup.py install for manifestparser 21:54:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:54:25 INFO - Running setup.py install for mozcrash 21:54:25 INFO - Running setup.py install for mozdebug 21:54:25 INFO - Running setup.py install for mozdevice 21:54:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:54:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:54:25 INFO - Running setup.py install for mozfile 21:54:26 INFO - Running setup.py install for mozhttpd 21:54:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Running setup.py install for mozinfo 21:54:26 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Running setup.py install for mozInstall 21:54:26 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Running setup.py install for mozleak 21:54:26 INFO - Running setup.py install for mozlog 21:54:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Running setup.py install for moznetwork 21:54:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Running setup.py install for mozprocess 21:54:26 INFO - Running setup.py install for mozprofile 21:54:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:54:26 INFO - Running setup.py install for mozrunner 21:54:27 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:54:27 INFO - Running setup.py install for mozscreenshot 21:54:27 INFO - Running setup.py install for moztest 21:54:27 INFO - Running setup.py install for mozversion 21:54:27 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:54:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:54:27 INFO - Cleaning up... 21:54:27 INFO - Return code: 0 21:54:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:27 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 21:54:27 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 21:54:27 INFO - Using env: {'DISPLAY': ':0', 21:54:27 INFO - 'HOME': '/home/cltbld', 21:54:27 INFO - 'LANG': 'en_US.UTF-8', 21:54:27 INFO - 'LANGUAGE': 'en_US:en', 21:54:27 INFO - 'LOGNAME': 'cltbld', 21:54:27 INFO - 'MAIL': '/var/mail/cltbld', 21:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:27 INFO - 'MOZ_NO_REMOTE': '1', 21:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:27 INFO - 'NO_EM_RESTART': '1', 21:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:27 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:27 INFO - 'SHELL': '/bin/bash', 21:54:27 INFO - 'SHLVL': '1', 21:54:27 INFO - 'TERM': 'linux', 21:54:27 INFO - 'TMOUT': '86400', 21:54:27 INFO - 'USER': 'cltbld', 21:54:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:27 INFO - '_': '/tools/buildbot/bin/python'} 21:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:27 INFO - Running setup.py (path:/tmp/pip-3A3vMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:27 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)) 21:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:27 INFO - Running setup.py (path:/tmp/pip-AjbF8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:27 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)) 21:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:27 INFO - Running setup.py (path:/tmp/pip-DVKCKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:27 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)) 21:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:27 INFO - Running setup.py (path:/tmp/pip-CLpU38-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:27 INFO - Running setup.py (path:/tmp/pip-rBqjfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:27 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)) 21:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:27 INFO - Running setup.py (path:/tmp/pip-t7sUVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:28 INFO - Running setup.py (path:/tmp/pip-nWK7Vn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:28 INFO - Running setup.py (path:/tmp/pip-an5_hR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:28 INFO - Running setup.py (path:/tmp/pip-8QVPDW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:28 INFO - Running setup.py (path:/tmp/pip-TwxLzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:28 INFO - Running setup.py (path:/tmp/pip-Gz0xuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:28 INFO - Running setup.py (path:/tmp/pip-08SEda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:28 INFO - Running setup.py (path:/tmp/pip-cUl7QK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:28 INFO - Running setup.py (path:/tmp/pip-6qvl_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:28 INFO - Running setup.py (path:/tmp/pip-aimE8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:28 INFO - Running setup.py (path:/tmp/pip-SrKLCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:28 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)) 21:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:28 INFO - Running setup.py (path:/tmp/pip-h_Thu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:28 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)) 21:54:28 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)) 21:54:28 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)) 21:54:28 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)) 21:54:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:54:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:54:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:54:28 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 21:54:28 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 21:54:28 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 21:54:28 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 21:54:28 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 21:54:28 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 21:54:30 INFO - Downloading blessings-1.5.1.tar.gz 21:54:30 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 21:54:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:54:30 INFO - Installing collected packages: blessings 21:54:30 INFO - Running setup.py install for blessings 21:54:31 INFO - Successfully installed blessings 21:54:31 INFO - Cleaning up... 21:54:31 INFO - Return code: 0 21:54:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:54:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:31 INFO - Reading from file tmpfile_stdout 21:54:31 INFO - Current package versions: 21:54:31 INFO - argparse == 1.2.1 21:54:31 INFO - blessings == 1.5.1 21:54:31 INFO - blobuploader == 1.2.4 21:54:31 INFO - docopt == 0.6.1 21:54:31 INFO - manifestparser == 1.1 21:54:31 INFO - mozInstall == 1.12 21:54:31 INFO - mozcrash == 0.16 21:54:31 INFO - mozdebug == 0.1 21:54:31 INFO - mozdevice == 0.47 21:54:31 INFO - mozfile == 1.2 21:54:31 INFO - mozhttpd == 0.7 21:54:31 INFO - mozinfo == 0.9 21:54:31 INFO - mozleak == 0.1 21:54:31 INFO - mozlog == 3.1 21:54:31 INFO - moznetwork == 0.27 21:54:31 INFO - mozprocess == 0.22 21:54:31 INFO - mozprofile == 0.28 21:54:31 INFO - mozrunner == 6.11 21:54:31 INFO - mozscreenshot == 0.1 21:54:31 INFO - mozsystemmonitor == 0.0 21:54:31 INFO - moztest == 0.7 21:54:31 INFO - mozversion == 1.4 21:54:31 INFO - psutil == 3.1.1 21:54:31 INFO - requests == 1.2.3 21:54:31 INFO - wsgiref == 0.1.2 21:54:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54: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')]} 21:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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')]} 21:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:31 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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:31 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 21:54:31 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 21:54:31 INFO - Using env: {'DISPLAY': ':0', 21:54:31 INFO - 'HOME': '/home/cltbld', 21:54:31 INFO - 'LANG': 'en_US.UTF-8', 21:54:31 INFO - 'LANGUAGE': 'en_US:en', 21:54:31 INFO - 'LOGNAME': 'cltbld', 21:54:31 INFO - 'MAIL': '/var/mail/cltbld', 21:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:31 INFO - 'MOZ_NO_REMOTE': '1', 21:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:31 INFO - 'NO_EM_RESTART': '1', 21:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:31 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:31 INFO - 'SHELL': '/bin/bash', 21:54:31 INFO - 'SHLVL': '1', 21:54:31 INFO - 'TERM': 'linux', 21:54:31 INFO - 'TMOUT': '86400', 21:54:31 INFO - 'USER': 'cltbld', 21:54:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:31 INFO - '_': '/tools/buildbot/bin/python'} 21:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 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)) 21:54:31 INFO - Cleaning up... 21:54:31 INFO - Return code: 0 21:54:31 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:54: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')]} 21:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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')]} 21:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:31 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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:31 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 21:54:31 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 21:54:31 INFO - Using env: {'DISPLAY': ':0', 21:54:31 INFO - 'HOME': '/home/cltbld', 21:54:31 INFO - 'LANG': 'en_US.UTF-8', 21:54:31 INFO - 'LANGUAGE': 'en_US:en', 21:54:31 INFO - 'LOGNAME': 'cltbld', 21:54:31 INFO - 'MAIL': '/var/mail/cltbld', 21:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:31 INFO - 'MOZ_NO_REMOTE': '1', 21:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:31 INFO - 'NO_EM_RESTART': '1', 21:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:31 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:31 INFO - 'SHELL': '/bin/bash', 21:54:31 INFO - 'SHLVL': '1', 21:54:31 INFO - 'TERM': 'linux', 21:54:31 INFO - 'TMOUT': '86400', 21:54:31 INFO - 'USER': 'cltbld', 21:54:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:31 INFO - '_': '/tools/buildbot/bin/python'} 21:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:32 INFO - Downloading/unpacking jsonschema 21:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:54:33 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 21:54:33 INFO - Downloading/unpacking functools32 (from jsonschema) 21:54:33 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 21:54:33 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 21:54:33 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 21:54:33 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 21:54:33 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 21:54:33 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 21:54:34 INFO - Downloading functools32-3.2.3-2.tar.gz 21:54:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:54:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:54:34 INFO - warning: no files found matching '*.txt' 21:54:34 INFO - no previously-included directories found matching 'build' 21:54:34 INFO - no previously-included directories found matching 'dist' 21:54:34 INFO - no previously-included directories found matching '.git*' 21:54:34 INFO - Installing collected packages: jsonschema, functools32 21:54:34 INFO - Running setup.py install for functools32 21:54:34 INFO - warning: no files found matching '*.txt' 21:54:34 INFO - no previously-included directories found matching 'build' 21:54:34 INFO - no previously-included directories found matching 'dist' 21:54:34 INFO - no previously-included directories found matching '.git*' 21:54:34 INFO - Successfully installed jsonschema functools32 21:54:34 INFO - Cleaning up... 21:54:34 INFO - Return code: 0 21:54:34 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:54:34 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')]} 21:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:34 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')]} 21:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:34 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 0x7f216e21cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', '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 21:54:34 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 21:54:34 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 21:54:34 INFO - Using env: {'DISPLAY': ':0', 21:54:34 INFO - 'HOME': '/home/cltbld', 21:54:34 INFO - 'LANG': 'en_US.UTF-8', 21:54:34 INFO - 'LANGUAGE': 'en_US:en', 21:54:34 INFO - 'LOGNAME': 'cltbld', 21:54:34 INFO - 'MAIL': '/var/mail/cltbld', 21:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:34 INFO - 'MOZ_NO_REMOTE': '1', 21:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:34 INFO - 'NO_EM_RESTART': '1', 21:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:34 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:34 INFO - 'SHELL': '/bin/bash', 21:54:34 INFO - 'SHLVL': '1', 21:54:34 INFO - 'TERM': 'linux', 21:54:34 INFO - 'TMOUT': '86400', 21:54:34 INFO - 'USER': 'cltbld', 21:54:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:34 INFO - '_': '/tools/buildbot/bin/python'} 21:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:34 INFO - Downloading/unpacking flake8 21:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:54:36 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 21:54:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:54:36 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 21:54:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:54:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:54:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:54:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:54:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:54:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:54:36 INFO - no previously-included directories found matching 'docs/_build' 21:54:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:54:37 INFO - Running setup.py install for pep8 21:54:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:54:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:54:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:54:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:54:37 INFO - no previously-included directories found matching 'docs/_build' 21:54:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:54:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:54:37 INFO - Cleaning up... 21:54:37 INFO - Return code: 0 21:54:37 INFO - Running post-action listener: _resource_record_post_action 21:54:37 INFO - Running post-action listener: _start_resource_monitoring 21:54:37 INFO - Starting resource monitoring. 21:54:37 INFO - ##### 21:54:37 INFO - ##### Running install step. 21:54:37 INFO - ##### 21:54:37 INFO - Running pre-action listener: _resource_record_pre_action 21:54:37 INFO - Running main action method: install 21:54:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:37 INFO - Reading from file tmpfile_stdout 21:54:37 INFO - Detecting whether we're running mozinstall >=1.0... 21:54:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:54:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:54:37 INFO - Reading from file tmpfile_stdout 21:54:37 INFO - Output received: 21:54:37 INFO - Usage: mozinstall [options] installer 21:54:37 INFO - Options: 21:54:37 INFO - -h, --help show this help message and exit 21:54:37 INFO - -d DEST, --destination=DEST 21:54:37 INFO - Directory to install application into. [default: 21:54:37 INFO - "/builds/slave/test-pgo"] 21:54:37 INFO - --app=APP Application being installed. [default: firefox] 21:54:37 INFO - mkdir: /builds/slave/test-pgo/build/application 21:54:37 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'] 21:54:37 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 21:54:53 INFO - Reading from file tmpfile_stdout 21:54:53 INFO - Output received: 21:54:53 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:54:53 INFO - Running post-action listener: _resource_record_post_action 21:54:53 INFO - ##### 21:54:53 INFO - ##### Running run-tests step. 21:54:53 INFO - ##### 21:54:53 INFO - Running pre-action listener: _resource_record_pre_action 21:54:53 INFO - Running main action method: run_tests 21:54:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:54:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:54:53 INFO - Python 2.7.3 21:54:53 INFO - Return code: 0 21:54:53 INFO - grabbing minidump binary from tooltool 21:54: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')]} 21:54:53 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 0x21ea7f0>, '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 0x21562d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2156760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:54:53 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 21:54:53 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 21:54:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:54:53 INFO - Return code: 0 21:54:53 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:54:53 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:54:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:54:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:54:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:54:54 INFO - Return code: 0 21:54:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 21:54:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 21:54:54 INFO - Using env: {'DISPLAY': ':0', 21:54:54 INFO - 'HOME': '/home/cltbld', 21:54:54 INFO - 'LANG': 'en_US.UTF-8', 21:54:54 INFO - 'LANGUAGE': 'en_US:en', 21:54:54 INFO - 'LOGNAME': 'cltbld', 21:54:54 INFO - 'MAIL': '/var/mail/cltbld', 21:54:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:54 INFO - 'MOZ_NO_REMOTE': '1', 21:54:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:54 INFO - 'NO_EM_RESTART': '1', 21:54:54 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:54 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:54:54 INFO - 'SHELL': '/bin/bash', 21:54:54 INFO - 'SHLVL': '1', 21:54:54 INFO - 'TERM': 'linux', 21:54:54 INFO - 'TMOUT': '86400', 21:54:54 INFO - 'USER': 'cltbld', 21:54:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176', 21:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:54 INFO - '_': '/tools/buildbot/bin/python'} 21:54:54 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:54:54 INFO - mozversion application_buildid: 20160110193521 21:54:54 INFO - mozversion application_changeset: 5c34826911da061621bfa8fd2b5c50bfb35176e3 21:54:54 INFO - mozversion application_display_name: Nightly 21:54:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:54:54 INFO - mozversion application_name: Firefox 21:54:54 INFO - mozversion application_remotingname: firefox 21:54:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:54:54 INFO - mozversion application_vendor: Mozilla 21:54:54 INFO - mozversion application_version: 46.0a1 21:54:54 INFO - mozversion platform_buildid: 20160110193521 21:54:54 INFO - mozversion platform_changeset: 5c34826911da061621bfa8fd2b5c50bfb35176e3 21:54:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:54:54 INFO - mozversion platform_version: 46.0a1 21:54:54 INFO - using testdate: 1452491694 21:54:54 INFO - actual date: 1452491694 21:54:54 INFO - starting webserver on 'localhost:57997' 21:54:54 INFO - SUITE-START | Running 3 tests 21:54:54 INFO - TEST-START | dromaeo_css 21:54:54 INFO - operating with platform_type : linux_ 21:54:54 INFO - Initialising browser for dromaeo_css test... 21:54:54 INFO - TEST-INFO | started process 18053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeT32fM/profile http://localhost:57997/getInfo.html) 21:54:58 INFO - PROCESS | 18053 | __metrics Screen width/height:1600/1200 21:54:58 INFO - PROCESS | 18053 | colorDepth:24 21:54:58 INFO - PROCESS | 18053 | Browser inner width/height: 1024/697 21:54:58 INFO - PROCESS | 18053 | __metrics 21:54:58 INFO - PROCESS | 18053 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:54:59 INFO - PROCESS | 18053 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:59 INFO - PROCESS | 18053 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 21:54:59 INFO - TEST-INFO | 18053: exit 0 21:54:59 INFO - Browser initialized. 21:54:59 INFO - Running cycle 1/1 for dromaeo_css test... 21:54:59 INFO - TEST-INFO | started process 18149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeT32fM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:11 INFO - PROCESS | 18149 | RSS: Main: 148373504 21:55:11 INFO - PROCESS | 18149 | 21:56:02 INFO - PROCESS | 18149 | 1452491762852 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] 21:58:10 INFO - PROCESS | 18149 | Cycle 1(1): loaded http://localhost:57997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57997/tests/dromaeo/cssquery-ext.html) 21:58:12 INFO - PROCESS | 18149 | RSS: Main: 299261952 21:58:12 INFO - PROCESS | 18149 | 22:01:14 INFO - PROCESS | 18149 | Cycle 1(1): loaded http://localhost:57997/tests/dromaeo/cssquery-ext.html (next: http://localhost:57997/tests/dromaeo/cssquery-jquery.html) 22:01:15 INFO - PROCESS | 18149 | RSS: Main: 239235072 22:01:15 INFO - PROCESS | 18149 | 22:04:17 INFO - PROCESS | 18149 | Cycle 1(1): loaded http://localhost:57997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57997/tests/dromaeo/cssquery-mootools.html) 22:04:17 INFO - PROCESS | 18149 | RSS: Main: 235409408 22:04:17 INFO - PROCESS | 18149 | 22:07:19 INFO - PROCESS | 18149 | Cycle 1(1): loaded http://localhost:57997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57997/tests/dromaeo/cssquery-prototype.html) 22:07:20 INFO - PROCESS | 18149 | RSS: Main: 216993792 22:07:20 INFO - PROCESS | 18149 | 22:10:22 INFO - PROCESS | 18149 | Cycle 1(1): loaded http://localhost:57997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57997/tests/dromaeo/cssquery-yui.html) 22:10:23 INFO - PROCESS | 18149 | RSS: Main: 220307456 22:10:23 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | Cycle 1(1): loaded http://localhost:57997/tests/dromaeo/cssquery-yui.html (next: http://localhost:57997/tests/dromaeo/cssquery-dojo.html) 22:13:26 INFO - PROCESS | 18149 | RSS: Main: 262938624 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | __start_tp_report 22:13:26 INFO - PROCESS | 18149 | _x_x_mozilla_page_load 22:13:26 INFO - PROCESS | 18149 | _x_x_mozilla_page_load_details 22:13:26 INFO - PROCESS | 18149 | |i|pagename|runs| 22:13:26 INFO - PROCESS | 18149 | |0;dojo.html;3066.1568068781085;3143.654198038214;3184.219866132796;3192.968070319296;3206.8396580170984;4984.401871775383;5093.567046801027;5118.0275747607975;5120.6671566348205;5167.147420675588;4993.900121997558;4997.575206107476;5081.618878584111;5131.538161565459;5209.400918894328;4601.309803529472;4619.330197121415;4627.930581041287;4658.673892827504;4697.365855609501;528.3185785832549;4601.7699115044115;4615.492295847454;4708.529147085281;4731.266653668687;4615.699979501322;4625.306204069383;4689.038747056845;4713.9057218855605;4715;4678.345031695565;4701.905961880743;4708.670393072486;4712.764361781931;4736.455307639631;4565.338025986247;4687.250039993619;4689.132510485571;4705.505921878222;4759.881002974918;4912.975435122801;4914.975425122887;4928.975355123237;4993.101241776479;5005.674631148963;5359.410464848903;5372.435894231088;5374.91937620936;5387.973060134714;5414.377346605152;5321.228421878806;5408.35099788024;5408.756605952703;5414.242006119146;5420.295361602966;5004.124278251292;5128.512791284822;5190.870228244286;5193.454687257859;5208.7916483341;5532.806351777749;5540;5542.667439953616;5547.223388725582;5591.329040515083;5253.527182553588;5323.680579165262;5330.067238233293;5335.786568537215;5353.9196912046355;5323.3611966563485;5436.40199578054;5518.19986102021;5520.503154716095;5563.693996830213;5436.29328187341;5451.373092094381;5454.863628409322;5454.972725136349;5455.0453670607485;5284.233786100994;5379.004884096376;5433.185022246695;5449.700266485382;5501.394846566875;4235.110626768414;4249.596288352602;4276.615104640598;4281.593248641374;4311.978440107842;3822.522184726909;3826.3686491728554;3843.365844635604;3847.3844184930276;3875.806209689504;4927.482614325516;4965.82619608312;5020.397552293748;5035.899282014339;5108.361454818148;5340.786368545292;5452.5365343946205;5489.505944465017;5495.258140151109;5543.279373681396;4963.6277279204205;4967.652264341534;4977.701337919736;4979.103761322925;5011.123053465629;4589.403377560896;4598.701084429501;4617.907641847144;4620.353150558924;4710.3405523226775;5489.451054894478;5541.806036788774;5592.133219351089;5596.10462326034;5638.182463542763;5380.166074258496;5414.458554144554;5424.918626220531;5428.212909128233;5428.56571474289;5440.455954404686;5566.721663916707;5569.053260945568;5577.74900129487;5627.43725627434;5332.280142180756;5346.545543628835;5384.273123128484;5400.135978243619;5427.402985671494;5376.166694162411;5397.946020539902;5402.027635025733;5410.621256512007;5411;5191.506806853343;5283.8679033022945;5299.364076310867;5304.416514183359;5340.652857564246;5238.5023422774775;5320.920186197288;5392.865178370415;5420.349558053059;5443;5254.5533629641905;5277.656952298088;5284.471552844685;5294.311739473844;5305.867353316198;5334.78660853577;5381.515663590296;5393.110136827379;5399.973000134974;5420.295361602966;5073.264376665289;5253.789848406021;5265;5341.7062061586985;5361.410244873139 22:13:26 INFO - PROCESS | 18149 | |1;ext.html;527.7229454536365;533.6024661627088;537.3605409562621;551.9558435325174;556.7188569772266;28408.72160752766;29170.708292917065;29179.416411671755;29183.562246566293;29191;29164.416711665806;29643;29668.10995670128;36884.81557592215;38576.228475430544;8511.489310641366;8659.913400865973;8677.219050285474;8684.088170742076;8690.304775617935;8384.706535271267;8586.87119693205;8590.957045214765;8595.312375009984;8595.871061934076;7695.692172313101;7899.28906398424;7904.644291006918;10242.692719218436;10479.266451348409;9987;10097.293189476739;10099.444530550816;10106.140978016803;10107.140893024101;7620.542767433972;9992.400455972665;10169.288149829516;10173.237007224488;10176.491175441199;29352.559711604343;39830.60169398327;40804;40848.59151408478;40918.79540602278;2993.625796775403;3056.2512184514712;3074.969250307513;3160.8261545614982;3214.758893083028;26192.8690356547;27412.588811167847;27483.45033099327;27651.03221387262;28395.716042839515;3648.890533284006;3697.8335974880924;3701.925961480755;3751.4747935289083;3761.5110035695184;182379.93820679715;183433;183491;183650;183662;55454.72272638611;55814.441855580924;55826;55846;55848.72075639677;58297.708511457175;58723;58789;59149.40850591525;59215.70392148098;15484;15613.84386156124;15743.763843542127;15815.288312025987;15835.841641583667;12077.335746534025;12104.273743575413;12126.272423654433;12132;12134.029277657766;18775.091993714388;19209.231630734892;19274.903625481784;19275.807241927683;19376.612467750565;7330.157031941289;7688.077430708351;7711.884321735179;7731.845363092819;7737.342325902361;998.6205242007991;1045.137761346892;1081.659277327655;1118.2842980492492;1122.646366394583;28597.85701071481;28751.85624071908;28765.85617071943;29009.274768130967;29135.562966555517;1003.4631472162504;1055.551390658967;1062.559037999237;1097.8133717268083;1168.894799468035;13418.329083545783;13604.65988350299;13808.17150970945;13829.51596694111;13861.930690346686;314966;324694;325109;325876;326579;46836.531634683895;46951.765241173576;47122.5287747125;47161.52838471571;47224.05551889012;1326.7810811216234;1346.602752188107;1357.4773712120707;1364.3382959264748;1369.582277405381;24782.50434991254;26448.338791529597;26554.734452655226;26652.333691657863;26782.464350712486;37852.24295514129;41818.58181418147;42699.359509608;46763.766181168874;48053.51946480491;205643;205678;206378;206890;206991;27243.455130897666;28642.71357286484;28853;29014.709852902044;29021.85489072541;31190.844045779624;33465.49801752927;37204;39678;41448.37827432651;32716.345673086882;36118;37297.440538391405;37847.2430551393;38110.428343575426;36608.81695591505;36617.267654646224;37084.81457592803;37298.25403491969;37543.81228093842;35611.82194089013;36450.8177459111;36461.45307820332;36535.81732091322;36593.45109823302;29458.558121627764;30274.24314392158;32227.838860805547;32333.676663233065;32540.83729581337;24266.757332427154;24395.39011524655;24485.387865302797;24486.75513244845;24763.50472990494 22:13:26 INFO - PROCESS | 18149 | |2;jquery.html;348.4598871748789;355.05783364993476;355.1777634775496;355.443730561671;356.09906935453296;12842.422091005903;13243.801342979863;15929.283182256797;16212;16513.009219446827;14796.55610331689;14849.703005939875;16195.109268990202;16364.754528682079;16380.262888170031;4987.825426110077;5117.334746482952;5232.3459567554055;5275.525202731754;5275.683458992473;3894.922101557967;3970.404439334094;5222.4255331913455;5446.91829622556;5761.971190144064;5028.974855125737;5679.346875109374;5709.8572535686735;5730.398308177644;5730.656160630376;5136.64043516954;5153.3558305211845;5167.069927413064;5169.483051694838;5171.456997015315;5057.848264552069;5345.812896548602;5353.0899747043095;5359.196120581905;5360.463953604608;11945.343006134659;12029.57896473628;18759.906200469046;19205.13576889043;19324.516887077796;2041.806028427297;2055.7738648748627;2092.665173572221;2101.464126647695;2203.6143674856994;9678.322517423783;9908.752281193028;10242.334248273839;11515.712107197387;13026.674333141653;1736.5658585353663;1794.55136215946;1811.5199472139893;1823.7264410338423;1825.196913358118;52135.47864521344;53496.46503534954;54592;54733.45266547323;54768.17847732287;9371.344005919656;9607.759806004766;9807.558659860324;9818.852717209247;9908.950455247821;12707.30109843949;12730.363481825872;12773.361331933365;12815.679608009874;12830.486780528674;7353.0441042664115;7399.630018499053;7401.370883474858;7403.481756277009;7461.253874612604;7271.67277472515;7295.539729199724;7340.4861659684375;7365.121893917124;7372.410207183412;3979.1047014421524;4239.427677263591;4248.447701798808;4267.914641707149;4294.506131794821;1588.602849287678;1620.473346162502;1622.3105180298326;1631.3882294139698;1638.5903524118971;859.8015382776063;862.5988915154484;888;898.9820203595891;993.5578667492896;13355.117213262116;16223.837761622233;16490.422835200712;16517.33930642785;16867;903.223228023899;905.171767832426;936.9765755856022;939.0140352629711;996.8454889492141;9169.312301577409;9458.432494050241;9493.145616894513;9512.667056652985;9619.90380096204;471501;478411;478871;482452;504065;41981.79009104996;60639;61615.69192154011;63192;67431;1117.7038084907506;1149.8620165580016;1162.7674465107013;1165.9883401166048;1169.5438778876414;14973;15056;15272.923635381752;15284.235788210322;15514.069155850684;32163.35673286568;32588.348233035682;32894.1776455581;33213;33592.83203584064;42902;43172.56827431686;44432.33351499665;45258.77370613126;45506.54493455155;6994.685239164148;7183.676734547063;7383.15093764224;7447.813804654927;7451.143118541437;10401.959804019538;10705.839412408975;10731.356118632906;10803.135749140207;11273.267237629529;7515.24847515266;8692.391532592657;9066.818663626558;9159;9397.389169703947;9101.135392137736;9243.445393276425;9282.118198771106;9541.141297283279;9643.855342169732;3298.620658624289;3942.8619998299923;7039.782468522399;7825.139234684294;9003.684871029482;7394.2975417335265;7458.776236712907;7485;7569.432292578189;7602.277783610548;7029.648517574203;7118.359347658528;7275.272472752894;7309.159446663489;7466.887996679946 22:13:26 INFO - PROCESS | 18149 | |3;mootools.html;1258.7167887225369;1441.870231679149;1446.233496246989;1603.3105764521251;1802.2340505285251;6813.625250611214;7535.773926782198;7644.350230230423;7664.1952594977565;7667.808304792383;7546.169921308666;7709.267619576131;7709.884351734729;7711.922880771191;7742.5354478731315;2014.143988804752;2061.845361597886;2268.4669102760836;2307.538492301542;2335.182686059874;2369.8104151667912;2375.6199008158696;2376.0970831084164;2377.988110059447;2379.4527258730504;2246.8202543796456;2304.781045800646;2305.4812667149927;2306.9077236910503;2307.3654744945106;2303.7120359955006;2337.8947947342326;2351.5179388225374;2355.128602417117;2357.964630530543;2278.851874628144;2286.5998450271304;2321.6285394336824;2327.057541695616;2344.7303560090636;7833.255840695125;7869.173736757615;7890.56601886896;7892.56590887501;7906.604669766489;4713.316569097496;4861.951380486221;4881.560659540658;4887.804487820483;4888.73111978841;2981.3292009297734;3064.862081206351;3065.080475857234;3073.9077827665205;3093.938121237585;933.8319102561536;943.9952800236024;958.228625956105;960.4813400763649;988.5403287471288;10728.249022568423;10729.141668666489;10730.678079657622;10738.624148154777;10751.623693170779;4444.444444444444;4497.8425755098415;4535.092981403733;4543.772811359485;4569.81720731167;9265.72202833916;9268.119528644767;9277.072292770668;9286.72139835806;9286.95356523213;4864.854054378375;4872.1717308057005;4904.558589726942;4909.656324057353;4915.18899381598;4445.777711114496;4453.554644535585;4455.997400584843;4456.509783923766;4459.576340247671;3432.811195384228;3500.7724497907557;3501.299740052;3688.114852435396;3759.755615884959;1183.9526418943146;1207.0886480707186;1212.5149940023884;1216.154772433168;1217.6286232699113;991.5092029445326;997.4962643864802;997.6109317366233;1109.6948339206622;1341.436596629418;7237.348638622444;7244.38422734063;7258.3104605062435;7268.055152830098;7268.382187514015;1189.601483503019;1209.238179946628;1225.154643296123;1237.7029512916836;1251.874812518759;5759.280089988752;5762.942370576325;5835.79574714883;5840.766369345263;5846.824595262149;8661.913380866237;8883.822323553493;8959.238464730572;8965.910340896507;9001.459912405277;8884.555772211364;8899.73300800977;9033.909660903308;9035.367524273237;9098;6909;7343.008693826372;7384;7414.406847452191;7414.666340014713;7048.647567621701;7081.150261968597;7100.822479438056;7117.288271172842;7127.643617819192;8502.914970850212;8503.1921967413;8576.485410875368;8719.738407847775;8751.912480875364;8683.305335573265;8741.606627701642;8765.649374024968;8899.288056955558;8929.73210803677;6692.130023097161;6788.9660551696925;6796.558223715443;6797.28628494001;6803.965980170067;6644.302348253557;6767.221769496571;7135.072440582691;7360.300771426706;7364.410847132323;6802.93197068023;6908.5509441888125;6999;7042.542234754929;7049.7885063448175;6737.898931515933;6797.048413222054;6801.081853949653;6906.689198986158;6919.654017299014;6646.667666616553;6679.265280819203;6686.431653309523;6703.061571379913;6714.395704386433;6070.696465176812;6104.664243466652;6154.1999540059505;6156.353582873913;6169.198004259418;6255.186825712628;6306.2747784003595;6306.684665766602;6306.873862522632;6356.396142366468 22:13:26 INFO - PROCESS | 18149 | |4;prototype.html;327.6068717538954;334.9866005359786;336.9983150084249;340.65763907273185;347.9860805567777;5849.356570777211;5909.409059094094;5957.463828255456;6017.819465416039;6051.485623721989;5728.68492232927;5904;5904.0553511438175;5914.053751399777;5921.082232254007;4555.5899969002785;4556.863294101166;4560.0879824035155;4563.817447302113;4570.291604801261;4395.252807022814;4468.218061839165;4474.664400170001;4532.818687252506;4572.634189264851;4449.288113901776;4527.117212143633;4530.614897733697;4550.817967281305;4556.225441674923;4517.661175411858;4527.569880861296;4528;4539.795709193094;4557.384753058344;4010.458588090629;4017.5781542938157;4054.412110243998;4058.168075544536;4058.3303754880703;5497.532709719679;5637.774489020475;5645.01212287848;5656.264685590888;5659.349174844904;5329.973350133225;5332.813351532716;5349.786008559653;5381.596380271495;5384.91922621161;6005.369436209223;6384.776532821329;6387.904181437282;6393.456556192729;6397.9360206397805;4353.651707863363;4371.9781401093105;4472.731636101812;4481.574250446202;4483.843065492725;6521.282658907564;6618.073469714292;6618.801435956881;6624.635645039521;6627.73489060437;4593.425821772278;4612.976935115303;4615.561521655437;4617.468991066004;4620.0528891577815;4516.006478574708;4661.207594708908;4674.0885527322525;4684.4378674559275;4708.95291047092;5349;5350.678959262456;5351.1973204019705;5354.678719276778;5355.062863998784;6394.26465956421;6401.423871851555;6404.199475065617;6406.263279722798;6407.519436042316;1618.6924484347937;1657.1631326180202;1658.461000174948;1659.1123748794337;1660.7924009498813;1105.8120119579692;1121.5513794482108;1124.6288724720823;1128.9548418063187;1149.6091328948198;5844.561657875676;5966.134910437962;5969.432903874125;5975.820725378246;5976.551758618121;6441.838954026187;6450.870982580323;6451.258105317855;6452.677366131675;6457.547971642034;5812;5893.057110862242;5920.2007728956905;5920.2007728956905;5928.644281343047;3461.428864237423;3492.511048453219;3494.545709057806;3498.5976612689356;3501.2647344057523;6610.735570577123;6623.768168114093;6632.867342653217;6643.701033453506;6647.468202543785;6620.3710647488415;6630.900536491957;6636.170478690164;6641.003849422528;6646.534742567974;6430.131932189188;6556.311587283267;6591.439727623206;6619;6624.436922861514;6331.2085989251345;6374.58565193261;6432.581882177644;6453.09656648079;6504;6461.870762584816;6479.5788273762055;6494.253160886558;6505.577137486048;6510.088587597835;6715.597064176165;6722.361375669304;6730.562513436611;6732.596044237165;6740.898886516804;4519.728816271035;4601.539846015372;4615.630749540096;4615.953840461687;4619.422572178478;6562.34376562359;6562.5406221564035;6563.671816409065;6572.737090516517;6574.211094668479;6355.586886852339;6360.554761166674;6392.520560957853;6398.616083035033;6399.072134540559;6211.16149319836;6361.809145725636;6370.4903607712195;6371.076193951943;6375.936240637534;6242.344553821965;6243.469305109116;6253.687315634109;6253.749850005949;6257.4994000480765;6381.489480841428;6383.265924418752;6394.808155755149;6395.552311338161;6404;6071;6224;6243.157173781481;6247.875042499034;6308.053791931247 22:13:26 INFO - PROCESS | 18149 | |5;yui.html;752.924707529247;842.1115722912325;845.71245776436;849.1254008371372;853.8591132463146;12990.090693651448;13056.543020994244;13063;13091.60725178245;13094.410751516181;11044.613438529654;12416.627501174979;12435.564755233569;12441.626751197478;12520.186187897803;650.3236633900749;800.6797281087582;808.7129069180445;818.3616778912458;818.3780326951501;794.4399198565027;798.5009369144285;799.6361655446786;800.2077942836609;803.2168635580321;688.0607970120799;695.3533214110874;846.3609974469267;853.8676505141682;853.9146085391474;833.995830020852;837.7863644770575;846.6613354658125;848.2874385516135;850.8511010573187;627.4791922704145;628.3936001758325;628.8522197283635;629.8173529676388;630.1398590923402;11857.229280096766;12186.695332616755;12194.573189938399;12198.695032624166;12235.571754988621;12677.239365638092;12944.676383090404;13035.804462933063;13211.801822972662;13217.273049982246;10059.195264378832;10137.290389672726;10166.745831354201;10862.782744345148;10951.83572246417;3611.0791748104066;3679.7056235501095;3691.151035261905;3776.8866933992026;3784.2053168834577;42316.36525452121;42438.78780606108;42737.35893961562;42833.35749963753;42953;9269.860952085724;9606.471644059504;9612;10003.399796012263;10230.079292863678;17308.82691173072;17547.912260438618;17588.296468141132;17609.911950440164;17610.559736006704;7396.482246242711;7627.580483073484;7652.502587331805;7674.6930122794465;7752.806179845436;4308.763018033976;4325.416068830667;4334.13317336534;4339.956600434019;4410;3072.2472994116583;3094.798838075563;3109.5802066721158;3111.9066428007195;3114.828684422333;590.3034419385167;603.6649659439054;610.008735804318;611.9632822030692;621.564904566805;538.3889285660803;558.488982580942;581.4360070731384;628.0767272109991;639.4852144024105;7695.461317707706;8060;8127.3904457165945;8195.7951051223;8306.70926517569;586.5366360575098;621.5711159300068;642.6401215319436;648.3678413546754;653.3074940563018;3725.701943844486;3777.0731658831182;3881.437191607201;3922.764634121962;4072.4095006224525;56442;56507.43492565104;56670.716646416506;57352.713236434385;58677.70661146667;49114;49550;49872.50127498679;49975;50257;44647.77676111599;44876.775616122366;44974.77512612481;44975.55024449779;45262.09475810531;7631.656575454007;7744.341730952932;7869.921300786918;7933.444658873824;8022.077461091816;32131.377009023796;32975.34049318952;33216.83391583123;34077.48883766795;34394.82802586071;38212.42681359726;39086;39333.21333573255;40914.795426022676;44269.778651106535;10352.275340726077;10503.684889453329;10783.299085559414;10804.189013550129;10857.782844343226;11543.653690389301;11561.826572601585;11664.416779160838;12036.963826843043;12341.321227332583;11280.32318060919;11405.372704501333;11450.198486105892;11463.426828658701;11475.254108482923;10720.303180293256;10732.302400343953;10762.246642734934;10817.18871084656;11128.332300062022;10377.896221037692;10430.53062612169;10430.947845260725;10480.318779279323;10491.213159012952;9097.1812536872;9169.220616247427;9238.491882946502;9417.623295068395;9560.713178604654;9558.66544670961;9948.850767238353;9950.303478756417;9955;9958.203343732339 22:13:26 INFO - PROCESS | 18149 | __end_tp_report 22:13:26 INFO - PROCESS | 18149 | __start_cc_report 22:13:26 INFO - PROCESS | 18149 | _x_x_mozilla_cycle_collect,991 22:13:26 INFO - PROCESS | 18149 | __end_cc_report 22:13:26 INFO - PROCESS | 18149 | __startTimestamp1452492806302__endTimestamp 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | ------- Summary: start ------- 22:13:26 INFO - PROCESS | 18149 | Number of tests: 6 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | [#0] dojo.html Cycles:165 Average:5031.69 Median:528.32 stddev:632.96 (119.8%) stddev-sans-first:615.84 22:13:26 INFO - PROCESS | 18149 | Values: 3066.2 3143.7 3184.2 3193.0 3206.8 4984.4 5093.6 5118.0 5120.7 5167.1 4993.9 4997.6 5081.6 5131.5 5209.4 4601.3 4619.3 4627.9 4658.7 4697.4 528.3 4601.8 4615.5 4708.5 4731.3 4615.7 4625.3 4689.0 4713.9 4715.0 4678.3 4701.9 4708.7 4712.8 4736.5 4565.3 4687.3 4689.1 4705.5 4759.9 4913.0 4915.0 4929.0 4993.1 5005.7 5359.4 5372.4 5374.9 5388.0 5414.4 5321.2 5408.4 5408.8 5414.2 5420.3 5004.1 5128.5 5190.9 5193.5 5208.8 5532.8 5540.0 5542.7 5547.2 5591.3 5253.5 5323.7 5330.1 5335.8 5353.9 5323.4 5436.4 5518.2 5520.5 5563.7 5436.3 5451.4 5454.9 5455.0 5455.0 5284.2 5379.0 5433.2 5449.7 5501.4 4235.1 4249.6 4276.6 4281.6 4312.0 3822.5 3826.4 3843.4 3847.4 3875.8 4927.5 4965.8 5020.4 5035.9 5108.4 5340.8 5452.5 5489.5 5495.3 5543.3 4963.6 4967.7 4977.7 4979.1 5011.1 4589.4 4598.7 4617.9 4620.4 4710.3 5489.5 5541.8 5592.1 5596.1 5638.2 5380.2 5414.5 5424.9 5428.2 5428.6 5440.5 5566.7 5569.1 5577.7 5627.4 5332.3 5346.5 5384.3 5400.1 5427.4 5376.2 5397.9 5402.0 5410.6 5411.0 5191.5 5283.9 5299.4 5304.4 5340.7 5238.5 5320.9 5392.9 5420.3 5443.0 5254.6 5277.7 5284.5 5294.3 5305.9 5334.8 5381.5 5393.1 5400.0 5420.3 5073.3 5253.8 5265.0 5341.7 5361.4 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | [#1] ext.html Cycles:180 Average:40460.65 Median:3065.61 stddev:64186.90 (2093.8%) stddev-sans-first:64296.93 22:13:26 INFO - PROCESS | 18149 | Values: 527.7 533.6 537.4 552.0 556.7 28408.7 29170.7 29179.4 29183.6 29191.0 29164.4 29643.0 29668.1 36884.8 38576.2 8511.5 8659.9 8677.2 8684.1 8690.3 8384.7 8586.9 8591.0 8595.3 8595.9 7695.7 7899.3 7904.6 10242.7 10479.3 9987.0 10097.3 10099.4 10106.1 10107.1 7620.5 9992.4 10169.3 10173.2 10176.5 29352.6 39830.6 40804.0 40848.6 40918.8 2993.6 3056.3 3075.0 3160.8 3214.8 26192.9 27412.6 27483.5 27651.0 28395.7 3648.9 3697.8 3701.9 3751.5 3761.5 182379.9 183433.0 183491.0 183650.0 183662.0 55454.7 55814.4 55826.0 55846.0 55848.7 58297.7 58723.0 58789.0 59149.4 59215.7 15484.0 15613.8 15743.8 15815.3 15835.8 12077.3 12104.3 12126.3 12132.0 12134.0 18775.1 19209.2 19274.9 19275.8 19376.6 7330.2 7688.1 7711.9 7731.8 7737.3 998.6 1045.1 1081.7 1118.3 1122.6 28597.9 28751.9 28765.9 29009.3 29135.6 1003.5 1055.6 1062.6 1097.8 1168.9 13418.3 13604.7 13808.2 13829.5 13861.9 314966.0 324694.0 325109.0 325876.0 326579.0 46836.5 46951.8 47122.5 47161.5 47224.1 1326.8 1346.6 1357.5 1364.3 1369.6 24782.5 26448.3 26554.7 26652.3 26782.5 37852.2 41818.6 42699.4 46763.8 48053.5 205643.0 205678.0 206378.0 206890.0 206991.0 27243.5 28642.7 28853.0 29014.7 29021.9 31190.8 33465.5 37204.0 39678.0 41448.4 32716.3 36118.0 37297.4 37847.2 38110.4 36608.8 36617.3 37084.8 37298.3 37543.8 35611.8 36450.8 36461.5 36535.8 36593.5 29458.6 30274.2 32227.8 32333.7 32540.8 24266.8 24395.4 24485.4 24486.8 24763.5 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | [#2] jquery.html Cycles:180 Average:25138.50 Median:5087.59 stddev:78870.05 (1550.2%) stddev-sans-first:79069.33 22:13:26 INFO - PROCESS | 18149 | Values: 348.5 355.1 355.2 355.4 356.1 12842.4 13243.8 15929.3 16212.0 16513.0 14796.6 14849.7 16195.1 16364.8 16380.3 4987.8 5117.3 5232.3 5275.5 5275.7 3894.9 3970.4 5222.4 5446.9 5762.0 5029.0 5679.3 5709.9 5730.4 5730.7 5136.6 5153.4 5167.1 5169.5 5171.5 5057.8 5345.8 5353.1 5359.2 5360.5 11945.3 12029.6 18759.9 19205.1 19324.5 2041.8 2055.8 2092.7 2101.5 2203.6 9678.3 9908.8 10242.3 11515.7 13026.7 1736.6 1794.6 1811.5 1823.7 1825.2 52135.5 53496.5 54592.0 54733.5 54768.2 9371.3 9607.8 9807.6 9818.9 9909.0 12707.3 12730.4 12773.4 12815.7 12830.5 7353.0 7399.6 7401.4 7403.5 7461.3 7271.7 7295.5 7340.5 7365.1 7372.4 3979.1 4239.4 4248.4 4267.9 4294.5 1588.6 1620.5 1622.3 1631.4 1638.6 859.8 862.6 888.0 899.0 993.6 13355.1 16223.8 16490.4 16517.3 16867.0 903.2 905.2 937.0 939.0 996.8 9169.3 9458.4 9493.1 9512.7 9619.9 471501.0 478411.0 478871.0 482452.0 504065.0 41981.8 60639.0 61615.7 63192.0 67431.0 1117.7 1149.9 1162.8 1166.0 1169.5 14973.0 15056.0 15272.9 15284.2 15514.1 32163.4 32588.3 32894.2 33213.0 33592.8 42902.0 43172.6 44432.3 45258.8 45506.5 6994.7 7183.7 7383.2 7447.8 7451.1 10402.0 10705.8 10731.4 10803.1 11273.3 7515.2 8692.4 9066.8 9159.0 9397.4 9101.1 9243.4 9282.1 9541.1 9643.9 3298.6 3942.9 7039.8 7825.1 9003.7 7394.3 7458.8 7485.0 7569.4 7602.3 7029.6 7118.4 7275.3 7309.2 7466.9 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | [#3] mootools.html Cycles:180 Average:5427.48 Median:6331.64 stddev:2777.48 (43.9%) stddev-sans-first:2767.59 22:13:26 INFO - PROCESS | 18149 | Values: 1258.7 1441.9 1446.2 1603.3 1802.2 6813.6 7535.8 7644.4 7664.2 7667.8 7546.2 7709.3 7709.9 7711.9 7742.5 2014.1 2061.8 2268.5 2307.5 2335.2 2369.8 2375.6 2376.1 2378.0 2379.5 2246.8 2304.8 2305.5 2306.9 2307.4 2303.7 2337.9 2351.5 2355.1 2358.0 2278.9 2286.6 2321.6 2327.1 2344.7 7833.3 7869.2 7890.6 7892.6 7906.6 4713.3 4862.0 4881.6 4887.8 4888.7 2981.3 3064.9 3065.1 3073.9 3093.9 933.8 944.0 958.2 960.5 988.5 10728.2 10729.1 10730.7 10738.6 10751.6 4444.4 4497.8 4535.1 4543.8 4569.8 9265.7 9268.1 9277.1 9286.7 9287.0 4864.9 4872.2 4904.6 4909.7 4915.2 4445.8 4453.6 4456.0 4456.5 4459.6 3432.8 3500.8 3501.3 3688.1 3759.8 1184.0 1207.1 1212.5 1216.2 1217.6 991.5 997.5 997.6 1109.7 1341.4 7237.3 7244.4 7258.3 7268.1 7268.4 1189.6 1209.2 1225.2 1237.7 1251.9 5759.3 5762.9 5835.8 5840.8 5846.8 8661.9 8883.8 8959.2 8965.9 9001.5 8884.6 8899.7 9033.9 9035.4 9098.0 6909.0 7343.0 7384.0 7414.4 7414.7 7048.6 7081.2 7100.8 7117.3 7127.6 8502.9 8503.2 8576.5 8719.7 8751.9 8683.3 8741.6 8765.6 8899.3 8929.7 6692.1 6789.0 6796.6 6797.3 6804.0 6644.3 6767.2 7135.1 7360.3 7364.4 6802.9 6908.6 6999.0 7042.5 7049.8 6737.9 6797.0 6801.1 6906.7 6919.7 6646.7 6679.3 6686.4 6703.1 6714.4 6070.7 6104.7 6154.2 6156.4 6169.2 6255.2 6306.3 6306.7 6306.9 6356.4 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | [#4] prototype.html Cycles:180 Average:5289.57 Median:5920.64 stddev:1571.45 (26.5%) stddev-sans-first:1531.09 22:13:26 INFO - PROCESS | 18149 | Values: 327.6 335.0 337.0 340.7 348.0 5849.4 5909.4 5957.5 6017.8 6051.5 5728.7 5904.0 5904.1 5914.1 5921.1 4555.6 4556.9 4560.1 4563.8 4570.3 4395.3 4468.2 4474.7 4532.8 4572.6 4449.3 4527.1 4530.6 4550.8 4556.2 4517.7 4527.6 4528.0 4539.8 4557.4 4010.5 4017.6 4054.4 4058.2 4058.3 5497.5 5637.8 5645.0 5656.3 5659.3 5330.0 5332.8 5349.8 5381.6 5384.9 6005.4 6384.8 6387.9 6393.5 6397.9 4353.7 4372.0 4472.7 4481.6 4483.8 6521.3 6618.1 6618.8 6624.6 6627.7 4593.4 4613.0 4615.6 4617.5 4620.1 4516.0 4661.2 4674.1 4684.4 4709.0 5349.0 5350.7 5351.2 5354.7 5355.1 6394.3 6401.4 6404.2 6406.3 6407.5 1618.7 1657.2 1658.5 1659.1 1660.8 1105.8 1121.6 1124.6 1129.0 1149.6 5844.6 5966.1 5969.4 5975.8 5976.6 6441.8 6450.9 6451.3 6452.7 6457.5 5812.0 5893.1 5920.2 5920.2 5928.6 3461.4 3492.5 3494.5 3498.6 3501.3 6610.7 6623.8 6632.9 6643.7 6647.5 6620.4 6630.9 6636.2 6641.0 6646.5 6430.1 6556.3 6591.4 6619.0 6624.4 6331.2 6374.6 6432.6 6453.1 6504.0 6461.9 6479.6 6494.3 6505.6 6510.1 6715.6 6722.4 6730.6 6732.6 6740.9 4519.7 4601.5 4615.6 4616.0 4619.4 6562.3 6562.5 6563.7 6572.7 6574.2 6355.6 6360.6 6392.5 6398.6 6399.1 6211.2 6361.8 6370.5 6371.1 6375.9 6242.3 6243.5 6253.7 6253.7 6257.5 6381.5 6383.3 6394.8 6395.6 6404.0 6071.0 6224.0 6243.2 6247.9 6308.1 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - PROCESS | 18149 | [#5] yui.html Cycles:180 Average:13214.35 Median:24339.89 stddev:15161.73 (62.3%) stddev-sans-first:15175.38 22:13:26 INFO - PROCESS | 18149 | Values: 752.9 842.1 845.7 849.1 853.9 12990.1 13056.5 13063.0 13091.6 13094.4 11044.6 12416.6 12435.6 12441.6 12520.2 650.3 800.7 808.7 818.4 818.4 794.4 798.5 799.6 800.2 803.2 688.1 695.4 846.4 853.9 853.9 834.0 837.8 846.7 848.3 850.9 627.5 628.4 628.9 629.8 630.1 11857.2 12186.7 12194.6 12198.7 12235.6 12677.2 12944.7 13035.8 13211.8 13217.3 10059.2 10137.3 10166.7 10862.8 10951.8 3611.1 3679.7 3691.2 3776.9 3784.2 42316.4 42438.8 42737.4 42833.4 42953.0 9269.9 9606.5 9612.0 10003.4 10230.1 17308.8 17547.9 17588.3 17609.9 17610.6 7396.5 7627.6 7652.5 7674.7 7752.8 4308.8 4325.4 4334.1 4340.0 4410.0 3072.2 3094.8 3109.6 3111.9 3114.8 590.3 603.7 610.0 612.0 621.6 538.4 558.5 581.4 628.1 639.5 7695.5 8060.0 8127.4 8195.8 8306.7 586.5 621.6 642.6 648.4 653.3 3725.7 3777.1 3881.4 3922.8 4072.4 56442.0 56507.4 56670.7 57352.7 58677.7 49114.0 49550.0 49872.5 49975.0 50257.0 44647.8 44876.8 44974.8 44975.6 45262.1 7631.7 7744.3 7869.9 7933.4 8022.1 32131.4 32975.3 33216.8 34077.5 34394.8 38212.4 39086.0 39333.2 40914.8 44269.8 10352.3 10503.7 10783.3 10804.2 10857.8 11543.7 11561.8 11664.4 12037.0 12341.3 11280.3 11405.4 11450.2 11463.4 11475.3 10720.3 10732.3 10762.2 10817.2 11128.3 10377.9 10430.5 10430.9 10480.3 10491.2 9097.2 9169.2 9238.5 9417.6 9560.7 9558.7 9948.9 9950.3 9955.0 9958.2 22:13:26 INFO - PROCESS | 18149 | -------- Summary: end -------- 22:13:26 INFO - PROCESS | 18149 | 22:13:26 INFO - TEST-INFO | 18149: exit 0 22:13:27 INFO - TEST-OK | dromaeo_css | took 1112035ms 22:13:27 INFO - TEST-START | kraken 22:13:27 INFO - operating with platform_type : linux_ 22:13:27 INFO - Initialising browser for kraken test... 22:13:27 INFO - TEST-INFO | started process 18335 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJM1LFu/profile http://localhost:57997/getInfo.html) 22:13:30 INFO - PROCESS | 18335 | __metrics Screen width/height:1600/1200 22:13:30 INFO - PROCESS | 18335 | colorDepth:24 22:13:30 INFO - PROCESS | 18335 | Browser inner width/height: 1024/697 22:13:30 INFO - PROCESS | 18335 | __metrics 22:13:30 INFO - PROCESS | 18335 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:13:30 INFO - PROCESS | 18335 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:13:31 INFO - TEST-INFO | 18335: exit 0 22:13:31 INFO - Browser initialized. 22:13:31 INFO - Running cycle 1/1 for kraken test... 22:13:31 INFO - TEST-INFO | started process 18414 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJM1LFu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:43 INFO - PROCESS | 18414 | RSS: Main: 149147648 22:13:43 INFO - PROCESS | 18414 | 22:13:45 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57997/tests/kraken/driver.html?testName=audio-beat-detection) 22:13:46 INFO - PROCESS | 18414 | RSS: Main: 186208256 22:13:46 INFO - PROCESS | 18414 | 22:13:48 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57997/tests/kraken/driver.html?testName=audio-dft) 22:13:49 INFO - PROCESS | 18414 | RSS: Main: 175570944 22:13:49 INFO - PROCESS | 18414 | 22:13:52 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57997/tests/kraken/driver.html?testName=audio-fft) 22:13:52 INFO - PROCESS | 18414 | RSS: Main: 160489472 22:13:52 INFO - PROCESS | 18414 | 22:13:54 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57997/tests/kraken/driver.html?testName=audio-oscillator) 22:13:55 INFO - PROCESS | 18414 | RSS: Main: 163016704 22:13:55 INFO - PROCESS | 18414 | 22:13:57 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:13:58 INFO - PROCESS | 18414 | RSS: Main: 165040128 22:13:58 INFO - PROCESS | 18414 | 22:14:01 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57997/tests/kraken/driver.html?testName=imaging-darkroom) 22:14:01 INFO - PROCESS | 18414 | RSS: Main: 164220928 22:14:01 INFO - PROCESS | 18414 | 22:14:05 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57997/tests/kraken/driver.html?testName=imaging-desaturate) 22:14:05 INFO - PROCESS | 18414 | RSS: Main: 166109184 22:14:05 INFO - PROCESS | 18414 | 22:14:08 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57997/tests/kraken/driver.html?testName=json-parse-financial) 22:14:09 INFO - PROCESS | 18414 | RSS: Main: 164282368 22:14:09 INFO - PROCESS | 18414 | 22:14:10 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:14:11 INFO - PROCESS | 18414 | RSS: Main: 177688576 22:14:11 INFO - PROCESS | 18414 | 22:14:13 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:14:13 INFO - PROCESS | 18414 | RSS: Main: 174620672 22:14:13 INFO - PROCESS | 18414 | 22:14:15 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:14:16 INFO - PROCESS | 18414 | RSS: Main: 182726656 22:14:16 INFO - PROCESS | 18414 | 22:14:18 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:14:19 INFO - PROCESS | 18414 | RSS: Main: 192188416 22:14:19 INFO - PROCESS | 18414 | 22:14:21 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:14:22 INFO - PROCESS | 18414 | RSS: Main: 189472768 22:14:22 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | Cycle 1(1): loaded http://localhost:57997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57997/tests/kraken/driver.html?testName=ai-astar) 22:14:24 INFO - PROCESS | 18414 | RSS: Main: 249102336 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | __start_tp_report 22:14:24 INFO - PROCESS | 18414 | _x_x_mozilla_page_load 22:14:24 INFO - PROCESS | 18414 | _x_x_mozilla_page_load_details 22:14:24 INFO - PROCESS | 18414 | |i|pagename|runs| 22:14:24 INFO - PROCESS | 18414 | |0;ai-astar;109;111;105;110;112;111;101;110;111;110 22:14:24 INFO - PROCESS | 18414 | |1;audio-beat-detection;150;131;157;169;126;150;159;126;169;127 22:14:24 INFO - PROCESS | 18414 | |2;audio-dft;161;161;158;161;161;160;158;161;160;160 22:14:24 INFO - PROCESS | 18414 | |3;audio-fft;74;74;87;92;73;71;71;100;90;71 22:14:24 INFO - PROCESS | 18414 | |4;audio-oscillator;96;95;140;95;96;96;140;96;96;138 22:14:24 INFO - PROCESS | 18414 | |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;110 22:14:24 INFO - PROCESS | 18414 | |6;imaging-darkroom;146;145;146;146;146;145;146;146;145;145 22:14:24 INFO - PROCESS | 18414 | |7;imaging-desaturate;96;96;96;96;95;96;96;96;95;96 22:14:24 INFO - PROCESS | 18414 | |8;json-parse-financial;55;55;55;55;55;54;56;64;54;54 22:14:24 INFO - PROCESS | 18414 | |9;json-stringify-tinderbox;68;68;69;69;68;68;69;69;70;69 22:14:24 INFO - PROCESS | 18414 | |10;stanford-crypto-aes;84;83;86;86;86;84;86;93;86;86 22:14:24 INFO - PROCESS | 18414 | |11;stanford-crypto-ccm;122;116;119;115;132;123;119;124;118;126 22:14:24 INFO - PROCESS | 18414 | |12;stanford-crypto-pbkdf2;142;150;153;151;164;143;152;152;151;143 22:14:24 INFO - PROCESS | 18414 | |13;stanford-crypto-sha256-iterative;70;69;70;70;70;69;67;69;68;71 22:14:24 INFO - PROCESS | 18414 | __end_tp_report 22:14:24 INFO - PROCESS | 18414 | __start_cc_report 22:14:24 INFO - PROCESS | 18414 | _x_x_mozilla_cycle_collect,969 22:14:24 INFO - PROCESS | 18414 | __end_cc_report 22:14:24 INFO - PROCESS | 18414 | __startTimestamp1452492864418__endTimestamp 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | ------- Summary: start ------- 22:14:24 INFO - PROCESS | 18414 | Number of tests: 14 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.40 (3.1%) stddev-sans-first:3.61 22:14:24 INFO - PROCESS | 18414 | Values: 109.0 111.0 105.0 110.0 112.0 111.0 101.0 110.0 111.0 110.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:153.50 stddev:17.53 (11.4%) stddev-sans-first:18.54 22:14:24 INFO - PROCESS | 18414 | Values: 150.0 131.0 157.0 169.0 126.0 150.0 159.0 126.0 169.0 127.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#2] audio-dft Cycles:10 Average:160.10 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 22:14:24 INFO - PROCESS | 18414 | Values: 161.0 161.0 158.0 161.0 161.0 160.0 158.0 161.0 160.0 160.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#3] audio-fft Cycles:10 Average:80.30 Median:74.00 stddev:10.83 (14.6%) stddev-sans-first:11.25 22:14:24 INFO - PROCESS | 18414 | Values: 74.0 74.0 87.0 92.0 73.0 71.0 71.0 100.0 90.0 71.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:96.00 stddev:21.08 (22.0%) stddev-sans-first:21.84 22:14:24 INFO - PROCESS | 18414 | Values: 96.0 95.0 140.0 95.0 96.0 96.0 140.0 96.0 96.0 138.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:14:24 INFO - PROCESS | 18414 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:14:24 INFO - PROCESS | 18414 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:14:24 INFO - PROCESS | 18414 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:2.98 (5.4%) stddev-sans-first:3.15 22:14:24 INFO - PROCESS | 18414 | Values: 55.0 55.0 55.0 55.0 55.0 54.0 56.0 64.0 54.0 54.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 22:14:24 INFO - PROCESS | 18414 | Values: 68.0 68.0 69.0 69.0 68.0 68.0 69.0 69.0 70.0 69.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:2.71 (3.1%) stddev-sans-first:2.77 22:14:24 INFO - PROCESS | 18414 | Values: 84.0 83.0 86.0 86.0 86.0 84.0 86.0 93.0 86.0 86.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:5.13 (4.2%) stddev-sans-first:5.43 22:14:24 INFO - PROCESS | 18414 | Values: 122.0 116.0 119.0 115.0 132.0 123.0 119.0 124.0 118.0 126.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:151.50 stddev:6.47 (4.3%) stddev-sans-first:6.16 22:14:24 INFO - PROCESS | 18414 | Values: 142.0 150.0 153.0 151.0 164.0 143.0 152.0 152.0 151.0 143.0 22:14:24 INFO - PROCESS | 18414 | 22:14:24 INFO - PROCESS | 18414 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 22:14:24 INFO - PROCESS | 18414 | Values: 70.0 69.0 70.0 70.0 70.0 69.0 67.0 69.0 68.0 71.0 22:14:24 INFO - PROCESS | 18414 | -------- Summary: end -------- 22:14:24 INFO - PROCESS | 18414 | 22:14:25 INFO - TEST-INFO | 18414: exit 0 22:14:25 INFO - TEST-OK | kraken | took 58292ms 22:14:25 INFO - TEST-START | v8_7 22:14:25 INFO - operating with platform_type : linux_ 22:14:25 INFO - Initialising browser for v8_7 test... 22:14:25 INFO - TEST-INFO | started process 18665 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZe3ETI/profile http://localhost:57997/getInfo.html) 22:14:28 INFO - PROCESS | 18665 | __metrics Screen width/height:1600/1200 22:14:28 INFO - PROCESS | 18665 | colorDepth:24 22:14:28 INFO - PROCESS | 18665 | Browser inner width/height: 1024/697 22:14:28 INFO - PROCESS | 18665 | __metrics 22:14:28 INFO - PROCESS | 18665 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:14:29 INFO - PROCESS | 18665 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:29 INFO - TEST-INFO | 18665: exit 0 22:14:29 INFO - Browser initialized. 22:14:29 INFO - Running cycle 1/1 for v8_7 test... 22:14:29 INFO - TEST-INFO | started process 18745 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZe3ETI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:41 INFO - PROCESS | 18745 | RSS: Main: 149139456 22:14:41 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | Cycle 1(1): loaded http://localhost:57997/tests/v8_7/run.html (next: http://localhost:57997/tests/v8_7/run.html) 22:15:04 INFO - PROCESS | 18745 | RSS: Main: 567910400 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | __start_tp_report 22:15:04 INFO - PROCESS | 18745 | _x_x_mozilla_page_load 22:15:04 INFO - PROCESS | 18745 | _x_x_mozilla_page_load_details 22:15:04 INFO - PROCESS | 18745 | |i|pagename|runs| 22:15:04 INFO - PROCESS | 18745 | |0;Richards;167.7289500167729 22:15:04 INFO - PROCESS | 18745 | |1;DeltaBlue;190.69412662090008 22:15:04 INFO - PROCESS | 18745 | |2;Encrypt;280.0336040324839 22:15:04 INFO - PROCESS | 18745 | |3;Decrypt;5186.5284974093265 22:15:04 INFO - PROCESS | 18745 | |4;RayTrace;1107.4197120708748 22:15:04 INFO - PROCESS | 18745 | |5;Earley;785.7142857142857 22:15:04 INFO - PROCESS | 18745 | |6;Boyer;12280.487804878048 22:15:04 INFO - PROCESS | 18745 | |7;RegExp;42244.897959183676 22:15:04 INFO - PROCESS | 18745 | |8;Splay;571.4285714285714 22:15:04 INFO - PROCESS | 18745 | |9;NavierStokes;4835.748792270531 22:15:04 INFO - PROCESS | 18745 | __end_tp_report 22:15:04 INFO - PROCESS | 18745 | __startTimestamp1452492904373__endTimestamp 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | ------- Summary: start ------- 22:15:04 INFO - PROCESS | 18745 | Number of tests: 10 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#0] Richards Cycles:1 Average:167.73 Median:167.73 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 167.7 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#1] DeltaBlue Cycles:1 Average:190.69 Median:190.69 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 190.7 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 280.0 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 5186.5 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 1107.4 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#5] Earley Cycles:1 Average:785.71 Median:785.71 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 785.7 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 12280.5 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#7] RegExp Cycles:1 Average:42244.90 Median:42244.90 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 42244.9 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#8] Splay Cycles:1 Average:571.43 Median:571.43 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 571.4 22:15:04 INFO - PROCESS | 18745 | 22:15:04 INFO - PROCESS | 18745 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:15:04 INFO - PROCESS | 18745 | Values: 4835.7 22:15:04 INFO - PROCESS | 18745 | -------- Summary: end -------- 22:15:04 INFO - PROCESS | 18745 | 22:15:05 INFO - TEST-INFO | 18745: exit 0 22:15:05 INFO - TEST-OK | v8_7 | took 39964ms 22:15:05 INFO - SUITE-END | took 1210s 22:15:05 INFO - Completed test suite (00:20:10) 22:15:05 INFO - Working with test: dromaeo_css 22:15:05 INFO - Generating results file: dromaeo_css 22:15:05 INFO - Working with test: kraken 22:15:05 INFO - Generating results file: kraken 22:15:05 INFO - javascript benchmark 22:15:05 INFO - Working with test: v8_7 22:15:05 INFO - Generating results file: v8_7 22:15:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:15:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:15:07 INFO - process_Request line: dromaeo_css 6683.72 graph.html#tests=[[72,63,35]] 22:15:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:15:07 INFO - process_Request line: kraken 1506.40 graph.html#tests=[[232,63,35]] 22:15:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:15:07 INFO - process_Request line: v8_7 20128.57 graph.html#tests=[[230,63,35]] 22:15:07 INFO - RETURN: dromaeo_css: 6683.72 22:15:07 INFO - RETURN: kraken: 1506.40 22:15:07 INFO - RETURN: v8_7: 20128.57 22:15:07 INFO - javascript benchmark 22:15:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3066.1568068781085, 3143.654198038214, 3184.219866132796, 3192.968070319296, 3206.8396580170984, 4984.401871775383, 5093.567046801027, 5118.0275747607975, 5120.6671566348205, 5167.147420675588, 4993.900121997558, 4997.575206107476, 5081.618878584111, 5131.538161565459, 5209.400918894328, 4601.309803529472, 4619.330197121415, 4627.930581041287, 4658.673892827504, 4697.365855609501, 528.3185785832549, 4601.7699115044115, 4615.492295847454, 4708.529147085281, 4731.266653668687, 4615.699979501322, 4625.306204069383, 4689.038747056845, 4713.9057218855605, 4715.0, 4678.345031695565, 4701.905961880743, 4708.670393072486, 4712.764361781931, 4736.455307639631, 4565.338025986247, 4687.250039993619, 4689.132510485571, 4705.505921878222, 4759.881002974918, 4912.975435122801, 4914.975425122887, 4928.975355123237, 4993.101241776479, 5005.674631148963, 5359.410464848903, 5372.435894231088, 5374.91937620936, 5387.973060134714, 5414.377346605152, 5321.228421878806, 5408.35099788024, 5408.756605952703, 5414.242006119146, 5420.295361602966, 5004.124278251292, 5128.512791284822, 5190.870228244286, 5193.454687257859, 5208.7916483341, 5532.806351777749, 5540.0, 5542.667439953616, 5547.223388725582, 5591.329040515083, 5253.527182553588, 5323.680579165262, 5330.067238233293, 5335.786568537215, 5353.9196912046355, 5323.3611966563485, 5436.40199578054, 5518.19986102021, 5520.503154716095, 5563.693996830213, 5436.29328187341, 5451.373092094381, 5454.863628409322, 5454.972725136349, 5455.0453670607485, 5284.233786100994, 5379.004884096376, 5433.185022246695, 5449.700266485382, 5501.394846566875, 4235.110626768414, 4249.596288352602, 4276.615104640598, 4281.593248641374, 4311.978440107842, 3822.522184726909, 3826.3686491728554, 3843.365844635604, 3847.3844184930276, 3875.806209689504, 4927.482614325516, 4965.82619608312, 5020.397552293748, 5035.899282014339, 5108.361454818148, 5340.786368545292, 5452.5365343946205, 5489.505944465017, 5495.258140151109, 5543.279373681396, 4963.6277279204205, 4967.652264341534, 4977.701337919736, 4979.103761322925, 5011.123053465629, 4589.403377560896, 4598.701084429501, 4617.907641847144, 4620.353150558924, 4710.3405523226775, 5489.451054894478, 5541.806036788774, 5592.133219351089, 5596.10462326034, 5638.182463542763, 5380.166074258496, 5414.458554144554, 5424.918626220531, 5428.212909128233, 5428.56571474289, 5440.455954404686, 5566.721663916707, 5569.053260945568, 5577.74900129487, 5627.43725627434, 5332.280142180756, 5346.545543628835, 5384.273123128484, 5400.135978243619, 5427.402985671494, 5376.166694162411, 5397.946020539902, 5402.027635025733, 5410.621256512007, 5411.0, 5191.506806853343, 5283.8679033022945, 5299.364076310867, 5304.416514183359, 5340.652857564246, 5238.5023422774775, 5320.920186197288, 5392.865178370415, 5420.349558053059, 5443.0, 5254.5533629641905, 5277.656952298088, 5284.471552844685, 5294.311739473844, 5305.867353316198, 5334.78660853577, 5381.515663590296, 5393.110136827379, 5399.973000134974, 5420.295361602966, 5073.264376665289, 5253.789848406021, 5265.0, 5341.7062061586985, 5361.410244873139], "unit": "score", "name": "dojo.html", "value": 4995.5601583221405}, {"lowerIsBetter": false, "replicates": [527.7229454536365, 533.6024661627088, 537.3605409562621, 551.9558435325174, 556.7188569772266, 28408.72160752766, 29170.708292917065, 29179.416411671755, 29183.562246566293, 29191.0, 29164.416711665806, 29643.0, 29668.10995670128, 36884.81557592215, 38576.228475430544, 8511.489310641366, 8659.913400865973, 8677.219050285474, 8684.088170742076, 8690.304775617935, 8384.706535271267, 8586.87119693205, 8590.957045214765, 8595.312375009984, 8595.871061934076, 7695.692172313101, 7899.28906398424, 7904.644291006918, 10242.692719218436, 10479.266451348409, 9987.0, 10097.293189476739, 10099.444530550816, 10106.140978016803, 10107.140893024101, 7620.542767433972, 9992.400455972665, 10169.288149829516, 10173.237007224488, 10176.491175441199, 29352.559711604343, 39830.60169398327, 40804.0, 40848.59151408478, 40918.79540602278, 2993.625796775403, 3056.2512184514712, 3074.969250307513, 3160.8261545614982, 3214.758893083028, 26192.8690356547, 27412.588811167847, 27483.45033099327, 27651.03221387262, 28395.716042839515, 3648.890533284006, 3697.8335974880924, 3701.925961480755, 3751.4747935289083, 3761.5110035695184, 182379.93820679715, 183433.0, 183491.0, 183650.0, 183662.0, 55454.72272638611, 55814.441855580924, 55826.0, 55846.0, 55848.72075639677, 58297.708511457175, 58723.0, 58789.0, 59149.40850591525, 59215.70392148098, 15484.0, 15613.84386156124, 15743.763843542127, 15815.288312025987, 15835.841641583667, 12077.335746534025, 12104.273743575413, 12126.272423654433, 12132.0, 12134.029277657766, 18775.091993714388, 19209.231630734892, 19274.903625481784, 19275.807241927683, 19376.612467750565, 7330.157031941289, 7688.077430708351, 7711.884321735179, 7731.845363092819, 7737.342325902361, 998.6205242007991, 1045.137761346892, 1081.659277327655, 1118.2842980492492, 1122.646366394583, 28597.85701071481, 28751.85624071908, 28765.85617071943, 29009.274768130967, 29135.562966555517, 1003.4631472162504, 1055.551390658967, 1062.559037999237, 1097.8133717268083, 1168.894799468035, 13418.329083545783, 13604.65988350299, 13808.17150970945, 13829.51596694111, 13861.930690346686, 314966.0, 324694.0, 325109.0, 325876.0, 326579.0, 46836.531634683895, 46951.765241173576, 47122.5287747125, 47161.52838471571, 47224.05551889012, 1326.7810811216234, 1346.602752188107, 1357.4773712120707, 1364.3382959264748, 1369.582277405381, 24782.50434991254, 26448.338791529597, 26554.734452655226, 26652.333691657863, 26782.464350712486, 37852.24295514129, 41818.58181418147, 42699.359509608, 46763.766181168874, 48053.51946480491, 205643.0, 205678.0, 206378.0, 206890.0, 206991.0, 27243.455130897666, 28642.71357286484, 28853.0, 29014.709852902044, 29021.85489072541, 31190.844045779624, 33465.49801752927, 37204.0, 39678.0, 41448.37827432651, 32716.345673086882, 36118.0, 37297.440538391405, 37847.2430551393, 38110.428343575426, 36608.81695591505, 36617.267654646224, 37084.81457592803, 37298.25403491969, 37543.81228093842, 35611.82194089013, 36450.8177459111, 36461.45307820332, 36535.81732091322, 36593.45109823302, 29458.558121627764, 30274.24314392158, 32227.838860805547, 32333.676663233065, 32540.83729581337, 24266.757332427154, 24395.39011524655, 24485.387865302797, 24486.75513244845, 24763.50472990494], "unit": "score", "name": "ext.html", "value": 17515.89665113966}, {"lowerIsBetter": false, "replicates": [348.4598871748789, 355.05783364993476, 355.1777634775496, 355.443730561671, 356.09906935453296, 12842.422091005903, 13243.801342979863, 15929.283182256797, 16212.0, 16513.009219446827, 14796.55610331689, 14849.703005939875, 16195.109268990202, 16364.754528682079, 16380.262888170031, 4987.825426110077, 5117.334746482952, 5232.3459567554055, 5275.525202731754, 5275.683458992473, 3894.922101557967, 3970.404439334094, 5222.4255331913455, 5446.91829622556, 5761.971190144064, 5028.974855125737, 5679.346875109374, 5709.8572535686735, 5730.398308177644, 5730.656160630376, 5136.64043516954, 5153.3558305211845, 5167.069927413064, 5169.483051694838, 5171.456997015315, 5057.848264552069, 5345.812896548602, 5353.0899747043095, 5359.196120581905, 5360.463953604608, 11945.343006134659, 12029.57896473628, 18759.906200469046, 19205.13576889043, 19324.516887077796, 2041.806028427297, 2055.7738648748627, 2092.665173572221, 2101.464126647695, 2203.6143674856994, 9678.322517423783, 9908.752281193028, 10242.334248273839, 11515.712107197387, 13026.674333141653, 1736.5658585353663, 1794.55136215946, 1811.5199472139893, 1823.7264410338423, 1825.196913358118, 52135.47864521344, 53496.46503534954, 54592.0, 54733.45266547323, 54768.17847732287, 9371.344005919656, 9607.759806004766, 9807.558659860324, 9818.852717209247, 9908.950455247821, 12707.30109843949, 12730.363481825872, 12773.361331933365, 12815.679608009874, 12830.486780528674, 7353.0441042664115, 7399.630018499053, 7401.370883474858, 7403.481756277009, 7461.253874612604, 7271.67277472515, 7295.539729199724, 7340.4861659684375, 7365.121893917124, 7372.410207183412, 3979.1047014421524, 4239.427677263591, 4248.447701798808, 4267.914641707149, 4294.506131794821, 1588.602849287678, 1620.473346162502, 1622.3105180298326, 1631.3882294139698, 1638.5903524118971, 859.8015382776063, 862.5988915154484, 888.0, 898.9820203595891, 993.5578667492896, 13355.117213262116, 16223.837761622233, 16490.422835200712, 16517.33930642785, 16867.0, 903.223228023899, 905.171767832426, 936.9765755856022, 939.0140352629711, 996.8454889492141, 9169.312301577409, 9458.432494050241, 9493.145616894513, 9512.667056652985, 9619.90380096204, 471501.0, 478411.0, 478871.0, 482452.0, 504065.0, 41981.79009104996, 60639.0, 61615.69192154011, 63192.0, 67431.0, 1117.7038084907506, 1149.8620165580016, 1162.7674465107013, 1165.9883401166048, 1169.5438778876414, 14973.0, 15056.0, 15272.923635381752, 15284.235788210322, 15514.069155850684, 32163.35673286568, 32588.348233035682, 32894.1776455581, 33213.0, 33592.83203584064, 42902.0, 43172.56827431686, 44432.33351499665, 45258.77370613126, 45506.54493455155, 6994.685239164148, 7183.676734547063, 7383.15093764224, 7447.813804654927, 7451.143118541437, 10401.959804019538, 10705.839412408975, 10731.356118632906, 10803.135749140207, 11273.267237629529, 7515.24847515266, 8692.391532592657, 9066.818663626558, 9159.0, 9397.389169703947, 9101.135392137736, 9243.445393276425, 9282.118198771106, 9541.141297283279, 9643.855342169732, 3298.620658624289, 3942.8619998299923, 7039.782468522399, 7825.139234684294, 9003.684871029482, 7394.2975417335265, 7458.776236712907, 7485.0, 7569.432292578189, 7602.277783610548, 7029.648517574203, 7118.359347658528, 7275.272472752894, 7309.159446663489, 7466.887996679946], "unit": "score", "name": "jquery.html", "value": 7755.804442890411}, {"lowerIsBetter": false, "replicates": [1258.7167887225369, 1441.870231679149, 1446.233496246989, 1603.3105764521251, 1802.2340505285251, 6813.625250611214, 7535.773926782198, 7644.350230230423, 7664.1952594977565, 7667.808304792383, 7546.169921308666, 7709.267619576131, 7709.884351734729, 7711.922880771191, 7742.5354478731315, 2014.143988804752, 2061.845361597886, 2268.4669102760836, 2307.538492301542, 2335.182686059874, 2369.8104151667912, 2375.6199008158696, 2376.0970831084164, 2377.988110059447, 2379.4527258730504, 2246.8202543796456, 2304.781045800646, 2305.4812667149927, 2306.9077236910503, 2307.3654744945106, 2303.7120359955006, 2337.8947947342326, 2351.5179388225374, 2355.128602417117, 2357.964630530543, 2278.851874628144, 2286.5998450271304, 2321.6285394336824, 2327.057541695616, 2344.7303560090636, 7833.255840695125, 7869.173736757615, 7890.56601886896, 7892.56590887501, 7906.604669766489, 4713.316569097496, 4861.951380486221, 4881.560659540658, 4887.804487820483, 4888.73111978841, 2981.3292009297734, 3064.862081206351, 3065.080475857234, 3073.9077827665205, 3093.938121237585, 933.8319102561536, 943.9952800236024, 958.228625956105, 960.4813400763649, 988.5403287471288, 10728.249022568423, 10729.141668666489, 10730.678079657622, 10738.624148154777, 10751.623693170779, 4444.444444444444, 4497.8425755098415, 4535.092981403733, 4543.772811359485, 4569.81720731167, 9265.72202833916, 9268.119528644767, 9277.072292770668, 9286.72139835806, 9286.95356523213, 4864.854054378375, 4872.1717308057005, 4904.558589726942, 4909.656324057353, 4915.18899381598, 4445.777711114496, 4453.554644535585, 4455.997400584843, 4456.509783923766, 4459.576340247671, 3432.811195384228, 3500.7724497907557, 3501.299740052, 3688.114852435396, 3759.755615884959, 1183.9526418943146, 1207.0886480707186, 1212.5149940023884, 1216.154772433168, 1217.6286232699113, 991.5092029445326, 997.4962643864802, 997.6109317366233, 1109.6948339206622, 1341.436596629418, 7237.348638622444, 7244.38422734063, 7258.3104605062435, 7268.055152830098, 7268.382187514015, 1189.601483503019, 1209.238179946628, 1225.154643296123, 1237.7029512916836, 1251.874812518759, 5759.280089988752, 5762.942370576325, 5835.79574714883, 5840.766369345263, 5846.824595262149, 8661.913380866237, 8883.822323553493, 8959.238464730572, 8965.910340896507, 9001.459912405277, 8884.555772211364, 8899.73300800977, 9033.909660903308, 9035.367524273237, 9098.0, 6909.0, 7343.008693826372, 7384.0, 7414.406847452191, 7414.666340014713, 7048.647567621701, 7081.150261968597, 7100.822479438056, 7117.288271172842, 7127.643617819192, 8502.914970850212, 8503.1921967413, 8576.485410875368, 8719.738407847775, 8751.912480875364, 8683.305335573265, 8741.606627701642, 8765.649374024968, 8899.288056955558, 8929.73210803677, 6692.130023097161, 6788.9660551696925, 6796.558223715443, 6797.28628494001, 6803.965980170067, 6644.302348253557, 6767.221769496571, 7135.072440582691, 7360.300771426706, 7364.410847132323, 6802.93197068023, 6908.5509441888125, 6999.0, 7042.542234754929, 7049.7885063448175, 6737.898931515933, 6797.048413222054, 6801.081853949653, 6906.689198986158, 6919.654017299014, 6646.667666616553, 6679.265280819203, 6686.431653309523, 6703.061571379913, 6714.395704386433, 6070.696465176812, 6104.664243466652, 6154.1999540059505, 6156.353582873913, 6169.198004259418, 6255.186825712628, 6306.2747784003595, 6306.684665766602, 6306.873862522632, 6356.396142366468], "unit": "score", "name": "mootools.html", "value": 4478.15799652523}, {"lowerIsBetter": false, "replicates": [327.6068717538954, 334.9866005359786, 336.9983150084249, 340.65763907273185, 347.9860805567777, 5849.356570777211, 5909.409059094094, 5957.463828255456, 6017.819465416039, 6051.485623721989, 5728.68492232927, 5904.0, 5904.0553511438175, 5914.053751399777, 5921.082232254007, 4555.5899969002785, 4556.863294101166, 4560.0879824035155, 4563.817447302113, 4570.291604801261, 4395.252807022814, 4468.218061839165, 4474.664400170001, 4532.818687252506, 4572.634189264851, 4449.288113901776, 4527.117212143633, 4530.614897733697, 4550.817967281305, 4556.225441674923, 4517.661175411858, 4527.569880861296, 4528.0, 4539.795709193094, 4557.384753058344, 4010.458588090629, 4017.5781542938157, 4054.412110243998, 4058.168075544536, 4058.3303754880703, 5497.532709719679, 5637.774489020475, 5645.01212287848, 5656.264685590888, 5659.349174844904, 5329.973350133225, 5332.813351532716, 5349.786008559653, 5381.596380271495, 5384.91922621161, 6005.369436209223, 6384.776532821329, 6387.904181437282, 6393.456556192729, 6397.9360206397805, 4353.651707863363, 4371.9781401093105, 4472.731636101812, 4481.574250446202, 4483.843065492725, 6521.282658907564, 6618.073469714292, 6618.801435956881, 6624.635645039521, 6627.73489060437, 4593.425821772278, 4612.976935115303, 4615.561521655437, 4617.468991066004, 4620.0528891577815, 4516.006478574708, 4661.207594708908, 4674.0885527322525, 4684.4378674559275, 4708.95291047092, 5349.0, 5350.678959262456, 5351.1973204019705, 5354.678719276778, 5355.062863998784, 6394.26465956421, 6401.423871851555, 6404.199475065617, 6406.263279722798, 6407.519436042316, 1618.6924484347937, 1657.1631326180202, 1658.461000174948, 1659.1123748794337, 1660.7924009498813, 1105.8120119579692, 1121.5513794482108, 1124.6288724720823, 1128.9548418063187, 1149.6091328948198, 5844.561657875676, 5966.134910437962, 5969.432903874125, 5975.820725378246, 5976.551758618121, 6441.838954026187, 6450.870982580323, 6451.258105317855, 6452.677366131675, 6457.547971642034, 5812.0, 5893.057110862242, 5920.2007728956905, 5920.2007728956905, 5928.644281343047, 3461.428864237423, 3492.511048453219, 3494.545709057806, 3498.5976612689356, 3501.2647344057523, 6610.735570577123, 6623.768168114093, 6632.867342653217, 6643.701033453506, 6647.468202543785, 6620.3710647488415, 6630.900536491957, 6636.170478690164, 6641.003849422528, 6646.534742567974, 6430.131932189188, 6556.311587283267, 6591.439727623206, 6619.0, 6624.436922861514, 6331.2085989251345, 6374.58565193261, 6432.581882177644, 6453.09656648079, 6504.0, 6461.870762584816, 6479.5788273762055, 6494.253160886558, 6505.577137486048, 6510.088587597835, 6715.597064176165, 6722.361375669304, 6730.562513436611, 6732.596044237165, 6740.898886516804, 4519.728816271035, 4601.539846015372, 4615.630749540096, 4615.953840461687, 4619.422572178478, 6562.34376562359, 6562.5406221564035, 6563.671816409065, 6572.737090516517, 6574.211094668479, 6355.586886852339, 6360.554761166674, 6392.520560957853, 6398.616083035033, 6399.072134540559, 6211.16149319836, 6361.809145725636, 6370.4903607712195, 6371.076193951943, 6375.936240637534, 6242.344553821965, 6243.469305109116, 6253.687315634109, 6253.749850005949, 6257.4994000480765, 6381.489480841428, 6383.265924418752, 6394.808155755149, 6395.552311338161, 6404.0, 6071.0, 6224.0, 6243.157173781481, 6247.875042499034, 6308.053791931247], "unit": "score", "name": "prototype.html", "value": 4783.514298520812}, {"lowerIsBetter": false, "replicates": [752.924707529247, 842.1115722912325, 845.71245776436, 849.1254008371372, 853.8591132463146, 12990.090693651448, 13056.543020994244, 13063.0, 13091.60725178245, 13094.410751516181, 11044.613438529654, 12416.627501174979, 12435.564755233569, 12441.626751197478, 12520.186187897803, 650.3236633900749, 800.6797281087582, 808.7129069180445, 818.3616778912458, 818.3780326951501, 794.4399198565027, 798.5009369144285, 799.6361655446786, 800.2077942836609, 803.2168635580321, 688.0607970120799, 695.3533214110874, 846.3609974469267, 853.8676505141682, 853.9146085391474, 833.995830020852, 837.7863644770575, 846.6613354658125, 848.2874385516135, 850.8511010573187, 627.4791922704145, 628.3936001758325, 628.8522197283635, 629.8173529676388, 630.1398590923402, 11857.229280096766, 12186.695332616755, 12194.573189938399, 12198.695032624166, 12235.571754988621, 12677.239365638092, 12944.676383090404, 13035.804462933063, 13211.801822972662, 13217.273049982246, 10059.195264378832, 10137.290389672726, 10166.745831354201, 10862.782744345148, 10951.83572246417, 3611.0791748104066, 3679.7056235501095, 3691.151035261905, 3776.8866933992026, 3784.2053168834577, 42316.36525452121, 42438.78780606108, 42737.35893961562, 42833.35749963753, 42953.0, 9269.860952085724, 9606.471644059504, 9612.0, 10003.399796012263, 10230.079292863678, 17308.82691173072, 17547.912260438618, 17588.296468141132, 17609.911950440164, 17610.559736006704, 7396.482246242711, 7627.580483073484, 7652.502587331805, 7674.6930122794465, 7752.806179845436, 4308.763018033976, 4325.416068830667, 4334.13317336534, 4339.956600434019, 4410.0, 3072.2472994116583, 3094.798838075563, 3109.5802066721158, 3111.9066428007195, 3114.828684422333, 590.3034419385167, 603.6649659439054, 610.008735804318, 611.9632822030692, 621.564904566805, 538.3889285660803, 558.488982580942, 581.4360070731384, 628.0767272109991, 639.4852144024105, 7695.461317707706, 8060.0, 8127.3904457165945, 8195.7951051223, 8306.70926517569, 586.5366360575098, 621.5711159300068, 642.6401215319436, 648.3678413546754, 653.3074940563018, 3725.701943844486, 3777.0731658831182, 3881.437191607201, 3922.764634121962, 4072.4095006224525, 56442.0, 56507.43492565104, 56670.716646416506, 57352.713236434385, 58677.70661146667, 49114.0, 49550.0, 49872.50127498679, 49975.0, 50257.0, 44647.77676111599, 44876.775616122366, 44974.77512612481, 44975.55024449779, 45262.09475810531, 7631.656575454007, 7744.341730952932, 7869.921300786918, 7933.444658873824, 8022.077461091816, 32131.377009023796, 32975.34049318952, 33216.83391583123, 34077.48883766795, 34394.82802586071, 38212.42681359726, 39086.0, 39333.21333573255, 40914.795426022676, 44269.778651106535, 10352.275340726077, 10503.684889453329, 10783.299085559414, 10804.189013550129, 10857.782844343226, 11543.653690389301, 11561.826572601585, 11664.416779160838, 12036.963826843043, 12341.321227332583, 11280.32318060919, 11405.372704501333, 11450.198486105892, 11463.426828658701, 11475.254108482923, 10720.303180293256, 10732.302400343953, 10762.246642734934, 10817.18871084656, 11128.332300062022, 10377.896221037692, 10430.53062612169, 10430.947845260725, 10480.318779279323, 10491.213159012952, 9097.1812536872, 9169.220616247427, 9238.491882946502, 9417.623295068395, 9560.713178604654, 9558.66544670961, 9948.850767238353, 9950.303478756417, 9955.0, 9958.203343732339], "unit": "score", "name": "yui.html", "value": 6131.710266811533}], "name": "dromaeo_css", "value": 6683.716130834057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 112.0, 111.0, 101.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [150.0, 131.0, 157.0, 169.0, 126.0, 150.0, 159.0, 126.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 158.0, 161.0, 161.0, 160.0, 158.0, 161.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 87.0, 92.0, 73.0, 71.0, 71.0, 100.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 140.0, 95.0, 96.0, 96.0, 140.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 56.0, 64.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 86.0, 86.0, 86.0, 84.0, 86.0, 93.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [122.0, 116.0, 119.0, 115.0, 132.0, 123.0, 119.0, 124.0, 118.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 153.0, 151.0, 164.0, 143.0, 152.0, 152.0, 151.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 70.0, 70.0, 69.0, 67.0, 69.0, 68.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1506.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7289500167729], "unit": "score", "name": "Richards", "value": 210.47052400000004}, {"lowerIsBetter": false, "replicates": [190.69412662090008], "unit": "score", "name": "DeltaBlue", "value": 346.72279200000014}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1107.4197120708748], "unit": "score", "name": "RayTrace", "value": 668.2100670000003}, {"lowerIsBetter": false, "replicates": [785.7142857142857], "unit": "score", "name": "Earley", "value": 848.2256363636362}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [42244.897959183676], "unit": "score", "name": "RegExp", "value": 21.564379227053134}, {"lowerIsBetter": false, "replicates": [571.4285714285714], "unit": "score", "name": "Splay", "value": 142.60924999999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20128.571497933834}]} 22:15:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20128.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1506.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6683.72"}}} 22:15:07 INFO - Return code: 0 22:15:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:15:07 INFO - # TBPL SUCCESS # 22:15:07 INFO - Running post-action listener: _resource_record_post_action 22:15:07 INFO - Running post-run listener: _resource_record_post_run 22:15:08 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405352448; Read time: 188; Write time: 257704 22:15:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 96808960; Read time: 0; Write time: 63708 22:15:09 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308543488; Read time: 188; Write time: 193996 22:15:09 INFO - Running post-run listener: _upload_blobber_files 22:15:09 INFO - Blob upload gear active. 22:15:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:15:09 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 22:15:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:15:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:15:10 INFO - (blobuploader) - INFO - Open directory for files ... 22:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:12 INFO - (blobuploader) - INFO - Done attempting. 22:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:14 INFO - (blobuploader) - INFO - Done attempting. 22:15:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:15:14 INFO - Return code: 0 22:15:14 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:15:14 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:15:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba280d9c697dfa811dc3600ae0f81abf618c6c01b43da18353d287fff1f41ec3f58dae27a0dba87c0e5bce47e5b6866a8e2583c205f6f5d6e3fa30ff56c4668b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/677fe211b24657f4b67104ade1084989178c0fafc974efaec94f8903229bb3da4f95247b95939a6704551012b1f99a363ad0364a2f8bbf9e2634d76506e93165"} 22:15:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:15:14 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:15:14 INFO - Contents: 22:15:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba280d9c697dfa811dc3600ae0f81abf618c6c01b43da18353d287fff1f41ec3f58dae27a0dba87c0e5bce47e5b6866a8e2583c205f6f5d6e3fa30ff56c4668b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/677fe211b24657f4b67104ade1084989178c0fafc974efaec94f8903229bb3da4f95247b95939a6704551012b1f99a363ad0364a2f8bbf9e2634d76506e93165"} 22:15:14 INFO - Copying logs to upload dir... 22:15:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1362.422262 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 42 secs) (at 2016-01-10 22:15:14.090106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 22:15:14.093940) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba280d9c697dfa811dc3600ae0f81abf618c6c01b43da18353d287fff1f41ec3f58dae27a0dba87c0e5bce47e5b6866a8e2583c205f6f5d6e3fa30ff56c4668b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/677fe211b24657f4b67104ade1084989178c0fafc974efaec94f8903229bb3da4f95247b95939a6704551012b1f99a363ad0364a2f8bbf9e2634d76506e93165"} build_url:https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/aGc36MzXQjGWa1bcn06O4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba280d9c697dfa811dc3600ae0f81abf618c6c01b43da18353d287fff1f41ec3f58dae27a0dba87c0e5bce47e5b6866a8e2583c205f6f5d6e3fa30ff56c4668b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/677fe211b24657f4b67104ade1084989178c0fafc974efaec94f8903229bb3da4f95247b95939a6704551012b1f99a363ad0364a2f8bbf9e2634d76506e93165"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 22:15:14.123604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 22:15:14.124352) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452489160.721005-703776176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 22:15:14.203755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 22:15:14.204101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 22:15:14.204421) ========= ========= Total master_lag: 0.25 =========