builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1451742449.13 results: success (0) buildid: 20160102030217 builduid: e5e6a042e2de46619877fa9470acca63 revision: ce643acfab14d95bea2fb6c4f56477413514b686 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.133478) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.133955) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.134260) ========= 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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006484 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.169670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.169983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.198195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.198480) ========= 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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.255026) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.255323) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.255663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.255940) ========= 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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-02 05:47:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 40.3M=0s 2016-01-02 05:47:30 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.434931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.435243) ========= 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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018542 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:29.485251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-02 05:47:29.485639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ce643acfab14d95bea2fb6c4f56477413514b686 --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 ce643acfab14d95bea2fb6c4f56477413514b686 --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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-02 05:47:30,284 truncating revision to first 12 chars 2016-01-02 05:47:30,284 Setting DEBUG logging. 2016-01-02 05:47:30,284 attempt 1/10 2016-01-02 05:47:30,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ce643acfab14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-02 05:47:31,302 unpacking tar archive at: mozilla-central-ce643acfab14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.320648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-02 05:47:30.820431) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:30.820733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:30.830687) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:30.831027) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 05:47:30.831483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-02 05:47:30.831783) ========= /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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:31 INFO - MultiFileLogger online at 20160102 05:47:31 in /builds/slave/test-pgo 05:47:31 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 05:47:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:47:31 INFO - {'append_to_log': False, 05:47:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:47:31 INFO - 'blob_upload_branch': 'Firefox', 05:47:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:47:31 INFO - 'branch': 'Firefox', 05:47:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:31 INFO - 'config_files': ('talos/linux_config.py',), 05:47:31 INFO - 'default_actions': ('clobber', 05:47:31 INFO - 'read-buildbot-config', 05:47:31 INFO - 'download-and-extract', 05:47:31 INFO - 'populate-webroot', 05:47:31 INFO - 'create-virtualenv', 05:47:31 INFO - 'install', 05:47:31 INFO - 'run-tests'), 05:47:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:31 INFO - 'download_minidump_stackwalk': True, 05:47:31 INFO - 'download_symbols': 'ondemand', 05:47:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:31 INFO - 'installer_path': 'installer.exe', 05:47:31 INFO - 'log_level': 'info', 05:47:31 INFO - 'log_name': 'talos', 05:47:31 INFO - 'log_to_console': True, 05:47:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:31 INFO - 'opt_config_files': (), 05:47:31 INFO - 'pip_index': False, 05:47:31 INFO - 'sps_profile': False, 05:47:31 INFO - 'sps_profile_interval': 0, 05:47:31 INFO - 'suite': 'dromaeojs-e10s', 05:47:31 INFO - 'system_bits': '32', 05:47:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:31 INFO - 'title': 'talos-linux64-ix-044', 05:47:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:31 INFO - 'use_talos_json': True, 05:47:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:47:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:31 INFO - 'work_dir': 'build'} 05:47:31 INFO - ##### 05:47:31 INFO - ##### Running clobber step. 05:47:31 INFO - ##### 05:47:31 INFO - Running pre-action listener: _resource_record_pre_action 05:47:31 INFO - Running main action method: clobber 05:47:31 INFO - rmtree: /builds/slave/test-pgo/build 05:47:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:47:32 INFO - Running post-action listener: _resource_record_post_action 05:47:32 INFO - ##### 05:47:32 INFO - ##### Running read-buildbot-config step. 05:47:32 INFO - ##### 05:47:32 INFO - Running pre-action listener: _resource_record_pre_action 05:47:32 INFO - Running main action method: read_buildbot_config 05:47:32 INFO - Using buildbot properties: 05:47:32 INFO - { 05:47:32 INFO - "project": "", 05:47:32 INFO - "product": "firefox", 05:47:32 INFO - "script_repo_revision": "production", 05:47:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:47:32 INFO - "repository": "", 05:47:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:47:32 INFO - "buildid": "20160102030217", 05:47:32 INFO - "stage_platform": "linux64-pgo", 05:47:32 INFO - "basedir": "/builds/slave/test-pgo", 05:47:32 INFO - "nightly_build": "True", 05:47:32 INFO - "buildnumber": 282, 05:47:32 INFO - "slavename": "talos-linux64-ix-044", 05:47:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:47:32 INFO - "platform": "ubuntu64_hw", 05:47:32 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:47:32 INFO - "branch": "mozilla-central", 05:47:32 INFO - "repo_path": "mozilla-central", 05:47:32 INFO - "revision": "ce643acfab14d95bea2fb6c4f56477413514b686", 05:47:32 INFO - "pgo_build": "True", 05:47:32 INFO - "builduid": "e5e6a042e2de46619877fa9470acca63", 05:47:32 INFO - "slavebuilddir": "test" 05:47:32 INFO - } 05:47:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:47:32 INFO - Running post-action listener: _resource_record_post_action 05:47:32 INFO - ##### 05:47:32 INFO - ##### Running download-and-extract step. 05:47:32 INFO - ##### 05:47:32 INFO - Running pre-action listener: _resource_record_pre_action 05:47:32 INFO - Running main action method: download_and_extract 05:47:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:47: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')]} 05:47:32 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json 05:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json 05:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:47:33 INFO - Downloaded 1302 bytes. 05:47:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:47:33 INFO - Using the following test package requirements: 05:47:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:33 INFO - u'jsshell-linux-x86_64.zip'], 05:47:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47:33 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')]} 05:47:33 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:40 INFO - Downloaded 23199205 bytes. 05:47:40 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 05:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:40 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 05:47:42 INFO - Return code: 0 05:47:42 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 05:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:42 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:43 INFO - Downloaded 23199205 bytes. 05:47:43 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 05:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:43 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 05:47:44 INFO - Return code: 0 05:47:44 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')]} 05:47:44 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:45 INFO - Downloaded 11132285 bytes. 05:47:45 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 05:47:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:45 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 05:47:45 INFO - Return code: 0 05:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:45 INFO - https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CB1cX810SICAa1vd9VCpFg/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 05:47:47 INFO - Downloaded 54989007 bytes. 05:47:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:47 INFO - mkdir: /builds/slave/test-pgo/properties 05:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:47:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:47:47 INFO - Contents: 05:47:47 INFO - build_url:https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:47 INFO - Running post-action listener: _resource_record_post_action 05:47:47 INFO - Running post-action listener: set_extra_try_arguments 05:47:47 INFO - ##### 05:47:47 INFO - ##### Running populate-webroot step. 05:47:47 INFO - ##### 05:47:47 INFO - Running pre-action listener: _resource_record_pre_action 05:47:47 INFO - Running main action method: populate_webroot 05:47:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:47 INFO - '--tppagecycles', 05:47:47 INFO - '7'], 05:47:47 INFO - 'tests': ['tsvgm']}}, 05:47:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:47:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:47:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:47:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'tests': ['damp', 'tps']}, 05:47:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['damp', 'tps']}, 05:47:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:47:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:47 INFO - 'other': {'tests': ['a11yr', 05:47:47 INFO - 'ts_paint', 05:47:47 INFO - 'tpaint', 05:47:47 INFO - 'sessionrestore', 05:47:47 INFO - 'sessionrestore_no_auto_restore']}, 05:47:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['a11yr', 05:47:47 INFO - 'ts_paint', 05:47:47 INFO - 'tpaint', 05:47:47 INFO - 'sessionrestore', 05:47:47 INFO - 'sessionrestore_no_auto_restore']}, 05:47:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['a11yr', 05:47:47 INFO - 'ts_paint', 05:47:47 INFO - 'tpaint', 05:47:47 INFO - 'sessionrestore', 05:47:47 INFO - 'sessionrestore_no_auto_restore']}, 05:47:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['a11yr', 05:47:47 INFO - 'ts_paint', 05:47:47 INFO - 'tpaint', 05:47:47 INFO - 'sessionrestore', 05:47:47 INFO - 'sessionrestore_no_auto_restore']}, 05:47:47 INFO - 'other_l64': {'tests': ['a11yr', 05:47:47 INFO - 'ts_paint', 05:47:47 INFO - 'tpaint', 05:47:47 INFO - 'sessionrestore', 05:47:47 INFO - 'sessionrestore_no_auto_restore']}, 05:47:47 INFO - 'other_nol64': {'tests': ['a11yr', 05:47:47 INFO - 'ts_paint', 05:47:47 INFO - 'tpaint', 05:47:47 INFO - 'sessionrestore', 05:47:47 INFO - 'sessionrestore_no_auto_restore']}, 05:47:47 INFO - 'svgr': {'tests': ['tsvgx', 05:47:47 INFO - 'tsvgr_opacity', 05:47:47 INFO - 'tart', 05:47:47 INFO - 'tscrollx', 05:47:47 INFO - 'cart']}, 05:47:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['tsvgx', 05:47:47 INFO - 'tsvgr_opacity', 05:47:47 INFO - 'tart', 05:47:47 INFO - 'tscrollx', 05:47:47 INFO - 'cart']}, 05:47:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'tests': ['tp5o']}, 05:47:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'talos_options': ['--e10s'], 05:47:47 INFO - 'tests': ['tp5o']}, 05:47:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'talos_options': ['--xperf_path', 05:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:47 INFO - 'tests': ['tp5n']}, 05:47:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:47 INFO - 'talos_options': ['--e10s', 05:47:47 INFO - '--xperf_path', 05:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:47 INFO - 'tests': ['tp5n']}}, 05:47:47 INFO - 'talos.zip': {'path': '', 05:47:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:47 INFO - Running post-action listener: _resource_record_post_action 05:47:47 INFO - ##### 05:47:47 INFO - ##### Running create-virtualenv step. 05:47:47 INFO - ##### 05:47:47 INFO - Running pre-action listener: _resource_record_pre_action 05:47:47 INFO - Running main action method: create_virtualenv 05:47:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:47:47 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 05:47:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:47:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:47 INFO - Using real prefix '/usr' 05:47:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:47:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:49 INFO - Installing pip.................done. 05:47:49 INFO - Return code: 0 05:47:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:47:49 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 05:47:49 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 05:47:49 INFO - Using env: {'DISPLAY': ':0', 05:47:49 INFO - 'HOME': '/home/cltbld', 05:47:49 INFO - 'LANG': 'en_US.UTF-8', 05:47:49 INFO - 'LANGUAGE': 'en_US:en', 05:47:49 INFO - 'LOGNAME': 'cltbld', 05:47:49 INFO - 'MAIL': '/var/mail/cltbld', 05:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:49 INFO - 'MOZ_NO_REMOTE': '1', 05:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:49 INFO - 'NO_EM_RESTART': '1', 05:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:49 INFO - 'SHELL': '/bin/bash', 05:47:49 INFO - 'SHLVL': '1', 05:47:49 INFO - 'TERM': 'linux', 05:47:49 INFO - 'TMOUT': '86400', 05:47:49 INFO - 'USER': 'cltbld', 05:47:49 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:49 INFO - '_': '/tools/buildbot/bin/python'} 05:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:49 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 05:47:49 INFO - Cleaning up... 05:47:49 INFO - Return code: 0 05:47:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:47:49 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 05:47:49 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 05:47:49 INFO - Using env: {'DISPLAY': ':0', 05:47:49 INFO - 'HOME': '/home/cltbld', 05:47:49 INFO - 'LANG': 'en_US.UTF-8', 05:47:49 INFO - 'LANGUAGE': 'en_US:en', 05:47:49 INFO - 'LOGNAME': 'cltbld', 05:47:49 INFO - 'MAIL': '/var/mail/cltbld', 05:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:49 INFO - 'MOZ_NO_REMOTE': '1', 05:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:49 INFO - 'NO_EM_RESTART': '1', 05:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:49 INFO - 'SHELL': '/bin/bash', 05:47:49 INFO - 'SHLVL': '1', 05:47:49 INFO - 'TERM': 'linux', 05:47:49 INFO - 'TMOUT': '86400', 05:47:49 INFO - 'USER': 'cltbld', 05:47:49 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:49 INFO - '_': '/tools/buildbot/bin/python'} 05:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:50 INFO - Downloading/unpacking psutil>=0.7.1 05:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:47:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:47:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:51 INFO - Installing collected packages: psutil 05:47:51 INFO - Running setup.py install for psutil 05:47:51 INFO - building 'psutil._psutil_linux' extension 05:47:51 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 05:47:52 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 05:47:52 INFO - building 'psutil._psutil_posix' extension 05:47:52 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 05:47:52 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 05:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:52 INFO - Successfully installed psutil 05:47:52 INFO - Cleaning up... 05:47:52 INFO - Return code: 0 05:47:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:47: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')]} 05:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:47:52 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 05:47:52 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 05:47:52 INFO - Using env: {'DISPLAY': ':0', 05:47:52 INFO - 'HOME': '/home/cltbld', 05:47:52 INFO - 'LANG': 'en_US.UTF-8', 05:47:52 INFO - 'LANGUAGE': 'en_US:en', 05:47:52 INFO - 'LOGNAME': 'cltbld', 05:47:52 INFO - 'MAIL': '/var/mail/cltbld', 05:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:52 INFO - 'MOZ_NO_REMOTE': '1', 05:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:52 INFO - 'NO_EM_RESTART': '1', 05:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:52 INFO - 'SHELL': '/bin/bash', 05:47:52 INFO - 'SHLVL': '1', 05:47:52 INFO - 'TERM': 'linux', 05:47:52 INFO - 'TMOUT': '86400', 05:47:52 INFO - 'USER': 'cltbld', 05:47:52 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:52 INFO - '_': '/tools/buildbot/bin/python'} 05:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:47:52 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 05:47:52 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 05:47:52 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 05:47:52 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 05:47:52 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 05:47:52 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 05:47:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:47:54 INFO - Installing collected packages: mozsystemmonitor 05:47:54 INFO - Running setup.py install for mozsystemmonitor 05:47:54 INFO - Successfully installed mozsystemmonitor 05:47:54 INFO - Cleaning up... 05:47:54 INFO - Return code: 0 05:47:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:47:54 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')]} 05:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:54 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')]} 05:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:54 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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:47:54 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 05:47:54 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 05:47:54 INFO - Using env: {'DISPLAY': ':0', 05:47:54 INFO - 'HOME': '/home/cltbld', 05:47:54 INFO - 'LANG': 'en_US.UTF-8', 05:47:54 INFO - 'LANGUAGE': 'en_US:en', 05:47:54 INFO - 'LOGNAME': 'cltbld', 05:47:54 INFO - 'MAIL': '/var/mail/cltbld', 05:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:54 INFO - 'MOZ_NO_REMOTE': '1', 05:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:54 INFO - 'NO_EM_RESTART': '1', 05:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:54 INFO - 'SHELL': '/bin/bash', 05:47:54 INFO - 'SHLVL': '1', 05:47:54 INFO - 'TERM': 'linux', 05:47:54 INFO - 'TMOUT': '86400', 05:47:54 INFO - 'USER': 'cltbld', 05:47:54 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:54 INFO - '_': '/tools/buildbot/bin/python'} 05:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:54 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 05:47:54 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 05:47:54 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 05:47:54 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 05:47:54 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 05:47:54 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 05:47:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:47:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 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 05:47:56 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 05:47:57 INFO - Downloading docopt-0.6.1.tar.gz 05:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:47:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:57 INFO - Running setup.py install for blobuploader 05:47:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:47:57 INFO - Running setup.py install for requests 05:47:57 INFO - Running setup.py install for docopt 05:47:57 INFO - Successfully installed blobuploader requests docopt 05:47:57 INFO - Cleaning up... 05:47:57 INFO - Return code: 0 05:47:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:47: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')]} 05:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:57 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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:47:57 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 05:47:57 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 05:47:57 INFO - Using env: {'DISPLAY': ':0', 05:47:57 INFO - 'HOME': '/home/cltbld', 05:47:57 INFO - 'LANG': 'en_US.UTF-8', 05:47:57 INFO - 'LANGUAGE': 'en_US:en', 05:47:57 INFO - 'LOGNAME': 'cltbld', 05:47:57 INFO - 'MAIL': '/var/mail/cltbld', 05:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:57 INFO - 'MOZ_NO_REMOTE': '1', 05:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:57 INFO - 'NO_EM_RESTART': '1', 05:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:47:57 INFO - 'SHELL': '/bin/bash', 05:47:57 INFO - 'SHLVL': '1', 05:47:57 INFO - 'TERM': 'linux', 05:47:57 INFO - 'TMOUT': '86400', 05:47:57 INFO - 'USER': 'cltbld', 05:47:57 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:57 INFO - '_': '/tools/buildbot/bin/python'} 05:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:47:57 INFO - Running setup.py (path:/tmp/pip-EbNhkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:47:58 INFO - Running setup.py (path:/tmp/pip-TvVvan-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:47:58 INFO - Running setup.py (path:/tmp/pip-jSDhh3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:47:58 INFO - Running setup.py (path:/tmp/pip-neV0a0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:47:58 INFO - Running setup.py (path:/tmp/pip-5vOhuJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:47:58 INFO - Running setup.py (path:/tmp/pip-VClNr3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:47:58 INFO - Running setup.py (path:/tmp/pip-2pb3fc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:47:58 INFO - Running setup.py (path:/tmp/pip-5mMQ1U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:47:58 INFO - Running setup.py (path:/tmp/pip-ZxDS84-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:47:58 INFO - Running setup.py (path:/tmp/pip-kEp2cO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:47:58 INFO - Running setup.py (path:/tmp/pip-Mzue7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:47:58 INFO - Running setup.py (path:/tmp/pip-IULGab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:47:58 INFO - Running setup.py (path:/tmp/pip-_Ngi01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:47:58 INFO - Running setup.py (path:/tmp/pip-FlTKk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:47:58 INFO - Running setup.py (path:/tmp/pip-IqK5ZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:47:59 INFO - Running setup.py (path:/tmp/pip-2X5Tj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:47:59 INFO - Running setup.py (path:/tmp/pip-gmXelh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:59 INFO - Running setup.py install for manifestparser 05:47:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Running setup.py install for mozcrash 05:47:59 INFO - Running setup.py install for mozdebug 05:47:59 INFO - Running setup.py install for mozdevice 05:47:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Running setup.py install for mozfile 05:47:59 INFO - Running setup.py install for mozhttpd 05:47:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Running setup.py install for mozinfo 05:47:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Running setup.py install for mozInstall 05:47:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:47:59 INFO - Running setup.py install for mozleak 05:48:00 INFO - Running setup.py install for mozlog 05:48:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:48:00 INFO - Running setup.py install for moznetwork 05:48:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:48:00 INFO - Running setup.py install for mozprocess 05:48:00 INFO - Running setup.py install for mozprofile 05:48:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:48:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:48:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:48:00 INFO - Running setup.py install for mozrunner 05:48:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:48:00 INFO - Running setup.py install for mozscreenshot 05:48:00 INFO - Running setup.py install for moztest 05:48:00 INFO - Running setup.py install for mozversion 05:48:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:48:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:00 INFO - Cleaning up... 05:48:00 INFO - Return code: 0 05:48:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:48:00 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')]} 05:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:00 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')]} 05:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:00 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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:48:00 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 05:48:00 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 05:48:00 INFO - Using env: {'DISPLAY': ':0', 05:48:00 INFO - 'HOME': '/home/cltbld', 05:48:00 INFO - 'LANG': 'en_US.UTF-8', 05:48:00 INFO - 'LANGUAGE': 'en_US:en', 05:48:00 INFO - 'LOGNAME': 'cltbld', 05:48:00 INFO - 'MAIL': '/var/mail/cltbld', 05:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:00 INFO - 'MOZ_NO_REMOTE': '1', 05:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:00 INFO - 'NO_EM_RESTART': '1', 05:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:00 INFO - 'SHELL': '/bin/bash', 05:48:00 INFO - 'SHLVL': '1', 05:48:00 INFO - 'TERM': 'linux', 05:48:00 INFO - 'TMOUT': '86400', 05:48:00 INFO - 'USER': 'cltbld', 05:48:00 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:00 INFO - '_': '/tools/buildbot/bin/python'} 05:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:48:01 INFO - Running setup.py (path:/tmp/pip-9PEO33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:48:01 INFO - Running setup.py (path:/tmp/pip-9P7fxO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:48:01 INFO - Running setup.py (path:/tmp/pip-bRm1xw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:48:01 INFO - Running setup.py (path:/tmp/pip-ldBHd9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:48:01 INFO - Running setup.py (path:/tmp/pip-gpZNQs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:48:01 INFO - Running setup.py (path:/tmp/pip-TDl6YZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:48:01 INFO - Running setup.py (path:/tmp/pip-ZAH5Rj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:48:01 INFO - Running setup.py (path:/tmp/pip-HRVXeD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:48:01 INFO - Running setup.py (path:/tmp/pip-hp9oFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:48:01 INFO - Running setup.py (path:/tmp/pip-QD9nyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:48:01 INFO - Running setup.py (path:/tmp/pip-CMz3Fm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:48:01 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)) 05:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:48:01 INFO - Running setup.py (path:/tmp/pip-Sk0mjq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:48:02 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)) 05:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:48:02 INFO - Running setup.py (path:/tmp/pip-iZdkkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:48:02 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)) 05:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:48:02 INFO - Running setup.py (path:/tmp/pip-wXd05w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:48:02 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)) 05:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:48:02 INFO - Running setup.py (path:/tmp/pip-HQwLDa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:48:02 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)) 05:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:48:02 INFO - Running setup.py (path:/tmp/pip-wfbNlt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:48:02 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)) 05:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:48:02 INFO - Running setup.py (path:/tmp/pip-r_0ywY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:48:02 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)) 05:48:02 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)) 05:48:02 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)) 05:48:02 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)) 05:48:02 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)) 05:48:02 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)) 05:48:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:04 INFO - Downloading blessings-1.5.1.tar.gz 05:48:04 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 05:48:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:04 INFO - Installing collected packages: blessings 05:48:04 INFO - Running setup.py install for blessings 05:48:04 INFO - Successfully installed blessings 05:48:04 INFO - Cleaning up... 05:48:04 INFO - Return code: 0 05:48:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:48:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:48:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:48:04 INFO - Reading from file tmpfile_stdout 05:48:04 INFO - Current package versions: 05:48:04 INFO - argparse == 1.2.1 05:48:04 INFO - blessings == 1.5.1 05:48:04 INFO - blobuploader == 1.2.4 05:48:04 INFO - docopt == 0.6.1 05:48:04 INFO - manifestparser == 1.1 05:48:04 INFO - mozInstall == 1.12 05:48:04 INFO - mozcrash == 0.16 05:48:04 INFO - mozdebug == 0.1 05:48:04 INFO - mozdevice == 0.47 05:48:04 INFO - mozfile == 1.2 05:48:04 INFO - mozhttpd == 0.7 05:48:04 INFO - mozinfo == 0.9 05:48:04 INFO - mozleak == 0.1 05:48:04 INFO - mozlog == 3.1 05:48:04 INFO - moznetwork == 0.27 05:48:04 INFO - mozprocess == 0.22 05:48:04 INFO - mozprofile == 0.28 05:48:04 INFO - mozrunner == 6.11 05:48:04 INFO - mozscreenshot == 0.1 05:48:04 INFO - mozsystemmonitor == 0.0 05:48:04 INFO - moztest == 0.7 05:48:04 INFO - mozversion == 1.4 05:48:04 INFO - psutil == 3.1.1 05:48:04 INFO - requests == 1.2.3 05:48:04 INFO - wsgiref == 0.1.2 05:48:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:04 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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:48:04 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 05:48:04 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 05:48:04 INFO - Using env: {'DISPLAY': ':0', 05:48:04 INFO - 'HOME': '/home/cltbld', 05:48:04 INFO - 'LANG': 'en_US.UTF-8', 05:48:04 INFO - 'LANGUAGE': 'en_US:en', 05:48:04 INFO - 'LOGNAME': 'cltbld', 05:48:04 INFO - 'MAIL': '/var/mail/cltbld', 05:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:04 INFO - 'MOZ_NO_REMOTE': '1', 05:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:04 INFO - 'NO_EM_RESTART': '1', 05:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:04 INFO - 'SHELL': '/bin/bash', 05:48:04 INFO - 'SHLVL': '1', 05:48:04 INFO - 'TERM': 'linux', 05:48:04 INFO - 'TMOUT': '86400', 05:48:04 INFO - 'USER': 'cltbld', 05:48:04 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:04 INFO - '_': '/tools/buildbot/bin/python'} 05:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 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)) 05:48:04 INFO - Cleaning up... 05:48:04 INFO - Return code: 0 05:48:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:04 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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:48:04 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 05:48:04 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 05:48:04 INFO - Using env: {'DISPLAY': ':0', 05:48:04 INFO - 'HOME': '/home/cltbld', 05:48:04 INFO - 'LANG': 'en_US.UTF-8', 05:48:04 INFO - 'LANGUAGE': 'en_US:en', 05:48:04 INFO - 'LOGNAME': 'cltbld', 05:48:04 INFO - 'MAIL': '/var/mail/cltbld', 05:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:04 INFO - 'MOZ_NO_REMOTE': '1', 05:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:04 INFO - 'NO_EM_RESTART': '1', 05:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:04 INFO - 'SHELL': '/bin/bash', 05:48:04 INFO - 'SHLVL': '1', 05:48:04 INFO - 'TERM': 'linux', 05:48:04 INFO - 'TMOUT': '86400', 05:48:04 INFO - 'USER': 'cltbld', 05:48:04 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:04 INFO - '_': '/tools/buildbot/bin/python'} 05:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:04 INFO - Downloading/unpacking jsonschema 05:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:06 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 05:48:06 INFO - Downloading/unpacking functools32 (from jsonschema) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:06 INFO - warning: no files found matching '*.txt' 05:48:06 INFO - no previously-included directories found matching 'build' 05:48:06 INFO - no previously-included directories found matching 'dist' 05:48:06 INFO - no previously-included directories found matching '.git*' 05:48:06 INFO - Installing collected packages: jsonschema, functools32 05:48:06 INFO - Running setup.py install for functools32 05:48:07 INFO - warning: no files found matching '*.txt' 05:48:07 INFO - no previously-included directories found matching 'build' 05:48:07 INFO - no previously-included directories found matching 'dist' 05:48:07 INFO - no previously-included directories found matching '.git*' 05:48:07 INFO - Successfully installed jsonschema functools32 05:48:07 INFO - Cleaning up... 05:48:07 INFO - Return code: 0 05:48:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:07 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 0x7f60e571af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, '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': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', '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 05:48:07 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 05:48:07 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 05:48:07 INFO - Using env: {'DISPLAY': ':0', 05:48:07 INFO - 'HOME': '/home/cltbld', 05:48:07 INFO - 'LANG': 'en_US.UTF-8', 05:48:07 INFO - 'LANGUAGE': 'en_US:en', 05:48:07 INFO - 'LOGNAME': 'cltbld', 05:48:07 INFO - 'MAIL': '/var/mail/cltbld', 05:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:07 INFO - 'MOZ_NO_REMOTE': '1', 05:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:07 INFO - 'NO_EM_RESTART': '1', 05:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:07 INFO - 'SHELL': '/bin/bash', 05:48:07 INFO - 'SHLVL': '1', 05:48:07 INFO - 'TERM': 'linux', 05:48:07 INFO - 'TMOUT': '86400', 05:48:07 INFO - 'USER': 'cltbld', 05:48:07 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:07 INFO - '_': '/tools/buildbot/bin/python'} 05:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:07 INFO - Downloading/unpacking flake8 05:48:07 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 05:48:07 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 05:48:07 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 05:48:07 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 05:48:07 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 05:48:07 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 05:48:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:48:09 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 05:48:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:48:09 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 05:48:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 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 05:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:09 INFO - no previously-included directories found matching 'docs/_build' 05:48:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:48:09 INFO - Running setup.py install for pep8 05:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:09 INFO - no previously-included directories found matching 'docs/_build' 05:48:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:48:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:48:09 INFO - Cleaning up... 05:48:09 INFO - Return code: 0 05:48:09 INFO - Running post-action listener: _resource_record_post_action 05:48:09 INFO - Running post-action listener: _start_resource_monitoring 05:48:09 INFO - Starting resource monitoring. 05:48:09 INFO - ##### 05:48:09 INFO - ##### Running install step. 05:48:09 INFO - ##### 05:48:09 INFO - Running pre-action listener: _resource_record_pre_action 05:48:09 INFO - Running main action method: install 05:48:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:48:10 INFO - Reading from file tmpfile_stdout 05:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:48:10 INFO - Reading from file tmpfile_stdout 05:48:10 INFO - Output received: 05:48:10 INFO - Usage: mozinstall [options] installer 05:48:10 INFO - Options: 05:48:10 INFO - -h, --help show this help message and exit 05:48:10 INFO - -d DEST, --destination=DEST 05:48:10 INFO - Directory to install application into. [default: 05:48:10 INFO - "/builds/slave/test-pgo"] 05:48:10 INFO - --app=APP Application being installed. [default: firefox] 05:48:10 INFO - mkdir: /builds/slave/test-pgo/build/application 05:48:10 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'] 05:48:10 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 05:48:26 INFO - Reading from file tmpfile_stdout 05:48:26 INFO - Output received: 05:48:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:48:26 INFO - Running post-action listener: _resource_record_post_action 05:48:26 INFO - ##### 05:48:26 INFO - ##### Running run-tests step. 05:48:26 INFO - ##### 05:48:26 INFO - Running pre-action listener: _resource_record_pre_action 05:48:26 INFO - Running main action method: run_tests 05:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:48:26 INFO - Python 2.7.3 05:48:26 INFO - Return code: 0 05:48:26 INFO - grabbing minidump binary from tooltool 05:48:26 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')]} 05:48:26 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 0x1952840>, '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 0x18bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bfb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:48:26 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 05:48:26 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 05:48:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:26 INFO - Return code: 0 05:48:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:48:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:48:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:48:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:48:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:48:27 INFO - Return code: 0 05:48:27 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/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:48:27 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/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:48:27 INFO - Using env: {'DISPLAY': ':0', 05:48:27 INFO - 'HOME': '/home/cltbld', 05:48:27 INFO - 'LANG': 'en_US.UTF-8', 05:48:27 INFO - 'LANGUAGE': 'en_US:en', 05:48:27 INFO - 'LOGNAME': 'cltbld', 05:48:27 INFO - 'MAIL': '/var/mail/cltbld', 05:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:27 INFO - 'MOZ_NO_REMOTE': '1', 05:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:27 INFO - 'NO_EM_RESTART': '1', 05:48:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:48:27 INFO - 'SHELL': '/bin/bash', 05:48:27 INFO - 'SHLVL': '1', 05:48:27 INFO - 'TERM': 'linux', 05:48:27 INFO - 'TMOUT': '86400', 05:48:27 INFO - 'USER': 'cltbld', 05:48:27 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614', 05:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:27 INFO - '_': '/tools/buildbot/bin/python'} 05:48:27 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/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:48:27 INFO - mozversion application_buildid: 20160102030217 05:48:27 INFO - mozversion application_changeset: ce643acfab14d95bea2fb6c4f56477413514b686 05:48:27 INFO - mozversion application_display_name: Nightly 05:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:27 INFO - mozversion application_name: Firefox 05:48:27 INFO - mozversion application_remotingname: firefox 05:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:27 INFO - mozversion application_vendor: Mozilla 05:48:27 INFO - mozversion application_version: 46.0a1 05:48:27 INFO - mozversion platform_buildid: 20160102030217 05:48:27 INFO - mozversion platform_changeset: ce643acfab14d95bea2fb6c4f56477413514b686 05:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:27 INFO - mozversion platform_version: 46.0a1 05:48:27 INFO - using testdate: 1451742507 05:48:27 INFO - actual date: 1451742507 05:48:27 INFO - starting webserver on 'localhost:37691' 05:48:27 INFO - SUITE-START | Running 3 tests 05:48:27 INFO - TEST-START | dromaeo_css 05:48:27 INFO - operating with platform_type : linux_ 05:48:27 INFO - Initialising browser for dromaeo_css test... 05:48:27 INFO - TEST-INFO | started process 718 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgr5nhM/profile http://localhost:37691/getInfo.html) 05:48:32 INFO - PROCESS | 718 | __metrics Screen width/height:1600/1200 05:48:32 INFO - PROCESS | 718 | colorDepth:24 05:48:32 INFO - PROCESS | 718 | Browser inner width/height: 1024/670 05:48:32 INFO - PROCESS | 718 | __metrics 05:48:32 INFO - PROCESS | 718 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:48:33 INFO - TEST-INFO | 718: exit 0 05:48:33 INFO - Browser initialized. 05:48:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:33 INFO - TEST-INFO | started process 855 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgr5nhM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:45 INFO - PROCESS | 855 | RSS: Main: 150208512 05:48:45 INFO - PROCESS | 855 | 05:49:34 INFO - PROCESS | 855 | 1451742574667 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] 05:51:43 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:37691/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37691/tests/dromaeo/cssquery-ext.html) 05:51:44 INFO - PROCESS | 855 | RSS: Main: 157663232 05:51:44 INFO - PROCESS | 855 | 05:54:46 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:37691/tests/dromaeo/cssquery-ext.html (next: http://localhost:37691/tests/dromaeo/cssquery-jquery.html) 05:54:46 INFO - PROCESS | 855 | RSS: Main: 152502272 05:54:46 INFO - PROCESS | 855 | 05:57:48 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:37691/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37691/tests/dromaeo/cssquery-mootools.html) 05:57:49 INFO - PROCESS | 855 | RSS: Main: 153305088 05:57:49 INFO - PROCESS | 855 | 06:00:50 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:37691/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37691/tests/dromaeo/cssquery-prototype.html) 06:00:51 INFO - PROCESS | 855 | RSS: Main: 152444928 06:00:51 INFO - PROCESS | 855 | 06:03:53 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:37691/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37691/tests/dromaeo/cssquery-yui.html) 06:03:54 INFO - PROCESS | 855 | RSS: Main: 152928256 06:03:54 INFO - PROCESS | 855 | 06:06:56 INFO - PROCESS | 855 | Cycle 1(1): loaded http://localhost:37691/tests/dromaeo/cssquery-yui.html (next: http://localhost:37691/tests/dromaeo/cssquery-dojo.html) 06:06:57 INFO - PROCESS | 855 | RSS: Main: 155148288 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | __start_tp_report 06:06:57 INFO - PROCESS | 855 | _x_x_mozilla_page_load 06:06:57 INFO - PROCESS | 855 | _x_x_mozilla_page_load_details 06:06:57 INFO - PROCESS | 855 | |i|pagename|runs| 06:06:57 INFO - PROCESS | 855 | |0;dojo.html;3195.8561864716085;3232.434323993302;3260.1197676627326;3275.9181020474484;3285.3757786020656;5221.791128354871;5247.842564723055;5308.575313974888;5310.415854256029;5323.494268044535;5263.76313065912;5282.286891269678;5287.762050707718;5303.098473259545;5314.5748340132795;4841.806327746904;4931.975340123295;4934.333864928225;4956.975215123919;4978.228374601925;718.28021008314;4935.851924442254;5000.149974504325;5013.273075404064;5057.544820966113;4914.1400254955415;4923.458419573844;4928.063667903105;4934.605231581465;4947.406311242674;4906.779194936236;4916.237983112624;4927;4938.456769755324;4944.530269624416;4753.904921901577;4874.366332376769;4891.290762839404;4947.356843610343;5001;5055.59555235584;5071.366079240095;5090.312807770941;5092.643514953955;5141.794328226866;5733.942660573382;5794.449527294901;5803.767849286023;5806.274215723035;5823.88352232953;5596.720163991784;5704;5810.767569297223;5817.825465236049;5833.154192642043;5317.973410132963;5348.973255133699;5353.197020446886;5354.250404943311;5384.003959267548;5876.147958546072;5919.704014799243;5926.199963005025;5934.228550288435;5948.524118070544;5585.553155747531;5633.971830140823;5670.404607516151;5686.061799802987;5695.686737229492;5811.535077193815;5812.302523697099;5819.94180058194;5828.271466066742;5854.004819180749;5719.28508936383;5773.018586840163;5773.336066352339;5775.133729940459;5775.711214439261;5464.836054918359;5571.9442805571425;5593.412691667398;5692.800751973744;5752.798652047159;4481.775911204427;4492.528284530143;4505.346724724896;4509.549045095464;4524.140413321458;3961.2275606256503;4019.196160767858;4019.3569028955226;4038.414429907647;4114.156597897484;5202.895942081137;5209.869753256199;5256.26412302278;5295.179247216687;5317.229001794718;5734.971325143348;5737.684427356452;5770.798022069207;5777.786664800355;5777.971110144423;5157.045946499835;5375.4624537546715;5376.731163441812;5378.1663842104535;5432.2123292123215;4785.736784476887;4824.517548245148;4825.927611085836;4846.3699719037;4850.587700045465;5836.066229403275;5839.678817664984;5854.356020837705;5954.285485741739;6050.6369617823075;5765.164051212634;5770.047942089508;5798.942010580009;5800.738966746422;5802.0426629605645;5935.080062590306;5946.702664866826;5947.316058653138;5960.4635582797755;6017.789377371771;5559;5656.745446455002;5659.292588426447;5664.971675141598;5665.546756259407;5719;5720.313562372542;5758.856028599319;5822.82531524055;5854.443827836349;5612.831615051555;5659.688717120598;5661.094224923992;5666.716664166693;5679.744411501575;5598.524125449382;5638.407967163553;5648.350439699323;5662.490375866192;5664.405237450009;5391.568674505952;5517.089680202882;5557.333120025461;5647.858803529944;5684.772609095755;5641.576881733969;5653.915191272216;5655.547556195576;5661.094224923992;5701.572382071278;5412.161115027177;5573.108302671553;5578.135389014709;5582.441755824385;5589.77640894376 06:06:57 INFO - PROCESS | 855 | |1;ext.html;505.87858913860686;520.8880090780483;533.1043846338152;535.7080391186804;567.1577707104951;36099.278014439726;36728.63271367286;37085.44371834425;37109.257814843724;37207;40168;40786.59213407865;40818.38772418416;40939;40989.18021639565;8491.915080849174;8675.349348798834;8699.347548933823;8705.260052895512;8729.214370706635;8484.151584841527;8486.830263394728;8539.231469167773;8730.912690873074;8736.912630873705;8674.65301387947;8697.130286971316;8747.212750852423;8787.868181977276;8800.647974081028;8643.870341944845;8672.046074931752;8715.128487151298;8723.694670686527;8725.476471411705;8578.485290882567;8674.08922063187;8675.132486751338;8686.131386861327;8699.52152631605;40451.7977410114;40550.986225344604;40733.59266407328;40841;40882.182356353005;2768.43247134337;3133.7336326412283;3201.3277211785553;3241.5623890774677;3335.5997280326515;26780.464390712077;26801.597976030374;27007.32481687954;27184.456310873673;27747;3847.1920896611746;3878.612138786099;3896.6687831534355;3918.804059797027;3936.409538569209;171917.14041429837;172285;172308;172694;172827.13586432114;52475.277225049926;56842.71578642163;56941.71529142328;57211;57355;45868;51207.7439612807;51391;51519.74240128775;51662;14690.265486725835;15292.847071529364;15303.387864485296;15332.540023799304;15350.155741434328;11374.772504550028;11485.425728713531;11493.827592586118;11502.597409090642;11556.42217889119;20229.49426264355;20830.895845520674;20896.37310880676;20916.686249706265;20925;6444.516661250425;6678.432333251728;6691.698873550702;6713.1944166700305;6718.395344419026;956;971.2181693736469;972.5234635028785;1001.1940387987594;1056.5668076088766;28430.289242769097;28576;28653.283667908054;28907.710922890503;29188.708112919023;914.2000749344323;999.2256001598673;1066.269605320358;1091.7598128411737;1100.9284396514201;13400.798988015187;14266.785998210034;14333.498327558485;14442.350094245785;14490.782638260434;323997;324716;325650;325787;326055;43316;43636;43847.56152438435;43976.78011609986;44075.559244407785;1302.3683513496137;1321.808337791015;1321.8744219299151;1334.5462542735515;1356.796480527909;25638.487230255665;26702.732972670026;27871.721282787723;28065.593380850485;28417.14748557464;42468.362974556025;42595;42836.35745463758;42957;42973.785131074146;252559;252892;254360;254535;254710;30953.380932380776;31254.531182032744;31296.843515783185;31388.058358249287;31745.5238171423;36526.63473365339;37072.443913341864;37205.88382348534;37378.06554836151;37877.81061094677;29046;29417.411651767274;29455.85272073626;29471;29479.55780663249;28285.669016874057;28609.71390286154;28660.426791463637;28810.855945720137;30482.23794405069;33715.15712107217;34333;34609.65390346165;34619.48070778991;34753.82623086868;29627.40745185127;31091.68908310888;31496;31775.841120794248;31845.681543184273;24479.877600612595;25010;26259.868700656374;26450.338741531617;26735.19794406171 06:06:57 INFO - PROCESS | 855 | |2;jquery.html;345.4059018488201;353.30751726615836;359.1416514530273;361.2071503050803;361.79739345966277;16500.917495412523;16968.151592420378;17442.215100320485;17643.823561764377;17939.73090403645;10335.17318614511;10616.363018218912;15185.392584296615;15208.087514749122;15234.619134521643;4887.071456423277;4893.119238537062;5002.7248501332415;5016.824411145611;5041.697498150104;4990.950090499103;5020.297158397827;5027.371578552681;5028.044671512419;5028.094942910275;4072.4705788247634;4990.351254336932;5004.274380214867;5526.58550608706;5526.917096243559;5435.510804027636;5446.891062178774;5469.15228139639;5487.862803429906;5496.532794712434;5130.127878260705;5287.629865909388;5335.33308336458;5342.171963345649;5358.866028349284;20034.298799541946;20241.493962650904;20286.594268114703;21064.789352106436;21122.89438552813;1959.3632069577445;2128.1806504495726;2152.397328747953;2181.760006399295;2183.6833659119497;9977.35147215436;10763.677089687322;12073.215241009306;12467.875321246762;13562.186268823902;1846.5937493751353;1862.928815930845;1888.4051523770106;1893.4508992392189;1914.8659593828438;58156.41843581595;59941.99999999956;60855;60973;62367.68816155935;10090.949545252373;10274.486275686186;10310.742231444274;10399.94800025995;10428.113610343054;13642.522511712043;13668;13671.658208544866;13677.589672309847;13716.177029378268;7698;7707.807304817312;7714.614269286625;7740.187280335596;7794.727184548514;7451.813704657427;7467.477276590586;7476.887846682304;7512.436567257478;7519.323260906544;4258.297380932174;4310.89222769427;4493.146302202636;4500.302453119772;4504.572065653758;1832.8991905445328;1854.5178253654146;1866.8973206473775;1881.8776779509287;1897.117840204284;421.1744979839549;422.57742257742257;437.55588078100755;913.9451632902047;1000;10149.949250253701;10515.684529464128;10555.155587552978;10637.680869573926;10678.145748340114;443.9622632076245;445.8751549566127;448.7487007275936;459.1734877220989;466.1771972468596;5737.225474560964;5775.855603609859;5806.738696758656;5837.94162058374;5909.379515150933;535520;540158;548425;548433;562012;39946;80667.59666201631;81131;83279.5836020816;83691.5815420919;1153.1697178031804;1161.8083016302385;1200.123909546019;1225.0628269373935;1239.4484454417698;14444.85555144477;15265.23673816327;15472.226388680747;15562;15661;31893.36213275768;31936.840315798272;32263.677363226067;33207.667923320456;33602.66397335995;42231.577684222764;42869.571304287805;43214.78392608017;44849.36565845634;48192.5180748188;9716.174125199437;9813.607455701693;9852.556634951301;9999.450030248407;10061.295709300279;17377.21802518915;17703;17890.642187156445;17964.10179490994;17996.730049049012;13565.59303220905;13846.169229846242;13934.442622294995;14006.089604175697;14700.191489468181;9945.801083978135;13785.793213101611;14080.577582672537;14384.928075359556;14932.62668433298;14457.927710361802;14493.78259326132;15058.849411506182;15199.164045977577;15350.769738454155;8641.95679021626;9082.63669453241;9122.7263182102;9466;9583.664571739955;13504.662383440493;13784.862151378358;13966.650833729238;14220.217888015844;14237.928810356296 06:06:57 INFO - PROCESS | 855 | |3;mootools.html;1410.4005797536047;1473;1622.1402656592004;1762.436020473449;1782.1356642028613;7431.62841857907;7508.2867127622785;7609.315161635444;7639.9618001909985;7692.346150577194;7622.3139917407425;7645.350145237661;7723.884141737878;7734.226577342263;7755.728549500768;2252.40311317501;2295.678604995302;2295.701558797354;2296.1504243429954;2299.1722979727283;2242.159190303636;2286.817054635625;2291.106468477295;2292.083166733303;2301.8618882867;2195.714557107574;2238.1942500699815;2264.8074913632363;2269.1944359752297;2270.8523945943543;2261.3216035189375;2290.1640901071073;2299.367673889685;2329.545738580986;2330.5804955108074;2269.954600907989;2283.0525331987205;2283.9771602284095;2284.4060544258446;2296.816254699637;7456.40348772097;7541.886871696929;7547.05661792276;7581.848363032764;7585.544867307924;4513.187626227278;4564.132814765184;4585.72485650862;4586.3808385867815;4588.105319462706;2935.0754512328763;2940.1473572663904;3018.1247438242885;3021.6827233140425;3037.665856755755;976.7411635916487;982.3761911186376;1009.3540134314045;1009.5658866687321;1020.6937918624383;10310;10321.690349289533;10355.17158627308;10419.218558608134;10430.582776689;4024.5774193709826;4076.8165432555606;4092.5498195198506;4107.794610269475;4134.400511925754;8484.36367272457;8511.148885111439;8553.871691924502;8557.871631925525;8571.185737354941;4552.226121559343;4565.497795242521;4579.4046773919845;4586.839460618862;4619.815207391734;4207.347861081476;4214.7471151731;4220.261454245495;4226.746395216297;4235.0682849773;3300.6369299377047;3334.449815780418;3352.0446672698163;3358.328334333094;3364.0748794081333;1055.5619417941623;1071.4000159910474;1083.4311986207147;1086.8695756509112;1093.8031154392127;1015.096564057989;1025.3335332034237;1062.6227689170387;1154.653603918821;1316.4734106357535;6792.354726300993;6855.6572171391235;6859.897101543481;6889.069975553336;6896.2069362023;1100.7138144082596;1121.6130434999911;1129.971750706239;1142.2404101272728;1171.1216587559331;5259.526642602108;5261.263423120766;5264.947350526522;5268.2361057647195;5295.470452954673;8675.349348798865;8820.8676869847;8942.239909607757;8943.821123577492;9017.233535149455;8828.38201325901;8871.201591856763;8871.866921996176;8888.60001299943;8956.149165829236;7031.859362812817;7091.96454017737;7136.3220494052985;7142.607156606437;7254.782356529313;7071.292870712888;7106.644667766487;7168.139823221247;7175.784726458214;7188.4968052235845;8039.316658083894;8163.306118979954;8180.9590952044855;8339.83320333602;8361.707340243061;8304.501729896225;8479.109693482096;8482.448640838325;8497.277731392654;8512.53181075022;6580.276169621434;6663.733450662113;6827.146606674166;6834.8633027340165;6839.829004274933;6932.48006399512;6958.06066181059;6976.02335672996;6976.61628610411;6989.650517474208;6688;6777;6778.93221067783;6824.317568243136;6864.21061577925;6185.8144255672405;6242.875142497034;6659.600423974577;6683.365080317362;6800.6599670017295;6786.558873673195;6811.89782153278;6825.283345248876;6846.110005699227;6848.383645471931;6274.623522588659;6315.96842015787;6352.174217351715;6357.841053973502;6367.299597044414;6287.748490060347;6334.968325158529;6335.239771227482;6337.493000560036;6368.395002474757 06:06:57 INFO - PROCESS | 855 | |4;prototype.html;338.6292010248778;344.8603315657158;346.24691296430257;350.05834305717605;354.65244060820396;6230;6248.750049997994;6249.843753906161;6298.181236439268;6360.204974378203;6125.203723515948;6138.600990935586;6202.4417802397775;6239.500839932806;6261.060840873871;4775;4779.450363208241;4787.61699064074;4790.041991601676;4793.304970779235;4790.13777520048;4792.305115758213;4795.304680821278;4799.976000119995;4804.327394164819;4665.253559430492;4736.90526189476;4737.242041273397;4738.455077666078;4745.76271186441;4696.647751418657;4716.174669432869;4720.575148236675;4727.739974301412;4728.148933192024;4104.979475102636;4106.856260030914;4110.136871257039;4120.896977575585;4120.958790412087;5925.792597259118;5927.733252003627;5931.940680593182;5932.703364831785;5937.050071988504;5379.623426360156;5499.862503437406;5512.641678290898;5522.337319521643;5528.502434780889;6613.074169616258;6613.338666133396;6623.138991931018;6624.304448032935;6631.0053491976105;4525.298578720271;4528.456585209796;4530.161920044769;4530.546945305443;4534.251848445036;6736.932630673679;6819.079424277708;6851.657417129173;6856.142982127234;6867.141607299038;4632.351470794091;4638.165130276582;4645.5354464553275;4647.721136731807;4648.512476007645;4702.811887524529;4707.7881495332795;4710.411198600175;4714.669973101919;4715.316279139505;5432.02223599748;5438.129899216186;5443.265159203536;5446.128619420873;5454.563634909197;6383.489320854414;6489.253735820346;6519.185101862267;6601.6699165041555;6605.471562275006;1613;1629.4378439438374;1636.9263383147786;1641.8768592355382;1658.9834101659071;1101.9283746556448;1106.1980064453207;1118.9384583847966;1123.8763735989035;1130.9708165569293;6063.727132279058;6083.695815209222;6095.908561371494;6101.420365065312;6112.419320164578;6707.798766037026;6716;6718;6723;6723.596584204964;5950.345461999176;6028.728707208186;6040.063790112539;6065.696715164224;6078.6048906820915;3618.1859081706407;3644.3986742187244;3650.671439570451;3656.8171591420323;3664.7801131931637;7010.92989070113;7014.298570143047;7023.367896889305;7031.859362812817;7040.859182816315;6789.388954994074;6876.381125698711;6900.3099690031595;6933.410660093848;6955.200151982587;6905.1713794345;6975.4070903972715;6997.230304666483;7005.754798582026;7024.859502810017;6610.305917878553;6660.83435398813;6669.566478178903;6672.065910772399;6683.732650694113;6462.418382345423;6647;6650.235222949229;6655.035019922181;6660.067590537232;6929.89605155913;7019.964900175466;7027.8945815811785;7035.401990830836;7036;4598.3102534620075;4602.148602508547;4607.170709272363;4614.2617181250835;4618.51505591908;6701.798946031627;6738.427233684995;6741.966290168518;6742.6291553965;6887.552309099892;6609.867802644017;6660.0675905374255;6672.866542669022;6682.933170668425;6689.163854518185;6623.834404139935;6648.700808463534;6655.667216639052;6663.067170596218;6689.130413046273;6340.651264180515;6459.321771213955;6484.481241500763;6513.54405191632;6515.869682606227;6686.665666716547;6688.799336019927;6694.564853284521;6695.12963314766;6695.531312808057;6482.611043337415;6514.9348506514325;6519.478441724746;6538.1500404947055;6557.508186886098 06:06:57 INFO - PROCESS | 855 | |5;yui.html;621.5990686007525;663.2140913018073;675.1493118670473;710.7050574011786;760.8021914302279;13330.666733331671;13627.727445451084;13652.45390184394;13684.863151368483;13691.110077844933;12035.939820300908;12517.436715347809;12520.436580353884;12541.372931353419;12567.434465449054;679.2460368990417;685.3112621815094;810.129111205455;825.9256666899978;841.6380956188837;833.791552111972;836.5900708652778;840.306746933782;843.6667516331046;847.0682249525535;868.68727258187;870.4342177584557;871.7036207689384;872.8865247517814;874.1302404107921;853.2363534636465;858.8754630578532;861.2937391339104;867.6312567158964;868.1969178509885;628.6730899932055;631.4348657951153;638.4732595608641;638.6264035539215;642.2132887213173;13722.725545489035;13879.930600346934;13887.4445022199;13938.303084845818;13939.721205575934;11419.371934543597;11919.523219071227;12466.75066498665;12793.104482686216;12908.54820081302;9870.654527091518;10259.589616415335;10299.639512617097;10421.739456513573;10495.370277783357;3542.291541691646;3606.1525541497726;3614.4036234021355;3668.101315177772;3762.3415902217275;44646.10707785826;44695.32957005648;44747.10505789866;45535.77232113852;47387.289190662515;9127.543622818832;9303.76740581491;9333.066693330748;9396.624135034523;9713.805723885624;17434.738478922573;17444;17552.561185970197;17571.297148113932;17577.384791532237;7612.429067819936;7704.460687751915;7834.334081603013;7861.213878612208;8038.557879316577;4412.294032954712;4458.888527786831;4480.708753930984;4516.81932722694;4559.065391594715;2922.2986483243867;2955.9704402956127;2957.482440572891;2964.8221106733663;2964.9407011859644;516.754541592748;532.292051571409;539.4551502982016;543.2150542466178;543.2584522127347;502.8164719877292;552.1055889459021;617.450469082517;651.6839332923528;725.8024259970985;9302.302327325478;9307.72076837696;9434.386764860263;9571.521423928776;9780.217582593517;523.8742701751628;557.4007941462944;640.545212898847;645.1258544671996;658.9703463344161;4017.457643218128;4187.330027195695;4280.464941882265;4306.397104405386;4317.786725703171;54338;56464;56559.43440565624;56572;56740.71629641908;49713;50585;50860.89669239641;50900;51112.48887511077;46346;46427.30359044617;46480.3027954581;46519.99999999932;47040;8372.916270837213;8512.53181075022;8665.610047548002;8755.562221889008;8911.37620366568;34660.65339346574;35950.92147235587;36040;36062.819685901406;36213.818930905174;44390;45248.77375613232;45452.545474546154;45581.316280256484;46189.76905115453;11101.666949991513;11338.546458141913;11490.54037838477;11604.88395116038;11733.178677492493;12531;12834.358282085672;12894.871051289367;12898.742025159256;12927.095103342675;11857.407129643656;11858.703532411759;11962.222455540363;12105.81841272364;12248.510059597516;10025.947275535964;10350.016748408889;10357.223208259562;10557.63489840564;10601.257911946399;11510.13673974472;11593.362365070003;11608.88391116078;11970.46132924038;11973.76052478963;9643.517824108627;9933.900660993297;9968.352057116264;10009.24930630191;10337.638182663572;8914.37599368038;9025.954870225607;9146.451212927246;9278.675246366345;9764.365316254705 06:06:57 INFO - PROCESS | 855 | __end_tp_report 06:06:57 INFO - PROCESS | 855 | __start_cc_report 06:06:57 INFO - PROCESS | 855 | _x_x_mozilla_cycle_collect,322 06:06:57 INFO - PROCESS | 855 | __end_cc_report 06:06:57 INFO - PROCESS | 855 | __startTimestamp1451743617101__endTimestamp 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | ------- Summary: start ------- 06:06:57 INFO - PROCESS | 855 | Number of tests: 6 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | [#0] dojo.html Cycles:165 Average:5311.27 Median:5578.14 stddev:683.01 (12.2%) stddev-sans-first:664.64 06:06:57 INFO - PROCESS | 855 | Values: 3195.9 3232.4 3260.1 3275.9 3285.4 5221.8 5247.8 5308.6 5310.4 5323.5 5263.8 5282.3 5287.8 5303.1 5314.6 4841.8 4932.0 4934.3 4957.0 4978.2 718.3 4935.9 5000.1 5013.3 5057.5 4914.1 4923.5 4928.1 4934.6 4947.4 4906.8 4916.2 4927.0 4938.5 4944.5 4753.9 4874.4 4891.3 4947.4 5001.0 5055.6 5071.4 5090.3 5092.6 5141.8 5733.9 5794.4 5803.8 5806.3 5823.9 5596.7 5704.0 5810.8 5817.8 5833.2 5318.0 5349.0 5353.2 5354.3 5384.0 5876.1 5919.7 5926.2 5934.2 5948.5 5585.6 5634.0 5670.4 5686.1 5695.7 5811.5 5812.3 5819.9 5828.3 5854.0 5719.3 5773.0 5773.3 5775.1 5775.7 5464.8 5571.9 5593.4 5692.8 5752.8 4481.8 4492.5 4505.3 4509.5 4524.1 3961.2 4019.2 4019.4 4038.4 4114.2 5202.9 5209.9 5256.3 5295.2 5317.2 5735.0 5737.7 5770.8 5777.8 5778.0 5157.0 5375.5 5376.7 5378.2 5432.2 4785.7 4824.5 4825.9 4846.4 4850.6 5836.1 5839.7 5854.4 5954.3 6050.6 5765.2 5770.0 5798.9 5800.7 5802.0 5935.1 5946.7 5947.3 5960.5 6017.8 5559.0 5656.7 5659.3 5665.0 5665.5 5719.0 5720.3 5758.9 5822.8 5854.4 5612.8 5659.7 5661.1 5666.7 5679.7 5598.5 5638.4 5648.4 5662.5 5664.4 5391.6 5517.1 5557.3 5647.9 5684.8 5641.6 5653.9 5655.5 5661.1 5701.6 5412.2 5573.1 5578.1 5582.4 5589.8 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | [#1] ext.html Cycles:180 Average:41298.68 Median:34024.08 stddev:67535.67 (198.5%) stddev-sans-first:67655.67 06:06:57 INFO - PROCESS | 855 | Values: 505.9 520.9 533.1 535.7 567.2 36099.3 36728.6 37085.4 37109.3 37207.0 40168.0 40786.6 40818.4 40939.0 40989.2 8491.9 8675.3 8699.3 8705.3 8729.2 8484.2 8486.8 8539.2 8730.9 8736.9 8674.7 8697.1 8747.2 8787.9 8800.6 8643.9 8672.0 8715.1 8723.7 8725.5 8578.5 8674.1 8675.1 8686.1 8699.5 40451.8 40551.0 40733.6 40841.0 40882.2 2768.4 3133.7 3201.3 3241.6 3335.6 26780.5 26801.6 27007.3 27184.5 27747.0 3847.2 3878.6 3896.7 3918.8 3936.4 171917.1 172285.0 172308.0 172694.0 172827.1 52475.3 56842.7 56941.7 57211.0 57355.0 45868.0 51207.7 51391.0 51519.7 51662.0 14690.3 15292.8 15303.4 15332.5 15350.2 11374.8 11485.4 11493.8 11502.6 11556.4 20229.5 20830.9 20896.4 20916.7 20925.0 6444.5 6678.4 6691.7 6713.2 6718.4 956.0 971.2 972.5 1001.2 1056.6 28430.3 28576.0 28653.3 28907.7 29188.7 914.2 999.2 1066.3 1091.8 1100.9 13400.8 14266.8 14333.5 14442.4 14490.8 323997.0 324716.0 325650.0 325787.0 326055.0 43316.0 43636.0 43847.6 43976.8 44075.6 1302.4 1321.8 1321.9 1334.5 1356.8 25638.5 26702.7 27871.7 28065.6 28417.1 42468.4 42595.0 42836.4 42957.0 42973.8 252559.0 252892.0 254360.0 254535.0 254710.0 30953.4 31254.5 31296.8 31388.1 31745.5 36526.6 37072.4 37205.9 37378.1 37877.8 29046.0 29417.4 29455.9 29471.0 29479.6 28285.7 28609.7 28660.4 28810.9 30482.2 33715.2 34333.0 34609.7 34619.5 34753.8 29627.4 31091.7 31496.0 31775.8 31845.7 24479.9 25010.0 26259.9 26450.3 26735.2 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | [#2] jquery.html Cycles:180 Average:28431.49 Median:349.36 stddev:89347.97 (25575.0%) stddev-sans-first:89573.73 06:06:57 INFO - PROCESS | 855 | Values: 345.4 353.3 359.1 361.2 361.8 16500.9 16968.2 17442.2 17643.8 17939.7 10335.2 10616.4 15185.4 15208.1 15234.6 4887.1 4893.1 5002.7 5016.8 5041.7 4991.0 5020.3 5027.4 5028.0 5028.1 4072.5 4990.4 5004.3 5526.6 5526.9 5435.5 5446.9 5469.2 5487.9 5496.5 5130.1 5287.6 5335.3 5342.2 5358.9 20034.3 20241.5 20286.6 21064.8 21122.9 1959.4 2128.2 2152.4 2181.8 2183.7 9977.4 10763.7 12073.2 12467.9 13562.2 1846.6 1862.9 1888.4 1893.5 1914.9 58156.4 59942.0 60855.0 60973.0 62367.7 10090.9 10274.5 10310.7 10399.9 10428.1 13642.5 13668.0 13671.7 13677.6 13716.2 7698.0 7707.8 7714.6 7740.2 7794.7 7451.8 7467.5 7476.9 7512.4 7519.3 4258.3 4310.9 4493.1 4500.3 4504.6 1832.9 1854.5 1866.9 1881.9 1897.1 421.2 422.6 437.6 913.9 1000.0 10149.9 10515.7 10555.2 10637.7 10678.1 444.0 445.9 448.7 459.2 466.2 5737.2 5775.9 5806.7 5837.9 5909.4 535520.0 540158.0 548425.0 548433.0 562012.0 39946.0 80667.6 81131.0 83279.6 83691.6 1153.2 1161.8 1200.1 1225.1 1239.4 14444.9 15265.2 15472.2 15562.0 15661.0 31893.4 31936.8 32263.7 33207.7 33602.7 42231.6 42869.6 43214.8 44849.4 48192.5 9716.2 9813.6 9852.6 9999.5 10061.3 17377.2 17703.0 17890.6 17964.1 17996.7 13565.6 13846.2 13934.4 14006.1 14700.2 9945.8 13785.8 14080.6 14384.9 14932.6 14457.9 14493.8 15058.8 15199.2 15350.8 8642.0 9082.6 9122.7 9466.0 9583.7 13504.7 13784.9 13966.7 14220.2 14237.9 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | [#3] mootools.html Cycles:180 Average:5283.09 Median:6281.19 stddev:2704.42 (43.1%) stddev-sans-first:2696.34 06:06:57 INFO - PROCESS | 855 | Values: 1410.4 1473.0 1622.1 1762.4 1782.1 7431.6 7508.3 7609.3 7640.0 7692.3 7622.3 7645.4 7723.9 7734.2 7755.7 2252.4 2295.7 2295.7 2296.2 2299.2 2242.2 2286.8 2291.1 2292.1 2301.9 2195.7 2238.2 2264.8 2269.2 2270.9 2261.3 2290.2 2299.4 2329.5 2330.6 2270.0 2283.1 2284.0 2284.4 2296.8 7456.4 7541.9 7547.1 7581.8 7585.5 4513.2 4564.1 4585.7 4586.4 4588.1 2935.1 2940.1 3018.1 3021.7 3037.7 976.7 982.4 1009.4 1009.6 1020.7 10310.0 10321.7 10355.2 10419.2 10430.6 4024.6 4076.8 4092.5 4107.8 4134.4 8484.4 8511.1 8553.9 8557.9 8571.2 4552.2 4565.5 4579.4 4586.8 4619.8 4207.3 4214.7 4220.3 4226.7 4235.1 3300.6 3334.4 3352.0 3358.3 3364.1 1055.6 1071.4 1083.4 1086.9 1093.8 1015.1 1025.3 1062.6 1154.7 1316.5 6792.4 6855.7 6859.9 6889.1 6896.2 1100.7 1121.6 1130.0 1142.2 1171.1 5259.5 5261.3 5264.9 5268.2 5295.5 8675.3 8820.9 8942.2 8943.8 9017.2 8828.4 8871.2 8871.9 8888.6 8956.1 7031.9 7092.0 7136.3 7142.6 7254.8 7071.3 7106.6 7168.1 7175.8 7188.5 8039.3 8163.3 8181.0 8339.8 8361.7 8304.5 8479.1 8482.4 8497.3 8512.5 6580.3 6663.7 6827.1 6834.9 6839.8 6932.5 6958.1 6976.0 6976.6 6989.7 6688.0 6777.0 6778.9 6824.3 6864.2 6185.8 6242.9 6659.6 6683.4 6800.7 6786.6 6811.9 6825.3 6846.1 6848.4 6274.6 6316.0 6352.2 6357.8 6367.3 6287.7 6335.0 6335.2 6337.5 6368.4 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | [#4] prototype.html Cycles:180 Average:5484.88 Median:6131.90 stddev:1653.28 (27.0%) stddev-sans-first:1612.16 06:06:57 INFO - PROCESS | 855 | Values: 338.6 344.9 346.2 350.1 354.7 6230.0 6248.8 6249.8 6298.2 6360.2 6125.2 6138.6 6202.4 6239.5 6261.1 4775.0 4779.5 4787.6 4790.0 4793.3 4790.1 4792.3 4795.3 4800.0 4804.3 4665.3 4736.9 4737.2 4738.5 4745.8 4696.6 4716.2 4720.6 4727.7 4728.1 4105.0 4106.9 4110.1 4120.9 4121.0 5925.8 5927.7 5931.9 5932.7 5937.1 5379.6 5499.9 5512.6 5522.3 5528.5 6613.1 6613.3 6623.1 6624.3 6631.0 4525.3 4528.5 4530.2 4530.5 4534.3 6736.9 6819.1 6851.7 6856.1 6867.1 4632.4 4638.2 4645.5 4647.7 4648.5 4702.8 4707.8 4710.4 4714.7 4715.3 5432.0 5438.1 5443.3 5446.1 5454.6 6383.5 6489.3 6519.2 6601.7 6605.5 1613.0 1629.4 1636.9 1641.9 1659.0 1101.9 1106.2 1118.9 1123.9 1131.0 6063.7 6083.7 6095.9 6101.4 6112.4 6707.8 6716.0 6718.0 6723.0 6723.6 5950.3 6028.7 6040.1 6065.7 6078.6 3618.2 3644.4 3650.7 3656.8 3664.8 7010.9 7014.3 7023.4 7031.9 7040.9 6789.4 6876.4 6900.3 6933.4 6955.2 6905.2 6975.4 6997.2 7005.8 7024.9 6610.3 6660.8 6669.6 6672.1 6683.7 6462.4 6647.0 6650.2 6655.0 6660.1 6929.9 7020.0 7027.9 7035.4 7036.0 4598.3 4602.1 4607.2 4614.3 4618.5 6701.8 6738.4 6742.0 6742.6 6887.6 6609.9 6660.1 6672.9 6682.9 6689.2 6623.8 6648.7 6655.7 6663.1 6689.1 6340.7 6459.3 6484.5 6513.5 6515.9 6686.7 6688.8 6694.6 6695.1 6695.5 6482.6 6514.9 6519.5 6538.2 6557.5 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - PROCESS | 855 | [#5] yui.html Cycles:180 Average:13736.11 Median:46386.65 stddev:15712.40 (33.9%) stddev-sans-first:15725.61 06:06:57 INFO - PROCESS | 855 | Values: 621.6 663.2 675.1 710.7 760.8 13330.7 13627.7 13652.5 13684.9 13691.1 12035.9 12517.4 12520.4 12541.4 12567.4 679.2 685.3 810.1 825.9 841.6 833.8 836.6 840.3 843.7 847.1 868.7 870.4 871.7 872.9 874.1 853.2 858.9 861.3 867.6 868.2 628.7 631.4 638.5 638.6 642.2 13722.7 13879.9 13887.4 13938.3 13939.7 11419.4 11919.5 12466.8 12793.1 12908.5 9870.7 10259.6 10299.6 10421.7 10495.4 3542.3 3606.2 3614.4 3668.1 3762.3 44646.1 44695.3 44747.1 45535.8 47387.3 9127.5 9303.8 9333.1 9396.6 9713.8 17434.7 17444.0 17552.6 17571.3 17577.4 7612.4 7704.5 7834.3 7861.2 8038.6 4412.3 4458.9 4480.7 4516.8 4559.1 2922.3 2956.0 2957.5 2964.8 2964.9 516.8 532.3 539.5 543.2 543.3 502.8 552.1 617.5 651.7 725.8 9302.3 9307.7 9434.4 9571.5 9780.2 523.9 557.4 640.5 645.1 659.0 4017.5 4187.3 4280.5 4306.4 4317.8 54338.0 56464.0 56559.4 56572.0 56740.7 49713.0 50585.0 50860.9 50900.0 51112.5 46346.0 46427.3 46480.3 46520.0 47040.0 8372.9 8512.5 8665.6 8755.6 8911.4 34660.7 35950.9 36040.0 36062.8 36213.8 44390.0 45248.8 45452.5 45581.3 46189.8 11101.7 11338.5 11490.5 11604.9 11733.2 12531.0 12834.4 12894.9 12898.7 12927.1 11857.4 11858.7 11962.2 12105.8 12248.5 10025.9 10350.0 10357.2 10557.6 10601.3 11510.1 11593.4 11608.9 11970.5 11973.8 9643.5 9933.9 9968.4 10009.2 10337.6 8914.4 9026.0 9146.5 9278.7 9764.4 06:06:57 INFO - PROCESS | 855 | -------- Summary: end -------- 06:06:57 INFO - PROCESS | 855 | 06:06:57 INFO - TEST-INFO | 855: exit 0 06:06:57 INFO - TEST-OK | dromaeo_css | took 1110544ms 06:06:57 INFO - TEST-START | kraken 06:06:57 INFO - operating with platform_type : linux_ 06:06:57 INFO - Initialising browser for kraken test... 06:06:57 INFO - TEST-INFO | started process 1105 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmwyNgj/profile http://localhost:37691/getInfo.html) 06:07:02 INFO - PROCESS | 1105 | __metrics Screen width/height:1600/1200 06:07:02 INFO - PROCESS | 1105 | colorDepth:24 06:07:02 INFO - PROCESS | 1105 | Browser inner width/height: 1024/670 06:07:02 INFO - PROCESS | 1105 | __metrics 06:07:02 INFO - PROCESS | 1105 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:07:03 INFO - TEST-INFO | 1105: exit 0 06:07:03 INFO - Browser initialized. 06:07:03 INFO - Running cycle 1/1 for kraken test... 06:07:03 INFO - TEST-INFO | started process 1310 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmwyNgj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:15 INFO - PROCESS | 1310 | RSS: Main: 150216704 06:07:15 INFO - PROCESS | 1310 | 06:07:17 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37691/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:18 INFO - PROCESS | 1310 | RSS: Main: 150880256 06:07:18 INFO - PROCESS | 1310 | 06:07:21 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37691/tests/kraken/driver.html?testName=audio-dft) 06:07:21 INFO - PROCESS | 1310 | RSS: Main: 152039424 06:07:21 INFO - PROCESS | 1310 | 06:07:24 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37691/tests/kraken/driver.html?testName=audio-fft) 06:07:25 INFO - PROCESS | 1310 | RSS: Main: 145604608 06:07:25 INFO - PROCESS | 1310 | 06:07:27 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37691/tests/kraken/driver.html?testName=audio-oscillator) 06:07:28 INFO - PROCESS | 1310 | RSS: Main: 146423808 06:07:28 INFO - PROCESS | 1310 | 06:07:30 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37691/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:30 INFO - PROCESS | 1310 | RSS: Main: 147705856 06:07:30 INFO - PROCESS | 1310 | 06:07:33 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37691/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:34 INFO - PROCESS | 1310 | RSS: Main: 147578880 06:07:34 INFO - PROCESS | 1310 | 06:07:37 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37691/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:38 INFO - PROCESS | 1310 | RSS: Main: 149196800 06:07:38 INFO - PROCESS | 1310 | 06:07:41 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37691/tests/kraken/driver.html?testName=json-parse-financial) 06:07:41 INFO - PROCESS | 1310 | RSS: Main: 147939328 06:07:41 INFO - PROCESS | 1310 | 06:07:43 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37691/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:43 INFO - PROCESS | 1310 | RSS: Main: 148320256 06:07:43 INFO - PROCESS | 1310 | 06:07:45 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:46 INFO - PROCESS | 1310 | RSS: Main: 148549632 06:07:46 INFO - PROCESS | 1310 | 06:07:48 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:49 INFO - PROCESS | 1310 | RSS: Main: 148746240 06:07:49 INFO - PROCESS | 1310 | 06:07:51 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:52 INFO - PROCESS | 1310 | RSS: Main: 147689472 06:07:52 INFO - PROCESS | 1310 | 06:07:54 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:55 INFO - PROCESS | 1310 | RSS: Main: 148070400 06:07:55 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | Cycle 1(1): loaded http://localhost:37691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37691/tests/kraken/driver.html?testName=ai-astar) 06:07:57 INFO - PROCESS | 1310 | RSS: Main: 149409792 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | __start_tp_report 06:07:57 INFO - PROCESS | 1310 | _x_x_mozilla_page_load 06:07:57 INFO - PROCESS | 1310 | _x_x_mozilla_page_load_details 06:07:57 INFO - PROCESS | 1310 | |i|pagename|runs| 06:07:57 INFO - PROCESS | 1310 | |0;ai-astar;112;107;111;110;112;123;111;111;111;113 06:07:57 INFO - PROCESS | 1310 | |1;audio-beat-detection;161;126;147;182;129;154;154;128;163;130 06:07:57 INFO - PROCESS | 1310 | |2;audio-dft;162;163;161;162;165;160;165;171;165;164 06:07:57 INFO - PROCESS | 1310 | |3;audio-fft;72;71;73;71;72;135;74;72;73;71 06:07:57 INFO - PROCESS | 1310 | |4;audio-oscillator;97;96;141;98;96;98;140;97;96;140 06:07:57 INFO - PROCESS | 1310 | |5;imaging-gaussian-blur;111;110;110;111;110;110;111;109;110;110 06:07:57 INFO - PROCESS | 1310 | |6;imaging-darkroom;146;148;149;147;148;146;148;148;148;148 06:07:57 INFO - PROCESS | 1310 | |7;imaging-desaturate;96;96;97;97;96;96;96;96;96;97 06:07:57 INFO - PROCESS | 1310 | |8;json-parse-financial;63;61;61;59;59;59;60;61;56;61 06:07:57 INFO - PROCESS | 1310 | |9;json-stringify-tinderbox;68;68;68;67;68;68;69;69;68;69 06:07:57 INFO - PROCESS | 1310 | |10;stanford-crypto-aes;84;87;88;86;88;87;87;86;87;89 06:07:57 INFO - PROCESS | 1310 | |11;stanford-crypto-ccm;125;119;144;137;120;119;121;135;122;124 06:07:57 INFO - PROCESS | 1310 | |12;stanford-crypto-pbkdf2;145;160;153;146;151;152;150;141;153;147 06:07:57 INFO - PROCESS | 1310 | |13;stanford-crypto-sha256-iterative;68;68;69;68;69;67;69;68;73;67 06:07:57 INFO - PROCESS | 1310 | __end_tp_report 06:07:57 INFO - PROCESS | 1310 | __start_cc_report 06:07:57 INFO - PROCESS | 1310 | _x_x_mozilla_cycle_collect,716 06:07:57 INFO - PROCESS | 1310 | __end_cc_report 06:07:57 INFO - PROCESS | 1310 | __startTimestamp1451743677300__endTimestamp 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | ------- Summary: start ------- 06:07:57 INFO - PROCESS | 1310 | Number of tests: 14 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:4.15 (3.7%) stddev-sans-first:4.40 06:07:57 INFO - PROCESS | 1310 | Values: 112.0 107.0 111.0 110.0 112.0 123.0 111.0 111.0 111.0 113.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:154.00 stddev:18.82 (12.2%) stddev-sans-first:19.31 06:07:57 INFO - PROCESS | 1310 | Values: 161.0 126.0 147.0 182.0 129.0 154.0 154.0 128.0 163.0 130.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.50 stddev:3.08 (1.9%) stddev-sans-first:3.20 06:07:57 INFO - PROCESS | 1310 | Values: 162.0 163.0 161.0 162.0 165.0 160.0 165.0 171.0 165.0 164.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#3] audio-fft Cycles:10 Average:78.40 Median:72.00 stddev:19.91 (27.7%) stddev-sans-first:20.98 06:07:57 INFO - PROCESS | 1310 | Values: 72.0 71.0 73.0 71.0 72.0 135.0 74.0 72.0 73.0 71.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.50 stddev:21.02 (21.8%) stddev-sans-first:21.77 06:07:57 INFO - PROCESS | 1310 | Values: 97.0 96.0 141.0 98.0 96.0 98.0 140.0 97.0 96.0 140.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 06:07:57 INFO - PROCESS | 1310 | Values: 111.0 110.0 110.0 111.0 110.0 110.0 111.0 109.0 110.0 110.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:0.83 06:07:57 INFO - PROCESS | 1310 | Values: 146.0 148.0 149.0 147.0 148.0 146.0 148.0 148.0 148.0 148.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:07:57 INFO - PROCESS | 1310 | Values: 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:61.00 stddev:1.89 (3.1%) stddev-sans-first:1.66 06:07:57 INFO - PROCESS | 1310 | Values: 63.0 61.0 61.0 59.0 59.0 59.0 60.0 61.0 56.0 61.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 06:07:57 INFO - PROCESS | 1310 | Values: 68.0 68.0 68.0 67.0 68.0 68.0 69.0 69.0 68.0 69.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:1.37 (1.6%) stddev-sans-first:0.97 06:07:57 INFO - PROCESS | 1310 | Values: 84.0 87.0 88.0 86.0 88.0 87.0 87.0 86.0 87.0 89.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:124.50 stddev:8.83 (7.1%) stddev-sans-first:9.35 06:07:57 INFO - PROCESS | 1310 | Values: 125.0 119.0 144.0 137.0 120.0 119.0 121.0 135.0 122.0 124.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.50 stddev:5.31 (3.5%) stddev-sans-first:5.34 06:07:57 INFO - PROCESS | 1310 | Values: 145.0 160.0 153.0 146.0 151.0 152.0 150.0 141.0 153.0 147.0 06:07:57 INFO - PROCESS | 1310 | 06:07:57 INFO - PROCESS | 1310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.71 (2.5%) stddev-sans-first:1.80 06:07:57 INFO - PROCESS | 1310 | Values: 68.0 68.0 69.0 68.0 69.0 67.0 69.0 68.0 73.0 67.0 06:07:57 INFO - PROCESS | 1310 | -------- Summary: end -------- 06:07:57 INFO - PROCESS | 1310 | 06:07:58 INFO - TEST-INFO | 1310: exit 0 06:07:58 INFO - TEST-OK | kraken | took 60395ms 06:07:58 INFO - TEST-START | v8_7 06:07:58 INFO - operating with platform_type : linux_ 06:07:58 INFO - Initialising browser for v8_7 test... 06:07:58 INFO - TEST-INFO | started process 1597 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY38t9q/profile http://localhost:37691/getInfo.html) 06:08:03 INFO - PROCESS | 1597 | __metrics Screen width/height:1600/1200 06:08:03 INFO - PROCESS | 1597 | colorDepth:24 06:08:03 INFO - PROCESS | 1597 | Browser inner width/height: 1024/670 06:08:03 INFO - PROCESS | 1597 | __metrics 06:08:03 INFO - PROCESS | 1597 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:08:04 INFO - TEST-INFO | 1597: exit 0 06:08:04 INFO - Browser initialized. 06:08:04 INFO - Running cycle 1/1 for v8_7 test... 06:08:04 INFO - TEST-INFO | started process 1718 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY38t9q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:15 INFO - PROCESS | 1718 | RSS: Main: 150634496 06:08:15 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | Cycle 1(1): loaded http://localhost:37691/tests/v8_7/run.html (next: http://localhost:37691/tests/v8_7/run.html) 06:08:37 INFO - PROCESS | 1718 | RSS: Main: 145772544 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | __start_tp_report 06:08:37 INFO - PROCESS | 1718 | _x_x_mozilla_page_load 06:08:37 INFO - PROCESS | 1718 | _x_x_mozilla_page_load_details 06:08:37 INFO - PROCESS | 1718 | |i|pagename|runs| 06:08:37 INFO - PROCESS | 1718 | |0;Richards;166.38935108153078 06:08:37 INFO - PROCESS | 1718 | |1;DeltaBlue;189.89745537409797 06:08:37 INFO - PROCESS | 1718 | |2;Encrypt;279.3296089385475 06:08:37 INFO - PROCESS | 1718 | |3;Decrypt;5218.75 06:08:37 INFO - PROCESS | 1718 | |4;RayTrace;1066.0980810234541 06:08:37 INFO - PROCESS | 1718 | |5;Earley;716.3323782234957 06:08:37 INFO - PROCESS | 1718 | |6;Boyer;12345.67901234568 06:08:37 INFO - PROCESS | 1718 | |7;RegExp;25125 06:08:37 INFO - PROCESS | 1718 | |8;Splay;577.3672055427252 06:08:37 INFO - PROCESS | 1718 | |9;NavierStokes;4830.917874396136 06:08:37 INFO - PROCESS | 1718 | __end_tp_report 06:08:37 INFO - PROCESS | 1718 | __startTimestamp1451743717563__endTimestamp 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | ------- Summary: start ------- 06:08:37 INFO - PROCESS | 1718 | Number of tests: 10 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 166.4 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#1] DeltaBlue Cycles:1 Average:189.90 Median:189.90 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 189.9 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 279.3 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 5218.8 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 1066.1 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 716.3 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 12345.7 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#7] RegExp Cycles:1 Average:25125.00 Median:25125.00 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 25125.0 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#8] Splay Cycles:1 Average:577.37 Median:577.37 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 577.4 06:08:37 INFO - PROCESS | 1718 | 06:08:37 INFO - PROCESS | 1718 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:08:37 INFO - PROCESS | 1718 | Values: 4830.9 06:08:37 INFO - PROCESS | 1718 | -------- Summary: end -------- 06:08:37 INFO - PROCESS | 1718 | 06:08:38 INFO - TEST-INFO | 1718: exit 0 06:08:38 INFO - TEST-OK | v8_7 | took 40245ms 06:08:38 INFO - SUITE-END | took 1211s 06:08:38 INFO - Completed test suite (00:20:11) 06:08:38 INFO - Working with test: dromaeo_css 06:08:38 INFO - Generating results file: dromaeo_css 06:08:38 INFO - Working with test: kraken 06:08:38 INFO - Generating results file: kraken 06:08:38 INFO - javascript benchmark 06:08:38 INFO - Working with test: v8_7 06:08:38 INFO - Generating results file: v8_7 06:08:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:08:38 INFO - process_Request line: dromaeo_css 6847.81 graph.html#tests=[[72,1,43]] 06:08:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:38 INFO - process_Request line: kraken 1525.80 graph.html#tests=[[232,1,43]] 06:08:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:38 INFO - process_Request line: v8_7 21435.23 graph.html#tests=[[230,1,43]] 06:08:38 INFO - RETURN: dromaeo_css: 6847.81 06:08:38 INFO - RETURN: kraken: 1525.80 06:08:38 INFO - RETURN: v8_7: 21435.23 06:08:38 INFO - javascript benchmark 06:08:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3195.8561864716085, 3232.434323993302, 3260.1197676627326, 3275.9181020474484, 3285.3757786020656, 5221.791128354871, 5247.842564723055, 5308.575313974888, 5310.415854256029, 5323.494268044535, 5263.76313065912, 5282.286891269678, 5287.762050707718, 5303.098473259545, 5314.5748340132795, 4841.806327746904, 4931.975340123295, 4934.333864928225, 4956.975215123919, 4978.228374601925, 718.28021008314, 4935.851924442254, 5000.149974504325, 5013.273075404064, 5057.544820966113, 4914.1400254955415, 4923.458419573844, 4928.063667903105, 4934.605231581465, 4947.406311242674, 4906.779194936236, 4916.237983112624, 4927.0, 4938.456769755324, 4944.530269624416, 4753.904921901577, 4874.366332376769, 4891.290762839404, 4947.356843610343, 5001.0, 5055.59555235584, 5071.366079240095, 5090.312807770941, 5092.643514953955, 5141.794328226866, 5733.942660573382, 5794.449527294901, 5803.767849286023, 5806.274215723035, 5823.88352232953, 5596.720163991784, 5704.0, 5810.767569297223, 5817.825465236049, 5833.154192642043, 5317.973410132963, 5348.973255133699, 5353.197020446886, 5354.250404943311, 5384.003959267548, 5876.147958546072, 5919.704014799243, 5926.199963005025, 5934.228550288435, 5948.524118070544, 5585.553155747531, 5633.971830140823, 5670.404607516151, 5686.061799802987, 5695.686737229492, 5811.535077193815, 5812.302523697099, 5819.94180058194, 5828.271466066742, 5854.004819180749, 5719.28508936383, 5773.018586840163, 5773.336066352339, 5775.133729940459, 5775.711214439261, 5464.836054918359, 5571.9442805571425, 5593.412691667398, 5692.800751973744, 5752.798652047159, 4481.775911204427, 4492.528284530143, 4505.346724724896, 4509.549045095464, 4524.140413321458, 3961.2275606256503, 4019.196160767858, 4019.3569028955226, 4038.414429907647, 4114.156597897484, 5202.895942081137, 5209.869753256199, 5256.26412302278, 5295.179247216687, 5317.229001794718, 5734.971325143348, 5737.684427356452, 5770.798022069207, 5777.786664800355, 5777.971110144423, 5157.045946499835, 5375.4624537546715, 5376.731163441812, 5378.1663842104535, 5432.2123292123215, 4785.736784476887, 4824.517548245148, 4825.927611085836, 4846.3699719037, 4850.587700045465, 5836.066229403275, 5839.678817664984, 5854.356020837705, 5954.285485741739, 6050.6369617823075, 5765.164051212634, 5770.047942089508, 5798.942010580009, 5800.738966746422, 5802.0426629605645, 5935.080062590306, 5946.702664866826, 5947.316058653138, 5960.4635582797755, 6017.789377371771, 5559.0, 5656.745446455002, 5659.292588426447, 5664.971675141598, 5665.546756259407, 5719.0, 5720.313562372542, 5758.856028599319, 5822.82531524055, 5854.443827836349, 5612.831615051555, 5659.688717120598, 5661.094224923992, 5666.716664166693, 5679.744411501575, 5598.524125449382, 5638.407967163553, 5648.350439699323, 5662.490375866192, 5664.405237450009, 5391.568674505952, 5517.089680202882, 5557.333120025461, 5647.858803529944, 5684.772609095755, 5641.576881733969, 5653.915191272216, 5655.547556195576, 5661.094224923992, 5701.572382071278, 5412.161115027177, 5573.108302671553, 5578.135389014709, 5582.441755824385, 5589.77640894376], "unit": "score", "name": "dojo.html", "value": 5270.531577656518}, {"lowerIsBetter": false, "replicates": [505.87858913860686, 520.8880090780483, 533.1043846338152, 535.7080391186804, 567.1577707104951, 36099.278014439726, 36728.63271367286, 37085.44371834425, 37109.257814843724, 37207.0, 40168.0, 40786.59213407865, 40818.38772418416, 40939.0, 40989.18021639565, 8491.915080849174, 8675.349348798834, 8699.347548933823, 8705.260052895512, 8729.214370706635, 8484.151584841527, 8486.830263394728, 8539.231469167773, 8730.912690873074, 8736.912630873705, 8674.65301387947, 8697.130286971316, 8747.212750852423, 8787.868181977276, 8800.647974081028, 8643.870341944845, 8672.046074931752, 8715.128487151298, 8723.694670686527, 8725.476471411705, 8578.485290882567, 8674.08922063187, 8675.132486751338, 8686.131386861327, 8699.52152631605, 40451.7977410114, 40550.986225344604, 40733.59266407328, 40841.0, 40882.182356353005, 2768.43247134337, 3133.7336326412283, 3201.3277211785553, 3241.5623890774677, 3335.5997280326515, 26780.464390712077, 26801.597976030374, 27007.32481687954, 27184.456310873673, 27747.0, 3847.1920896611746, 3878.612138786099, 3896.6687831534355, 3918.804059797027, 3936.409538569209, 171917.14041429837, 172285.0, 172308.0, 172694.0, 172827.13586432114, 52475.277225049926, 56842.71578642163, 56941.71529142328, 57211.0, 57355.0, 45868.0, 51207.7439612807, 51391.0, 51519.74240128775, 51662.0, 14690.265486725835, 15292.847071529364, 15303.387864485296, 15332.540023799304, 15350.155741434328, 11374.772504550028, 11485.425728713531, 11493.827592586118, 11502.597409090642, 11556.42217889119, 20229.49426264355, 20830.895845520674, 20896.37310880676, 20916.686249706265, 20925.0, 6444.516661250425, 6678.432333251728, 6691.698873550702, 6713.1944166700305, 6718.395344419026, 956.0, 971.2181693736469, 972.5234635028785, 1001.1940387987594, 1056.5668076088766, 28430.289242769097, 28576.0, 28653.283667908054, 28907.710922890503, 29188.708112919023, 914.2000749344323, 999.2256001598673, 1066.269605320358, 1091.7598128411737, 1100.9284396514201, 13400.798988015187, 14266.785998210034, 14333.498327558485, 14442.350094245785, 14490.782638260434, 323997.0, 324716.0, 325650.0, 325787.0, 326055.0, 43316.0, 43636.0, 43847.56152438435, 43976.78011609986, 44075.559244407785, 1302.3683513496137, 1321.808337791015, 1321.8744219299151, 1334.5462542735515, 1356.796480527909, 25638.487230255665, 26702.732972670026, 27871.721282787723, 28065.593380850485, 28417.14748557464, 42468.362974556025, 42595.0, 42836.35745463758, 42957.0, 42973.785131074146, 252559.0, 252892.0, 254360.0, 254535.0, 254710.0, 30953.380932380776, 31254.531182032744, 31296.843515783185, 31388.058358249287, 31745.5238171423, 36526.63473365339, 37072.443913341864, 37205.88382348534, 37378.06554836151, 37877.81061094677, 29046.0, 29417.411651767274, 29455.85272073626, 29471.0, 29479.55780663249, 28285.669016874057, 28609.71390286154, 28660.426791463637, 28810.855945720137, 30482.23794405069, 33715.15712107217, 34333.0, 34609.65390346165, 34619.48070778991, 34753.82623086868, 29627.40745185127, 31091.68908310888, 31496.0, 31775.841120794248, 31845.681543184273, 24479.877600612595, 25010.0, 26259.868700656374, 26450.338741531617, 26735.19794406171], "unit": "score", "name": "ext.html", "value": 17336.722977055404}, {"lowerIsBetter": false, "replicates": [345.4059018488201, 353.30751726615836, 359.1416514530273, 361.2071503050803, 361.79739345966277, 16500.917495412523, 16968.151592420378, 17442.215100320485, 17643.823561764377, 17939.73090403645, 10335.17318614511, 10616.363018218912, 15185.392584296615, 15208.087514749122, 15234.619134521643, 4887.071456423277, 4893.119238537062, 5002.7248501332415, 5016.824411145611, 5041.697498150104, 4990.950090499103, 5020.297158397827, 5027.371578552681, 5028.044671512419, 5028.094942910275, 4072.4705788247634, 4990.351254336932, 5004.274380214867, 5526.58550608706, 5526.917096243559, 5435.510804027636, 5446.891062178774, 5469.15228139639, 5487.862803429906, 5496.532794712434, 5130.127878260705, 5287.629865909388, 5335.33308336458, 5342.171963345649, 5358.866028349284, 20034.298799541946, 20241.493962650904, 20286.594268114703, 21064.789352106436, 21122.89438552813, 1959.3632069577445, 2128.1806504495726, 2152.397328747953, 2181.760006399295, 2183.6833659119497, 9977.35147215436, 10763.677089687322, 12073.215241009306, 12467.875321246762, 13562.186268823902, 1846.5937493751353, 1862.928815930845, 1888.4051523770106, 1893.4508992392189, 1914.8659593828438, 58156.41843581595, 59941.99999999956, 60855.0, 60973.0, 62367.68816155935, 10090.949545252373, 10274.486275686186, 10310.742231444274, 10399.94800025995, 10428.113610343054, 13642.522511712043, 13668.0, 13671.658208544866, 13677.589672309847, 13716.177029378268, 7698.0, 7707.807304817312, 7714.614269286625, 7740.187280335596, 7794.727184548514, 7451.813704657427, 7467.477276590586, 7476.887846682304, 7512.436567257478, 7519.323260906544, 4258.297380932174, 4310.89222769427, 4493.146302202636, 4500.302453119772, 4504.572065653758, 1832.8991905445328, 1854.5178253654146, 1866.8973206473775, 1881.8776779509287, 1897.117840204284, 421.1744979839549, 422.57742257742257, 437.55588078100755, 913.9451632902047, 1000.0, 10149.949250253701, 10515.684529464128, 10555.155587552978, 10637.680869573926, 10678.145748340114, 443.9622632076245, 445.8751549566127, 448.7487007275936, 459.1734877220989, 466.1771972468596, 5737.225474560964, 5775.855603609859, 5806.738696758656, 5837.94162058374, 5909.379515150933, 535520.0, 540158.0, 548425.0, 548433.0, 562012.0, 39946.0, 80667.59666201631, 81131.0, 83279.5836020816, 83691.5815420919, 1153.1697178031804, 1161.8083016302385, 1200.123909546019, 1225.0628269373935, 1239.4484454417698, 14444.85555144477, 15265.23673816327, 15472.226388680747, 15562.0, 15661.0, 31893.36213275768, 31936.840315798272, 32263.677363226067, 33207.667923320456, 33602.66397335995, 42231.577684222764, 42869.571304287805, 43214.78392608017, 44849.36565845634, 48192.5180748188, 9716.174125199437, 9813.607455701693, 9852.556634951301, 9999.450030248407, 10061.295709300279, 17377.21802518915, 17703.0, 17890.642187156445, 17964.10179490994, 17996.730049049012, 13565.59303220905, 13846.169229846242, 13934.442622294995, 14006.089604175697, 14700.191489468181, 9945.801083978135, 13785.793213101611, 14080.577582672537, 14384.928075359556, 14932.62668433298, 14457.927710361802, 14493.78259326132, 15058.849411506182, 15199.164045977577, 15350.769738454155, 8641.95679021626, 9082.63669453241, 9122.7263182102, 9466.0, 9583.664571739955, 13504.662383440493, 13784.862151378358, 13966.650833729238, 14220.217888015844, 14237.928810356296], "unit": "score", "name": "jquery.html", "value": 8330.339252793778}, {"lowerIsBetter": false, "replicates": [1410.4005797536047, 1473.0, 1622.1402656592004, 1762.436020473449, 1782.1356642028613, 7431.62841857907, 7508.2867127622785, 7609.315161635444, 7639.9618001909985, 7692.346150577194, 7622.3139917407425, 7645.350145237661, 7723.884141737878, 7734.226577342263, 7755.728549500768, 2252.40311317501, 2295.678604995302, 2295.701558797354, 2296.1504243429954, 2299.1722979727283, 2242.159190303636, 2286.817054635625, 2291.106468477295, 2292.083166733303, 2301.8618882867, 2195.714557107574, 2238.1942500699815, 2264.8074913632363, 2269.1944359752297, 2270.8523945943543, 2261.3216035189375, 2290.1640901071073, 2299.367673889685, 2329.545738580986, 2330.5804955108074, 2269.954600907989, 2283.0525331987205, 2283.9771602284095, 2284.4060544258446, 2296.816254699637, 7456.40348772097, 7541.886871696929, 7547.05661792276, 7581.848363032764, 7585.544867307924, 4513.187626227278, 4564.132814765184, 4585.72485650862, 4586.3808385867815, 4588.105319462706, 2935.0754512328763, 2940.1473572663904, 3018.1247438242885, 3021.6827233140425, 3037.665856755755, 976.7411635916487, 982.3761911186376, 1009.3540134314045, 1009.5658866687321, 1020.6937918624383, 10310.0, 10321.690349289533, 10355.17158627308, 10419.218558608134, 10430.582776689, 4024.5774193709826, 4076.8165432555606, 4092.5498195198506, 4107.794610269475, 4134.400511925754, 8484.36367272457, 8511.148885111439, 8553.871691924502, 8557.871631925525, 8571.185737354941, 4552.226121559343, 4565.497795242521, 4579.4046773919845, 4586.839460618862, 4619.815207391734, 4207.347861081476, 4214.7471151731, 4220.261454245495, 4226.746395216297, 4235.0682849773, 3300.6369299377047, 3334.449815780418, 3352.0446672698163, 3358.328334333094, 3364.0748794081333, 1055.5619417941623, 1071.4000159910474, 1083.4311986207147, 1086.8695756509112, 1093.8031154392127, 1015.096564057989, 1025.3335332034237, 1062.6227689170387, 1154.653603918821, 1316.4734106357535, 6792.354726300993, 6855.6572171391235, 6859.897101543481, 6889.069975553336, 6896.2069362023, 1100.7138144082596, 1121.6130434999911, 1129.971750706239, 1142.2404101272728, 1171.1216587559331, 5259.526642602108, 5261.263423120766, 5264.947350526522, 5268.2361057647195, 5295.470452954673, 8675.349348798865, 8820.8676869847, 8942.239909607757, 8943.821123577492, 9017.233535149455, 8828.38201325901, 8871.201591856763, 8871.866921996176, 8888.60001299943, 8956.149165829236, 7031.859362812817, 7091.96454017737, 7136.3220494052985, 7142.607156606437, 7254.782356529313, 7071.292870712888, 7106.644667766487, 7168.139823221247, 7175.784726458214, 7188.4968052235845, 8039.316658083894, 8163.306118979954, 8180.9590952044855, 8339.83320333602, 8361.707340243061, 8304.501729896225, 8479.109693482096, 8482.448640838325, 8497.277731392654, 8512.53181075022, 6580.276169621434, 6663.733450662113, 6827.146606674166, 6834.8633027340165, 6839.829004274933, 6932.48006399512, 6958.06066181059, 6976.02335672996, 6976.61628610411, 6989.650517474208, 6688.0, 6777.0, 6778.93221067783, 6824.317568243136, 6864.21061577925, 6185.8144255672405, 6242.875142497034, 6659.600423974577, 6683.365080317362, 6800.6599670017295, 6786.558873673195, 6811.89782153278, 6825.283345248876, 6846.110005699227, 6848.383645471931, 6274.623522588659, 6315.96842015787, 6352.174217351715, 6357.841053973502, 6367.299597044414, 6287.748490060347, 6334.968325158529, 6335.239771227482, 6337.493000560036, 6368.395002474757], "unit": "score", "name": "mootools.html", "value": 4364.797435978867}, {"lowerIsBetter": false, "replicates": [338.6292010248778, 344.8603315657158, 346.24691296430257, 350.05834305717605, 354.65244060820396, 6230.0, 6248.750049997994, 6249.843753906161, 6298.181236439268, 6360.204974378203, 6125.203723515948, 6138.600990935586, 6202.4417802397775, 6239.500839932806, 6261.060840873871, 4775.0, 4779.450363208241, 4787.61699064074, 4790.041991601676, 4793.304970779235, 4790.13777520048, 4792.305115758213, 4795.304680821278, 4799.976000119995, 4804.327394164819, 4665.253559430492, 4736.90526189476, 4737.242041273397, 4738.455077666078, 4745.76271186441, 4696.647751418657, 4716.174669432869, 4720.575148236675, 4727.739974301412, 4728.148933192024, 4104.979475102636, 4106.856260030914, 4110.136871257039, 4120.896977575585, 4120.958790412087, 5925.792597259118, 5927.733252003627, 5931.940680593182, 5932.703364831785, 5937.050071988504, 5379.623426360156, 5499.862503437406, 5512.641678290898, 5522.337319521643, 5528.502434780889, 6613.074169616258, 6613.338666133396, 6623.138991931018, 6624.304448032935, 6631.0053491976105, 4525.298578720271, 4528.456585209796, 4530.161920044769, 4530.546945305443, 4534.251848445036, 6736.932630673679, 6819.079424277708, 6851.657417129173, 6856.142982127234, 6867.141607299038, 4632.351470794091, 4638.165130276582, 4645.5354464553275, 4647.721136731807, 4648.512476007645, 4702.811887524529, 4707.7881495332795, 4710.411198600175, 4714.669973101919, 4715.316279139505, 5432.02223599748, 5438.129899216186, 5443.265159203536, 5446.128619420873, 5454.563634909197, 6383.489320854414, 6489.253735820346, 6519.185101862267, 6601.6699165041555, 6605.471562275006, 1613.0, 1629.4378439438374, 1636.9263383147786, 1641.8768592355382, 1658.9834101659071, 1101.9283746556448, 1106.1980064453207, 1118.9384583847966, 1123.8763735989035, 1130.9708165569293, 6063.727132279058, 6083.695815209222, 6095.908561371494, 6101.420365065312, 6112.419320164578, 6707.798766037026, 6716.0, 6718.0, 6723.0, 6723.596584204964, 5950.345461999176, 6028.728707208186, 6040.063790112539, 6065.696715164224, 6078.6048906820915, 3618.1859081706407, 3644.3986742187244, 3650.671439570451, 3656.8171591420323, 3664.7801131931637, 7010.92989070113, 7014.298570143047, 7023.367896889305, 7031.859362812817, 7040.859182816315, 6789.388954994074, 6876.381125698711, 6900.3099690031595, 6933.410660093848, 6955.200151982587, 6905.1713794345, 6975.4070903972715, 6997.230304666483, 7005.754798582026, 7024.859502810017, 6610.305917878553, 6660.83435398813, 6669.566478178903, 6672.065910772399, 6683.732650694113, 6462.418382345423, 6647.0, 6650.235222949229, 6655.035019922181, 6660.067590537232, 6929.89605155913, 7019.964900175466, 7027.8945815811785, 7035.401990830836, 7036.0, 4598.3102534620075, 4602.148602508547, 4607.170709272363, 4614.2617181250835, 4618.51505591908, 6701.798946031627, 6738.427233684995, 6741.966290168518, 6742.6291553965, 6887.552309099892, 6609.867802644017, 6660.0675905374255, 6672.866542669022, 6682.933170668425, 6689.163854518185, 6623.834404139935, 6648.700808463534, 6655.667216639052, 6663.067170596218, 6689.130413046273, 6340.651264180515, 6459.321771213955, 6484.481241500763, 6513.54405191632, 6515.869682606227, 6686.665666716547, 6688.799336019927, 6694.564853284521, 6695.12963314766, 6695.531312808057, 6482.611043337415, 6514.9348506514325, 6519.478441724746, 6538.1500404947055, 6557.508186886098], "unit": "score", "name": "prototype.html", "value": 4946.027119039428}, {"lowerIsBetter": false, "replicates": [621.5990686007525, 663.2140913018073, 675.1493118670473, 710.7050574011786, 760.8021914302279, 13330.666733331671, 13627.727445451084, 13652.45390184394, 13684.863151368483, 13691.110077844933, 12035.939820300908, 12517.436715347809, 12520.436580353884, 12541.372931353419, 12567.434465449054, 679.2460368990417, 685.3112621815094, 810.129111205455, 825.9256666899978, 841.6380956188837, 833.791552111972, 836.5900708652778, 840.306746933782, 843.6667516331046, 847.0682249525535, 868.68727258187, 870.4342177584557, 871.7036207689384, 872.8865247517814, 874.1302404107921, 853.2363534636465, 858.8754630578532, 861.2937391339104, 867.6312567158964, 868.1969178509885, 628.6730899932055, 631.4348657951153, 638.4732595608641, 638.6264035539215, 642.2132887213173, 13722.725545489035, 13879.930600346934, 13887.4445022199, 13938.303084845818, 13939.721205575934, 11419.371934543597, 11919.523219071227, 12466.75066498665, 12793.104482686216, 12908.54820081302, 9870.654527091518, 10259.589616415335, 10299.639512617097, 10421.739456513573, 10495.370277783357, 3542.291541691646, 3606.1525541497726, 3614.4036234021355, 3668.101315177772, 3762.3415902217275, 44646.10707785826, 44695.32957005648, 44747.10505789866, 45535.77232113852, 47387.289190662515, 9127.543622818832, 9303.76740581491, 9333.066693330748, 9396.624135034523, 9713.805723885624, 17434.738478922573, 17444.0, 17552.561185970197, 17571.297148113932, 17577.384791532237, 7612.429067819936, 7704.460687751915, 7834.334081603013, 7861.213878612208, 8038.557879316577, 4412.294032954712, 4458.888527786831, 4480.708753930984, 4516.81932722694, 4559.065391594715, 2922.2986483243867, 2955.9704402956127, 2957.482440572891, 2964.8221106733663, 2964.9407011859644, 516.754541592748, 532.292051571409, 539.4551502982016, 543.2150542466178, 543.2584522127347, 502.8164719877292, 552.1055889459021, 617.450469082517, 651.6839332923528, 725.8024259970985, 9302.302327325478, 9307.72076837696, 9434.386764860263, 9571.521423928776, 9780.217582593517, 523.8742701751628, 557.4007941462944, 640.545212898847, 645.1258544671996, 658.9703463344161, 4017.457643218128, 4187.330027195695, 4280.464941882265, 4306.397104405386, 4317.786725703171, 54338.0, 56464.0, 56559.43440565624, 56572.0, 56740.71629641908, 49713.0, 50585.0, 50860.89669239641, 50900.0, 51112.48887511077, 46346.0, 46427.30359044617, 46480.3027954581, 46519.99999999932, 47040.0, 8372.916270837213, 8512.53181075022, 8665.610047548002, 8755.562221889008, 8911.37620366568, 34660.65339346574, 35950.92147235587, 36040.0, 36062.819685901406, 36213.818930905174, 44390.0, 45248.77375613232, 45452.545474546154, 45581.316280256484, 46189.76905115453, 11101.666949991513, 11338.546458141913, 11490.54037838477, 11604.88395116038, 11733.178677492493, 12531.0, 12834.358282085672, 12894.871051289367, 12898.742025159256, 12927.095103342675, 11857.407129643656, 11858.703532411759, 11962.222455540363, 12105.81841272364, 12248.510059597516, 10025.947275535964, 10350.016748408889, 10357.223208259562, 10557.63489840564, 10601.257911946399, 11510.13673974472, 11593.362365070003, 11608.88391116078, 11970.46132924038, 11973.76052478963, 9643.517824108627, 9933.900660993297, 9968.352057116264, 10009.24930630191, 10337.638182663572, 8914.37599368038, 9025.954870225607, 9146.451212927246, 9278.675246366345, 9764.365316254705], "unit": "score", "name": "yui.html", "value": 6274.3543145979465}], "name": "dromaeo_css", "value": 6847.80765164127}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 111.0, 110.0, 112.0, 123.0, 111.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [161.0, 126.0, 147.0, 182.0, 129.0, 154.0, 154.0, 128.0, 163.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 162.0, 165.0, 160.0, 165.0, 171.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 71.0, 72.0, 135.0, 74.0, 72.0, 73.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 141.0, 98.0, 96.0, 98.0, 140.0, 97.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 149.0, 147.0, 148.0, 146.0, 148.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 61.0, 59.0, 59.0, 59.0, 60.0, 61.0, 56.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 88.0, 86.0, 88.0, 87.0, 87.0, 86.0, 87.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [125.0, 119.0, 144.0, 137.0, 120.0, 119.0, 121.0, 135.0, 122.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [145.0, 160.0, 153.0, 146.0, 151.0, 152.0, 150.0, 141.0, 153.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 67.0, 69.0, 68.0, 73.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1525.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [189.89745537409797], "unit": "score", "name": "DeltaBlue", "value": 348.1773879999999}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [25125.0], "unit": "score", "name": "RegExp", "value": 36.25810945273629}, {"lowerIsBetter": false, "replicates": [577.3672055427252], "unit": "score", "name": "Splay", "value": 141.14241199999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21435.227071842448}]} 06:08:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21435.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1525.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6847.81"}}} 06:08:38 INFO - Return code: 0 06:08:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:08:38 INFO - # TBPL SUCCESS # 06:08:38 INFO - Running post-action listener: _resource_record_post_action 06:08:38 INFO - Running post-run listener: _resource_record_post_run 06:08:40 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 24576; Write bytes: 553156608; Read time: 40; Write time: 591496 06:08:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234680320; Read time: 0; Write time: 317724 06:08:40 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 24576; Write bytes: 317607936; Read time: 40; Write time: 273636 06:08:40 INFO - Running post-run listener: _upload_blobber_files 06:08:40 INFO - Blob upload gear active. 06:08:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:08:40 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 06:08:40 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'] 06:08:40 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 06:08:40 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:41 INFO - (blobuploader) - INFO - Done attempting. 06:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:42 INFO - (blobuploader) - INFO - Done attempting. 06:08:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:42 INFO - Return code: 0 06:08:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:08:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/922b20c0759a14d35e6909f73952a2bdc6ae491d0eb5945c1621b838a540ad295fa5cc614c605c37454bf869e9476def5c3785c265db15ba9f5000a7fee9fe42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c50b331652f19f85b51e9b07e55e11ac660dbe6f9382d83be1b0620e82955117a6d9a6a18ecbe4a836d94d5e9aaf1c26c2ca40dad41f29a654ccde1170ae7e"} 06:08:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:08:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:08:42 INFO - Contents: 06:08:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/922b20c0759a14d35e6909f73952a2bdc6ae491d0eb5945c1621b838a540ad295fa5cc614c605c37454bf869e9476def5c3785c265db15ba9f5000a7fee9fe42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c50b331652f19f85b51e9b07e55e11ac660dbe6f9382d83be1b0620e82955117a6d9a6a18ecbe4a836d94d5e9aaf1c26c2ca40dad41f29a654ccde1170ae7e"} 06:08:42 INFO - Copying logs to upload dir... 06:08:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.631062 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-02 06:08:41.476111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:41.479991) ========= 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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 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/922b20c0759a14d35e6909f73952a2bdc6ae491d0eb5945c1621b838a540ad295fa5cc614c605c37454bf869e9476def5c3785c265db15ba9f5000a7fee9fe42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c50b331652f19f85b51e9b07e55e11ac660dbe6f9382d83be1b0620e82955117a6d9a6a18ecbe4a836d94d5e9aaf1c26c2ca40dad41f29a654ccde1170ae7e"} build_url:https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/CB1cX810SICAa1vd9VCpFg/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/922b20c0759a14d35e6909f73952a2bdc6ae491d0eb5945c1621b838a540ad295fa5cc614c605c37454bf869e9476def5c3785c265db15ba9f5000a7fee9fe42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c50b331652f19f85b51e9b07e55e11ac660dbe6f9382d83be1b0620e82955117a6d9a6a18ecbe4a836d94d5e9aaf1c26c2ca40dad41f29a654ccde1170ae7e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:41.505707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:41.506081) ========= 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=0cff312cb257a7829adc5a5d000001df-1451741803.110526-393334614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:08:41.591896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 06:08:41.592257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 06:08:41.592653) ========= ========= Total master_lag: 0.25 =========