builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1452361824.87 results: success (0) buildid: 20160109073343 builduid: d9d81b6ea0b541cebe5925130ba25fe6 revision: 108e407489921aae013640db1e1ccc596fa3c73b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:24.874520) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:24.874961) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:24.875539) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006234 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:24.963581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:24.963947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.025577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.025886) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.076824) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.077200) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.077644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.081652) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 09:50:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-01-09 09:50:25 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.259683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.260074) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.108482 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.380287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:25.380662) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 108e407489921aae013640db1e1ccc596fa3c73b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 108e407489921aae013640db1e1ccc596fa3c73b --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=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 09:50:25,429 truncating revision to first 12 chars 2016-01-09 09:50:25,429 Setting DEBUG logging. 2016-01-09 09:50:25,430 attempt 1/10 2016-01-09 09:50:25,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/108e40748992?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 09:50:25,697 unpacking tar archive at: mozilla-central-108e40748992/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:26.341408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:26.341779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:26.351944) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:26.352245) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 09:50:26.352672) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-09 09:50:26.353031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:50:26 INFO - MultiFileLogger online at 20160109 09:50:26 in /builds/slave/test-pgo 09:50:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:50:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:50:26 INFO - {'append_to_log': False, 09:50:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:50:26 INFO - 'blob_upload_branch': 'Firefox', 09:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:50:26 INFO - 'branch': 'Firefox', 09:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:26 INFO - 'config_files': ('talos/linux_config.py',), 09:50:26 INFO - 'default_actions': ('clobber', 09:50:26 INFO - 'read-buildbot-config', 09:50:26 INFO - 'download-and-extract', 09:50:26 INFO - 'populate-webroot', 09:50:26 INFO - 'create-virtualenv', 09:50:26 INFO - 'install', 09:50:26 INFO - 'run-tests'), 09:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:26 INFO - 'download_minidump_stackwalk': True, 09:50:26 INFO - 'download_symbols': 'ondemand', 09:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:26 INFO - 'installer_path': 'installer.exe', 09:50:26 INFO - 'log_level': 'info', 09:50:26 INFO - 'log_name': 'talos', 09:50:26 INFO - 'log_to_console': True, 09:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:50:26 INFO - 'opt_config_files': (), 09:50:26 INFO - 'pip_index': False, 09:50:26 INFO - 'sps_profile': False, 09:50:26 INFO - 'sps_profile_interval': 0, 09:50:26 INFO - 'suite': 'dromaeojs-e10s', 09:50:26 INFO - 'system_bits': '32', 09:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:26 INFO - 'title': 'talos-linux64-ix-036', 09:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:26 INFO - 'use_talos_json': True, 09:50:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:26 INFO - 'work_dir': 'build'} 09:50:26 INFO - ##### 09:50:26 INFO - ##### Running clobber step. 09:50:26 INFO - ##### 09:50:26 INFO - Running pre-action listener: _resource_record_pre_action 09:50:26 INFO - Running main action method: clobber 09:50:26 INFO - rmtree: /builds/slave/test-pgo/build 09:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:50:31 INFO - Running post-action listener: _resource_record_post_action 09:50:31 INFO - ##### 09:50:31 INFO - ##### Running read-buildbot-config step. 09:50:31 INFO - ##### 09:50:31 INFO - Running pre-action listener: _resource_record_pre_action 09:50:31 INFO - Running main action method: read_buildbot_config 09:50:31 INFO - Using buildbot properties: 09:50:31 INFO - { 09:50:31 INFO - "project": "", 09:50:31 INFO - "product": "firefox", 09:50:31 INFO - "script_repo_revision": "production", 09:50:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:50:31 INFO - "repository": "", 09:50:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:50:31 INFO - "buildid": "20160109073343", 09:50:31 INFO - "pgo_build": "True", 09:50:31 INFO - "basedir": "/builds/slave/test-pgo", 09:50:31 INFO - "buildnumber": 608, 09:50:31 INFO - "slavename": "talos-linux64-ix-036", 09:50:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:50:31 INFO - "platform": "ubuntu64_hw", 09:50:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:50:31 INFO - "branch": "mozilla-central", 09:50:31 INFO - "repo_path": "mozilla-central", 09:50:31 INFO - "revision": "108e407489921aae013640db1e1ccc596fa3c73b", 09:50:31 INFO - "stage_platform": "linux64-pgo", 09:50:31 INFO - "builduid": "d9d81b6ea0b541cebe5925130ba25fe6", 09:50:31 INFO - "slavebuilddir": "test" 09:50:31 INFO - } 09:50:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:50:31 INFO - Running post-action listener: _resource_record_post_action 09:50:31 INFO - ##### 09:50:31 INFO - ##### Running download-and-extract step. 09:50:31 INFO - ##### 09:50:31 INFO - Running pre-action listener: _resource_record_pre_action 09:50:31 INFO - Running main action method: download_and_extract 09:50:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:31 INFO - https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/test_packages.json 09:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/test_packages.json 09:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:50:32 INFO - Downloaded 1302 bytes. 09:50:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:50:32 INFO - Using the following test package requirements: 09:50:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:50:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'jsshell-linux-x86_64.zip'], 09:50:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:50:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:50:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:50:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:50:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:50:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:50: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')]} 09:50:32 INFO - https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:35 INFO - Downloaded 24028222 bytes. 09:50:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:50:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:50:36 INFO - Return code: 0 09:50:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:36 INFO - https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:50 INFO - Downloaded 24028222 bytes. 09:50:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:50:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:50:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:50:51 INFO - Return code: 0 09:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:51 INFO - https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:50:52 INFO - Downloaded 11132285 bytes. 09:50:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:50:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:50:52 INFO - Return code: 0 09:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:52 INFO - https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:50:54 INFO - Downloaded 55930620 bytes. 09:50:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:50:54 INFO - mkdir: /builds/slave/test-pgo/properties 09:50:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:50:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:50:54 INFO - Contents: 09:50:54 INFO - build_url:https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:50:54 INFO - Running post-action listener: _resource_record_post_action 09:50:54 INFO - Running post-action listener: set_extra_try_arguments 09:50:54 INFO - ##### 09:50:54 INFO - ##### Running populate-webroot step. 09:50:54 INFO - ##### 09:50:54 INFO - Running pre-action listener: _resource_record_pre_action 09:50:54 INFO - Running main action method: populate_webroot 09:50:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:54 INFO - '--tppagecycles', 09:50:54 INFO - '7'], 09:50:54 INFO - 'tests': ['tsvgm']}}, 09:50:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:50:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:50:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:50:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'tests': ['damp', 'tps']}, 09:50:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['damp', 'tps']}, 09:50:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:50:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:54 INFO - 'other': {'tests': ['a11yr', 09:50:54 INFO - 'ts_paint', 09:50:54 INFO - 'tpaint', 09:50:54 INFO - 'sessionrestore', 09:50:54 INFO - 'sessionrestore_no_auto_restore']}, 09:50:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['a11yr', 09:50:54 INFO - 'ts_paint', 09:50:54 INFO - 'tpaint', 09:50:54 INFO - 'sessionrestore', 09:50:54 INFO - 'sessionrestore_no_auto_restore']}, 09:50:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['a11yr', 09:50:54 INFO - 'ts_paint', 09:50:54 INFO - 'tpaint', 09:50:54 INFO - 'sessionrestore', 09:50:54 INFO - 'sessionrestore_no_auto_restore']}, 09:50:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['a11yr', 09:50:54 INFO - 'ts_paint', 09:50:54 INFO - 'tpaint', 09:50:54 INFO - 'sessionrestore', 09:50:54 INFO - 'sessionrestore_no_auto_restore']}, 09:50:54 INFO - 'other_l64': {'tests': ['a11yr', 09:50:54 INFO - 'ts_paint', 09:50:54 INFO - 'tpaint', 09:50:54 INFO - 'sessionrestore', 09:50:54 INFO - 'sessionrestore_no_auto_restore']}, 09:50:54 INFO - 'other_nol64': {'tests': ['a11yr', 09:50:54 INFO - 'ts_paint', 09:50:54 INFO - 'tpaint', 09:50:54 INFO - 'sessionrestore', 09:50:54 INFO - 'sessionrestore_no_auto_restore']}, 09:50:54 INFO - 'svgr': {'tests': ['tsvgx', 09:50:54 INFO - 'tsvgr_opacity', 09:50:54 INFO - 'tart', 09:50:54 INFO - 'tscrollx', 09:50:54 INFO - 'cart']}, 09:50:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['tsvgx', 09:50:54 INFO - 'tsvgr_opacity', 09:50:54 INFO - 'tart', 09:50:54 INFO - 'tscrollx', 09:50:54 INFO - 'cart']}, 09:50:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'tests': ['tp5o']}, 09:50:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'talos_options': ['--e10s'], 09:50:54 INFO - 'tests': ['tp5o']}, 09:50:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'talos_options': ['--xperf_path', 09:50:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:54 INFO - 'tests': ['tp5n']}, 09:50:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:54 INFO - 'talos_options': ['--e10s', 09:50:54 INFO - '--xperf_path', 09:50:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:54 INFO - 'tests': ['tp5n']}}, 09:50:54 INFO - 'talos.zip': {'path': '', 09:50:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:54 INFO - Running post-action listener: _resource_record_post_action 09:50:54 INFO - ##### 09:50:54 INFO - ##### Running create-virtualenv step. 09:50:54 INFO - ##### 09:50:54 INFO - Running pre-action listener: _resource_record_pre_action 09:50:54 INFO - Running main action method: create_virtualenv 09:50:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:50:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:50:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:50:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:54 INFO - Using real prefix '/usr' 09:50:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:50:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:57 INFO - Installing pip.................done. 09:50:57 INFO - Return code: 0 09:50:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:57 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 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:50:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:50:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:50:57 INFO - Using env: {'DISPLAY': ':0', 09:50:57 INFO - 'HOME': '/home/cltbld', 09:50:57 INFO - 'LANG': 'en_US.UTF-8', 09:50:57 INFO - 'LANGUAGE': 'en_US:en', 09:50:57 INFO - 'LOGNAME': 'cltbld', 09:50:57 INFO - 'MAIL': '/var/mail/cltbld', 09:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:57 INFO - 'MOZ_NO_REMOTE': '1', 09:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:57 INFO - 'NO_EM_RESTART': '1', 09:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:57 INFO - 'SHELL': '/bin/bash', 09:50:57 INFO - 'SHLVL': '1', 09:50:57 INFO - 'TERM': 'linux', 09:50:57 INFO - 'TMOUT': '86400', 09:50:57 INFO - 'USER': 'cltbld', 09:50:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:57 INFO - '_': '/tools/buildbot/bin/python'} 09:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:50:57 INFO - Cleaning up... 09:50:57 INFO - Return code: 0 09:50:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:57 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 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:50:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:50:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:50:57 INFO - Using env: {'DISPLAY': ':0', 09:50:57 INFO - 'HOME': '/home/cltbld', 09:50:57 INFO - 'LANG': 'en_US.UTF-8', 09:50:57 INFO - 'LANGUAGE': 'en_US:en', 09:50:57 INFO - 'LOGNAME': 'cltbld', 09:50:57 INFO - 'MAIL': '/var/mail/cltbld', 09:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:57 INFO - 'MOZ_NO_REMOTE': '1', 09:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:57 INFO - 'NO_EM_RESTART': '1', 09:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:57 INFO - 'SHELL': '/bin/bash', 09:50:57 INFO - 'SHLVL': '1', 09:50:57 INFO - 'TERM': 'linux', 09:50:57 INFO - 'TMOUT': '86400', 09:50:57 INFO - 'USER': 'cltbld', 09:50:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:57 INFO - '_': '/tools/buildbot/bin/python'} 09:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:58 INFO - Downloading/unpacking psutil>=0.7.1 09:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:50:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:50:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:59 INFO - Installing collected packages: psutil 09:50:59 INFO - Running setup.py install for psutil 09:50:59 INFO - building 'psutil._psutil_linux' extension 09:50:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:51:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:51:00 INFO - building 'psutil._psutil_posix' extension 09:51:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:51:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:51:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:01 INFO - Successfully installed psutil 09:51:01 INFO - Cleaning up... 09:51:01 INFO - Return code: 0 09:51:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:51:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:51:01 INFO - Using env: {'DISPLAY': ':0', 09:51:01 INFO - 'HOME': '/home/cltbld', 09:51:01 INFO - 'LANG': 'en_US.UTF-8', 09:51:01 INFO - 'LANGUAGE': 'en_US:en', 09:51:01 INFO - 'LOGNAME': 'cltbld', 09:51:01 INFO - 'MAIL': '/var/mail/cltbld', 09:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:01 INFO - 'MOZ_NO_REMOTE': '1', 09:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:01 INFO - 'NO_EM_RESTART': '1', 09:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:01 INFO - 'SHELL': '/bin/bash', 09:51:01 INFO - 'SHLVL': '1', 09:51:01 INFO - 'TERM': 'linux', 09:51:01 INFO - 'TMOUT': '86400', 09:51:01 INFO - 'USER': 'cltbld', 09:51:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:01 INFO - '_': '/tools/buildbot/bin/python'} 09:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:51:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:51:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:51:03 INFO - Installing collected packages: mozsystemmonitor 09:51:03 INFO - Running setup.py install for mozsystemmonitor 09:51:03 INFO - Successfully installed mozsystemmonitor 09:51:03 INFO - Cleaning up... 09:51:03 INFO - Return code: 0 09:51:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:51:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:03 INFO - Using env: {'DISPLAY': ':0', 09:51:03 INFO - 'HOME': '/home/cltbld', 09:51:03 INFO - 'LANG': 'en_US.UTF-8', 09:51:03 INFO - 'LANGUAGE': 'en_US:en', 09:51:03 INFO - 'LOGNAME': 'cltbld', 09:51:03 INFO - 'MAIL': '/var/mail/cltbld', 09:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:03 INFO - 'MOZ_NO_REMOTE': '1', 09:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:03 INFO - 'NO_EM_RESTART': '1', 09:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:03 INFO - 'SHELL': '/bin/bash', 09:51:03 INFO - 'SHLVL': '1', 09:51:03 INFO - 'TERM': 'linux', 09:51:03 INFO - 'TMOUT': '86400', 09:51:03 INFO - 'USER': 'cltbld', 09:51:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:03 INFO - '_': '/tools/buildbot/bin/python'} 09:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:51:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:51:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:51:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:06 INFO - Downloading docopt-0.6.1.tar.gz 09:51:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:51:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:06 INFO - Running setup.py install for blobuploader 09:51:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:51:06 INFO - Running setup.py install for requests 09:51:06 INFO - Running setup.py install for docopt 09:51:06 INFO - Successfully installed blobuploader requests docopt 09:51:06 INFO - Cleaning up... 09:51:06 INFO - Return code: 0 09:51:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 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 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:51:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:06 INFO - Using env: {'DISPLAY': ':0', 09:51:06 INFO - 'HOME': '/home/cltbld', 09:51:06 INFO - 'LANG': 'en_US.UTF-8', 09:51:06 INFO - 'LANGUAGE': 'en_US:en', 09:51:06 INFO - 'LOGNAME': 'cltbld', 09:51:06 INFO - 'MAIL': '/var/mail/cltbld', 09:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:06 INFO - 'MOZ_NO_REMOTE': '1', 09:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:06 INFO - 'NO_EM_RESTART': '1', 09:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:06 INFO - 'SHELL': '/bin/bash', 09:51:06 INFO - 'SHLVL': '1', 09:51:06 INFO - 'TERM': 'linux', 09:51:06 INFO - 'TMOUT': '86400', 09:51:06 INFO - 'USER': 'cltbld', 09:51:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:06 INFO - '_': '/tools/buildbot/bin/python'} 09:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:07 INFO - Running setup.py (path:/tmp/pip-hoKAKV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:07 INFO - Running setup.py (path:/tmp/pip-eD8MHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:07 INFO - Running setup.py (path:/tmp/pip-1XdUQ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:07 INFO - Running setup.py (path:/tmp/pip-YQydrG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:07 INFO - Running setup.py (path:/tmp/pip-TPJBqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:07 INFO - Running setup.py (path:/tmp/pip-9YPsF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:07 INFO - Running setup.py (path:/tmp/pip-diK3y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:07 INFO - Running setup.py (path:/tmp/pip-CwJ_3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:07 INFO - Running setup.py (path:/tmp/pip-kQAyZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:07 INFO - Running setup.py (path:/tmp/pip-n2szBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:07 INFO - Running setup.py (path:/tmp/pip-QpnA4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:07 INFO - Running setup.py (path:/tmp/pip-pLlvVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:07 INFO - Running setup.py (path:/tmp/pip-yoYM1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:08 INFO - Running setup.py (path:/tmp/pip-gHSuDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:08 INFO - Running setup.py (path:/tmp/pip-ewPAhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:08 INFO - Running setup.py (path:/tmp/pip-4Zr0JK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:08 INFO - Running setup.py (path:/tmp/pip-NJPM47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:08 INFO - Running setup.py install for manifestparser 09:51:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:51:08 INFO - Running setup.py install for mozcrash 09:51:08 INFO - Running setup.py install for mozdebug 09:51:08 INFO - Running setup.py install for mozdevice 09:51:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:51:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:51:08 INFO - Running setup.py install for mozfile 09:51:08 INFO - Running setup.py install for mozhttpd 09:51:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:51:08 INFO - Running setup.py install for mozinfo 09:51:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Running setup.py install for mozInstall 09:51:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Running setup.py install for mozleak 09:51:09 INFO - Running setup.py install for mozlog 09:51:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Running setup.py install for moznetwork 09:51:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Running setup.py install for mozprocess 09:51:09 INFO - Running setup.py install for mozprofile 09:51:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Running setup.py install for mozrunner 09:51:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:51:09 INFO - Running setup.py install for mozscreenshot 09:51:09 INFO - Running setup.py install for moztest 09:51:10 INFO - Running setup.py install for mozversion 09:51:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:51:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:10 INFO - Cleaning up... 09:51:10 INFO - Return code: 0 09:51:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:10 INFO - Using env: {'DISPLAY': ':0', 09:51:10 INFO - 'HOME': '/home/cltbld', 09:51:10 INFO - 'LANG': 'en_US.UTF-8', 09:51:10 INFO - 'LANGUAGE': 'en_US:en', 09:51:10 INFO - 'LOGNAME': 'cltbld', 09:51:10 INFO - 'MAIL': '/var/mail/cltbld', 09:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:10 INFO - 'MOZ_NO_REMOTE': '1', 09:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:10 INFO - 'NO_EM_RESTART': '1', 09:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:10 INFO - 'SHELL': '/bin/bash', 09:51:10 INFO - 'SHLVL': '1', 09:51:10 INFO - 'TERM': 'linux', 09:51:10 INFO - 'TMOUT': '86400', 09:51:10 INFO - 'USER': 'cltbld', 09:51:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:10 INFO - '_': '/tools/buildbot/bin/python'} 09:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:10 INFO - Running setup.py (path:/tmp/pip-Tw3uiE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:10 INFO - Running setup.py (path:/tmp/pip-LpCvHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:10 INFO - Running setup.py (path:/tmp/pip-sE1JFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:10 INFO - Running setup.py (path:/tmp/pip-IC3gpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:10 INFO - Running setup.py (path:/tmp/pip-ZcAsRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:10 INFO - Running setup.py (path:/tmp/pip-TBDWJH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:10 INFO - Running setup.py (path:/tmp/pip-Y2pYHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:10 INFO - Running setup.py (path:/tmp/pip-DBXDK8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:10 INFO - Running setup.py (path:/tmp/pip-UWnzcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:10 INFO - Running setup.py (path:/tmp/pip-fexb3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:11 INFO - Running setup.py (path:/tmp/pip-qCLEb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:11 INFO - Running setup.py (path:/tmp/pip-kc22PF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:11 INFO - Running setup.py (path:/tmp/pip-ySaOFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:11 INFO - Running setup.py (path:/tmp/pip-rs5eAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:11 INFO - Running setup.py (path:/tmp/pip-M2iXYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:11 INFO - Running setup.py (path:/tmp/pip-TiYXwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:11 INFO - Running setup.py (path:/tmp/pip-OTgn92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:13 INFO - Downloading blessings-1.5.1.tar.gz 09:51:13 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:51:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:13 INFO - Installing collected packages: blessings 09:51:13 INFO - Running setup.py install for blessings 09:51:13 INFO - Successfully installed blessings 09:51:13 INFO - Cleaning up... 09:51:13 INFO - Return code: 0 09:51:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:51:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:51:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:51:13 INFO - Reading from file tmpfile_stdout 09:51:13 INFO - Current package versions: 09:51:13 INFO - argparse == 1.2.1 09:51:13 INFO - blessings == 1.5.1 09:51:13 INFO - blobuploader == 1.2.4 09:51:13 INFO - docopt == 0.6.1 09:51:13 INFO - manifestparser == 1.1 09:51:13 INFO - mozInstall == 1.12 09:51:13 INFO - mozcrash == 0.16 09:51:13 INFO - mozdebug == 0.1 09:51:13 INFO - mozdevice == 0.47 09:51:13 INFO - mozfile == 1.2 09:51:13 INFO - mozhttpd == 0.7 09:51:13 INFO - mozinfo == 0.9 09:51:13 INFO - mozleak == 0.1 09:51:13 INFO - mozlog == 3.1 09:51:13 INFO - moznetwork == 0.27 09:51:13 INFO - mozprocess == 0.22 09:51:13 INFO - mozprofile == 0.28 09:51:13 INFO - mozrunner == 6.11 09:51:13 INFO - mozscreenshot == 0.1 09:51:13 INFO - mozsystemmonitor == 0.0 09:51:13 INFO - moztest == 0.7 09:51:13 INFO - mozversion == 1.4 09:51:13 INFO - psutil == 3.1.1 09:51:13 INFO - requests == 1.2.3 09:51:13 INFO - wsgiref == 0.1.2 09:51:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:51:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:13 INFO - Using env: {'DISPLAY': ':0', 09:51:13 INFO - 'HOME': '/home/cltbld', 09:51:13 INFO - 'LANG': 'en_US.UTF-8', 09:51:13 INFO - 'LANGUAGE': 'en_US:en', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MAIL': '/var/mail/cltbld', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SHLVL': '1', 09:51:13 INFO - 'TERM': 'linux', 09:51:13 INFO - 'TMOUT': '86400', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - '_': '/tools/buildbot/bin/python'} 09:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:51:13 INFO - Cleaning up... 09:51:14 INFO - Return code: 0 09:51:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:51:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:51:14 INFO - Using env: {'DISPLAY': ':0', 09:51:14 INFO - 'HOME': '/home/cltbld', 09:51:14 INFO - 'LANG': 'en_US.UTF-8', 09:51:14 INFO - 'LANGUAGE': 'en_US:en', 09:51:14 INFO - 'LOGNAME': 'cltbld', 09:51:14 INFO - 'MAIL': '/var/mail/cltbld', 09:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:14 INFO - 'MOZ_NO_REMOTE': '1', 09:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:14 INFO - 'NO_EM_RESTART': '1', 09:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:14 INFO - 'SHELL': '/bin/bash', 09:51:14 INFO - 'SHLVL': '1', 09:51:14 INFO - 'TERM': 'linux', 09:51:14 INFO - 'TMOUT': '86400', 09:51:14 INFO - 'USER': 'cltbld', 09:51:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:14 INFO - '_': '/tools/buildbot/bin/python'} 09:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:14 INFO - Downloading/unpacking jsonschema 09:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 09:51:15 INFO - Downloading/unpacking functools32 (from jsonschema) 09:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:16 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:16 INFO - warning: no files found matching '*.txt' 09:51:16 INFO - no previously-included directories found matching 'build' 09:51:16 INFO - no previously-included directories found matching 'dist' 09:51:16 INFO - no previously-included directories found matching '.git*' 09:51:16 INFO - Installing collected packages: jsonschema, functools32 09:51:16 INFO - Running setup.py install for functools32 09:51:16 INFO - warning: no files found matching '*.txt' 09:51:16 INFO - no previously-included directories found matching 'build' 09:51:16 INFO - no previously-included directories found matching 'dist' 09:51:16 INFO - no previously-included directories found matching '.git*' 09:51:16 INFO - Successfully installed jsonschema functools32 09:51:16 INFO - Cleaning up... 09:51:16 INFO - Return code: 0 09:51:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fc737bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, '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': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:51:16 INFO - Using env: {'DISPLAY': ':0', 09:51:16 INFO - 'HOME': '/home/cltbld', 09:51:16 INFO - 'LANG': 'en_US.UTF-8', 09:51:16 INFO - 'LANGUAGE': 'en_US:en', 09:51:16 INFO - 'LOGNAME': 'cltbld', 09:51:16 INFO - 'MAIL': '/var/mail/cltbld', 09:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:16 INFO - 'MOZ_NO_REMOTE': '1', 09:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:16 INFO - 'NO_EM_RESTART': '1', 09:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:16 INFO - 'SHELL': '/bin/bash', 09:51:16 INFO - 'SHLVL': '1', 09:51:16 INFO - 'TERM': 'linux', 09:51:16 INFO - 'TMOUT': '86400', 09:51:16 INFO - 'USER': 'cltbld', 09:51:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:16 INFO - '_': '/tools/buildbot/bin/python'} 09:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:16 INFO - Downloading/unpacking flake8 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:51:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:51:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:51:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:51:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 09:51:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:51:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:19 INFO - no previously-included directories found matching 'docs/_build' 09:51:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:51:19 INFO - Running setup.py install for pep8 09:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:19 INFO - no previously-included directories found matching 'docs/_build' 09:51:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:51:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:51:19 INFO - Cleaning up... 09:51:19 INFO - Return code: 0 09:51:19 INFO - Running post-action listener: _resource_record_post_action 09:51:19 INFO - Running post-action listener: _start_resource_monitoring 09:51:19 INFO - Starting resource monitoring. 09:51:19 INFO - ##### 09:51:19 INFO - ##### Running install step. 09:51:19 INFO - ##### 09:51:19 INFO - Running pre-action listener: _resource_record_pre_action 09:51:19 INFO - Running main action method: install 09:51:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:51:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:51:19 INFO - Reading from file tmpfile_stdout 09:51:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:51:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:51:19 INFO - Reading from file tmpfile_stdout 09:51:19 INFO - Output received: 09:51:19 INFO - Usage: mozinstall [options] installer 09:51:19 INFO - Options: 09:51:19 INFO - -h, --help show this help message and exit 09:51:19 INFO - -d DEST, --destination=DEST 09:51:19 INFO - Directory to install application into. [default: 09:51:19 INFO - "/builds/slave/test-pgo"] 09:51:19 INFO - --app=APP Application being installed. [default: firefox] 09:51:19 INFO - mkdir: /builds/slave/test-pgo/build/application 09:51:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:51:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:51:35 INFO - Reading from file tmpfile_stdout 09:51:35 INFO - Output received: 09:51:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:51:35 INFO - Running post-action listener: _resource_record_post_action 09:51:35 INFO - ##### 09:51:35 INFO - ##### Running run-tests step. 09:51:35 INFO - ##### 09:51:35 INFO - Running pre-action listener: _resource_record_pre_action 09:51:35 INFO - Running main action method: run_tests 09:51:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:51:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:51:35 INFO - Python 2.7.3 09:51:35 INFO - Return code: 0 09:51:35 INFO - grabbing minidump binary from tooltool 09:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961540>, '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 0x2962440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29628f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:51:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:51:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:51:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:35 INFO - Return code: 0 09:51:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:51:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:51:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:51:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:51:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:51:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:51:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:51:36 INFO - Return code: 0 09:51:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:51:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:51:36 INFO - Using env: {'DISPLAY': ':0', 09:51:36 INFO - 'HOME': '/home/cltbld', 09:51:36 INFO - 'LANG': 'en_US.UTF-8', 09:51:36 INFO - 'LANGUAGE': 'en_US:en', 09:51:36 INFO - 'LOGNAME': 'cltbld', 09:51:36 INFO - 'MAIL': '/var/mail/cltbld', 09:51:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:51:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:36 INFO - 'MOZ_NO_REMOTE': '1', 09:51:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:36 INFO - 'NO_EM_RESTART': '1', 09:51:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:51:36 INFO - 'SHELL': '/bin/bash', 09:51:36 INFO - 'SHLVL': '1', 09:51:36 INFO - 'TERM': 'linux', 09:51:36 INFO - 'TMOUT': '86400', 09:51:36 INFO - 'USER': 'cltbld', 09:51:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690', 09:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:36 INFO - '_': '/tools/buildbot/bin/python'} 09:51:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:51:37 INFO - mozversion application_buildid: 20160109073343 09:51:37 INFO - mozversion application_changeset: 108e407489921aae013640db1e1ccc596fa3c73b 09:51:37 INFO - mozversion application_display_name: Nightly 09:51:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:37 INFO - mozversion application_name: Firefox 09:51:37 INFO - mozversion application_remotingname: firefox 09:51:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:51:37 INFO - mozversion application_vendor: Mozilla 09:51:37 INFO - mozversion application_version: 46.0a1 09:51:37 INFO - mozversion platform_buildid: 20160109073343 09:51:37 INFO - mozversion platform_changeset: 108e407489921aae013640db1e1ccc596fa3c73b 09:51:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:51:37 INFO - mozversion platform_version: 46.0a1 09:51:37 INFO - using testdate: 1452361897 09:51:37 INFO - actual date: 1452361897 09:51:37 INFO - starting webserver on 'localhost:46577' 09:51:37 INFO - SUITE-START | Running 3 tests 09:51:37 INFO - TEST-START | dromaeo_css 09:51:37 INFO - operating with platform_type : linux_ 09:51:37 INFO - Initialising browser for dromaeo_css test... 09:51:37 INFO - TEST-INFO | started process 3358 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgRVxPl/profile http://localhost:46577/getInfo.html) 09:51:43 INFO - PROCESS | 3358 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 09:51:44 INFO - PROCESS | 3358 | __metrics Screen width/height:1600/1200 09:51:44 INFO - PROCESS | 3358 | colorDepth:24 09:51:44 INFO - PROCESS | 3358 | Browser inner width/height: 1024/697 09:51:44 INFO - PROCESS | 3358 | __metrics 09:51:44 INFO - PROCESS | 3358 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:51:45 INFO - TEST-INFO | 3358: exit 0 09:51:45 INFO - Browser initialized. 09:51:45 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:45 INFO - TEST-INFO | started process 3489 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgRVxPl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:57 INFO - PROCESS | 3489 | RSS: Main: 150687744 09:51:57 INFO - PROCESS | 3489 | 09:52:47 INFO - PROCESS | 3489 | 1452361967027 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] 09:54:55 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:46577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46577/tests/dromaeo/cssquery-ext.html) 09:54:56 INFO - PROCESS | 3489 | RSS: Main: 157691904 09:54:56 INFO - PROCESS | 3489 | 09:57:58 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:46577/tests/dromaeo/cssquery-ext.html (next: http://localhost:46577/tests/dromaeo/cssquery-jquery.html) 09:57:59 INFO - PROCESS | 3489 | RSS: Main: 152932352 09:57:59 INFO - PROCESS | 3489 | 10:01:01 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:46577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46577/tests/dromaeo/cssquery-mootools.html) 10:01:01 INFO - PROCESS | 3489 | RSS: Main: 153706496 10:01:01 INFO - PROCESS | 3489 | 10:04:03 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:46577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46577/tests/dromaeo/cssquery-prototype.html) 10:04:03 INFO - PROCESS | 3489 | RSS: Main: 152793088 10:04:03 INFO - PROCESS | 3489 | 10:07:06 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:46577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46577/tests/dromaeo/cssquery-yui.html) 10:07:06 INFO - PROCESS | 3489 | RSS: Main: 153845760 10:07:06 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:46577/tests/dromaeo/cssquery-yui.html (next: http://localhost:46577/tests/dromaeo/cssquery-dojo.html) 10:10:09 INFO - PROCESS | 3489 | RSS: Main: 155783168 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | __start_tp_report 10:10:09 INFO - PROCESS | 3489 | _x_x_mozilla_page_load 10:10:09 INFO - PROCESS | 3489 | _x_x_mozilla_page_load_details 10:10:09 INFO - PROCESS | 3489 | |i|pagename|runs| 10:10:09 INFO - PROCESS | 3489 | |0;dojo.html;3155.1165673611386;3218.871245150194;3235.9676403235962;3250.8537115829795;3268.967310326896;5152.69083854969;5283.656562323446;5295.417504074553;5316.229146773716;5326.9733651331735;5205;5231.189165679316;5243.659162154458;5249.212618107285;5269.710165940872;4471.8658440246845;4750.76246187691;4847.2971419144205;4850.029994001214;4893.6329775266995;4723.645726570504;4803.159447096744;4835.830745923893;4844.806207751686;4852.902941941159;4713.293006049103;4790.856274311742;4790.880227994293;4793.616510679155;4804.4234691836855;4762.309465127537;4773.832915847928;4779.498152693952;4797.544233297866;4827.806887724487;4746.406699162605;4764.928526072112;4765.0231702500905;4811.422629284508;4832.565069143794;4988.7006779592975;5024.62315326352;5041.143005689041;5046.5205805448795;5120.257562653394;5597.076482380443;5631.690257035862;5641.548676105943;5660.943390566083;5694.629849059839;5615;5640.8871822563315;5681.659100453986;5697.6866272355;5717.42825717425;5227.111391063529;5241.895162096813;5259.0796610593;5278.023565640369;5312.468753124656;5683.119116536944;5723.942760572341;5730.36965933747;5735.8852822944145;5779.8555036124435;5416.91874621881;5498.725063746877;5508.586855985817;5529;5613.186088017214;5617.438256174431;5641.689707066069;5643.492085712305;5658.886822263614;5666.15007748841;5613.186088017214;5634.408387119375;5640.492355688008;5640.520555752807;5657.462541058593;5417.83746487606;5471.7264136793;5558.916616250759;5614.989301925611;5681.659100453986;4298.312270036779;4343.565643435694;4351.8476853309985;4353.934690979638;4388.451443569554;3860.092878173627;3876.7480113792512;3888.397298418693;3898.1034362096875;3929.587393323717;5244.685318880879;5247.16045432729;5269.051570717308;5341.679499230058;5371.764494166286;5592.3009623797025;5605.775768969277;5624.959382514248;5648.63283886546;5651.547876169897;5249.737513124329;5268.236105764643;5272.841814745564;5326.201069839555;5337.8131765388025;4814.301926220748;4876.561109500162;4884.682495637772;4900.289458028566;4913.70517768935;5830.650160990354;5833.591648584643;5838.970805145947;5860.853478663067;5865.912011319833;5532.30846144232;5641;5652.3217213934595;5664.518515926193;5711.086226203954;5586.301712285965;5719.771209151588;5812;5828.271466066742;5850.23946886902;5480.205370221375;5491.2312276282155;5498.202760599771;5503.614746967673;5542.974549708317;5573.832785016456;5612.859678507906;5617.045102332531;5623.943760562505;5682.715864206856;5517.613767036269;5593.328800543961;5601.60788744784;5609.579281553818;5650.886982260414;5430.456954304696;5478.589105817159;5489.231507589021;5497.890042199214;5510.228568000403;5382.892342153056;5391.137418013099;5425.06848699878;5476.2607048048;5481.205225242238;5480.72596370172;5525.171224316385;5539.030669632879;5551.278333816578;5577.414371490935;5409.675419474686;5412.945870541244;5433.347998240237;5454.127339625641;5468.589855760754 10:10:09 INFO - PROCESS | 3489 | |1;ext.html;507.3961985237565;536.4849744245524;539.2369796737617;541.0963690636636;552.698779165355;27838.304042398926;28456;36135.096622584446;36268.64253823503;36362.27282953776;37815.621843781555;38092.42861357082;38326.42510362347;38384.42423363645;38428.423573646345;8284.58577071147;8428.494290342569;8439.198276163756;8444.662213511452;8452.704155354564;8061.355091592688;8191.344692424622;8200.876986845202;8280.213379728915;8290.83418331633;8312.293455056297;8401.117882622328;8563.828723425528;8602.48385096893;8622.698205562807;8459.196376344238;8461.576921153948;8475.49147051179;8536.402451828375;8547.273481754028;8306.210909963544;8407.117252688502;8429.957850210709;8462.449940753893;8463.746087617319;37506;37514;37608.623913760784;37705;37976;2844.5164322065298;2880.438314528668;3031.666516683163;3165.9525107123413;3347.4309367407354;28527.714722852714;28692.426151477062;29085.197960258785;29148.8542557288;29477.41045179106;3773.716971227169;3807.3527500325013;3847.153626202231;3859.459675645412;3978.8408463661417;271004;273296;274112;274656.999999998;275543;52039.47960520422;52644.736776315876;58534.12198817021;59009;59431.40568594345;52812.47187528075;52926.20610690843;53030.204546931054;53065;53105.2034219487;15246.847531524543;15262.236888155549;15283.770743438858;15375.461858834888;15548.611284717972;11873.228240164362;11910.940445297718;11965.820512692317;11982.940085299517;12014.038876889828;18832.811671883104;18958.71561926572;19515.609687806165;19772;19783.10976006083;7743.109542402583;7858.528488290606;7868.763937081897;7991.24083212094;8034.196580341919;919.8988111307751;934.4486752815872;1063.7181146996052;1067.4716015572342;1136.5737848306885;27966.86016569904;28134.71865281362;28178;28324;28336.291592709935;1045.811753884293;1064.6539874540806;1129.412705393191;1139.3334899083964;1142.3659868772745;14626.414943402146;14632.487862924747;14914.627134321512;15765.763513547307;16329.836701633069;305283;308779;311216;311607;314128;48851.75574122178;48884.26673599899;49068.26397604039;49147.75426122918;49317;1354.2686949047602;1358.843732970721;1375.4223226245;1385.2727318157847;1386.4869998100767;26685.466290674467;28579.428411432073;29594.260143496584;29599;29708.55437168401;43253.3511997314;43323.35014974715;43451.34822977721;43507.347389789815;43767.343489847044;309196;310003.84974976553;310664;311260;312830;31435.685643143275;40376.3943540853;40434;41194.38208426816;41624;38011.42982855315;38068.80965595154;38572.80713596414;39037;39191.60808391879;32661.510077348383;33048.66951330456;33296.500552492216;33477;33825.15437114092;34105.829470852485;35746.10634734049;35938;36041;36942.26115477621;32631.673683262863;32831;32882;33549.16127096842;34436.48345274873;31449.685503145593;32467.18832029218;32621.673783262813;32708.34583308368;32895.342093158484;24758;24989.87505062463;25400;26942.865285673448;27712.44575108527 10:10:09 INFO - PROCESS | 3489 | |2;jquery.html;342.3034125554499;347.3365871186035;361.1566991075838;361.6618461738275;363.4058314655537;16254.106024168681;16712.58218544537;17468.912655436707;17928.462146135622;18104.637907241846;15496.767548486754;15588.766168507482;16093.356265749386;16133.193340332966;16166.676666466663;4765.880852978668;4937.827176048839;4955.554000139987;4967.776450059756;4984.700917944917;4813.061453016663;4824.179889418807;4875.439324477695;4895.681780684262;4954.157793175169;4910.926336104962;4925.82759603414;4943.505649435064;4974.751262436882;5210.218467229908;5099.821506247301;5102.6173037022;5117.283580298761;5118.744062796864;5144.22836574515;5293.153095504739;5294.788208471657;5307.071262529042;5314.256004159421;5316.3354580677415;12704.110712250145;16812.915935420366;18981.43055708331;19995.80004199954;19998.900005500025;2012.5069358007381;2013.5872146209992;2036.9694454583193;2045.4988527810633;2239.703102163388;9567.617295308179;10080.991900809933;12198.390080496029;12458.190217635825;12770.936145319214;1698.2188193431036;1747.6329970706167;1757.8066412694593;1801.9369322073796;1816.5766358916082;54977.72511137419;56787.716061419844;57829.99999999958;58346;58761.706191468766;10113.64602238918;10122.949385253174;10195.847062294071;10238.436885971194;10253.282270241161;13276.867231327757;13367;13413.262270575213;13418.932905335607;13449.529266475627;7687.5387476751575;7744.148143704188;7765.689372425153;7781.26078022587;7789.337906277917;7521.285477879593;7540.509866858746;7561.508501947355;7577.431692623075;7622.123455802543;4435.3125265583885;4445.3998710174355;4463.486699029589;4485;4503.527129651405;1835.4386209784375;1842.5946291815778;1877.7465042219399;1905.9904700476409;1909.1122627978057;882.8984666763276;905.1491597897955;971.2327261463365;1016.2987538598492;1033.9247182929819;15488;15636.061836289859;16290.42983495572;16429.91785041091;16536.007839529666;874.7813046738315;881.6870011145951;917.312015988009;920.6777627830206;938.6339327662217;9114;9328.486933218603;9411;9578.377405468622;9870.963548827413;487909;497128;497735;503882;517148;41607.1678566427;41987.16025679469;49521.25718114231;72605.27394725985;74843;1100.1803656276124;1106.6956586938657;1118.6364431559614;1126.3467189030343;1130.1185075641013;15131.54605361841;15250;15389.615259618151;15598.220088995731;15762.921185394458;32144.517832233003;33059.33881322408;33386.833065834515;33782;34785.956421307405;41374.112855731226;42669.9594566893;42908.57091429046;43478.34782478328;45118.548814512746;7253.274672532704;9341.392809467363;9619.615215391586;9761.170300524534;9887.505624718879;10889.891101088888;11038.392888391216;11228.157888158257;11320.660380188607;11639.941800290944;7222.74720384784;7358.742444014434;7559.938225018876;7658.923410766044;7679.539227646359;7512.737054203077;7717.073951125901;7909.52542847431;7930.722424715107;7931.801704957422;7931.36549076061;8005.519668819889;8080.191980801873;8093.757187284391;8116.147804480444;8797.912020879709;9218.492982886006;9958.55186516623;10321.690349289533;10443.738906527398;9203.86194207074;9289.489078100769;9598.520073996133;9622.47076410804;9634.855477167708 10:10:09 INFO - PROCESS | 3489 | |3;mootools.html;1457.8687918087371;1471.0732238689627;1622.69168857917;1748.3094177799762;1764.3824661368524;7462.776116716501;7596.050493688289;7636.9236307636975;7657.195994420589;7672.53964762114;7622.542647441143;7679.193684663113;7690.384769218463;7804.219578042193;7812.101608315045;2261.8869056547146;2308.9653655195184;2311.2719493359537;2311.9653205201935;2313.6298192289237;2358.7641235876445;2376.441536238991;2381.880905954704;2387.9283621491295;2397.3287479505766;2225.721784776903;2278.396225000368;2279.1453205048106;2290.3014580552926;2299.8620082795;2286.977130228693;2319.6288593824993;2354.929352119439;2356.1635619355225;2358.457554762397;2360.929172124822;2361.2916125162383;2362.385779697274;2390.1634427950253;2395.2454976682466;7522.097348318182;7568.243175682388;7577.583232922187;7599;7600.50596711212;4675.812967481296;4806.110869489155;4809.350737650408;4821.879453013667;4825.30033145192;2981.2844917219927;2990.1029691092585;3068.8925887593828;3072.9231769205726;3079.3533357994847;1004.9949750251202;1005.4520286443906;1865.9253629854788;1933.9709904351446;1943.8444924406015;10359.067683908484;10398.84401733967;10444.791104177873;10506.422146781924;10531.157507399466;4088.100617864065;4122.628963393309;4162.646175075092;4194.328907374806;4219.346001369792;8465.195806398382;8475.321974242046;8510.106438823957;8550.230479256898;8551.358648101417;4721.763911804396;4726.976365118221;4746.7389293589185;4776.617870570346;4789.185838407479;4392.450943632046;4404.229259879508;4411.669124815588;4426.579474949875;4439.66702497314;3422.401079811023;3489.7557170998293;3505.071156143624;3516.7362447816004;3526.365254254259;1039.4127318065268;1060.596973150198;1086.8750093739163;1097.023648952433;1099.6371197504805;1058.4866339825178;1104.7017305327518;1150.9482073306722;1251.8998480121568;1350.1898860683511;7014.789556313217;7034.6482675866;7035.47233957445;7077.221505634376;7162.355388015104;633.6514916795744;633.87956288306;640.5324113397153;645.6997496164212;781.956088621685;5436.048691478975;5503.532199762985;5586.972065139648;5595.38450770415;5624.156376543551;9004.8649270261;9216.07839216073;9241.768955776159;9340.439573625605;9376.01551837061;9206.401583897024;9413.246940244764;9422.057794220524;9437;9526.523673816282;7412.407007439392;7425.294597013275;7428.294312040348;7455.664495097733;7481.663325150382;6999.160100787938;7104.893426598502;7117.501774875709;7118.822029449098;7143.714251429885;8241.546714930737;8360.665573376997;8401.62192701342;8508.234258916727;8595.699150529701;8531.274841638531;8607.139286071342;8661.220490155916;8691.695790647549;8743.825123497621;6416;6427.100205971261;6489.837754055998;6514.902276465762;6529.216494020748;7440.479166458296;7459.888101678588;7479.70081196746;7480.551166930001;7535.623218839146;6793;6918.342757438237;7069.016050590873;7169.390601798906;7193.964030179815;6628.801135965929;6727.865442691021;6773.153355830521;6795.864082718417;6899.6205208714;6709.7651582194385;6812.455003599799;6832.453403727789;6833.282505337067;6849.554778939353;6015.4586087252355;6049.485793707408;6058.666773327509;6087.695615219132;6107.786227482017;6269.811905642838;6281.12064311006;6329.208848893888;6419.711112999833;6472 10:10:09 INFO - PROCESS | 3489 | |4;prototype.html;350.3798277049622;350.78952628422934;351.1274482909968;353.9681428671419;355.14410271246294;6304.936950630492;6315.68421578921;6368.33132521085;6372.490200783937;6499.480041596673;6262.561620686553;6302.275238347592;6309.242890853093;6327.050942358648;6332.176817013793;4815.831445899395;4819.590334821544;4832.4684284728655;4833.879153021167;4840.370751802261;4816.349792777965;4844.806207751686;4845.103655823684;4847.806087756486;4859.149648811462;4701.529847015288;4778.80884764609;4796.280557916306;4804.231322988323;4806.687565308243;4784.545468180518;4785.258284965836;4796.208625576758;4799.304100905384;4805.303231031481;4170.249355116078;4182.477190351206;4182.811773470201;4188.706790524634;4204.138151678899;5955.434233747787;5992.011318132503;6000.18997435345;6002.3697511761075;6012.218411606507;5422.75597598109;5617.887642247132;5625.128105143709;5625.774969001235;5643.633163844337;6672.199336079653;6698.062271282024;6708.262091169968;6709.664516774142;6721.6975236114495;4595.678302518825;4602.815887364502;4617.884552886171;4641.350210970467;4641.675082744209;6747.122874026394;6910.896336554955;6919.481038922101;6991.196012458581;7009.299070093001;4662.976685116552;4668.253079507331;4681.7190968542;4683.859484215479;4694.201985662446;4734.502877197845;4742.146413645508;4748.525147485293;4750.453697824794;4759.262314341283;5492.670439773627;5498;5500.147477140969;5500.1749737539685;5503.3120859892515;6533.771318003942;6688.699008544627;6692.966535167293;6702.0282059101155;6707;1658.4112640012863;1683.1752441303672;1705.7953045634604;1707.3853412771393;1717.3216579451296;1105.8562386889653;1133.4559411482535;1134.8467956825723;1136.6135513925306;1140.224647239885;6299.307076221612;6302.527310451735;6317.936820631827;6322;6343.065365063608;6792.252852186256;6795.048693182958;6796.796096117125;6799.660016999229;6840.897386539206;6095.4818840398175;6295.874082518416;6312.43188113072;6321.8735625288155;6324.968375158187;3693.3351996640326;3704.129529560551;3714.925701486009;3716.405375140019;3727.8322475488667;7026;7043.7321282169705;7060.082189315356;7112.502124851314;7138.678759455837;6963.82590435233;6964.721411143599;6969.930300697029;6983.336583024605;6989.126359205099;7327.45044121693;7330.486865919334;7331.780046598504;7335.193128755833;7336.449766267551;6913.792586222421;6953.20038195614;6965;6967.233604303624;6990.196127445409;6806.081179040766;6903.482238832007;6919.6886140124825;6928.861422771415;6938.5836849789175;7277.818054548678;7281.745138920112;7283.7450689225625;7291.197968223597;7297.963510182628;4687.929681054855;4739.881502962454;4758.1435341638835;4763.595094416874;4771.475137734777;6839.521233513607;6958.826029349307;6963.825904352431;6964.512484126265;6974.093367862349;6741.325867413219;6757.594544327356;6772.0857684212;6773.458123350021;6773.93226067733;6637.402633762985;6640.169978752656;6667.199936007516;6671.8665626686225;6691.899621505779;6433.131527243762;6595.472362211108;6612.735490580515;6616.470682345304;6633;6711.758324709945;6713.832154195989;6761.22245941723;6769.966150169218;6783.21992970795;6588.37410446026;6592.868142637216;6592.967035164794;6599;6600.174978127734 10:10:09 INFO - PROCESS | 3489 | |5;yui.html;720.8125887269312;724.3299947548517;804.4971892567146;850.5407080176705;858.974230773077;12158.878411215885;12350.505979760821;12406.379681015937;12414.937925310383;12434.378281085943;11634.941825290862;11674.241174323684;11699.766004679901;12862.421191046402;13194.142380745245;780.1262585903781;785.6386062411298;789.4355535791908;791.3115589437198;793.5080250244828;785.7249962513104;790.549386849496;792.1484404265409;792.5363662257586;793.6507936507946;814.2590242878952;821.6384790692106;821.9219174178473;824.9505029698207;825.7770401991459;816.346922462028;817.6238930092164;818.4761752478419;818.8362327534487;821.100894520502;597.3518732175595;598.8920497080367;600.2197143713155;601.2514419547647;601.7442586900594;12433.3783310835;12439;12451.315177665225;12469.251844889335;12497.875021249762;12086.33525156116;12392.256464612063;12707.872921270762;12837.229766213964;12839.404966609365;10509.106725928305;10612.787744245072;10617.41604211768;10775.245732798707;10849.457527123612;3569.1077230692326;3633.691136253395;3643.5081264029545;3646.161382881952;3753;45165.774171128935;45213.547864521264;45504.544954550365;45563.08873822538;45771;9219;9971.40171589707;10008.749781255381;10076.84884726715;10251.077403033614;17267.136643167792;17305.56736081608;17329.22018509145;17344.13279336028;17380.739288910678;6996.825079373057;7078.221395646475;7371.520851144658;7427.331540161412;7526.247375262539;4296.076343586144;4366.6506679465565;4375.387207890317;4382.211850123222;4402.207602631493;2787.6794168670863;2812.3250419899077;2826.5053615617594;2829.2219639599275;2855.971440285612;551.4154995704566;553.1232995701857;557.9274694289717;558.8742532930058;569.9572532060112;556.1713047559108;592.8517870532366;639.0414378432351;652.6508318049915;693.4833549006023;8463.830723385621;9041.59312830911;9075.727728168165;9465.432074075577;9586.60334916271;539.5953035223582;589.7611467355728;663.2439019517753;668.3683918696883;690.7064497588505;4184.790760461965;4265.55211702773;4407.27279998803;4449.7330160190495;4492.3710680504755;60299.79400411967;60423.697881510314;60466;60511;60666;46844.7657761709;48374.75812620985;48551.75724121357;50519.24221136612;50553.49446505488;42336.57663423388;43715.34426983598;43876;44050.118997619866;44456.77771611121;8746.825063498567;8920.643174272956;8954.598091282984;8973.685920992733;9123.452592844451;32424.892381995094;33159.336813263115;33687.66312336845;33730.15674608154;34034;37502.62497375101;37660.05849853776;46459.53540464687;46808.53191468042;48267.5173248263;10012.69961901144;10194.592216311265;10567.418791966516;10827.025567698945;10925.344479331265;11482.827757583476;11632.127590430582;11707.414629268333;11813.822792657946;11918.880811191777;10083.445410502492;10444;10589.205809564468;11102.333859968428;11479.196456248317;10459.29060460308;10516.737081573021;10553.788924221319;10566.577336906437;11626.186166968231;10692.572297108029;10697.358158510515;10728.088112510524;10737.946310268399;11114.555417783198;8765.517896515752;9187.356885018253;9368.765780855532;9397.664474010544;9480.478573678514;8678.609462574073;8919.42023768453;9173.954130229306;9282;9700.660476883275 10:10:09 INFO - PROCESS | 3489 | __end_tp_report 10:10:09 INFO - PROCESS | 3489 | __start_cc_report 10:10:09 INFO - PROCESS | 3489 | _x_x_mozilla_cycle_collect,310 10:10:09 INFO - PROCESS | 3489 | __end_cc_report 10:10:09 INFO - PROCESS | 3489 | __startTimestamp1452363009522__endTimestamp 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | ------- Summary: start ------- 10:10:09 INFO - PROCESS | 3489 | Number of tests: 6 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | [#0] dojo.html Cycles:165 Average:5228.50 Median:5430.46 stddev:567.22 (10.4%) stddev-sans-first:545.14 10:10:09 INFO - PROCESS | 3489 | Values: 3155.1 3218.9 3236.0 3250.9 3269.0 5152.7 5283.7 5295.4 5316.2 5327.0 5205.0 5231.2 5243.7 5249.2 5269.7 4471.9 4750.8 4847.3 4850.0 4893.6 4723.6 4803.2 4835.8 4844.8 4852.9 4713.3 4790.9 4790.9 4793.6 4804.4 4762.3 4773.8 4779.5 4797.5 4827.8 4746.4 4764.9 4765.0 4811.4 4832.6 4988.7 5024.6 5041.1 5046.5 5120.3 5597.1 5631.7 5641.5 5660.9 5694.6 5615.0 5640.9 5681.7 5697.7 5717.4 5227.1 5241.9 5259.1 5278.0 5312.5 5683.1 5723.9 5730.4 5735.9 5779.9 5416.9 5498.7 5508.6 5529.0 5613.2 5617.4 5641.7 5643.5 5658.9 5666.2 5613.2 5634.4 5640.5 5640.5 5657.5 5417.8 5471.7 5558.9 5615.0 5681.7 4298.3 4343.6 4351.8 4353.9 4388.5 3860.1 3876.7 3888.4 3898.1 3929.6 5244.7 5247.2 5269.1 5341.7 5371.8 5592.3 5605.8 5625.0 5648.6 5651.5 5249.7 5268.2 5272.8 5326.2 5337.8 4814.3 4876.6 4884.7 4900.3 4913.7 5830.7 5833.6 5839.0 5860.9 5865.9 5532.3 5641.0 5652.3 5664.5 5711.1 5586.3 5719.8 5812.0 5828.3 5850.2 5480.2 5491.2 5498.2 5503.6 5543.0 5573.8 5612.9 5617.0 5623.9 5682.7 5517.6 5593.3 5601.6 5609.6 5650.9 5430.5 5478.6 5489.2 5497.9 5510.2 5382.9 5391.1 5425.1 5476.3 5481.2 5480.7 5525.2 5539.0 5551.3 5577.4 5409.7 5412.9 5433.3 5454.1 5468.6 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | [#1] ext.html Cycles:180 Average:45902.46 Median:34271.16 stddev:78090.82 (227.9%) stddev-sans-first:78235.50 10:10:09 INFO - PROCESS | 3489 | Values: 507.4 536.5 539.2 541.1 552.7 27838.3 28456.0 36135.1 36268.6 36362.3 37815.6 38092.4 38326.4 38384.4 38428.4 8284.6 8428.5 8439.2 8444.7 8452.7 8061.4 8191.3 8200.9 8280.2 8290.8 8312.3 8401.1 8563.8 8602.5 8622.7 8459.2 8461.6 8475.5 8536.4 8547.3 8306.2 8407.1 8430.0 8462.4 8463.7 37506.0 37514.0 37608.6 37705.0 37976.0 2844.5 2880.4 3031.7 3166.0 3347.4 28527.7 28692.4 29085.2 29148.9 29477.4 3773.7 3807.4 3847.2 3859.5 3978.8 271004.0 273296.0 274112.0 274657.0 275543.0 52039.5 52644.7 58534.1 59009.0 59431.4 52812.5 52926.2 53030.2 53065.0 53105.2 15246.8 15262.2 15283.8 15375.5 15548.6 11873.2 11910.9 11965.8 11982.9 12014.0 18832.8 18958.7 19515.6 19772.0 19783.1 7743.1 7858.5 7868.8 7991.2 8034.2 919.9 934.4 1063.7 1067.5 1136.6 27966.9 28134.7 28178.0 28324.0 28336.3 1045.8 1064.7 1129.4 1139.3 1142.4 14626.4 14632.5 14914.6 15765.8 16329.8 305283.0 308779.0 311216.0 311607.0 314128.0 48851.8 48884.3 49068.3 49147.8 49317.0 1354.3 1358.8 1375.4 1385.3 1386.5 26685.5 28579.4 29594.3 29599.0 29708.6 43253.4 43323.4 43451.3 43507.3 43767.3 309196.0 310003.8 310664.0 311260.0 312830.0 31435.7 40376.4 40434.0 41194.4 41624.0 38011.4 38068.8 38572.8 39037.0 39191.6 32661.5 33048.7 33296.5 33477.0 33825.2 34105.8 35746.1 35938.0 36041.0 36942.3 32631.7 32831.0 32882.0 33549.2 34436.5 31449.7 32467.2 32621.7 32708.3 32895.3 24758.0 24989.9 25400.0 26942.9 27712.4 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | [#2] jquery.html Cycles:180 Average:25960.84 Median:4789.47 stddev:81698.87 (1705.8%) stddev-sans-first:81905.41 10:10:09 INFO - PROCESS | 3489 | Values: 342.3 347.3 361.2 361.7 363.4 16254.1 16712.6 17468.9 17928.5 18104.6 15496.8 15588.8 16093.4 16133.2 16166.7 4765.9 4937.8 4955.6 4967.8 4984.7 4813.1 4824.2 4875.4 4895.7 4954.2 4910.9 4925.8 4943.5 4974.8 5210.2 5099.8 5102.6 5117.3 5118.7 5144.2 5293.2 5294.8 5307.1 5314.3 5316.3 12704.1 16812.9 18981.4 19995.8 19998.9 2012.5 2013.6 2037.0 2045.5 2239.7 9567.6 10081.0 12198.4 12458.2 12770.9 1698.2 1747.6 1757.8 1801.9 1816.6 54977.7 56787.7 57830.0 58346.0 58761.7 10113.6 10122.9 10195.8 10238.4 10253.3 13276.9 13367.0 13413.3 13418.9 13449.5 7687.5 7744.1 7765.7 7781.3 7789.3 7521.3 7540.5 7561.5 7577.4 7622.1 4435.3 4445.4 4463.5 4485.0 4503.5 1835.4 1842.6 1877.7 1906.0 1909.1 882.9 905.1 971.2 1016.3 1033.9 15488.0 15636.1 16290.4 16429.9 16536.0 874.8 881.7 917.3 920.7 938.6 9114.0 9328.5 9411.0 9578.4 9871.0 487909.0 497128.0 497735.0 503882.0 517148.0 41607.2 41987.2 49521.3 72605.3 74843.0 1100.2 1106.7 1118.6 1126.3 1130.1 15131.5 15250.0 15389.6 15598.2 15762.9 32144.5 33059.3 33386.8 33782.0 34786.0 41374.1 42670.0 42908.6 43478.3 45118.5 7253.3 9341.4 9619.6 9761.2 9887.5 10889.9 11038.4 11228.2 11320.7 11639.9 7222.7 7358.7 7559.9 7658.9 7679.5 7512.7 7717.1 7909.5 7930.7 7931.8 7931.4 8005.5 8080.2 8093.8 8116.1 8797.9 9218.5 9958.6 10321.7 10443.7 9203.9 9289.5 9598.5 9622.5 9634.9 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | [#3] mootools.html Cycles:180 Average:5391.38 Median:6275.47 stddev:2754.62 (43.9%) stddev-sans-first:2746.48 10:10:09 INFO - PROCESS | 3489 | Values: 1457.9 1471.1 1622.7 1748.3 1764.4 7462.8 7596.1 7636.9 7657.2 7672.5 7622.5 7679.2 7690.4 7804.2 7812.1 2261.9 2309.0 2311.3 2312.0 2313.6 2358.8 2376.4 2381.9 2387.9 2397.3 2225.7 2278.4 2279.1 2290.3 2299.9 2287.0 2319.6 2354.9 2356.2 2358.5 2360.9 2361.3 2362.4 2390.2 2395.2 7522.1 7568.2 7577.6 7599.0 7600.5 4675.8 4806.1 4809.4 4821.9 4825.3 2981.3 2990.1 3068.9 3072.9 3079.4 1005.0 1005.5 1865.9 1934.0 1943.8 10359.1 10398.8 10444.8 10506.4 10531.2 4088.1 4122.6 4162.6 4194.3 4219.3 8465.2 8475.3 8510.1 8550.2 8551.4 4721.8 4727.0 4746.7 4776.6 4789.2 4392.5 4404.2 4411.7 4426.6 4439.7 3422.4 3489.8 3505.1 3516.7 3526.4 1039.4 1060.6 1086.9 1097.0 1099.6 1058.5 1104.7 1150.9 1251.9 1350.2 7014.8 7034.6 7035.5 7077.2 7162.4 633.7 633.9 640.5 645.7 782.0 5436.0 5503.5 5587.0 5595.4 5624.2 9004.9 9216.1 9241.8 9340.4 9376.0 9206.4 9413.2 9422.1 9437.0 9526.5 7412.4 7425.3 7428.3 7455.7 7481.7 6999.2 7104.9 7117.5 7118.8 7143.7 8241.5 8360.7 8401.6 8508.2 8595.7 8531.3 8607.1 8661.2 8691.7 8743.8 6416.0 6427.1 6489.8 6514.9 6529.2 7440.5 7459.9 7479.7 7480.6 7535.6 6793.0 6918.3 7069.0 7169.4 7194.0 6628.8 6727.9 6773.2 6795.9 6899.6 6709.8 6812.5 6832.5 6833.3 6849.6 6015.5 6049.5 6058.7 6087.7 6107.8 6269.8 6281.1 6329.2 6419.7 6472.0 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | [#4] prototype.html Cycles:180 Average:5593.06 Median:6319.91 stddev:1695.34 (26.8%) stddev-sans-first:1653.79 10:10:09 INFO - PROCESS | 3489 | Values: 350.4 350.8 351.1 354.0 355.1 6304.9 6315.7 6368.3 6372.5 6499.5 6262.6 6302.3 6309.2 6327.1 6332.2 4815.8 4819.6 4832.5 4833.9 4840.4 4816.3 4844.8 4845.1 4847.8 4859.1 4701.5 4778.8 4796.3 4804.2 4806.7 4784.5 4785.3 4796.2 4799.3 4805.3 4170.2 4182.5 4182.8 4188.7 4204.1 5955.4 5992.0 6000.2 6002.4 6012.2 5422.8 5617.9 5625.1 5625.8 5643.6 6672.2 6698.1 6708.3 6709.7 6721.7 4595.7 4602.8 4617.9 4641.4 4641.7 6747.1 6910.9 6919.5 6991.2 7009.3 4663.0 4668.3 4681.7 4683.9 4694.2 4734.5 4742.1 4748.5 4750.5 4759.3 5492.7 5498.0 5500.1 5500.2 5503.3 6533.8 6688.7 6693.0 6702.0 6707.0 1658.4 1683.2 1705.8 1707.4 1717.3 1105.9 1133.5 1134.8 1136.6 1140.2 6299.3 6302.5 6317.9 6322.0 6343.1 6792.3 6795.0 6796.8 6799.7 6840.9 6095.5 6295.9 6312.4 6321.9 6325.0 3693.3 3704.1 3714.9 3716.4 3727.8 7026.0 7043.7 7060.1 7112.5 7138.7 6963.8 6964.7 6969.9 6983.3 6989.1 7327.5 7330.5 7331.8 7335.2 7336.4 6913.8 6953.2 6965.0 6967.2 6990.2 6806.1 6903.5 6919.7 6928.9 6938.6 7277.8 7281.7 7283.7 7291.2 7298.0 4687.9 4739.9 4758.1 4763.6 4771.5 6839.5 6958.8 6963.8 6964.5 6974.1 6741.3 6757.6 6772.1 6773.5 6773.9 6637.4 6640.2 6667.2 6671.9 6691.9 6433.1 6595.5 6612.7 6616.5 6633.0 6711.8 6713.8 6761.2 6770.0 6783.2 6588.4 6592.9 6593.0 6599.0 6600.2 10:10:09 INFO - PROCESS | 3489 | 10:10:09 INFO - PROCESS | 3489 | [#5] yui.html Cycles:180 Average:13407.73 Median:45189.66 stddev:15633.68 (34.6%) stddev-sans-first:15648.50 10:10:09 INFO - PROCESS | 3489 | Values: 720.8 724.3 804.5 850.5 859.0 12158.9 12350.5 12406.4 12414.9 12434.4 11634.9 11674.2 11699.8 12862.4 13194.1 780.1 785.6 789.4 791.3 793.5 785.7 790.5 792.1 792.5 793.7 814.3 821.6 821.9 825.0 825.8 816.3 817.6 818.5 818.8 821.1 597.4 598.9 600.2 601.3 601.7 12433.4 12439.0 12451.3 12469.3 12497.9 12086.3 12392.3 12707.9 12837.2 12839.4 10509.1 10612.8 10617.4 10775.2 10849.5 3569.1 3633.7 3643.5 3646.2 3753.0 45165.8 45213.5 45504.5 45563.1 45771.0 9219.0 9971.4 10008.7 10076.8 10251.1 17267.1 17305.6 17329.2 17344.1 17380.7 6996.8 7078.2 7371.5 7427.3 7526.2 4296.1 4366.7 4375.4 4382.2 4402.2 2787.7 2812.3 2826.5 2829.2 2856.0 551.4 553.1 557.9 558.9 570.0 556.2 592.9 639.0 652.7 693.5 8463.8 9041.6 9075.7 9465.4 9586.6 539.6 589.8 663.2 668.4 690.7 4184.8 4265.6 4407.3 4449.7 4492.4 60299.8 60423.7 60466.0 60511.0 60666.0 46844.8 48374.8 48551.8 50519.2 50553.5 42336.6 43715.3 43876.0 44050.1 44456.8 8746.8 8920.6 8954.6 8973.7 9123.5 32424.9 33159.3 33687.7 33730.2 34034.0 37502.6 37660.1 46459.5 46808.5 48267.5 10012.7 10194.6 10567.4 10827.0 10925.3 11482.8 11632.1 11707.4 11813.8 11918.9 10083.4 10444.0 10589.2 11102.3 11479.2 10459.3 10516.7 10553.8 10566.6 11626.2 10692.6 10697.4 10728.1 10737.9 11114.6 8765.5 9187.4 9368.8 9397.7 9480.5 8678.6 8919.4 9174.0 9282.0 9700.7 10:10:09 INFO - PROCESS | 3489 | -------- Summary: end -------- 10:10:09 INFO - PROCESS | 3489 | 10:10:10 INFO - TEST-INFO | 3489: exit 0 10:10:10 INFO - TEST-OK | dromaeo_css | took 1112898ms 10:10:10 INFO - TEST-START | kraken 10:10:10 INFO - operating with platform_type : linux_ 10:10:10 INFO - Initialising browser for kraken test... 10:10:10 INFO - TEST-INFO | started process 3725 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD4TPeH/profile http://localhost:46577/getInfo.html) 10:10:13 INFO - PROCESS | 3725 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 10:10:14 INFO - PROCESS | 3725 | __metrics Screen width/height:1600/1200 10:10:14 INFO - PROCESS | 3725 | colorDepth:24 10:10:14 INFO - PROCESS | 3725 | Browser inner width/height: 1024/697 10:10:14 INFO - PROCESS | 3725 | __metrics 10:10:14 INFO - PROCESS | 3725 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:10:15 INFO - TEST-INFO | 3725: exit 0 10:10:15 INFO - Browser initialized. 10:10:15 INFO - Running cycle 1/1 for kraken test... 10:10:15 INFO - TEST-INFO | started process 3845 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD4TPeH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:27 INFO - PROCESS | 3845 | RSS: Main: 150024192 10:10:27 INFO - PROCESS | 3845 | 10:10:30 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46577/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:30 INFO - PROCESS | 3845 | RSS: Main: 151384064 10:10:30 INFO - PROCESS | 3845 | 10:10:33 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46577/tests/kraken/driver.html?testName=audio-dft) 10:10:33 INFO - PROCESS | 3845 | RSS: Main: 152068096 10:10:33 INFO - PROCESS | 3845 | 10:10:36 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46577/tests/kraken/driver.html?testName=audio-fft) 10:10:37 INFO - PROCESS | 3845 | RSS: Main: 145616896 10:10:37 INFO - PROCESS | 3845 | 10:10:39 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46577/tests/kraken/driver.html?testName=audio-oscillator) 10:10:40 INFO - PROCESS | 3845 | RSS: Main: 146935808 10:10:40 INFO - PROCESS | 3845 | 10:10:42 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:42 INFO - PROCESS | 3845 | RSS: Main: 147808256 10:10:42 INFO - PROCESS | 3845 | 10:10:45 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46577/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:46 INFO - PROCESS | 3845 | RSS: Main: 146989056 10:10:46 INFO - PROCESS | 3845 | 10:10:49 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46577/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:50 INFO - PROCESS | 3845 | RSS: Main: 148373504 10:10:50 INFO - PROCESS | 3845 | 10:10:53 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46577/tests/kraken/driver.html?testName=json-parse-financial) 10:10:53 INFO - PROCESS | 3845 | RSS: Main: 149516288 10:10:53 INFO - PROCESS | 3845 | 10:10:55 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:56 INFO - PROCESS | 3845 | RSS: Main: 148361216 10:10:56 INFO - PROCESS | 3845 | 10:10:57 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:58 INFO - PROCESS | 3845 | RSS: Main: 149065728 10:10:58 INFO - PROCESS | 3845 | 10:11:00 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:01 INFO - PROCESS | 3845 | RSS: Main: 149090304 10:11:01 INFO - PROCESS | 3845 | 10:11:03 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:04 INFO - PROCESS | 3845 | RSS: Main: 147578880 10:11:04 INFO - PROCESS | 3845 | 10:11:06 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:07 INFO - PROCESS | 3845 | RSS: Main: 149016576 10:11:07 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | Cycle 1(1): loaded http://localhost:46577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46577/tests/kraken/driver.html?testName=ai-astar) 10:11:09 INFO - PROCESS | 3845 | RSS: Main: 149225472 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | __start_tp_report 10:11:09 INFO - PROCESS | 3845 | _x_x_mozilla_page_load 10:11:09 INFO - PROCESS | 3845 | _x_x_mozilla_page_load_details 10:11:09 INFO - PROCESS | 3845 | |i|pagename|runs| 10:11:09 INFO - PROCESS | 3845 | |0;ai-astar;114;109;112;111;113;124;112;111;112;112 10:11:09 INFO - PROCESS | 3845 | |1;audio-beat-detection;154;129;158;166;127;153;154;127;169;127 10:11:09 INFO - PROCESS | 3845 | |2;audio-dft;163;162;162;164;162;160;166;170;164;161 10:11:09 INFO - PROCESS | 3845 | |3;audio-fft;74;74;74;75;72;142;71;72;73;72 10:11:09 INFO - PROCESS | 3845 | |4;audio-oscillator;96;97;137;96;97;97;136;97;98;137 10:11:09 INFO - PROCESS | 3845 | |5;imaging-gaussian-blur;110;109;109;110;109;112;110;109;110;110 10:11:09 INFO - PROCESS | 3845 | |6;imaging-darkroom;147;146;146;147;146;146;146;146;146;148 10:11:09 INFO - PROCESS | 3845 | |7;imaging-desaturate;97;97;97;97;97;96;97;97;98;98 10:11:09 INFO - PROCESS | 3845 | |8;json-parse-financial;60;58;58;57;58;58;60;56;55;58 10:11:09 INFO - PROCESS | 3845 | |9;json-stringify-tinderbox;72;70;69;67;68;68;68;67;68;68 10:11:09 INFO - PROCESS | 3845 | |10;stanford-crypto-aes;86;86;85;86;85;84;87;85;85;85 10:11:09 INFO - PROCESS | 3845 | |11;stanford-crypto-ccm;132;120;119;119;118;123;128;119;134;121 10:11:09 INFO - PROCESS | 3845 | |12;stanford-crypto-pbkdf2;142;153;164;154;150;151;150;164;147;140 10:11:09 INFO - PROCESS | 3845 | |13;stanford-crypto-sha256-iterative;73;69;69;67;70;69;66;67;70;70 10:11:09 INFO - PROCESS | 3845 | __end_tp_report 10:11:09 INFO - PROCESS | 3845 | __start_cc_report 10:11:09 INFO - PROCESS | 3845 | _x_x_mozilla_cycle_collect,768 10:11:09 INFO - PROCESS | 3845 | __end_cc_report 10:11:09 INFO - PROCESS | 3845 | __startTimestamp1452363069368__endTimestamp 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | ------- Summary: start ------- 10:11:09 INFO - PROCESS | 3845 | Number of tests: 14 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:4.08 (3.6%) stddev-sans-first:4.31 10:11:09 INFO - PROCESS | 3845 | Values: 114.0 109.0 112.0 111.0 113.0 124.0 112.0 111.0 112.0 112.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:154.00 stddev:17.06 (11.1%) stddev-sans-first:17.88 10:11:09 INFO - PROCESS | 3845 | Values: 154.0 129.0 158.0 166.0 127.0 153.0 154.0 127.0 169.0 127.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.88 (1.8%) stddev-sans-first:3.05 10:11:09 INFO - PROCESS | 3845 | Values: 163.0 162.0 162.0 164.0 162.0 160.0 166.0 170.0 164.0 161.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:21.86 (29.7%) stddev-sans-first:23.08 10:11:09 INFO - PROCESS | 3845 | Values: 74.0 74.0 74.0 75.0 72.0 142.0 71.0 72.0 73.0 72.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:97.00 stddev:19.24 (19.8%) stddev-sans-first:19.84 10:11:09 INFO - PROCESS | 3845 | Values: 96.0 97.0 137.0 96.0 97.0 97.0 136.0 97.0 98.0 137.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 10:11:09 INFO - PROCESS | 3845 | Values: 110.0 109.0 109.0 110.0 109.0 112.0 110.0 109.0 110.0 110.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:11:09 INFO - PROCESS | 3845 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 148.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:11:09 INFO - PROCESS | 3845 | Values: 97.0 97.0 97.0 97.0 97.0 96.0 97.0 97.0 98.0 98.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.55 (2.7%) stddev-sans-first:1.42 10:11:09 INFO - PROCESS | 3845 | Values: 60.0 58.0 58.0 57.0 58.0 58.0 60.0 56.0 55.0 58.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:0.93 10:11:09 INFO - PROCESS | 3845 | Values: 72.0 70.0 69.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 10:11:09 INFO - PROCESS | 3845 | Values: 86.0 86.0 85.0 86.0 85.0 84.0 87.0 85.0 85.0 85.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:122.00 stddev:5.89 (4.8%) stddev-sans-first:5.34 10:11:09 INFO - PROCESS | 3845 | Values: 132.0 120.0 119.0 119.0 118.0 123.0 128.0 119.0 134.0 121.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:152.00 stddev:7.95 (5.2%) stddev-sans-first:7.65 10:11:09 INFO - PROCESS | 3845 | Values: 142.0 153.0 164.0 154.0 150.0 151.0 150.0 164.0 147.0 140.0 10:11:09 INFO - PROCESS | 3845 | 10:11:09 INFO - PROCESS | 3845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:2.00 (2.9%) stddev-sans-first:1.51 10:11:09 INFO - PROCESS | 3845 | Values: 73.0 69.0 69.0 67.0 70.0 69.0 66.0 67.0 70.0 70.0 10:11:09 INFO - PROCESS | 3845 | -------- Summary: end -------- 10:11:09 INFO - PROCESS | 3845 | 10:11:10 INFO - TEST-INFO | 3845: exit 0 10:11:10 INFO - TEST-OK | kraken | took 60052ms 10:11:10 INFO - TEST-START | v8_7 10:11:10 INFO - operating with platform_type : linux_ 10:11:10 INFO - Initialising browser for v8_7 test... 10:11:10 INFO - TEST-INFO | started process 4130 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiiZtgv/profile http://localhost:46577/getInfo.html) 10:11:14 INFO - PROCESS | 4130 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 10:11:14 INFO - PROCESS | 4130 | __metrics Screen width/height:1600/1200 10:11:14 INFO - PROCESS | 4130 | colorDepth:24 10:11:14 INFO - PROCESS | 4130 | Browser inner width/height: 1024/697 10:11:14 INFO - PROCESS | 4130 | __metrics 10:11:14 INFO - PROCESS | 4130 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:11:15 INFO - TEST-INFO | 4130: exit 0 10:11:15 INFO - Browser initialized. 10:11:15 INFO - Running cycle 1/1 for v8_7 test... 10:11:15 INFO - TEST-INFO | started process 4254 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiiZtgv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:27 INFO - PROCESS | 4254 | RSS: Main: 150880256 10:11:27 INFO - PROCESS | 4254 | 10:11:49 INFO - PROCESS | 4254 | Cycle 1(1): loaded http://localhost:46577/tests/v8_7/run.html (next: http://localhost:46577/tests/v8_7/run.html) 10:11:50 INFO - PROCESS | 4254 | RSS: Main: 147320832 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | __start_tp_report 10:11:50 INFO - PROCESS | 4254 | _x_x_mozilla_page_load 10:11:50 INFO - PROCESS | 4254 | _x_x_mozilla_page_load_details 10:11:50 INFO - PROCESS | 4254 | |i|pagename|runs| 10:11:50 INFO - PROCESS | 4254 | |0;Richards;169.7792869269949 10:11:50 INFO - PROCESS | 4254 | |1;DeltaBlue;189.89745537409797 10:11:50 INFO - PROCESS | 4254 | |2;Encrypt;281.45229383619477 10:11:50 INFO - PROCESS | 4254 | |3;Decrypt;5218.75 10:11:50 INFO - PROCESS | 4254 | |4;RayTrace;1076.3440860215053 10:11:50 INFO - PROCESS | 4254 | |5;Earley;723.589001447178 10:11:50 INFO - PROCESS | 4254 | |6;Boyer;12195.121951219513 10:11:50 INFO - PROCESS | 4254 | |7;RegExp;40784.313725490196 10:11:50 INFO - PROCESS | 4254 | |8;Splay;603.5003017501509 10:11:50 INFO - PROCESS | 4254 | |9;NavierStokes;4840.579710144928 10:11:50 INFO - PROCESS | 4254 | __end_tp_report 10:11:50 INFO - PROCESS | 4254 | __startTimestamp1452363110198__endTimestamp 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | ------- Summary: start ------- 10:11:50 INFO - PROCESS | 4254 | Number of tests: 10 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#0] Richards Cycles:1 Average:169.78 Median:169.78 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 169.8 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#1] DeltaBlue Cycles:1 Average:189.90 Median:189.90 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 189.9 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 281.5 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 5218.8 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#4] RayTrace Cycles:1 Average:1076.34 Median:1076.34 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 1076.3 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#5] Earley Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 723.6 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 12195.1 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#7] RegExp Cycles:1 Average:40784.31 Median:40784.31 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 40784.3 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#8] Splay Cycles:1 Average:603.50 Median:603.50 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 603.5 10:11:50 INFO - PROCESS | 4254 | 10:11:50 INFO - PROCESS | 4254 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:11:50 INFO - PROCESS | 4254 | Values: 4840.6 10:11:50 INFO - PROCESS | 4254 | -------- Summary: end -------- 10:11:50 INFO - PROCESS | 4254 | 10:11:51 INFO - TEST-INFO | 4254: exit 0 10:11:51 INFO - TEST-OK | v8_7 | took 40793ms 10:11:51 INFO - SUITE-END | took 1213s 10:11:51 INFO - Completed test suite (00:20:13) 10:11:51 INFO - Working with test: dromaeo_css 10:11:51 INFO - Generating results file: dromaeo_css 10:11:51 INFO - Working with test: kraken 10:11:51 INFO - Generating results file: kraken 10:11:51 INFO - javascript benchmark 10:11:51 INFO - Working with test: v8_7 10:11:51 INFO - Generating results file: v8_7 10:11:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:11:51 INFO - process_Request line: dromaeo_css 6852.40 graph.html#tests=[[72,1,43]] 10:11:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:51 INFO - process_Request line: kraken 1520.30 graph.html#tests=[[232,1,43]] 10:11:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:51 INFO - process_Request line: v8_7 20284.83 graph.html#tests=[[230,1,43]] 10:11:51 INFO - RETURN: dromaeo_css: 6852.40 10:11:51 INFO - RETURN: kraken: 1520.30 10:11:51 INFO - RETURN: v8_7: 20284.83 10:11:51 INFO - javascript benchmark 10:11:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3155.1165673611386, 3218.871245150194, 3235.9676403235962, 3250.8537115829795, 3268.967310326896, 5152.69083854969, 5283.656562323446, 5295.417504074553, 5316.229146773716, 5326.9733651331735, 5205.0, 5231.189165679316, 5243.659162154458, 5249.212618107285, 5269.710165940872, 4471.8658440246845, 4750.76246187691, 4847.2971419144205, 4850.029994001214, 4893.6329775266995, 4723.645726570504, 4803.159447096744, 4835.830745923893, 4844.806207751686, 4852.902941941159, 4713.293006049103, 4790.856274311742, 4790.880227994293, 4793.616510679155, 4804.4234691836855, 4762.309465127537, 4773.832915847928, 4779.498152693952, 4797.544233297866, 4827.806887724487, 4746.406699162605, 4764.928526072112, 4765.0231702500905, 4811.422629284508, 4832.565069143794, 4988.7006779592975, 5024.62315326352, 5041.143005689041, 5046.5205805448795, 5120.257562653394, 5597.076482380443, 5631.690257035862, 5641.548676105943, 5660.943390566083, 5694.629849059839, 5615.0, 5640.8871822563315, 5681.659100453986, 5697.6866272355, 5717.42825717425, 5227.111391063529, 5241.895162096813, 5259.0796610593, 5278.023565640369, 5312.468753124656, 5683.119116536944, 5723.942760572341, 5730.36965933747, 5735.8852822944145, 5779.8555036124435, 5416.91874621881, 5498.725063746877, 5508.586855985817, 5529.0, 5613.186088017214, 5617.438256174431, 5641.689707066069, 5643.492085712305, 5658.886822263614, 5666.15007748841, 5613.186088017214, 5634.408387119375, 5640.492355688008, 5640.520555752807, 5657.462541058593, 5417.83746487606, 5471.7264136793, 5558.916616250759, 5614.989301925611, 5681.659100453986, 4298.312270036779, 4343.565643435694, 4351.8476853309985, 4353.934690979638, 4388.451443569554, 3860.092878173627, 3876.7480113792512, 3888.397298418693, 3898.1034362096875, 3929.587393323717, 5244.685318880879, 5247.16045432729, 5269.051570717308, 5341.679499230058, 5371.764494166286, 5592.3009623797025, 5605.775768969277, 5624.959382514248, 5648.63283886546, 5651.547876169897, 5249.737513124329, 5268.236105764643, 5272.841814745564, 5326.201069839555, 5337.8131765388025, 4814.301926220748, 4876.561109500162, 4884.682495637772, 4900.289458028566, 4913.70517768935, 5830.650160990354, 5833.591648584643, 5838.970805145947, 5860.853478663067, 5865.912011319833, 5532.30846144232, 5641.0, 5652.3217213934595, 5664.518515926193, 5711.086226203954, 5586.301712285965, 5719.771209151588, 5812.0, 5828.271466066742, 5850.23946886902, 5480.205370221375, 5491.2312276282155, 5498.202760599771, 5503.614746967673, 5542.974549708317, 5573.832785016456, 5612.859678507906, 5617.045102332531, 5623.943760562505, 5682.715864206856, 5517.613767036269, 5593.328800543961, 5601.60788744784, 5609.579281553818, 5650.886982260414, 5430.456954304696, 5478.589105817159, 5489.231507589021, 5497.890042199214, 5510.228568000403, 5382.892342153056, 5391.137418013099, 5425.06848699878, 5476.2607048048, 5481.205225242238, 5480.72596370172, 5525.171224316385, 5539.030669632879, 5551.278333816578, 5577.414371490935, 5409.675419474686, 5412.945870541244, 5433.347998240237, 5454.127339625641, 5468.589855760754], "unit": "score", "name": "dojo.html", "value": 5192.911723991675}, {"lowerIsBetter": false, "replicates": [507.3961985237565, 536.4849744245524, 539.2369796737617, 541.0963690636636, 552.698779165355, 27838.304042398926, 28456.0, 36135.096622584446, 36268.64253823503, 36362.27282953776, 37815.621843781555, 38092.42861357082, 38326.42510362347, 38384.42423363645, 38428.423573646345, 8284.58577071147, 8428.494290342569, 8439.198276163756, 8444.662213511452, 8452.704155354564, 8061.355091592688, 8191.344692424622, 8200.876986845202, 8280.213379728915, 8290.83418331633, 8312.293455056297, 8401.117882622328, 8563.828723425528, 8602.48385096893, 8622.698205562807, 8459.196376344238, 8461.576921153948, 8475.49147051179, 8536.402451828375, 8547.273481754028, 8306.210909963544, 8407.117252688502, 8429.957850210709, 8462.449940753893, 8463.746087617319, 37506.0, 37514.0, 37608.623913760784, 37705.0, 37976.0, 2844.5164322065298, 2880.438314528668, 3031.666516683163, 3165.9525107123413, 3347.4309367407354, 28527.714722852714, 28692.426151477062, 29085.197960258785, 29148.8542557288, 29477.41045179106, 3773.716971227169, 3807.3527500325013, 3847.153626202231, 3859.459675645412, 3978.8408463661417, 271004.0, 273296.0, 274112.0, 274656.999999998, 275543.0, 52039.47960520422, 52644.736776315876, 58534.12198817021, 59009.0, 59431.40568594345, 52812.47187528075, 52926.20610690843, 53030.204546931054, 53065.0, 53105.2034219487, 15246.847531524543, 15262.236888155549, 15283.770743438858, 15375.461858834888, 15548.611284717972, 11873.228240164362, 11910.940445297718, 11965.820512692317, 11982.940085299517, 12014.038876889828, 18832.811671883104, 18958.71561926572, 19515.609687806165, 19772.0, 19783.10976006083, 7743.109542402583, 7858.528488290606, 7868.763937081897, 7991.24083212094, 8034.196580341919, 919.8988111307751, 934.4486752815872, 1063.7181146996052, 1067.4716015572342, 1136.5737848306885, 27966.86016569904, 28134.71865281362, 28178.0, 28324.0, 28336.291592709935, 1045.811753884293, 1064.6539874540806, 1129.412705393191, 1139.3334899083964, 1142.3659868772745, 14626.414943402146, 14632.487862924747, 14914.627134321512, 15765.763513547307, 16329.836701633069, 305283.0, 308779.0, 311216.0, 311607.0, 314128.0, 48851.75574122178, 48884.26673599899, 49068.26397604039, 49147.75426122918, 49317.0, 1354.2686949047602, 1358.843732970721, 1375.4223226245, 1385.2727318157847, 1386.4869998100767, 26685.466290674467, 28579.428411432073, 29594.260143496584, 29599.0, 29708.55437168401, 43253.3511997314, 43323.35014974715, 43451.34822977721, 43507.347389789815, 43767.343489847044, 309196.0, 310003.84974976553, 310664.0, 311260.0, 312830.0, 31435.685643143275, 40376.3943540853, 40434.0, 41194.38208426816, 41624.0, 38011.42982855315, 38068.80965595154, 38572.80713596414, 39037.0, 39191.60808391879, 32661.510077348383, 33048.66951330456, 33296.500552492216, 33477.0, 33825.15437114092, 34105.829470852485, 35746.10634734049, 35938.0, 36041.0, 36942.26115477621, 32631.673683262863, 32831.0, 32882.0, 33549.16127096842, 34436.48345274873, 31449.685503145593, 32467.18832029218, 32621.673783262813, 32708.34583308368, 32895.342093158484, 24758.0, 24989.87505062463, 25400.0, 26942.865285673448, 27712.44575108527], "unit": "score", "name": "ext.html", "value": 18035.12078122797}, {"lowerIsBetter": false, "replicates": [342.3034125554499, 347.3365871186035, 361.1566991075838, 361.6618461738275, 363.4058314655537, 16254.106024168681, 16712.58218544537, 17468.912655436707, 17928.462146135622, 18104.637907241846, 15496.767548486754, 15588.766168507482, 16093.356265749386, 16133.193340332966, 16166.676666466663, 4765.880852978668, 4937.827176048839, 4955.554000139987, 4967.776450059756, 4984.700917944917, 4813.061453016663, 4824.179889418807, 4875.439324477695, 4895.681780684262, 4954.157793175169, 4910.926336104962, 4925.82759603414, 4943.505649435064, 4974.751262436882, 5210.218467229908, 5099.821506247301, 5102.6173037022, 5117.283580298761, 5118.744062796864, 5144.22836574515, 5293.153095504739, 5294.788208471657, 5307.071262529042, 5314.256004159421, 5316.3354580677415, 12704.110712250145, 16812.915935420366, 18981.43055708331, 19995.80004199954, 19998.900005500025, 2012.5069358007381, 2013.5872146209992, 2036.9694454583193, 2045.4988527810633, 2239.703102163388, 9567.617295308179, 10080.991900809933, 12198.390080496029, 12458.190217635825, 12770.936145319214, 1698.2188193431036, 1747.6329970706167, 1757.8066412694593, 1801.9369322073796, 1816.5766358916082, 54977.72511137419, 56787.716061419844, 57829.99999999958, 58346.0, 58761.706191468766, 10113.64602238918, 10122.949385253174, 10195.847062294071, 10238.436885971194, 10253.282270241161, 13276.867231327757, 13367.0, 13413.262270575213, 13418.932905335607, 13449.529266475627, 7687.5387476751575, 7744.148143704188, 7765.689372425153, 7781.26078022587, 7789.337906277917, 7521.285477879593, 7540.509866858746, 7561.508501947355, 7577.431692623075, 7622.123455802543, 4435.3125265583885, 4445.3998710174355, 4463.486699029589, 4485.0, 4503.527129651405, 1835.4386209784375, 1842.5946291815778, 1877.7465042219399, 1905.9904700476409, 1909.1122627978057, 882.8984666763276, 905.1491597897955, 971.2327261463365, 1016.2987538598492, 1033.9247182929819, 15488.0, 15636.061836289859, 16290.42983495572, 16429.91785041091, 16536.007839529666, 874.7813046738315, 881.6870011145951, 917.312015988009, 920.6777627830206, 938.6339327662217, 9114.0, 9328.486933218603, 9411.0, 9578.377405468622, 9870.963548827413, 487909.0, 497128.0, 497735.0, 503882.0, 517148.0, 41607.1678566427, 41987.16025679469, 49521.25718114231, 72605.27394725985, 74843.0, 1100.1803656276124, 1106.6956586938657, 1118.6364431559614, 1126.3467189030343, 1130.1185075641013, 15131.54605361841, 15250.0, 15389.615259618151, 15598.220088995731, 15762.921185394458, 32144.517832233003, 33059.33881322408, 33386.833065834515, 33782.0, 34785.956421307405, 41374.112855731226, 42669.9594566893, 42908.57091429046, 43478.34782478328, 45118.548814512746, 7253.274672532704, 9341.392809467363, 9619.615215391586, 9761.170300524534, 9887.505624718879, 10889.891101088888, 11038.392888391216, 11228.157888158257, 11320.660380188607, 11639.941800290944, 7222.74720384784, 7358.742444014434, 7559.938225018876, 7658.923410766044, 7679.539227646359, 7512.737054203077, 7717.073951125901, 7909.52542847431, 7930.722424715107, 7931.801704957422, 7931.36549076061, 8005.519668819889, 8080.191980801873, 8093.757187284391, 8116.147804480444, 8797.912020879709, 9218.492982886006, 9958.55186516623, 10321.690349289533, 10443.738906527398, 9203.86194207074, 9289.489078100769, 9598.520073996133, 9622.47076410804, 9634.855477167708], "unit": "score", "name": "jquery.html", "value": 8031.529653627668}, {"lowerIsBetter": false, "replicates": [1457.8687918087371, 1471.0732238689627, 1622.69168857917, 1748.3094177799762, 1764.3824661368524, 7462.776116716501, 7596.050493688289, 7636.9236307636975, 7657.195994420589, 7672.53964762114, 7622.542647441143, 7679.193684663113, 7690.384769218463, 7804.219578042193, 7812.101608315045, 2261.8869056547146, 2308.9653655195184, 2311.2719493359537, 2311.9653205201935, 2313.6298192289237, 2358.7641235876445, 2376.441536238991, 2381.880905954704, 2387.9283621491295, 2397.3287479505766, 2225.721784776903, 2278.396225000368, 2279.1453205048106, 2290.3014580552926, 2299.8620082795, 2286.977130228693, 2319.6288593824993, 2354.929352119439, 2356.1635619355225, 2358.457554762397, 2360.929172124822, 2361.2916125162383, 2362.385779697274, 2390.1634427950253, 2395.2454976682466, 7522.097348318182, 7568.243175682388, 7577.583232922187, 7599.0, 7600.50596711212, 4675.812967481296, 4806.110869489155, 4809.350737650408, 4821.879453013667, 4825.30033145192, 2981.2844917219927, 2990.1029691092585, 3068.8925887593828, 3072.9231769205726, 3079.3533357994847, 1004.9949750251202, 1005.4520286443906, 1865.9253629854788, 1933.9709904351446, 1943.8444924406015, 10359.067683908484, 10398.84401733967, 10444.791104177873, 10506.422146781924, 10531.157507399466, 4088.100617864065, 4122.628963393309, 4162.646175075092, 4194.328907374806, 4219.346001369792, 8465.195806398382, 8475.321974242046, 8510.106438823957, 8550.230479256898, 8551.358648101417, 4721.763911804396, 4726.976365118221, 4746.7389293589185, 4776.617870570346, 4789.185838407479, 4392.450943632046, 4404.229259879508, 4411.669124815588, 4426.579474949875, 4439.66702497314, 3422.401079811023, 3489.7557170998293, 3505.071156143624, 3516.7362447816004, 3526.365254254259, 1039.4127318065268, 1060.596973150198, 1086.8750093739163, 1097.023648952433, 1099.6371197504805, 1058.4866339825178, 1104.7017305327518, 1150.9482073306722, 1251.8998480121568, 1350.1898860683511, 7014.789556313217, 7034.6482675866, 7035.47233957445, 7077.221505634376, 7162.355388015104, 633.6514916795744, 633.87956288306, 640.5324113397153, 645.6997496164212, 781.956088621685, 5436.048691478975, 5503.532199762985, 5586.972065139648, 5595.38450770415, 5624.156376543551, 9004.8649270261, 9216.07839216073, 9241.768955776159, 9340.439573625605, 9376.01551837061, 9206.401583897024, 9413.246940244764, 9422.057794220524, 9437.0, 9526.523673816282, 7412.407007439392, 7425.294597013275, 7428.294312040348, 7455.664495097733, 7481.663325150382, 6999.160100787938, 7104.893426598502, 7117.501774875709, 7118.822029449098, 7143.714251429885, 8241.546714930737, 8360.665573376997, 8401.62192701342, 8508.234258916727, 8595.699150529701, 8531.274841638531, 8607.139286071342, 8661.220490155916, 8691.695790647549, 8743.825123497621, 6416.0, 6427.100205971261, 6489.837754055998, 6514.902276465762, 6529.216494020748, 7440.479166458296, 7459.888101678588, 7479.70081196746, 7480.551166930001, 7535.623218839146, 6793.0, 6918.342757438237, 7069.016050590873, 7169.390601798906, 7193.964030179815, 6628.801135965929, 6727.865442691021, 6773.153355830521, 6795.864082718417, 6899.6205208714, 6709.7651582194385, 6812.455003599799, 6832.453403727789, 6833.282505337067, 6849.554778939353, 6015.4586087252355, 6049.485793707408, 6058.666773327509, 6087.695615219132, 6107.786227482017, 6269.811905642838, 6281.12064311006, 6329.208848893888, 6419.711112999833, 6472.0], "unit": "score", "name": "mootools.html", "value": 4441.139096787174}, {"lowerIsBetter": false, "replicates": [350.3798277049622, 350.78952628422934, 351.1274482909968, 353.9681428671419, 355.14410271246294, 6304.936950630492, 6315.68421578921, 6368.33132521085, 6372.490200783937, 6499.480041596673, 6262.561620686553, 6302.275238347592, 6309.242890853093, 6327.050942358648, 6332.176817013793, 4815.831445899395, 4819.590334821544, 4832.4684284728655, 4833.879153021167, 4840.370751802261, 4816.349792777965, 4844.806207751686, 4845.103655823684, 4847.806087756486, 4859.149648811462, 4701.529847015288, 4778.80884764609, 4796.280557916306, 4804.231322988323, 4806.687565308243, 4784.545468180518, 4785.258284965836, 4796.208625576758, 4799.304100905384, 4805.303231031481, 4170.249355116078, 4182.477190351206, 4182.811773470201, 4188.706790524634, 4204.138151678899, 5955.434233747787, 5992.011318132503, 6000.18997435345, 6002.3697511761075, 6012.218411606507, 5422.75597598109, 5617.887642247132, 5625.128105143709, 5625.774969001235, 5643.633163844337, 6672.199336079653, 6698.062271282024, 6708.262091169968, 6709.664516774142, 6721.6975236114495, 4595.678302518825, 4602.815887364502, 4617.884552886171, 4641.350210970467, 4641.675082744209, 6747.122874026394, 6910.896336554955, 6919.481038922101, 6991.196012458581, 7009.299070093001, 4662.976685116552, 4668.253079507331, 4681.7190968542, 4683.859484215479, 4694.201985662446, 4734.502877197845, 4742.146413645508, 4748.525147485293, 4750.453697824794, 4759.262314341283, 5492.670439773627, 5498.0, 5500.147477140969, 5500.1749737539685, 5503.3120859892515, 6533.771318003942, 6688.699008544627, 6692.966535167293, 6702.0282059101155, 6707.0, 1658.4112640012863, 1683.1752441303672, 1705.7953045634604, 1707.3853412771393, 1717.3216579451296, 1105.8562386889653, 1133.4559411482535, 1134.8467956825723, 1136.6135513925306, 1140.224647239885, 6299.307076221612, 6302.527310451735, 6317.936820631827, 6322.0, 6343.065365063608, 6792.252852186256, 6795.048693182958, 6796.796096117125, 6799.660016999229, 6840.897386539206, 6095.4818840398175, 6295.874082518416, 6312.43188113072, 6321.8735625288155, 6324.968375158187, 3693.3351996640326, 3704.129529560551, 3714.925701486009, 3716.405375140019, 3727.8322475488667, 7026.0, 7043.7321282169705, 7060.082189315356, 7112.502124851314, 7138.678759455837, 6963.82590435233, 6964.721411143599, 6969.930300697029, 6983.336583024605, 6989.126359205099, 7327.45044121693, 7330.486865919334, 7331.780046598504, 7335.193128755833, 7336.449766267551, 6913.792586222421, 6953.20038195614, 6965.0, 6967.233604303624, 6990.196127445409, 6806.081179040766, 6903.482238832007, 6919.6886140124825, 6928.861422771415, 6938.5836849789175, 7277.818054548678, 7281.745138920112, 7283.7450689225625, 7291.197968223597, 7297.963510182628, 4687.929681054855, 4739.881502962454, 4758.1435341638835, 4763.595094416874, 4771.475137734777, 6839.521233513607, 6958.826029349307, 6963.825904352431, 6964.512484126265, 6974.093367862349, 6741.325867413219, 6757.594544327356, 6772.0857684212, 6773.458123350021, 6773.93226067733, 6637.402633762985, 6640.169978752656, 6667.199936007516, 6671.8665626686225, 6691.899621505779, 6433.131527243762, 6595.472362211108, 6612.735490580515, 6616.470682345304, 6633.0, 6711.758324709945, 6713.832154195989, 6761.22245941723, 6769.966150169218, 6783.21992970795, 6588.37410446026, 6592.868142637216, 6592.967035164794, 6599.0, 6600.174978127734], "unit": "score", "name": "prototype.html", "value": 5041.198188703283}, {"lowerIsBetter": false, "replicates": [720.8125887269312, 724.3299947548517, 804.4971892567146, 850.5407080176705, 858.974230773077, 12158.878411215885, 12350.505979760821, 12406.379681015937, 12414.937925310383, 12434.378281085943, 11634.941825290862, 11674.241174323684, 11699.766004679901, 12862.421191046402, 13194.142380745245, 780.1262585903781, 785.6386062411298, 789.4355535791908, 791.3115589437198, 793.5080250244828, 785.7249962513104, 790.549386849496, 792.1484404265409, 792.5363662257586, 793.6507936507946, 814.2590242878952, 821.6384790692106, 821.9219174178473, 824.9505029698207, 825.7770401991459, 816.346922462028, 817.6238930092164, 818.4761752478419, 818.8362327534487, 821.100894520502, 597.3518732175595, 598.8920497080367, 600.2197143713155, 601.2514419547647, 601.7442586900594, 12433.3783310835, 12439.0, 12451.315177665225, 12469.251844889335, 12497.875021249762, 12086.33525156116, 12392.256464612063, 12707.872921270762, 12837.229766213964, 12839.404966609365, 10509.106725928305, 10612.787744245072, 10617.41604211768, 10775.245732798707, 10849.457527123612, 3569.1077230692326, 3633.691136253395, 3643.5081264029545, 3646.161382881952, 3753.0, 45165.774171128935, 45213.547864521264, 45504.544954550365, 45563.08873822538, 45771.0, 9219.0, 9971.40171589707, 10008.749781255381, 10076.84884726715, 10251.077403033614, 17267.136643167792, 17305.56736081608, 17329.22018509145, 17344.13279336028, 17380.739288910678, 6996.825079373057, 7078.221395646475, 7371.520851144658, 7427.331540161412, 7526.247375262539, 4296.076343586144, 4366.6506679465565, 4375.387207890317, 4382.211850123222, 4402.207602631493, 2787.6794168670863, 2812.3250419899077, 2826.5053615617594, 2829.2219639599275, 2855.971440285612, 551.4154995704566, 553.1232995701857, 557.9274694289717, 558.8742532930058, 569.9572532060112, 556.1713047559108, 592.8517870532366, 639.0414378432351, 652.6508318049915, 693.4833549006023, 8463.830723385621, 9041.59312830911, 9075.727728168165, 9465.432074075577, 9586.60334916271, 539.5953035223582, 589.7611467355728, 663.2439019517753, 668.3683918696883, 690.7064497588505, 4184.790760461965, 4265.55211702773, 4407.27279998803, 4449.7330160190495, 4492.3710680504755, 60299.79400411967, 60423.697881510314, 60466.0, 60511.0, 60666.0, 46844.7657761709, 48374.75812620985, 48551.75724121357, 50519.24221136612, 50553.49446505488, 42336.57663423388, 43715.34426983598, 43876.0, 44050.118997619866, 44456.77771611121, 8746.825063498567, 8920.643174272956, 8954.598091282984, 8973.685920992733, 9123.452592844451, 32424.892381995094, 33159.336813263115, 33687.66312336845, 33730.15674608154, 34034.0, 37502.62497375101, 37660.05849853776, 46459.53540464687, 46808.53191468042, 48267.5173248263, 10012.69961901144, 10194.592216311265, 10567.418791966516, 10827.025567698945, 10925.344479331265, 11482.827757583476, 11632.127590430582, 11707.414629268333, 11813.822792657946, 11918.880811191777, 10083.445410502492, 10444.0, 10589.205809564468, 11102.333859968428, 11479.196456248317, 10459.29060460308, 10516.737081573021, 10553.788924221319, 10566.577336906437, 11626.186166968231, 10692.572297108029, 10697.358158510515, 10728.088112510524, 10737.946310268399, 11114.555417783198, 8765.517896515752, 9187.356885018253, 9368.765780855532, 9397.664474010544, 9480.478573678514, 8678.609462574073, 8919.42023768453, 9173.954130229306, 9282.0, 9700.660476883275], "unit": "score", "name": "yui.html", "value": 6147.033359671022}], "name": "dromaeo_css", "value": 6852.404828856567}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 112.0, 111.0, 113.0, 124.0, 112.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 158.0, 166.0, 127.0, 153.0, 154.0, 127.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 164.0, 162.0, 160.0, 166.0, 170.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 75.0, 72.0, 142.0, 71.0, 72.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 137.0, 96.0, 97.0, 97.0, 136.0, 97.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 112.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 98.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 57.0, 58.0, 58.0, 60.0, 56.0, 55.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 85.0, 86.0, 85.0, 84.0, 87.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [132.0, 120.0, 119.0, 119.0, 118.0, 123.0, 128.0, 119.0, 134.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 164.0, 154.0, 150.0, 151.0, 150.0, 164.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.5}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 69.0, 67.0, 70.0, 69.0, 66.0, 67.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1520.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.7792869269949], "unit": "score", "name": "Richards", "value": 207.92877999999993}, {"lowerIsBetter": false, "replicates": [189.89745537409797], "unit": "score", "name": "DeltaBlue", "value": 348.1773879999999}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1076.3440860215053], "unit": "score", "name": "RayTrace", "value": 687.5022677322679}, {"lowerIsBetter": false, "replicates": [723.589001447178], "unit": "score", "name": "Earley", "value": 921.051866}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [40784.313725490196], "unit": "score", "name": "RegExp", "value": 22.336651442307705}, {"lowerIsBetter": false, "replicates": [603.5003017501509], "unit": "score", "name": "Splay", "value": 135.030587}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20284.826156827654}]} 10:11:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20284.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1520.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6852.40"}}} 10:11:51 INFO - Return code: 0 10:11:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:11:51 INFO - # TBPL SUCCESS # 10:11:51 INFO - Running post-action listener: _resource_record_post_action 10:11:51 INFO - Running post-run listener: _resource_record_post_run 10:11:52 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 10297344; Write bytes: 454754304; Read time: 3200; Write time: 537376 10:11:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 10665984; Read time: 0; Write time: 15112 10:11:52 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 8536064; Write bytes: 444088320; Read time: 3164; Write time: 522264 10:11:52 INFO - Running post-run listener: _upload_blobber_files 10:11:52 INFO - Blob upload gear active. 10:11:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:11:52 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:11:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:11:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:11:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:53 INFO - (blobuploader) - INFO - Done attempting. 10:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:54 INFO - (blobuploader) - INFO - Done attempting. 10:11:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:54 INFO - Return code: 0 10:11:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:11:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8afc14bc32f0b6511cd82fad5c25b1146ab39e43450f2ef87da785eb77c569c8e66f501330d64e81762146394377bbe3bea470d5e4a64c6a2af9de0512028310", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/550464e4d8d8e5034e347856861c9bd28f30ef221f89bbf1b04f7b63d22390696c2d0ce79e53bda79d5907ab50ce4ac4803379acdbf6c88b322d8549441669a3"} 10:11:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:11:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:11:54 INFO - Contents: 10:11:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8afc14bc32f0b6511cd82fad5c25b1146ab39e43450f2ef87da785eb77c569c8e66f501330d64e81762146394377bbe3bea470d5e4a64c6a2af9de0512028310", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/550464e4d8d8e5034e347856861c9bd28f30ef221f89bbf1b04f7b63d22390696c2d0ce79e53bda79d5907ab50ce4ac4803379acdbf6c88b322d8549441669a3"} 10:11:54 INFO - Copying logs to upload dir... 10:11:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1288.523495 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-09 10:11:54.900712) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 10:11:54.904296) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8afc14bc32f0b6511cd82fad5c25b1146ab39e43450f2ef87da785eb77c569c8e66f501330d64e81762146394377bbe3bea470d5e4a64c6a2af9de0512028310", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/550464e4d8d8e5034e347856861c9bd28f30ef221f89bbf1b04f7b63d22390696c2d0ce79e53bda79d5907ab50ce4ac4803379acdbf6c88b322d8549441669a3"} build_url:https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/GslPpqcZSNah0XBBpnUa1A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8afc14bc32f0b6511cd82fad5c25b1146ab39e43450f2ef87da785eb77c569c8e66f501330d64e81762146394377bbe3bea470d5e4a64c6a2af9de0512028310", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/550464e4d8d8e5034e347856861c9bd28f30ef221f89bbf1b04f7b63d22390696c2d0ce79e53bda79d5907ab50ce4ac4803379acdbf6c88b322d8549441669a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 10:11:54.929204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 10:11:54.929534) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452352833.574535-98497690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 10:11:55.012755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 10:11:55.013145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 10:11:55.013467) ========= ========= Total master_lag: 0.28 =========