builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1451746169.11 results: success (0) buildid: 20160102043001 builduid: b543deb103144a879f3f7ceb46b4d2c6 revision: 207a285fd90ef3666979bf1d59cbf66d74c5e3b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.106260) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.107037) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.107525) ========= 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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006334 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.144563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.145045) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.223820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.224122) ========= 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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004807 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.272938) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.273255) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.273657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.273949) ========= 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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-02 06:49:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.7M=0.001s 2016-01-02 06:49:30 (20.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.454065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.454366) ========= 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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:29.506138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-02 06:49:29.506679) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 207a285fd90ef3666979bf1d59cbf66d74c5e3b8 --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 207a285fd90ef3666979bf1d59cbf66d74c5e3b8 --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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-02 06:49:30,296 truncating revision to first 12 chars 2016-01-02 06:49:30,296 Setting DEBUG logging. 2016-01-02 06:49:30,296 attempt 1/10 2016-01-02 06:49:30,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/207a285fd90e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-02 06:49:31,346 unpacking tar archive at: mozilla-central-207a285fd90e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.330630 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-02 06:49:30.853668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:30.853989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:30.864333) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:30.864919) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 06:49:30.865634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2016-01-02 06:49:30.865932) ========= /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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:31 INFO - MultiFileLogger online at 20160102 06:49:31 in /builds/slave/test-pgo 06:49: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 06:49:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:49:31 INFO - {'append_to_log': False, 06:49:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:49:31 INFO - 'blob_upload_branch': 'Firefox', 06:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:49:31 INFO - 'branch': 'Firefox', 06:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:31 INFO - 'config_files': ('talos/linux_config.py',), 06:49:31 INFO - 'default_actions': ('clobber', 06:49:31 INFO - 'read-buildbot-config', 06:49:31 INFO - 'download-and-extract', 06:49:31 INFO - 'populate-webroot', 06:49:31 INFO - 'create-virtualenv', 06:49:31 INFO - 'install', 06:49:31 INFO - 'run-tests'), 06:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:31 INFO - 'download_minidump_stackwalk': True, 06:49:31 INFO - 'download_symbols': 'ondemand', 06:49:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:31 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:31 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:31 INFO - 'installer_path': 'installer.exe', 06:49:31 INFO - 'log_level': 'info', 06:49:31 INFO - 'log_name': 'talos', 06:49:31 INFO - 'log_to_console': True, 06:49:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:31 INFO - 'opt_config_files': (), 06:49:31 INFO - 'pip_index': False, 06:49:31 INFO - 'sps_profile': False, 06:49:31 INFO - 'sps_profile_interval': 0, 06:49:31 INFO - 'suite': 'dromaeojs-e10s', 06:49:31 INFO - 'system_bits': '32', 06:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:31 INFO - 'title': 'talos-linux64-ix-003', 06:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:31 INFO - 'use_talos_json': True, 06:49:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:31 INFO - 'work_dir': 'build'} 06:49:31 INFO - ##### 06:49:31 INFO - ##### Running clobber step. 06:49:31 INFO - ##### 06:49:31 INFO - Running pre-action listener: _resource_record_pre_action 06:49:31 INFO - Running main action method: clobber 06:49:31 INFO - rmtree: /builds/slave/test-pgo/build 06:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:49:32 INFO - Running post-action listener: _resource_record_post_action 06:49:32 INFO - ##### 06:49:32 INFO - ##### Running read-buildbot-config step. 06:49:32 INFO - ##### 06:49:32 INFO - Running pre-action listener: _resource_record_pre_action 06:49:32 INFO - Running main action method: read_buildbot_config 06:49:32 INFO - Using buildbot properties: 06:49:32 INFO - { 06:49:32 INFO - "project": "", 06:49:32 INFO - "product": "firefox", 06:49:32 INFO - "script_repo_revision": "production", 06:49:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:49:32 INFO - "repository": "", 06:49:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:49:32 INFO - "buildid": "20160102043001", 06:49:32 INFO - "pgo_build": "True", 06:49:32 INFO - "basedir": "/builds/slave/test-pgo", 06:49:32 INFO - "buildnumber": 283, 06:49:32 INFO - "slavename": "talos-linux64-ix-003", 06:49:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:49:32 INFO - "platform": "ubuntu64_hw", 06:49:32 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:49:32 INFO - "branch": "mozilla-central", 06:49:32 INFO - "repo_path": "mozilla-central", 06:49:32 INFO - "revision": "207a285fd90ef3666979bf1d59cbf66d74c5e3b8", 06:49:32 INFO - "stage_platform": "linux64-pgo", 06:49:32 INFO - "builduid": "b543deb103144a879f3f7ceb46b4d2c6", 06:49:32 INFO - "slavebuilddir": "test" 06:49:32 INFO - } 06:49:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:49:32 INFO - Running post-action listener: _resource_record_post_action 06:49:32 INFO - ##### 06:49:32 INFO - ##### Running download-and-extract step. 06:49:32 INFO - ##### 06:49:32 INFO - Running pre-action listener: _resource_record_pre_action 06:49:32 INFO - Running main action method: download_and_extract 06:49:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:49: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')]} 06:49:32 INFO - https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/test_packages.json 06:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/test_packages.json 06:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:49:37 INFO - Downloaded 1302 bytes. 06:49:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:49:37 INFO - Using the following test package requirements: 06:49:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:37 INFO - u'jsshell-linux-x86_64.zip'], 06:49:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:49:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:49:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:37 INFO - https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:43 INFO - Downloaded 23197903 bytes. 06:49: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 06:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49: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 06:49:44 INFO - Return code: 0 06:49:44 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 06:49: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')]} 06:49:44 INFO - https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:45 INFO - Downloaded 23197903 bytes. 06:49:45 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 06:49:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:45 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 06:49:47 INFO - Return code: 0 06:49:47 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')]} 06:49:47 INFO - https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:48 INFO - Downloaded 11132285 bytes. 06:49:48 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 06:49:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:48 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 06:49:48 INFO - Return code: 0 06:49:48 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')]} 06:49:48 INFO - https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnuutvNfQgSnDGCABRD5mQ/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 06:49:50 INFO - Downloaded 54986043 bytes. 06:49:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:50 INFO - mkdir: /builds/slave/test-pgo/properties 06:49:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:49:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:49:50 INFO - Contents: 06:49:50 INFO - build_url:https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:50 INFO - Running post-action listener: _resource_record_post_action 06:49:50 INFO - Running post-action listener: set_extra_try_arguments 06:49:50 INFO - ##### 06:49:50 INFO - ##### Running populate-webroot step. 06:49:50 INFO - ##### 06:49:50 INFO - Running pre-action listener: _resource_record_pre_action 06:49:50 INFO - Running main action method: populate_webroot 06:49:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:50 INFO - '--tppagecycles', 06:49:50 INFO - '7'], 06:49:50 INFO - 'tests': ['tsvgm']}}, 06:49:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:49:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'tests': ['damp', 'tps']}, 06:49:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['damp', 'tps']}, 06:49:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:49:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:50 INFO - 'other': {'tests': ['a11yr', 06:49:50 INFO - 'ts_paint', 06:49:50 INFO - 'tpaint', 06:49:50 INFO - 'sessionrestore', 06:49:50 INFO - 'sessionrestore_no_auto_restore']}, 06:49:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['a11yr', 06:49:50 INFO - 'ts_paint', 06:49:50 INFO - 'tpaint', 06:49:50 INFO - 'sessionrestore', 06:49:50 INFO - 'sessionrestore_no_auto_restore']}, 06:49:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['a11yr', 06:49:50 INFO - 'ts_paint', 06:49:50 INFO - 'tpaint', 06:49:50 INFO - 'sessionrestore', 06:49:50 INFO - 'sessionrestore_no_auto_restore']}, 06:49:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['a11yr', 06:49:50 INFO - 'ts_paint', 06:49:50 INFO - 'tpaint', 06:49:50 INFO - 'sessionrestore', 06:49:50 INFO - 'sessionrestore_no_auto_restore']}, 06:49:50 INFO - 'other_l64': {'tests': ['a11yr', 06:49:50 INFO - 'ts_paint', 06:49:50 INFO - 'tpaint', 06:49:50 INFO - 'sessionrestore', 06:49:50 INFO - 'sessionrestore_no_auto_restore']}, 06:49:50 INFO - 'other_nol64': {'tests': ['a11yr', 06:49:50 INFO - 'ts_paint', 06:49:50 INFO - 'tpaint', 06:49:50 INFO - 'sessionrestore', 06:49:50 INFO - 'sessionrestore_no_auto_restore']}, 06:49:50 INFO - 'svgr': {'tests': ['tsvgx', 06:49:50 INFO - 'tsvgr_opacity', 06:49:50 INFO - 'tart', 06:49:50 INFO - 'tscrollx', 06:49:50 INFO - 'cart']}, 06:49:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['tsvgx', 06:49:50 INFO - 'tsvgr_opacity', 06:49:50 INFO - 'tart', 06:49:50 INFO - 'tscrollx', 06:49:50 INFO - 'cart']}, 06:49:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'tests': ['tp5o']}, 06:49:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'talos_options': ['--e10s'], 06:49:50 INFO - 'tests': ['tp5o']}, 06:49:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'talos_options': ['--xperf_path', 06:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:50 INFO - 'tests': ['tp5n']}, 06:49:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:50 INFO - 'talos_options': ['--e10s', 06:49:50 INFO - '--xperf_path', 06:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:50 INFO - 'tests': ['tp5n']}}, 06:49:50 INFO - 'talos.zip': {'path': '', 06:49:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:50 INFO - Running post-action listener: _resource_record_post_action 06:49:50 INFO - ##### 06:49:50 INFO - ##### Running create-virtualenv step. 06:49:50 INFO - ##### 06:49:50 INFO - Running pre-action listener: _resource_record_pre_action 06:49:50 INFO - Running main action method: create_virtualenv 06:49:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:49:50 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 06:49:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:49:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:50 INFO - Using real prefix '/usr' 06:49:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:49:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:52 INFO - Installing pip.................done. 06:49:52 INFO - Return code: 0 06:49:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:49: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')]} 06:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:49: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:49: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 pip>=1.5 06:49:52 INFO - Using env: {'DISPLAY': ':0', 06:49:52 INFO - 'HOME': '/home/cltbld', 06:49:52 INFO - 'LANG': 'en_US.UTF-8', 06:49:52 INFO - 'LANGUAGE': 'en_US:en', 06:49:52 INFO - 'LOGNAME': 'cltbld', 06:49:52 INFO - 'MAIL': '/var/mail/cltbld', 06:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:52 INFO - 'MOZ_NO_REMOTE': '1', 06:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:52 INFO - 'NO_EM_RESTART': '1', 06:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:52 INFO - 'SHELL': '/bin/bash', 06:49:52 INFO - 'SHLVL': '1', 06:49:52 INFO - 'TERM': 'linux', 06:49:52 INFO - 'TMOUT': '86400', 06:49:52 INFO - 'USER': 'cltbld', 06:49:52 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:52 INFO - '_': '/tools/buildbot/bin/python'} 06:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:53 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 06:49:53 INFO - Cleaning up... 06:49:53 INFO - Return code: 0 06:49:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:49:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:49:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:49:53 INFO - Using env: {'DISPLAY': ':0', 06:49:53 INFO - 'HOME': '/home/cltbld', 06:49:53 INFO - 'LANG': 'en_US.UTF-8', 06:49:53 INFO - 'LANGUAGE': 'en_US:en', 06:49:53 INFO - 'LOGNAME': 'cltbld', 06:49:53 INFO - 'MAIL': '/var/mail/cltbld', 06:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:53 INFO - 'MOZ_NO_REMOTE': '1', 06:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:53 INFO - 'NO_EM_RESTART': '1', 06:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:53 INFO - 'SHELL': '/bin/bash', 06:49:53 INFO - 'SHLVL': '1', 06:49:53 INFO - 'TERM': 'linux', 06:49:53 INFO - 'TMOUT': '86400', 06:49:53 INFO - 'USER': 'cltbld', 06:49:53 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:53 INFO - '_': '/tools/buildbot/bin/python'} 06:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:53 INFO - Downloading/unpacking psutil>=0.7.1 06:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:49:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:55 INFO - Installing collected packages: psutil 06:49:55 INFO - Running setup.py install for psutil 06:49:55 INFO - building 'psutil._psutil_linux' extension 06:49:55 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 06:49:55 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 06:49:55 INFO - building 'psutil._psutil_posix' extension 06:49:55 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 06:49:55 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 06:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:55 INFO - Successfully installed psutil 06:49:55 INFO - Cleaning up... 06:49:55 INFO - Return code: 0 06:49:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:49:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:49:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:49:55 INFO - Using env: {'DISPLAY': ':0', 06:49:55 INFO - 'HOME': '/home/cltbld', 06:49:55 INFO - 'LANG': 'en_US.UTF-8', 06:49:55 INFO - 'LANGUAGE': 'en_US:en', 06:49:55 INFO - 'LOGNAME': 'cltbld', 06:49:55 INFO - 'MAIL': '/var/mail/cltbld', 06:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:55 INFO - 'MOZ_NO_REMOTE': '1', 06:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:55 INFO - 'NO_EM_RESTART': '1', 06:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:55 INFO - 'SHELL': '/bin/bash', 06:49:55 INFO - 'SHLVL': '1', 06:49:55 INFO - 'TERM': 'linux', 06:49:55 INFO - 'TMOUT': '86400', 06:49:55 INFO - 'USER': 'cltbld', 06:49:55 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:55 INFO - '_': '/tools/buildbot/bin/python'} 06:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:49:57 INFO - Installing collected packages: mozsystemmonitor 06:49:57 INFO - Running setup.py install for mozsystemmonitor 06:49:57 INFO - Successfully installed mozsystemmonitor 06:49:57 INFO - Cleaning up... 06:49:57 INFO - Return code: 0 06:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:49: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')]} 06:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:49:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:49:57 INFO - Using env: {'DISPLAY': ':0', 06:49:57 INFO - 'HOME': '/home/cltbld', 06:49:57 INFO - 'LANG': 'en_US.UTF-8', 06:49:57 INFO - 'LANGUAGE': 'en_US:en', 06:49:57 INFO - 'LOGNAME': 'cltbld', 06:49:57 INFO - 'MAIL': '/var/mail/cltbld', 06:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:57 INFO - 'MOZ_NO_REMOTE': '1', 06:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:57 INFO - 'NO_EM_RESTART': '1', 06:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:57 INFO - 'SHELL': '/bin/bash', 06:49:57 INFO - 'SHLVL': '1', 06:49:57 INFO - 'TERM': 'linux', 06:49:57 INFO - 'TMOUT': '86400', 06:49:57 INFO - 'USER': 'cltbld', 06:49:57 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:57 INFO - '_': '/tools/buildbot/bin/python'} 06:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 INFO - Downloading docopt-0.6.1.tar.gz 06:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:00 INFO - Running setup.py install for blobuploader 06:50:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:50:00 INFO - Running setup.py install for requests 06:50:00 INFO - Running setup.py install for docopt 06:50:00 INFO - Successfully installed blobuploader requests docopt 06:50:00 INFO - Cleaning up... 06:50:00 INFO - Return code: 0 06:50:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:50:00 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 06:50:00 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 06:50:00 INFO - Using env: {'DISPLAY': ':0', 06:50:00 INFO - 'HOME': '/home/cltbld', 06:50:00 INFO - 'LANG': 'en_US.UTF-8', 06:50:00 INFO - 'LANGUAGE': 'en_US:en', 06:50:00 INFO - 'LOGNAME': 'cltbld', 06:50:00 INFO - 'MAIL': '/var/mail/cltbld', 06:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:00 INFO - 'MOZ_NO_REMOTE': '1', 06:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:00 INFO - 'NO_EM_RESTART': '1', 06:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:00 INFO - 'SHELL': '/bin/bash', 06:50:00 INFO - 'SHLVL': '1', 06:50:00 INFO - 'TERM': 'linux', 06:50:00 INFO - 'TMOUT': '86400', 06:50:00 INFO - 'USER': 'cltbld', 06:50:00 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:00 INFO - '_': '/tools/buildbot/bin/python'} 06:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:01 INFO - Running setup.py (path:/tmp/pip-hlmRB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:01 INFO - Running setup.py (path:/tmp/pip-Zx4ScU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:01 INFO - Running setup.py (path:/tmp/pip-kJVlNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:01 INFO - Running setup.py (path:/tmp/pip-2lBOcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:01 INFO - Running setup.py (path:/tmp/pip-LkSwin-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:01 INFO - Running setup.py (path:/tmp/pip-qRNKvU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:01 INFO - Running setup.py (path:/tmp/pip-Z_RWYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:01 INFO - Running setup.py (path:/tmp/pip-tOx1WF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:01 INFO - Running setup.py (path:/tmp/pip-kk3Sot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:01 INFO - Running setup.py (path:/tmp/pip-H1rKzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:01 INFO - Running setup.py (path:/tmp/pip-FDWSts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:01 INFO - Running setup.py (path:/tmp/pip-SQIv_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:02 INFO - Running setup.py (path:/tmp/pip-uj2aY8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:02 INFO - Running setup.py (path:/tmp/pip-0giEBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:02 INFO - Running setup.py (path:/tmp/pip-PsyKYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:02 INFO - Running setup.py (path:/tmp/pip-50k2Uo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:02 INFO - Running setup.py (path:/tmp/pip-n7xR8e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:02 INFO - Running setup.py install for manifestparser 06:50:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:50:02 INFO - Running setup.py install for mozcrash 06:50:02 INFO - Running setup.py install for mozdebug 06:50:02 INFO - Running setup.py install for mozdevice 06:50:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:50:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:50:02 INFO - Running setup.py install for mozfile 06:50:02 INFO - Running setup.py install for mozhttpd 06:50:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Running setup.py install for mozinfo 06:50:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Running setup.py install for mozInstall 06:50:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Running setup.py install for mozleak 06:50:03 INFO - Running setup.py install for mozlog 06:50:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Running setup.py install for moznetwork 06:50:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Running setup.py install for mozprocess 06:50:03 INFO - Running setup.py install for mozprofile 06:50:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Running setup.py install for mozrunner 06:50:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:50:03 INFO - Running setup.py install for mozscreenshot 06:50:03 INFO - Running setup.py install for moztest 06:50:04 INFO - Running setup.py install for mozversion 06:50:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:04 INFO - Cleaning up... 06:50:04 INFO - Return code: 0 06:50:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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/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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:50: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/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 06:50: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/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 06:50:04 INFO - Using env: {'DISPLAY': ':0', 06:50:04 INFO - 'HOME': '/home/cltbld', 06:50:04 INFO - 'LANG': 'en_US.UTF-8', 06:50:04 INFO - 'LANGUAGE': 'en_US:en', 06:50:04 INFO - 'LOGNAME': 'cltbld', 06:50:04 INFO - 'MAIL': '/var/mail/cltbld', 06:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:04 INFO - 'MOZ_NO_REMOTE': '1', 06:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:04 INFO - 'NO_EM_RESTART': '1', 06:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:04 INFO - 'SHELL': '/bin/bash', 06:50:04 INFO - 'SHLVL': '1', 06:50:04 INFO - 'TERM': 'linux', 06:50:04 INFO - 'TMOUT': '86400', 06:50:04 INFO - 'USER': 'cltbld', 06:50:04 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:04 INFO - '_': '/tools/buildbot/bin/python'} 06:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:04 INFO - Running setup.py (path:/tmp/pip-fJpsaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:04 INFO - Running setup.py (path:/tmp/pip-wi2cVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:04 INFO - Running setup.py (path:/tmp/pip-zcuOIh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:04 INFO - Running setup.py (path:/tmp/pip-nvNMoC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:04 INFO - Running setup.py (path:/tmp/pip-kFXTuA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:04 INFO - Running setup.py (path:/tmp/pip-acpA3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:04 INFO - Running setup.py (path:/tmp/pip-gBAHFZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:04 INFO - Running setup.py (path:/tmp/pip-QHK8DL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:04 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)) 06:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:04 INFO - Running setup.py (path:/tmp/pip-4J2Eet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:05 INFO - Running setup.py (path:/tmp/pip-flE96I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:05 INFO - Running setup.py (path:/tmp/pip-nBO51z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:05 INFO - Running setup.py (path:/tmp/pip-4_V7T3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:05 INFO - Running setup.py (path:/tmp/pip-EdNrmv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:05 INFO - Running setup.py (path:/tmp/pip-8qV7TK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:05 INFO - Running setup.py (path:/tmp/pip-2ohm6d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:05 INFO - Running setup.py (path:/tmp/pip-QKb0rN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:05 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)) 06:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:05 INFO - Running setup.py (path:/tmp/pip-l2wrIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:05 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)) 06:50:05 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)) 06:50:05 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)) 06:50:05 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)) 06:50:05 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)) 06:50:05 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)) 06:50:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:07 INFO - Downloading blessings-1.5.1.tar.gz 06:50:07 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 06:50:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:07 INFO - Installing collected packages: blessings 06:50:07 INFO - Running setup.py install for blessings 06:50:07 INFO - Successfully installed blessings 06:50:07 INFO - Cleaning up... 06:50:07 INFO - Return code: 0 06:50:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:50:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:07 INFO - Reading from file tmpfile_stdout 06:50:07 INFO - Current package versions: 06:50:07 INFO - argparse == 1.2.1 06:50:07 INFO - blessings == 1.5.1 06:50:07 INFO - blobuploader == 1.2.4 06:50:07 INFO - docopt == 0.6.1 06:50:07 INFO - manifestparser == 1.1 06:50:07 INFO - mozInstall == 1.12 06:50:07 INFO - mozcrash == 0.16 06:50:07 INFO - mozdebug == 0.1 06:50:07 INFO - mozdevice == 0.47 06:50:07 INFO - mozfile == 1.2 06:50:07 INFO - mozhttpd == 0.7 06:50:07 INFO - mozinfo == 0.9 06:50:07 INFO - mozleak == 0.1 06:50:07 INFO - mozlog == 3.1 06:50:07 INFO - moznetwork == 0.27 06:50:07 INFO - mozprocess == 0.22 06:50:07 INFO - mozprofile == 0.28 06:50:07 INFO - mozrunner == 6.11 06:50:07 INFO - mozscreenshot == 0.1 06:50:07 INFO - mozsystemmonitor == 0.0 06:50:07 INFO - moztest == 0.7 06:50:07 INFO - mozversion == 1.4 06:50:07 INFO - psutil == 3.1.1 06:50:07 INFO - requests == 1.2.3 06:50:07 INFO - wsgiref == 0.1.2 06:50:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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', '-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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:50:07 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 06:50:07 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 06:50:07 INFO - Using env: {'DISPLAY': ':0', 06:50:07 INFO - 'HOME': '/home/cltbld', 06:50:07 INFO - 'LANG': 'en_US.UTF-8', 06:50:07 INFO - 'LANGUAGE': 'en_US:en', 06:50:07 INFO - 'LOGNAME': 'cltbld', 06:50:07 INFO - 'MAIL': '/var/mail/cltbld', 06:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:07 INFO - 'MOZ_NO_REMOTE': '1', 06:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:07 INFO - 'NO_EM_RESTART': '1', 06:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:07 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:07 INFO - 'SHELL': '/bin/bash', 06:50:07 INFO - 'SHLVL': '1', 06:50:07 INFO - 'TERM': 'linux', 06:50:07 INFO - 'TMOUT': '86400', 06:50:07 INFO - 'USER': 'cltbld', 06:50:07 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:07 INFO - '_': '/tools/buildbot/bin/python'} 06:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 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)) 06:50:07 INFO - Cleaning up... 06:50:08 INFO - Return code: 0 06:50:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:50:08 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')]} 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 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')]} 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:50:08 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 06:50:08 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 06:50:08 INFO - Using env: {'DISPLAY': ':0', 06:50:08 INFO - 'HOME': '/home/cltbld', 06:50:08 INFO - 'LANG': 'en_US.UTF-8', 06:50:08 INFO - 'LANGUAGE': 'en_US:en', 06:50:08 INFO - 'LOGNAME': 'cltbld', 06:50:08 INFO - 'MAIL': '/var/mail/cltbld', 06:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:08 INFO - 'MOZ_NO_REMOTE': '1', 06:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:08 INFO - 'NO_EM_RESTART': '1', 06:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:08 INFO - 'SHELL': '/bin/bash', 06:50:08 INFO - 'SHLVL': '1', 06:50:08 INFO - 'TERM': 'linux', 06:50:08 INFO - 'TMOUT': '86400', 06:50:08 INFO - 'USER': 'cltbld', 06:50:08 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:08 INFO - '_': '/tools/buildbot/bin/python'} 06:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:08 INFO - Downloading/unpacking jsonschema 06:50:08 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 06:50:08 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 06:50:08 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 06:50:08 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 06:50:08 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 06:50:08 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 06:50:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:09 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 06:50:09 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:10 INFO - warning: no files found matching '*.txt' 06:50:10 INFO - no previously-included directories found matching 'build' 06:50:10 INFO - no previously-included directories found matching 'dist' 06:50:10 INFO - no previously-included directories found matching '.git*' 06:50:10 INFO - Installing collected packages: jsonschema, functools32 06:50:10 INFO - Running setup.py install for functools32 06:50:10 INFO - warning: no files found matching '*.txt' 06:50:10 INFO - no previously-included directories found matching 'build' 06:50:10 INFO - no previously-included directories found matching 'dist' 06:50:10 INFO - no previously-included directories found matching '.git*' 06:50:10 INFO - Successfully installed jsonschema functools32 06:50:10 INFO - Cleaning up... 06:50:10 INFO - Return code: 0 06:50:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f79afeaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, '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': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', '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 06:50:10 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 06:50:10 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 06:50:10 INFO - Using env: {'DISPLAY': ':0', 06:50:10 INFO - 'HOME': '/home/cltbld', 06:50:10 INFO - 'LANG': 'en_US.UTF-8', 06:50:10 INFO - 'LANGUAGE': 'en_US:en', 06:50:10 INFO - 'LOGNAME': 'cltbld', 06:50:10 INFO - 'MAIL': '/var/mail/cltbld', 06:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:10 INFO - 'MOZ_NO_REMOTE': '1', 06:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:10 INFO - 'NO_EM_RESTART': '1', 06:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:10 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:10 INFO - 'SHELL': '/bin/bash', 06:50:10 INFO - 'SHLVL': '1', 06:50:10 INFO - 'TERM': 'linux', 06:50:10 INFO - 'TMOUT': '86400', 06:50:10 INFO - 'USER': 'cltbld', 06:50:10 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:10 INFO - '_': '/tools/buildbot/bin/python'} 06:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:10 INFO - Downloading/unpacking flake8 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:10 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 06:50:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:12 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 06:50:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:12 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 06:50:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 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 06:50:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:50:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:12 INFO - no previously-included directories found matching 'docs/_build' 06:50:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:13 INFO - Running setup.py install for pep8 06:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:13 INFO - no previously-included directories found matching 'docs/_build' 06:50:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:50:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:13 INFO - Cleaning up... 06:50:13 INFO - Return code: 0 06:50:13 INFO - Running post-action listener: _resource_record_post_action 06:50:13 INFO - Running post-action listener: _start_resource_monitoring 06:50:13 INFO - Starting resource monitoring. 06:50:13 INFO - ##### 06:50:13 INFO - ##### Running install step. 06:50:13 INFO - ##### 06:50:13 INFO - Running pre-action listener: _resource_record_pre_action 06:50:13 INFO - Running main action method: install 06:50:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:13 INFO - Reading from file tmpfile_stdout 06:50:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:50:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:50:13 INFO - Reading from file tmpfile_stdout 06:50:13 INFO - Output received: 06:50:13 INFO - Usage: mozinstall [options] installer 06:50:13 INFO - Options: 06:50:13 INFO - -h, --help show this help message and exit 06:50:13 INFO - -d DEST, --destination=DEST 06:50:13 INFO - Directory to install application into. [default: 06:50:13 INFO - "/builds/slave/test-pgo"] 06:50:13 INFO - --app=APP Application being installed. [default: firefox] 06:50:13 INFO - mkdir: /builds/slave/test-pgo/build/application 06:50:13 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'] 06:50:13 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 06:50:29 INFO - Reading from file tmpfile_stdout 06:50:29 INFO - Output received: 06:50:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:50:29 INFO - Running post-action listener: _resource_record_post_action 06:50:29 INFO - ##### 06:50:29 INFO - ##### Running run-tests step. 06:50:29 INFO - ##### 06:50:29 INFO - Running pre-action listener: _resource_record_pre_action 06:50:29 INFO - Running main action method: run_tests 06:50:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:50:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:50:29 INFO - Python 2.7.3 06:50:29 INFO - Return code: 0 06:50:29 INFO - grabbing minidump binary from tooltool 06:50:29 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')]} 06:50:29 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 0x2b5f840>, '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 0x2acc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2accb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:50:29 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 06:50:29 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 06:50:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:29 INFO - Return code: 0 06:50:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:50:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:50:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:50:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:50:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:50:30 INFO - Return code: 0 06:50:30 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/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:50:30 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/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 06:50:30 INFO - Using env: {'DISPLAY': ':0', 06:50:30 INFO - 'HOME': '/home/cltbld', 06:50:30 INFO - 'LANG': 'en_US.UTF-8', 06:50:30 INFO - 'LANGUAGE': 'en_US:en', 06:50:30 INFO - 'LOGNAME': 'cltbld', 06:50:30 INFO - 'MAIL': '/var/mail/cltbld', 06:50:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:30 INFO - 'MOZ_NO_REMOTE': '1', 06:50:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:30 INFO - 'NO_EM_RESTART': '1', 06:50:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:50:30 INFO - 'SHELL': '/bin/bash', 06:50:30 INFO - 'SHLVL': '1', 06:50:30 INFO - 'TERM': 'linux', 06:50:30 INFO - 'TMOUT': '86400', 06:50:30 INFO - 'USER': 'cltbld', 06:50:30 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1451743405.95587-1018975679', 06:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:30 INFO - '_': '/tools/buildbot/bin/python'} 06:50:30 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/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:50:30 INFO - mozversion application_buildid: 20160102043001 06:50:30 INFO - mozversion application_changeset: 207a285fd90ef3666979bf1d59cbf66d74c5e3b8 06:50:30 INFO - mozversion application_display_name: Nightly 06:50:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:30 INFO - mozversion application_name: Firefox 06:50:30 INFO - mozversion application_remotingname: firefox 06:50:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:50:30 INFO - mozversion application_vendor: Mozilla 06:50:30 INFO - mozversion application_version: 46.0a1 06:50:30 INFO - mozversion platform_buildid: 20160102043001 06:50:30 INFO - mozversion platform_changeset: 207a285fd90ef3666979bf1d59cbf66d74c5e3b8 06:50:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:50:30 INFO - mozversion platform_version: 46.0a1 06:50:30 INFO - using testdate: 1451746230 06:50:30 INFO - actual date: 1451746230 06:50:30 INFO - starting webserver on 'localhost:56100' 06:50:30 INFO - SUITE-START | Running 3 tests 06:50:30 INFO - TEST-START | dromaeo_css 06:50:30 INFO - operating with platform_type : linux_ 06:50:30 INFO - Initialising browser for dromaeo_css test... 06:50:30 INFO - TEST-INFO | started process 17547 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps6MqKR/profile http://localhost:56100/getInfo.html) 06:50:35 INFO - PROCESS | 17547 | __metrics Screen width/height:1600/1200 06:50:35 INFO - PROCESS | 17547 | colorDepth:24 06:50:35 INFO - PROCESS | 17547 | Browser inner width/height: 1024/697 06:50:35 INFO - PROCESS | 17547 | __metrics 06:50:35 INFO - PROCESS | 17547 | 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:50:35 INFO - TEST-INFO | 17547: exit 0 06:50:35 INFO - Browser initialized. 06:50:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:36 INFO - TEST-INFO | started process 17679 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps6MqKR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:47 INFO - PROCESS | 17679 | RSS: Main: 150216704 06:50:47 INFO - PROCESS | 17679 | 06:51:37 INFO - PROCESS | 17679 | 1451746297443 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] 06:53:45 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:56100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56100/tests/dromaeo/cssquery-ext.html) 06:53:46 INFO - PROCESS | 17679 | RSS: Main: 156897280 06:53:46 INFO - PROCESS | 17679 | 06:56:48 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:56100/tests/dromaeo/cssquery-ext.html (next: http://localhost:56100/tests/dromaeo/cssquery-jquery.html) 06:56:49 INFO - PROCESS | 17679 | RSS: Main: 152465408 06:56:49 INFO - PROCESS | 17679 | 06:59:50 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:56100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56100/tests/dromaeo/cssquery-mootools.html) 06:59:51 INFO - PROCESS | 17679 | RSS: Main: 152973312 06:59:51 INFO - PROCESS | 17679 | 07:02:53 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:56100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56100/tests/dromaeo/cssquery-prototype.html) 07:02:53 INFO - PROCESS | 17679 | RSS: Main: 152109056 07:02:53 INFO - PROCESS | 17679 | 07:05:55 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:56100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56100/tests/dromaeo/cssquery-yui.html) 07:05:56 INFO - PROCESS | 17679 | RSS: Main: 152711168 07:05:56 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | Cycle 1(1): loaded http://localhost:56100/tests/dromaeo/cssquery-yui.html (next: http://localhost:56100/tests/dromaeo/cssquery-dojo.html) 07:08:59 INFO - PROCESS | 17679 | RSS: Main: 155222016 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | __start_tp_report 07:08:59 INFO - PROCESS | 17679 | _x_x_mozilla_page_load 07:08:59 INFO - PROCESS | 17679 | _x_x_mozilla_page_load_details 07:08:59 INFO - PROCESS | 17679 | |i|pagename|runs| 07:08:59 INFO - PROCESS | 17679 | |0;dojo.html;3140.607424071991;3201.439748044093;3220.243242837931;3228.4673028950224;3248.886288979886;5331.546818520431;5338.119210330291;5446.591505637083;5457.181422786584;5462;5378.865528361793;5413.512783849453;5458.563314934806;5509.752061157247;5567.582431317647;4927.3101765752735;4985.376827896513;5016.598672106241;5055.39335279767;5086.160783470723;218.25357625568446;4852.951470485285;4925;4930.950690493103;4957.603391728653;4991.450940396553;5045.167547354682;5047.419546752134;5050.090983622947;5099.413567439737;4910.950890491121;4916.483769204217;4933.062718083588;4954.578860796837;4973.403191616993;4783.856484305476;4857.611391088704;4871.805127794884;4941.530554597308;4953.578945789613;5319.627626066177;5348.171033489776;5355.919661205085;5356.196570514454;5361.517463428271;5940.821775346746;5973.940260597382;5975.850603734898;5985.191999080112;5991.4308140727;5764.769409223626;5877.030290002144;5949.553783466214;6003.549733769941;6037.4566289033755;5535.114381698909;5552.139418390156;5555.611107222496;5567.415421380737;5574.303212098488;5884.735186916599;6097.603655762361;6100.969495152496;6108.602940808833;6114.663693496811;5693;5799.797007104731;5879.470847623735;5928.436798504135;5955.13650520672;5890.676012819336;5922.851928701817;5960.344362120163;5960.910586341209;5971.014782560916;5742.913856292159;5929.110633404937;5939.138824870456;5945.256842894638;5951.9107213391835;5757.827265182052;5822.621529600562;5877.882442351214;5897.911531327033;5962.195103661037;4555.385023021916;4557.977210113994;4562.1560011398;4566.383538222364;4605.424321959755;4002.3796311571755;4065.8170382332864;4088.9182216355507;4099.241640296555;4120.340745480708;5509.724513774376;5537.640053396516;5554.527865131509;5594.13290939905;5623.325200975909;5959;5959.404059594006;5973.402659734079;5973.940260597338;5976.641401515923;5543.556515478752;5594.328680558359;5599.356074051455;5602.467765562346;5613.550915926716;4841.95158048415;4962.106820772224;4973.055119527278;5027.095122877844;5070.062038522885;6093.11649810775;6145.385461453819;6161.260648722182;6181.81454556364;6183.659898705614;5767.653940763567;5847.707614619252;5906.497947674496;5907.497862681548;5919.970400147971;6029.638221706711;6125.571210015256;6128.361907045618;6183.412575805291;6199.969000154971;5855.092460668603;5876.500497457764;5888.17565540816;5901.380355062656;5928.67392293428;5727.0550359190265;5816.94183058164;5962.672053036951;5982.252218472691;6004.789832356021;5774.942250577608;5852.590318677822;5853.970730146322;5855.473007429352;5904.61619994699;5739.512141468022;5745.97127014379;5763.164341170591;5766.798162064308;5792.333881603669;5507.008738427122;5572.331320241597;5638;5684.602077854511;5687.687177205128;5800.883982320245;5811.4479124483105;5812;5841.737121829443;5855.3266374367495;5693.658380497018;5706.743196556082;5708.486236238592;5720.742566584597;5726.312842458931 07:08:59 INFO - PROCESS | 17679 | |1;ext.html;525.9053370393331;537.1968906484805;543.7036814935859;556.4074260912129;573.7819628541156;27049;35430.1142471438;35559.4666080009;35841.82079089601;35864;38509;38872.611273887254;38904.61095389045;38978.41532377017;38993.41509877354;8440.155984401572;8539.1887770662;8559.400841941067;8607.784805379884;8624.439411438269;8306.584670766468;8362.372822038342;8393.580320983958;8397.706080287191;8447.619857106445;8319.168083191693;8366.581670916461;8398.076211616717;8399.580020998956;8434.62044208012;8372.16278372164;8477.406581539295;8480.363972702042;8494;8497.065322814486;8259.38054645904;8363.20549547792;8376.581170941428;8411.1588841116;8635.52504612246;39061.609383906085;39417.40873886894;39511.60488395137;39601.60398396008;39692.20615587701;3173.841307934594;3210.133264018702;3237.320162765822;3245.2211469247445;3309.3546758382126;28680.42639147226;29587.704122958927;29590.26024349387;29747.553786693;30165.69834301651;3855.3253180693546;3991.341428664267;3997.6801855851463;4031.5766844481495;4043.433919251307;218825;218963;219618.90190549105;220060;220267.9999999984;52925.2061219082;58543.41456585465;59890;59960.40039599635;60208.39791602028;51250.974980500185;65426.67286663536;65645.67177164083;65832;65996.34003659998;14949.177795221367;15150.242487875563;15215.31531081104;15340.616484587752;15379.307931143125;11688.94155529217;11727.589534366256;11728;11763.353015584054;11879.524819007143;19378;19586.31447899317;19640.607187856163;19667.803321966596;20188.798112018692;7645.732399365996;7910.649142971342;7915.802104947307;7935.682572697143;7976.5612891290375;894.4141587260355;899.4243684042218;904.7104926423613;1062.6918193723734;1079.578964203961;27375.315617109733;27418.45163096727;27603.723962760516;27694.169174924784;27838.16485505438;1083.5449111373084;1112.8386383974278;1112.9833052504218;1126.5155982927256;1135.9719453894238;14529;14784.482543111155;16209.675806483805;16522.917385413235;16644.916775416044;295921;297641;298649;298834;300408;49805.252921206215;49869.25196122061;50240;50256.74871625618;50310.24534631983;1308.8167656528094;1341.3494455189225;1349.7435487257194;1355.8169647097714;1359.8164247826417;27487.587686184324;29033.7096629031;29623;29764.55353169661;30117.247068823453;45101.54898451105;45524;45673.54326456826;45718.54281457276;45722.08555828931;311740;311743;311833;312033;313854;32070.83964580162;42143.789281053396;42755;43179.35230971475;43279.78360108179;45035.32447013232;45885.31172032355;46326.53673463357;46754;46766.76616616895;33077.338453231285;33530.497042543895;33759.324813504085;33866.322673545896;34166.65833341734;33567;33598;34076.14809629779;34153.65846341604;34227;32842.50736238911;33496.1625959353;33566;33729.15677108092;35403.64596354003;29625.703742962294;32446.35107297888;32630.34739305248;32917.50623740598;32987.17532061718;24418.145364912143;24785.25644230604;25254.873725631252;25302.240932772045;27023.86488067547 07:08:59 INFO - PROCESS | 17679 | |2;jquery.html;356.2696472231924;359.2724732416857;359.5613351710915;363.7980920589073;364.23147159493465;13450.260235687034;13542.526011589596;16487.75268370974;16585;16997.320107195712;15810.683786324267;15895.841041589609;16453.095079770606;16607.750883736724;16717.83282167178;4686.976565117169;4870.2694595810735;4870.902581948359;4871.878203044935;4874.147024270738;4776.90446191076;5135.717535535544;5278.340207474066;5285.550728188108;5299.152135658295;5191.0656081905245;5238.345206849144;5247.47525247476;5263.289455923439;5511.283533140686;5506.669599823983;5508.063629183009;5529.502344788968;5534;5536.141898005815;5200.791968321262;5304.840854774363;5310.256564081032;5321.068812957717;5438.320209973754;12644.051696122828;12760.489580416772;12917.095803293772;13778.724425511433;19712.112954917062;2008.2067583304658;2040.9489762755902;2053.722747429093;2142.2180903970093;2163.134746101556;9543.522823858779;10469.985577162197;12260.141790074698;12376.690582735413;12798.61604151877;1638.852503274711;1673.6401673640105;1684.7220208665556;1692.949211523644;1694.8305169483076;58254.417455825744;59538.70230648862;60477.6976115121;61874.69062654703;63200;10186.134178594903;10298.845517317246;10343.327683700536;10356.844647330296;10418.21863360251;13600.183988960694;13666.18002919828;13714.65713357174;13802;13807.930960345135;7458.067741532309;7541.7360392386;7554.8866766998535;7563.773086807405;7582.582957937256;7101.218865924744;7118.572885626879;7141.9642901785155;7153.606551639606;7156.24859389767;4392.626626736763;4462.7768611569945;4529.38853254813;4532.32015197723;4552.157850797613;1867.738516607676;1940.7282980382759;1943.0770384067737;1960.7058941158941;1965.1746266568075;470.05988023952096;885.6634478897978;922.4557511068367;978.7014960437135;979.2264111352094;10733.463326833627;11001.119910407147;11176.552937882556;11180.161487888277;11331.943340283411;468.17834700101787;472.0841567359312;473.63592852585026;474.8456751555758;476.1928531139685;5938.732757025944;6104.511639068864;6120.326764055951;6197.870075611787;6215.844603884939;492084;492704;492957;534555;575429;42583;54863.17705234425;78215.21784782193;79076;80977.19022809697;509.22597651570146;514.0233556243168;515.4716415673964;515.6570880364591;516.5764073459802;10283.331583447052;10323.793524129325;14416.13503189812;14597.489087881873;14871.40514379456;31116.222094446915;31861.840690796398;32057.839710801298;32137.839310803298;33116.83441582873;35391.29217415586;49871.251931221785;50157.49842501674;50308.49691503038;50874.74562627163;14345.211013394364;14530.709385812435;14918.627034324229;15479.458218962282;15540.222988850739;11130.721731956766;11263.943680281545;11836.881631183578;11842.28946263227;19517.70723439121;10099.495025248854;10320.22598305115;10398.74003149897;10472.266941314036;10481.109105726098;10059.446730429603;10238.590456381662;10324;10446.42544660051;10521.4739263035;10399.376037437778;10694.57221711154;10724.410157441416;10933.18001149933;10941.343519388862;14461.49384771528;14578.708425831212;14825.555233343017;14926.402943882124;15149.772753408928;15154.3180556873;15234.466793662168;15262.618434539225;15391.615209619402;15586.688266234838 07:08:59 INFO - PROCESS | 17679 | |3;mootools.html;1440.251069443889;1465.3186268385198;1597.2812234494472;1736.4096207289535;1771.725382565702;6751.156105486814;6838.931610683891;7460.403167746581;7637.23627637236;7657.578833164173;7215.747448839292;7278.454115941299;7322.890156647654;7324.670389832457;7367.8158046048875;2269.546090781842;2281.167373908528;2289.221664634024;2296.540691861626;2312.1791763923816;2303.3780879162614;2337.030132495021;2340.5903966805827;2341.590221711202;2343.039353864916;2302.458922153293;2313.803326717231;2320.709911261092;2338.286822519131;2343.9179628713;2284.680144779732;2308.0998410619786;2332.370260029791;2335.252719129879;2343.8593684378993;2300.608896487601;2323.0707716913203;2328.7671232876746;2330.6154484510034;2340.8829558522007;7793.142754297023;7879.527228366259;7894.842103157962;7906.64420101091;7911.367090632735;4718.292256161569;4750.786214620351;4754.904901901942;4781.689190202661;4801;3103.7982531135403;3143.3241853001487;3144.921376965571;3160.478521044048;3183.4269831430565;1027.696829435311;1034.0745033195324;1044.7544826965657;1057.318029870729;1061.8247989081792;10902.127829773599;10948.3978381189;11002.50488728009;11011.83482247767;11043.558257669683;4316.266234740039;4337.7397356158735;4376.081022985209;4425.159219748238;4441.555844415532;9348.485833279236;9384.155426011692;9404.90595094054;9446.574904129331;9470;4874.098291816025;4897.730624815598;4914.8771280718265;4918.8770280743265;4920.926186107211;4201.390798334224;4265.53079161292;4270.829166833354;4287.185434767384;4392.450943632046;3522.1018640246575;3536.929261414809;3558.0749005258817;3567.94648080279;3568.37553428149;1091.5251865438559;1104.7017305327518;1108.7394462301352;1116.4864162485185;1118.7370967822555;1266.1453518874907;1273.866244044362;1292.5605294200018;1344.6907211341447;1346.5421756602802;7263;7296.6716497757725;7314.561126332437;7319.926800732031;7327.413806895435;487.48570258377043;494.7130664214747;496.95278948500555;496.9577585905166;497.20943699517215;5768.336641286306;5830.8542286442325;5839.445252700986;5840.328362238312;5855.443732845373;8843.646254149891;9282.932462766868;9293.90706092944;9307.488088155216;9425.575849086808;9128.680496182735;9150.725478235663;9152.130547597968;9244.445333280024;9261.861072083924;6683.632400217937;6838.692258848463;6850.520463567503;6851.965740171367;7056.50604457683;7256.455765817479;7361.668724907285;7366.152892417441;7371.557706537625;7391.704331826667;8145.592720364077;8223.17768223173;8404.033536143423;8417.663293468193;8429.536375499407;8638.91361086381;8723.389362744547;8728.91271087281;8740.694075707319;8775;6488.772892948724;6601.075849381186;6615.5038372123245;6666.83332916681;6691.364320389555;7431.331180193809;7450.95686603865;7466.440016998638;7487.625618719151;7500.062492188476;6508.121403610452;6578.868422631616;6664.633445160563;6768.424683901923;6860.656967151523;6830.5218634697085;6872.175338959357;6875.449964002968;6947.305269473012;6965.930340696528;6868.107146070979;6908.3091690830515;6919.896201557081;6958.304169583002;7000.964995174992;6556.672166391566;6582.473402127723;6598.934010660024;6602.735890564516;6610.305917878553;6549.541532092708;6560.081588577698;6585.5719378240265;6604.570702904296;6616.536842420985 07:08:59 INFO - PROCESS | 17679 | |4;prototype.html;340.09873834339;344.83620280366813;347.4076699227817;348.81687114265026;355.02545512567997;6175.969120154404;6209.844753881155;6307.211598550187;6310.810675679725;6366.5861718988235;6216.222972128484;6227.5952063115865;6252.124702541648;6254.280757712864;6265.498760099193;4781.115493633672;4781.378420805299;4784.138855006097;4794.2329227323635;4795.712257264575;4783.330333753277;4794.472608013116;4798.928016079744;4803.327534145223;4804.351412559295;4664.207084795593;4678.929816052745;4719.598834099105;4736.52634736527;4750.144973904696;4723.7874295656775;4728.125296820082;4734;4734.053189362107;4738.976305118486;4098.52866920305;4121.732087414309;4139.19285739281;4143.461350024508;4146.875593732163;5942.613730107572;5944.762209511658;5945.078512830518;5963.880722385571;5964.194833697438;5362.276092727471;5461.371942226655;5473.042217611902;5475.315585551806;5504.669719816784;6555.475561955032;6561.868762624768;6572.967135164341;6575.11235983141;6586.440152587036;4523.321501774727;4535.569120933506;4543.477500087499;4549.385832912548;4551.886202844922;6699.3300669933105;6781.8643627127185;6844.623545704984;6849.349311815419;6852.074969879102;4637.8840528986375;4650.255959046536;4657.3246879202325;4660;4663.603593694574;4704.529547045268;4713.08094921487;4715.174844402284;4716.504766999485;4721.362616046858;5453.10023846061;5462.590305727007;5469.097598896217;5478.863028424321;5484.341878974469;6451.225852897588;6590.2421221560135;6655.201375834834;6669.366410191024;6671.46628269747;1632.2328505602347;1656.1057029204094;1665.9750103748454;1669.732842745155;1670.3736098962888;1099.9010089092021;1118.3737107219983;1119.4290911635126;1121.170333952869;1129.2772625519674;6190.535709821691;6246.312905580383;6248;6262.780802671885;6269.8746025079245;6661.4004739573675;6681.966590167115;6694.196696396366;6703.162104736908;6704.2625311215725;6088.969555152196;6253.343398943045;6255.718492667841;6258.624482531062;6261.530385221035;3606.441001644749;3621.0766254604905;3623.1847834237087;3624.7643903146213;3635.9818200908826;7026.297370262932;7038.331358520933;7050.435965122778;7060.54106483077;7061.223265440797;6743.865122697519;6840.897386539206;6869.7595584154315;6884.965575172092;6894.13823272091;7053.858922821515;7061;7077.84125841613;7081.044059052065;7090.787276381717;6612.768553100618;6631.0716499689115;6648.135742353463;6669.566478178903;6701.765438209639;6537.5750576212395;6583.30875258091;6625.900611490928;6650.800475985729;6661.666916654245;6997.090378250795;7021.1574611047;7034.47241456903;7034.718611255493;7060.71757129709;4598.494165641843;4625.491195968508;4626.1904166771355;4634.37435946143;4641.791119399568;6678.83302917431;6722;6724.865502690017;6733.831654208684;6828.760993365208;6631.933680663132;6661.500387470862;6664.66676666155;6691.364320389555;6697.531172817856;6637.137172167587;6665.800025999228;6672.366125218096;6673.5318229989325;6677.9332206679255;6436.774712885027;6503.057056726842;6504.544681872224;6534.411902928759;6540.640264785482;6653.367930046637;6675.532712710258;6680.933190668031;6682.83292917681;6719.092922455406;6523.739050437929;6535.934640653722;6538.280789113099;6540.967295163494;6558.901616475852 07:08:59 INFO - PROCESS | 17679 | |5;yui.html;754.6792613139417;786.2255678157014;816.3591580609223;822.9012518497777;847.9024912135106;12378.38108094595;12515.374231288444;12547.623571292865;12618.936905315484;12668.49326026959;12337.691557711061;12363.072769542276;12439;12446.81329780054;12456.439460224288;786.850498405304;805.730080423059;807.6728924785472;815.7104227999034;816.7958010497375;805.6938363421891;809.6882700160422;812.0215140755375;812.8740045292959;813.4712436916022;854.0520022774715;854.9273311768476;855.9358048146382;857.0615176381851;857.5069335132292;846.7925358287259;848.5375470368664;848.961796719146;849.7280870121564;859.1151114352195;621.2606997672755;625.9812205633838;626.0702856258453;631.3780925788095;633.8637193003526;13558.525451609245;13669.521566745216;13689.726205475934;13692.931535342359;13723;11630;11700.297982121016;11821.881781182165;12239.938800305941;12434.253944763253;9725.56234969428;9872.950635246849;10338.638147664871;10443.791124177475;10514.474276286155;3637.6180501047274;3647.562292524914;3654.707623390149;3709.7217708671956;3770.472133901256;43447.348289775364;43463.78268108671;43489.130217395475;43844.342334865;43939.12121757547;9270.165685088374;9584.472853992958;9605.615775369046;9920.305578609428;10018.448985305879;16400.26198821056;16498.67002659964;16588.58528536796;16620.83379166217;17242;7026.578405295699;7339.7064117435775;7362.595057271901;7481.438892083115;7614.505057171266;4293.935590966138;4319.935200971988;4334.566543345641;4393.362962370438;4403.955960440355;3111.0977816433433;3125.9218519537194;3135.561021456998;3137.074563003919;3137.8901738439044;560.2520634952302;562.2971285892634;568.2101878389043;571.3657839797821;582.5659883386819;640.1805688718448;679.4971720926577;687.8540242929441;691.4399336537421;702.1143101851387;8476.915230847735;8510.78723031929;9091.409058411182;9124.817503650023;9461.810763784824;557.5790278339908;569.5699746691305;574.6035235687363;583.5681595619211;633.9587926784744;3807.2956503047026;3813.5423749149722;4055.959440405617;4114.382842573638;4153.626173644326;52965;53742;53916;54489.72755136199;57500;44660.55339446629;45815.77092114585;51655.22517162246;52175.47824521706;52304.21543676848;45904.540954590695;46101.76949115233;46832.29751553729;47010.76494617573;47127.76436117797;8245;8325.54209518458;8562.400631955703;8637.870431943651;8734.868976965223;30530.236744081576;30690;30896.382072358876;32424.675753243107;32878.17804554905;42422.575774243094;45245.321320179566;46937;47072;47228.52771472379;10554.78890422172;10945.890541094806;10984.340939543334;11158.44207789591;11338.943305283421;12127.939360303142;12238.632841014783;12332.876671233173;12350.258984460961;12499.500019999461;11267.605633802777;11378.772424551627;11420.828687569527;11533.250338728292;11829.231099978819;11321;11594.478248479007;11618.825717614412;11977.700557486132;12007.279563226235;11212.55149793999;11498.77002459963;11662.300261984308;11920.821187682019;11932.28406295625;9674.70975870725;9858.55636496345;9873.210143188671;10210.897891020995;10268.486575671335;9108.608740023554;9422.434653920787;9492.240620750184;9900.603975840886;10058.29591928558 07:08:59 INFO - PROCESS | 17679 | __end_tp_report 07:08:59 INFO - PROCESS | 17679 | __start_cc_report 07:08:59 INFO - PROCESS | 17679 | _x_x_mozilla_cycle_collect,306 07:08:59 INFO - PROCESS | 17679 | __end_cc_report 07:08:59 INFO - PROCESS | 17679 | __startTimestamp1451747339301__endTimestamp 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | ------- Summary: start ------- 07:08:59 INFO - PROCESS | 17679 | Number of tests: 6 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | [#0] dojo.html Cycles:165 Average:5448.88 Median:5706.74 stddev:754.17 (13.2%) stddev-sans-first:734.42 07:08:59 INFO - PROCESS | 17679 | Values: 3140.6 3201.4 3220.2 3228.5 3248.9 5331.5 5338.1 5446.6 5457.2 5462.0 5378.9 5413.5 5458.6 5509.8 5567.6 4927.3 4985.4 5016.6 5055.4 5086.2 218.3 4853.0 4925.0 4931.0 4957.6 4991.5 5045.2 5047.4 5050.1 5099.4 4911.0 4916.5 4933.1 4954.6 4973.4 4783.9 4857.6 4871.8 4941.5 4953.6 5319.6 5348.2 5355.9 5356.2 5361.5 5940.8 5973.9 5975.9 5985.2 5991.4 5764.8 5877.0 5949.6 6003.5 6037.5 5535.1 5552.1 5555.6 5567.4 5574.3 5884.7 6097.6 6101.0 6108.6 6114.7 5693.0 5799.8 5879.5 5928.4 5955.1 5890.7 5922.9 5960.3 5960.9 5971.0 5742.9 5929.1 5939.1 5945.3 5951.9 5757.8 5822.6 5877.9 5897.9 5962.2 4555.4 4558.0 4562.2 4566.4 4605.4 4002.4 4065.8 4088.9 4099.2 4120.3 5509.7 5537.6 5554.5 5594.1 5623.3 5959.0 5959.4 5973.4 5973.9 5976.6 5543.6 5594.3 5599.4 5602.5 5613.6 4842.0 4962.1 4973.1 5027.1 5070.1 6093.1 6145.4 6161.3 6181.8 6183.7 5767.7 5847.7 5906.5 5907.5 5920.0 6029.6 6125.6 6128.4 6183.4 6200.0 5855.1 5876.5 5888.2 5901.4 5928.7 5727.1 5816.9 5962.7 5982.3 6004.8 5774.9 5852.6 5854.0 5855.5 5904.6 5739.5 5746.0 5763.2 5766.8 5792.3 5507.0 5572.3 5638.0 5684.6 5687.7 5800.9 5811.4 5812.0 5841.7 5855.3 5693.7 5706.7 5708.5 5720.7 5726.3 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | [#1] ext.html Cycles:180 Average:44856.87 Median:34160.16 stddev:73099.01 (214.0%) stddev-sans-first:73228.29 07:08:59 INFO - PROCESS | 17679 | Values: 525.9 537.2 543.7 556.4 573.8 27049.0 35430.1 35559.5 35841.8 35864.0 38509.0 38872.6 38904.6 38978.4 38993.4 8440.2 8539.2 8559.4 8607.8 8624.4 8306.6 8362.4 8393.6 8397.7 8447.6 8319.2 8366.6 8398.1 8399.6 8434.6 8372.2 8477.4 8480.4 8494.0 8497.1 8259.4 8363.2 8376.6 8411.2 8635.5 39061.6 39417.4 39511.6 39601.6 39692.2 3173.8 3210.1 3237.3 3245.2 3309.4 28680.4 29587.7 29590.3 29747.6 30165.7 3855.3 3991.3 3997.7 4031.6 4043.4 218825.0 218963.0 219618.9 220060.0 220268.0 52925.2 58543.4 59890.0 59960.4 60208.4 51251.0 65426.7 65645.7 65832.0 65996.3 14949.2 15150.2 15215.3 15340.6 15379.3 11688.9 11727.6 11728.0 11763.4 11879.5 19378.0 19586.3 19640.6 19667.8 20188.8 7645.7 7910.6 7915.8 7935.7 7976.6 894.4 899.4 904.7 1062.7 1079.6 27375.3 27418.5 27603.7 27694.2 27838.2 1083.5 1112.8 1113.0 1126.5 1136.0 14529.0 14784.5 16209.7 16522.9 16644.9 295921.0 297641.0 298649.0 298834.0 300408.0 49805.3 49869.3 50240.0 50256.7 50310.2 1308.8 1341.3 1349.7 1355.8 1359.8 27487.6 29033.7 29623.0 29764.6 30117.2 45101.5 45524.0 45673.5 45718.5 45722.1 311740.0 311743.0 311833.0 312033.0 313854.0 32070.8 42143.8 42755.0 43179.4 43279.8 45035.3 45885.3 46326.5 46754.0 46766.8 33077.3 33530.5 33759.3 33866.3 34166.7 33567.0 33598.0 34076.1 34153.7 34227.0 32842.5 33496.2 33566.0 33729.2 35403.6 29625.7 32446.4 32630.3 32917.5 32987.2 24418.1 24785.3 25254.9 25302.2 27023.9 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | [#2] jquery.html Cycles:180 Average:27200.50 Median:31959.84 stddev:84728.05 (265.1%) stddev-sans-first:84941.76 07:08:59 INFO - PROCESS | 17679 | Values: 356.3 359.3 359.6 363.8 364.2 13450.3 13542.5 16487.8 16585.0 16997.3 15810.7 15895.8 16453.1 16607.8 16717.8 4687.0 4870.3 4870.9 4871.9 4874.1 4776.9 5135.7 5278.3 5285.6 5299.2 5191.1 5238.3 5247.5 5263.3 5511.3 5506.7 5508.1 5529.5 5534.0 5536.1 5200.8 5304.8 5310.3 5321.1 5438.3 12644.1 12760.5 12917.1 13778.7 19712.1 2008.2 2040.9 2053.7 2142.2 2163.1 9543.5 10470.0 12260.1 12376.7 12798.6 1638.9 1673.6 1684.7 1692.9 1694.8 58254.4 59538.7 60477.7 61874.7 63200.0 10186.1 10298.8 10343.3 10356.8 10418.2 13600.2 13666.2 13714.7 13802.0 13807.9 7458.1 7541.7 7554.9 7563.8 7582.6 7101.2 7118.6 7142.0 7153.6 7156.2 4392.6 4462.8 4529.4 4532.3 4552.2 1867.7 1940.7 1943.1 1960.7 1965.2 470.1 885.7 922.5 978.7 979.2 10733.5 11001.1 11176.6 11180.2 11331.9 468.2 472.1 473.6 474.8 476.2 5938.7 6104.5 6120.3 6197.9 6215.8 492084.0 492704.0 492957.0 534555.0 575429.0 42583.0 54863.2 78215.2 79076.0 80977.2 509.2 514.0 515.5 515.7 516.6 10283.3 10323.8 14416.1 14597.5 14871.4 31116.2 31861.8 32057.8 32137.8 33116.8 35391.3 49871.3 50157.5 50308.5 50874.7 14345.2 14530.7 14918.6 15479.5 15540.2 11130.7 11263.9 11836.9 11842.3 19517.7 10099.5 10320.2 10398.7 10472.3 10481.1 10059.4 10238.6 10324.0 10446.4 10521.5 10399.4 10694.6 10724.4 10933.2 10941.3 14461.5 14578.7 14825.6 14926.4 15149.8 15154.3 15234.5 15262.6 15391.6 15586.7 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | [#3] mootools.html Cycles:180 Average:5432.63 Median:6498.45 stddev:2823.57 (43.4%) stddev-sans-first:2815.54 07:08:59 INFO - PROCESS | 17679 | Values: 1440.3 1465.3 1597.3 1736.4 1771.7 6751.2 6838.9 7460.4 7637.2 7657.6 7215.7 7278.5 7322.9 7324.7 7367.8 2269.5 2281.2 2289.2 2296.5 2312.2 2303.4 2337.0 2340.6 2341.6 2343.0 2302.5 2313.8 2320.7 2338.3 2343.9 2284.7 2308.1 2332.4 2335.3 2343.9 2300.6 2323.1 2328.8 2330.6 2340.9 7793.1 7879.5 7894.8 7906.6 7911.4 4718.3 4750.8 4754.9 4781.7 4801.0 3103.8 3143.3 3144.9 3160.5 3183.4 1027.7 1034.1 1044.8 1057.3 1061.8 10902.1 10948.4 11002.5 11011.8 11043.6 4316.3 4337.7 4376.1 4425.2 4441.6 9348.5 9384.2 9404.9 9446.6 9470.0 4874.1 4897.7 4914.9 4918.9 4920.9 4201.4 4265.5 4270.8 4287.2 4392.5 3522.1 3536.9 3558.1 3567.9 3568.4 1091.5 1104.7 1108.7 1116.5 1118.7 1266.1 1273.9 1292.6 1344.7 1346.5 7263.0 7296.7 7314.6 7319.9 7327.4 487.5 494.7 497.0 497.0 497.2 5768.3 5830.9 5839.4 5840.3 5855.4 8843.6 9282.9 9293.9 9307.5 9425.6 9128.7 9150.7 9152.1 9244.4 9261.9 6683.6 6838.7 6850.5 6852.0 7056.5 7256.5 7361.7 7366.2 7371.6 7391.7 8145.6 8223.2 8404.0 8417.7 8429.5 8638.9 8723.4 8728.9 8740.7 8775.0 6488.8 6601.1 6615.5 6666.8 6691.4 7431.3 7451.0 7466.4 7487.6 7500.1 6508.1 6578.9 6664.6 6768.4 6860.7 6830.5 6872.2 6875.4 6947.3 6965.9 6868.1 6908.3 6919.9 6958.3 7001.0 6556.7 6582.5 6598.9 6602.7 6610.3 6549.5 6560.1 6585.6 6604.6 6616.5 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | [#4] prototype.html Cycles:180 Average:5500.80 Median:6255.00 stddev:1658.25 (26.5%) stddev-sans-first:1617.03 07:08:59 INFO - PROCESS | 17679 | Values: 340.1 344.8 347.4 348.8 355.0 6176.0 6209.8 6307.2 6310.8 6366.6 6216.2 6227.6 6252.1 6254.3 6265.5 4781.1 4781.4 4784.1 4794.2 4795.7 4783.3 4794.5 4798.9 4803.3 4804.4 4664.2 4678.9 4719.6 4736.5 4750.1 4723.8 4728.1 4734.0 4734.1 4739.0 4098.5 4121.7 4139.2 4143.5 4146.9 5942.6 5944.8 5945.1 5963.9 5964.2 5362.3 5461.4 5473.0 5475.3 5504.7 6555.5 6561.9 6573.0 6575.1 6586.4 4523.3 4535.6 4543.5 4549.4 4551.9 6699.3 6781.9 6844.6 6849.3 6852.1 4637.9 4650.3 4657.3 4660.0 4663.6 4704.5 4713.1 4715.2 4716.5 4721.4 5453.1 5462.6 5469.1 5478.9 5484.3 6451.2 6590.2 6655.2 6669.4 6671.5 1632.2 1656.1 1666.0 1669.7 1670.4 1099.9 1118.4 1119.4 1121.2 1129.3 6190.5 6246.3 6248.0 6262.8 6269.9 6661.4 6682.0 6694.2 6703.2 6704.3 6089.0 6253.3 6255.7 6258.6 6261.5 3606.4 3621.1 3623.2 3624.8 3636.0 7026.3 7038.3 7050.4 7060.5 7061.2 6743.9 6840.9 6869.8 6885.0 6894.1 7053.9 7061.0 7077.8 7081.0 7090.8 6612.8 6631.1 6648.1 6669.6 6701.8 6537.6 6583.3 6625.9 6650.8 6661.7 6997.1 7021.2 7034.5 7034.7 7060.7 4598.5 4625.5 4626.2 4634.4 4641.8 6678.8 6722.0 6724.9 6733.8 6828.8 6631.9 6661.5 6664.7 6691.4 6697.5 6637.1 6665.8 6672.4 6673.5 6677.9 6436.8 6503.1 6504.5 6534.4 6540.6 6653.4 6675.5 6680.9 6682.8 6719.1 6523.7 6535.9 6538.3 6541.0 6558.9 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - PROCESS | 17679 | [#5] yui.html Cycles:180 Average:13408.71 Median:45860.16 stddev:15289.77 (33.3%) stddev-sans-first:15303.13 07:08:59 INFO - PROCESS | 17679 | Values: 754.7 786.2 816.4 822.9 847.9 12378.4 12515.4 12547.6 12618.9 12668.5 12337.7 12363.1 12439.0 12446.8 12456.4 786.9 805.7 807.7 815.7 816.8 805.7 809.7 812.0 812.9 813.5 854.1 854.9 855.9 857.1 857.5 846.8 848.5 849.0 849.7 859.1 621.3 626.0 626.1 631.4 633.9 13558.5 13669.5 13689.7 13692.9 13723.0 11630.0 11700.3 11821.9 12239.9 12434.3 9725.6 9873.0 10338.6 10443.8 10514.5 3637.6 3647.6 3654.7 3709.7 3770.5 43447.3 43463.8 43489.1 43844.3 43939.1 9270.2 9584.5 9605.6 9920.3 10018.4 16400.3 16498.7 16588.6 16620.8 17242.0 7026.6 7339.7 7362.6 7481.4 7614.5 4293.9 4319.9 4334.6 4393.4 4404.0 3111.1 3125.9 3135.6 3137.1 3137.9 560.3 562.3 568.2 571.4 582.6 640.2 679.5 687.9 691.4 702.1 8476.9 8510.8 9091.4 9124.8 9461.8 557.6 569.6 574.6 583.6 634.0 3807.3 3813.5 4056.0 4114.4 4153.6 52965.0 53742.0 53916.0 54489.7 57500.0 44660.6 45815.8 51655.2 52175.5 52304.2 45904.5 46101.8 46832.3 47010.8 47127.8 8245.0 8325.5 8562.4 8637.9 8734.9 30530.2 30690.0 30896.4 32424.7 32878.2 42422.6 45245.3 46937.0 47072.0 47228.5 10554.8 10945.9 10984.3 11158.4 11338.9 12127.9 12238.6 12332.9 12350.3 12499.5 11267.6 11378.8 11420.8 11533.3 11829.2 11321.0 11594.5 11618.8 11977.7 12007.3 11212.6 11498.8 11662.3 11920.8 11932.3 9674.7 9858.6 9873.2 10210.9 10268.5 9108.6 9422.4 9492.2 9900.6 10058.3 07:08:59 INFO - PROCESS | 17679 | -------- Summary: end -------- 07:08:59 INFO - PROCESS | 17679 | 07:08:59 INFO - TEST-INFO | 17679: exit 0 07:08:59 INFO - TEST-OK | dromaeo_css | took 1109297ms 07:08:59 INFO - TEST-START | kraken 07:08:59 INFO - operating with platform_type : linux_ 07:08:59 INFO - Initialising browser for kraken test... 07:08:59 INFO - TEST-INFO | started process 17913 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4aby4i/profile http://localhost:56100/getInfo.html) 07:09:04 INFO - PROCESS | 17913 | __metrics Screen width/height:1600/1200 07:09:04 INFO - PROCESS | 17913 | colorDepth:24 07:09:04 INFO - PROCESS | 17913 | Browser inner width/height: 1024/697 07:09:04 INFO - PROCESS | 17913 | __metrics 07:09:04 INFO - PROCESS | 17913 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:05 INFO - TEST-INFO | 17913: exit 0 07:09:05 INFO - Browser initialized. 07:09:05 INFO - Running cycle 1/1 for kraken test... 07:09:05 INFO - TEST-INFO | started process 18039 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4aby4i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:17 INFO - PROCESS | 18039 | RSS: Main: 150155264 07:09:17 INFO - PROCESS | 18039 | 07:09:19 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56100/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:20 INFO - PROCESS | 18039 | RSS: Main: 150773760 07:09:20 INFO - PROCESS | 18039 | 07:09:22 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56100/tests/kraken/driver.html?testName=audio-dft) 07:09:23 INFO - PROCESS | 18039 | RSS: Main: 151134208 07:09:23 INFO - PROCESS | 18039 | 07:09:26 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56100/tests/kraken/driver.html?testName=audio-fft) 07:09:26 INFO - PROCESS | 18039 | RSS: Main: 145518592 07:09:26 INFO - PROCESS | 18039 | 07:09:29 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56100/tests/kraken/driver.html?testName=audio-oscillator) 07:09:29 INFO - PROCESS | 18039 | RSS: Main: 146354176 07:09:29 INFO - PROCESS | 18039 | 07:09:31 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:32 INFO - PROCESS | 18039 | RSS: Main: 146374656 07:09:32 INFO - PROCESS | 18039 | 07:09:35 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56100/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:35 INFO - PROCESS | 18039 | RSS: Main: 147558400 07:09:35 INFO - PROCESS | 18039 | 07:09:39 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56100/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:39 INFO - PROCESS | 18039 | RSS: Main: 148348928 07:09:39 INFO - PROCESS | 18039 | 07:09:42 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56100/tests/kraken/driver.html?testName=json-parse-financial) 07:09:43 INFO - PROCESS | 18039 | RSS: Main: 148037632 07:09:43 INFO - PROCESS | 18039 | 07:09:44 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:45 INFO - PROCESS | 18039 | RSS: Main: 148180992 07:09:45 INFO - PROCESS | 18039 | 07:09:47 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:47 INFO - PROCESS | 18039 | RSS: Main: 147939328 07:09:47 INFO - PROCESS | 18039 | 07:09:49 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:50 INFO - PROCESS | 18039 | RSS: Main: 148889600 07:09:50 INFO - PROCESS | 18039 | 07:09:53 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:09:53 INFO - PROCESS | 18039 | RSS: Main: 149274624 07:09:53 INFO - PROCESS | 18039 | 07:09:56 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:09:56 INFO - PROCESS | 18039 | RSS: Main: 148070400 07:09:56 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:56100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56100/tests/kraken/driver.html?testName=ai-astar) 07:09:58 INFO - PROCESS | 18039 | RSS: Main: 149254144 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | __start_tp_report 07:09:58 INFO - PROCESS | 18039 | _x_x_mozilla_page_load 07:09:58 INFO - PROCESS | 18039 | _x_x_mozilla_page_load_details 07:09:58 INFO - PROCESS | 18039 | |i|pagename|runs| 07:09:58 INFO - PROCESS | 18039 | |0;ai-astar;111;105;113;109;109;119;109;112;108;110 07:09:58 INFO - PROCESS | 18039 | |1;audio-beat-detection;150;135;150;165;139;151;160;126;173;128 07:09:58 INFO - PROCESS | 18039 | |2;audio-dft;162;163;163;163;163;162;165;167;169;162 07:09:58 INFO - PROCESS | 18039 | |3;audio-fft;72;72;73;72;75;132;73;73;72;72 07:09:58 INFO - PROCESS | 18039 | |4;audio-oscillator;96;96;147;96;97;97;142;97;97;137 07:09:58 INFO - PROCESS | 18039 | |5;imaging-gaussian-blur;110;110;109;109;110;109;110;109;111;110 07:09:58 INFO - PROCESS | 18039 | |6;imaging-darkroom;146;146;148;147;147;147;147;147;148;149 07:09:58 INFO - PROCESS | 18039 | |7;imaging-desaturate;104;97;96;95;97;96;96;97;96;96 07:09:58 INFO - PROCESS | 18039 | |8;json-parse-financial;59;62;62;59;58;61;58;60;63;58 07:09:58 INFO - PROCESS | 18039 | |9;json-stringify-tinderbox;70;67;67;68;67;68;68;67;68;69 07:09:58 INFO - PROCESS | 18039 | |10;stanford-crypto-aes;95;86;87;86;85;85;86;88;85;86 07:09:58 INFO - PROCESS | 18039 | |11;stanford-crypto-ccm;122;122;120;130;124;126;121;126;120;120 07:09:58 INFO - PROCESS | 18039 | |12;stanford-crypto-pbkdf2;143;154;163;157;154;155;158;153;155;143 07:09:58 INFO - PROCESS | 18039 | |13;stanford-crypto-sha256-iterative;68;68;69;69;69;78;69;69;71;69 07:09:58 INFO - PROCESS | 18039 | __end_tp_report 07:09:58 INFO - PROCESS | 18039 | __start_cc_report 07:09:58 INFO - PROCESS | 18039 | _x_x_mozilla_cycle_collect,743 07:09:58 INFO - PROCESS | 18039 | __end_cc_report 07:09:58 INFO - PROCESS | 18039 | __startTimestamp1451747398800__endTimestamp 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | ------- Summary: start ------- 07:09:58 INFO - PROCESS | 18039 | Number of tests: 14 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:3.72 (3.4%) stddev-sans-first:3.94 07:09:58 INFO - PROCESS | 18039 | Values: 111.0 105.0 113.0 109.0 109.0 119.0 109.0 112.0 108.0 110.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:150.50 stddev:15.66 (10.4%) stddev-sans-first:16.59 07:09:58 INFO - PROCESS | 18039 | Values: 150.0 135.0 150.0 165.0 139.0 151.0 160.0 126.0 173.0 128.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.38 (1.5%) stddev-sans-first:2.42 07:09:58 INFO - PROCESS | 18039 | Values: 162.0 163.0 163.0 163.0 163.0 162.0 165.0 167.0 169.0 162.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#3] audio-fft Cycles:10 Average:78.60 Median:72.50 stddev:18.79 (25.9%) stddev-sans-first:19.77 07:09:58 INFO - PROCESS | 18039 | Values: 72.0 72.0 73.0 72.0 75.0 132.0 73.0 73.0 72.0 72.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.50 stddev:22.07 (22.9%) stddev-sans-first:22.81 07:09:58 INFO - PROCESS | 18039 | Values: 96.0 96.0 147.0 96.0 97.0 97.0 142.0 97.0 97.0 137.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:09:58 INFO - PROCESS | 18039 | Values: 110.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 111.0 110.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 07:09:58 INFO - PROCESS | 18039 | Values: 146.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 149.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.54 (2.6%) stddev-sans-first:0.67 07:09:58 INFO - PROCESS | 18039 | Values: 104.0 97.0 96.0 95.0 97.0 96.0 96.0 97.0 96.0 96.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:60.50 stddev:1.89 (3.1%) stddev-sans-first:1.96 07:09:58 INFO - PROCESS | 18039 | Values: 59.0 62.0 62.0 59.0 58.0 61.0 58.0 60.0 63.0 58.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:0.71 07:09:58 INFO - PROCESS | 18039 | Values: 70.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 68.0 69.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:3.00 (3.5%) stddev-sans-first:1.00 07:09:58 INFO - PROCESS | 18039 | Values: 95.0 86.0 87.0 86.0 85.0 85.0 86.0 88.0 85.0 86.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:123.00 stddev:3.35 (2.7%) stddev-sans-first:3.53 07:09:58 INFO - PROCESS | 18039 | Values: 122.0 122.0 120.0 130.0 124.0 126.0 121.0 126.0 120.0 120.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:155.00 stddev:6.22 (4.0%) stddev-sans-first:5.32 07:09:58 INFO - PROCESS | 18039 | Values: 143.0 154.0 163.0 157.0 154.0 155.0 158.0 153.0 155.0 143.0 07:09:58 INFO - PROCESS | 18039 | 07:09:58 INFO - PROCESS | 18039 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.00 stddev:2.96 (4.3%) stddev-sans-first:3.06 07:09:58 INFO - PROCESS | 18039 | Values: 68.0 68.0 69.0 69.0 69.0 78.0 69.0 69.0 71.0 69.0 07:09:58 INFO - PROCESS | 18039 | -------- Summary: end -------- 07:09:58 INFO - PROCESS | 18039 | 07:09:59 INFO - TEST-INFO | 18039: exit 0 07:09:59 INFO - TEST-OK | kraken | took 60009ms 07:09:59 INFO - TEST-START | v8_7 07:09:59 INFO - operating with platform_type : linux_ 07:09:59 INFO - Initialising browser for v8_7 test... 07:09:59 INFO - TEST-INFO | started process 18326 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Jsi98/profile http://localhost:56100/getInfo.html) 07:10:04 INFO - PROCESS | 18326 | __metrics Screen width/height:1600/1200 07:10:04 INFO - PROCESS | 18326 | colorDepth:24 07:10:04 INFO - PROCESS | 18326 | Browser inner width/height: 1024/697 07:10:04 INFO - PROCESS | 18326 | __metrics 07:10:04 INFO - PROCESS | 18326 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:10:05 INFO - TEST-INFO | 18326: exit 0 07:10:05 INFO - Browser initialized. 07:10:05 INFO - Running cycle 1/1 for v8_7 test... 07:10:05 INFO - TEST-INFO | started process 18446 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Jsi98/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:16 INFO - PROCESS | 18446 | RSS: Main: 150704128 07:10:16 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | Cycle 1(1): loaded http://localhost:56100/tests/v8_7/run.html (next: http://localhost:56100/tests/v8_7/run.html) 07:10:38 INFO - PROCESS | 18446 | RSS: Main: 147095552 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | __start_tp_report 07:10:38 INFO - PROCESS | 18446 | _x_x_mozilla_page_load 07:10:38 INFO - PROCESS | 18446 | _x_x_mozilla_page_load_details 07:10:38 INFO - PROCESS | 18446 | |i|pagename|runs| 07:10:38 INFO - PROCESS | 18446 | |0;Richards;166.9727834362999 07:10:38 INFO - PROCESS | 18446 | |1;DeltaBlue;196.30938358853552 07:10:38 INFO - PROCESS | 18446 | |2;Encrypt;283.84899233607723 07:10:38 INFO - PROCESS | 18446 | |3;Decrypt;5202.072538860104 07:10:38 INFO - PROCESS | 18446 | |4;RayTrace;1059.322033898305 07:10:38 INFO - PROCESS | 18446 | |5;Earley;725.6894049346879 07:10:38 INFO - PROCESS | 18446 | |6;Boyer;12587.5 07:10:38 INFO - PROCESS | 18446 | |7;RegExp;25100 07:10:38 INFO - PROCESS | 18446 | |8;Splay;592.0663114268798 07:10:38 INFO - PROCESS | 18446 | |9;NavierStokes;4830.917874396136 07:10:38 INFO - PROCESS | 18446 | __end_tp_report 07:10:38 INFO - PROCESS | 18446 | __startTimestamp1451747438537__endTimestamp 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | ------- Summary: start ------- 07:10:38 INFO - PROCESS | 18446 | Number of tests: 10 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 167.0 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#1] DeltaBlue Cycles:1 Average:196.31 Median:196.31 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 196.3 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#2] Encrypt Cycles:1 Average:283.85 Median:283.85 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 283.8 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 5202.1 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 1059.3 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#5] Earley Cycles:1 Average:725.69 Median:725.69 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 725.7 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 12587.5 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 25100.0 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#8] Splay Cycles:1 Average:592.07 Median:592.07 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 592.1 07:10:38 INFO - PROCESS | 18446 | 07:10:38 INFO - PROCESS | 18446 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:10:38 INFO - PROCESS | 18446 | Values: 4830.9 07:10:38 INFO - PROCESS | 18446 | -------- Summary: end -------- 07:10:38 INFO - PROCESS | 18446 | 07:10:39 INFO - TEST-INFO | 18446: exit 0 07:10:39 INFO - TEST-OK | v8_7 | took 39456ms 07:10:39 INFO - SUITE-END | took 1208s 07:10:39 INFO - Completed test suite (00:20:08) 07:10:39 INFO - Working with test: dromaeo_css 07:10:39 INFO - Generating results file: dromaeo_css 07:10:39 INFO - Working with test: kraken 07:10:39 INFO - Generating results file: kraken 07:10:39 INFO - javascript benchmark 07:10:39 INFO - Working with test: v8_7 07:10:39 INFO - Generating results file: v8_7 07:10:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:10:39 INFO - process_Request line: dromaeo_css 6899.42 graph.html#tests=[[72,1,43]] 07:10:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:39 INFO - process_Request line: kraken 1526.10 graph.html#tests=[[232,1,43]] 07:10:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:39 INFO - process_Request line: v8_7 21222.83 graph.html#tests=[[230,1,43]] 07:10:39 INFO - RETURN: dromaeo_css: 6899.42 07:10:39 INFO - RETURN: kraken: 1526.10 07:10:39 INFO - RETURN: v8_7: 21222.83 07:10:39 INFO - javascript benchmark 07:10:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3140.607424071991, 3201.439748044093, 3220.243242837931, 3228.4673028950224, 3248.886288979886, 5331.546818520431, 5338.119210330291, 5446.591505637083, 5457.181422786584, 5462.0, 5378.865528361793, 5413.512783849453, 5458.563314934806, 5509.752061157247, 5567.582431317647, 4927.3101765752735, 4985.376827896513, 5016.598672106241, 5055.39335279767, 5086.160783470723, 218.25357625568446, 4852.951470485285, 4925.0, 4930.950690493103, 4957.603391728653, 4991.450940396553, 5045.167547354682, 5047.419546752134, 5050.090983622947, 5099.413567439737, 4910.950890491121, 4916.483769204217, 4933.062718083588, 4954.578860796837, 4973.403191616993, 4783.856484305476, 4857.611391088704, 4871.805127794884, 4941.530554597308, 4953.578945789613, 5319.627626066177, 5348.171033489776, 5355.919661205085, 5356.196570514454, 5361.517463428271, 5940.821775346746, 5973.940260597382, 5975.850603734898, 5985.191999080112, 5991.4308140727, 5764.769409223626, 5877.030290002144, 5949.553783466214, 6003.549733769941, 6037.4566289033755, 5535.114381698909, 5552.139418390156, 5555.611107222496, 5567.415421380737, 5574.303212098488, 5884.735186916599, 6097.603655762361, 6100.969495152496, 6108.602940808833, 6114.663693496811, 5693.0, 5799.797007104731, 5879.470847623735, 5928.436798504135, 5955.13650520672, 5890.676012819336, 5922.851928701817, 5960.344362120163, 5960.910586341209, 5971.014782560916, 5742.913856292159, 5929.110633404937, 5939.138824870456, 5945.256842894638, 5951.9107213391835, 5757.827265182052, 5822.621529600562, 5877.882442351214, 5897.911531327033, 5962.195103661037, 4555.385023021916, 4557.977210113994, 4562.1560011398, 4566.383538222364, 4605.424321959755, 4002.3796311571755, 4065.8170382332864, 4088.9182216355507, 4099.241640296555, 4120.340745480708, 5509.724513774376, 5537.640053396516, 5554.527865131509, 5594.13290939905, 5623.325200975909, 5959.0, 5959.404059594006, 5973.402659734079, 5973.940260597338, 5976.641401515923, 5543.556515478752, 5594.328680558359, 5599.356074051455, 5602.467765562346, 5613.550915926716, 4841.95158048415, 4962.106820772224, 4973.055119527278, 5027.095122877844, 5070.062038522885, 6093.11649810775, 6145.385461453819, 6161.260648722182, 6181.81454556364, 6183.659898705614, 5767.653940763567, 5847.707614619252, 5906.497947674496, 5907.497862681548, 5919.970400147971, 6029.638221706711, 6125.571210015256, 6128.361907045618, 6183.412575805291, 6199.969000154971, 5855.092460668603, 5876.500497457764, 5888.17565540816, 5901.380355062656, 5928.67392293428, 5727.0550359190265, 5816.94183058164, 5962.672053036951, 5982.252218472691, 6004.789832356021, 5774.942250577608, 5852.590318677822, 5853.970730146322, 5855.473007429352, 5904.61619994699, 5739.512141468022, 5745.97127014379, 5763.164341170591, 5766.798162064308, 5792.333881603669, 5507.008738427122, 5572.331320241597, 5638.0, 5684.602077854511, 5687.687177205128, 5800.883982320245, 5811.4479124483105, 5812.0, 5841.737121829443, 5855.3266374367495, 5693.658380497018, 5706.743196556082, 5708.486236238592, 5720.742566584597, 5726.312842458931], "unit": "score", "name": "dojo.html", "value": 5399.4467000989425}, {"lowerIsBetter": false, "replicates": [525.9053370393331, 537.1968906484805, 543.7036814935859, 556.4074260912129, 573.7819628541156, 27049.0, 35430.1142471438, 35559.4666080009, 35841.82079089601, 35864.0, 38509.0, 38872.611273887254, 38904.61095389045, 38978.41532377017, 38993.41509877354, 8440.155984401572, 8539.1887770662, 8559.400841941067, 8607.784805379884, 8624.439411438269, 8306.584670766468, 8362.372822038342, 8393.580320983958, 8397.706080287191, 8447.619857106445, 8319.168083191693, 8366.581670916461, 8398.076211616717, 8399.580020998956, 8434.62044208012, 8372.16278372164, 8477.406581539295, 8480.363972702042, 8494.0, 8497.065322814486, 8259.38054645904, 8363.20549547792, 8376.581170941428, 8411.1588841116, 8635.52504612246, 39061.609383906085, 39417.40873886894, 39511.60488395137, 39601.60398396008, 39692.20615587701, 3173.841307934594, 3210.133264018702, 3237.320162765822, 3245.2211469247445, 3309.3546758382126, 28680.42639147226, 29587.704122958927, 29590.26024349387, 29747.553786693, 30165.69834301651, 3855.3253180693546, 3991.341428664267, 3997.6801855851463, 4031.5766844481495, 4043.433919251307, 218825.0, 218963.0, 219618.90190549105, 220060.0, 220267.9999999984, 52925.2061219082, 58543.41456585465, 59890.0, 59960.40039599635, 60208.39791602028, 51250.974980500185, 65426.67286663536, 65645.67177164083, 65832.0, 65996.34003659998, 14949.177795221367, 15150.242487875563, 15215.31531081104, 15340.616484587752, 15379.307931143125, 11688.94155529217, 11727.589534366256, 11728.0, 11763.353015584054, 11879.524819007143, 19378.0, 19586.31447899317, 19640.607187856163, 19667.803321966596, 20188.798112018692, 7645.732399365996, 7910.649142971342, 7915.802104947307, 7935.682572697143, 7976.5612891290375, 894.4141587260355, 899.4243684042218, 904.7104926423613, 1062.6918193723734, 1079.578964203961, 27375.315617109733, 27418.45163096727, 27603.723962760516, 27694.169174924784, 27838.16485505438, 1083.5449111373084, 1112.8386383974278, 1112.9833052504218, 1126.5155982927256, 1135.9719453894238, 14529.0, 14784.482543111155, 16209.675806483805, 16522.917385413235, 16644.916775416044, 295921.0, 297641.0, 298649.0, 298834.0, 300408.0, 49805.252921206215, 49869.25196122061, 50240.0, 50256.74871625618, 50310.24534631983, 1308.8167656528094, 1341.3494455189225, 1349.7435487257194, 1355.8169647097714, 1359.8164247826417, 27487.587686184324, 29033.7096629031, 29623.0, 29764.55353169661, 30117.247068823453, 45101.54898451105, 45524.0, 45673.54326456826, 45718.54281457276, 45722.08555828931, 311740.0, 311743.0, 311833.0, 312033.0, 313854.0, 32070.83964580162, 42143.789281053396, 42755.0, 43179.35230971475, 43279.78360108179, 45035.32447013232, 45885.31172032355, 46326.53673463357, 46754.0, 46766.76616616895, 33077.338453231285, 33530.497042543895, 33759.324813504085, 33866.322673545896, 34166.65833341734, 33567.0, 33598.0, 34076.14809629779, 34153.65846341604, 34227.0, 32842.50736238911, 33496.1625959353, 33566.0, 33729.15677108092, 35403.64596354003, 29625.703742962294, 32446.35107297888, 32630.34739305248, 32917.50623740598, 32987.17532061718, 24418.145364912143, 24785.25644230604, 25254.873725631252, 25302.240932772045, 27023.86488067547], "unit": "score", "name": "ext.html", "value": 18220.50977902438}, {"lowerIsBetter": false, "replicates": [356.2696472231924, 359.2724732416857, 359.5613351710915, 363.7980920589073, 364.23147159493465, 13450.260235687034, 13542.526011589596, 16487.75268370974, 16585.0, 16997.320107195712, 15810.683786324267, 15895.841041589609, 16453.095079770606, 16607.750883736724, 16717.83282167178, 4686.976565117169, 4870.2694595810735, 4870.902581948359, 4871.878203044935, 4874.147024270738, 4776.90446191076, 5135.717535535544, 5278.340207474066, 5285.550728188108, 5299.152135658295, 5191.0656081905245, 5238.345206849144, 5247.47525247476, 5263.289455923439, 5511.283533140686, 5506.669599823983, 5508.063629183009, 5529.502344788968, 5534.0, 5536.141898005815, 5200.791968321262, 5304.840854774363, 5310.256564081032, 5321.068812957717, 5438.320209973754, 12644.051696122828, 12760.489580416772, 12917.095803293772, 13778.724425511433, 19712.112954917062, 2008.2067583304658, 2040.9489762755902, 2053.722747429093, 2142.2180903970093, 2163.134746101556, 9543.522823858779, 10469.985577162197, 12260.141790074698, 12376.690582735413, 12798.61604151877, 1638.852503274711, 1673.6401673640105, 1684.7220208665556, 1692.949211523644, 1694.8305169483076, 58254.417455825744, 59538.70230648862, 60477.6976115121, 61874.69062654703, 63200.0, 10186.134178594903, 10298.845517317246, 10343.327683700536, 10356.844647330296, 10418.21863360251, 13600.183988960694, 13666.18002919828, 13714.65713357174, 13802.0, 13807.930960345135, 7458.067741532309, 7541.7360392386, 7554.8866766998535, 7563.773086807405, 7582.582957937256, 7101.218865924744, 7118.572885626879, 7141.9642901785155, 7153.606551639606, 7156.24859389767, 4392.626626736763, 4462.7768611569945, 4529.38853254813, 4532.32015197723, 4552.157850797613, 1867.738516607676, 1940.7282980382759, 1943.0770384067737, 1960.7058941158941, 1965.1746266568075, 470.05988023952096, 885.6634478897978, 922.4557511068367, 978.7014960437135, 979.2264111352094, 10733.463326833627, 11001.119910407147, 11176.552937882556, 11180.161487888277, 11331.943340283411, 468.17834700101787, 472.0841567359312, 473.63592852585026, 474.8456751555758, 476.1928531139685, 5938.732757025944, 6104.511639068864, 6120.326764055951, 6197.870075611787, 6215.844603884939, 492084.0, 492704.0, 492957.0, 534555.0, 575429.0, 42583.0, 54863.17705234425, 78215.21784782193, 79076.0, 80977.19022809697, 509.22597651570146, 514.0233556243168, 515.4716415673964, 515.6570880364591, 516.5764073459802, 10283.331583447052, 10323.793524129325, 14416.13503189812, 14597.489087881873, 14871.40514379456, 31116.222094446915, 31861.840690796398, 32057.839710801298, 32137.839310803298, 33116.83441582873, 35391.29217415586, 49871.251931221785, 50157.49842501674, 50308.49691503038, 50874.74562627163, 14345.211013394364, 14530.709385812435, 14918.627034324229, 15479.458218962282, 15540.222988850739, 11130.721731956766, 11263.943680281545, 11836.881631183578, 11842.28946263227, 19517.70723439121, 10099.495025248854, 10320.22598305115, 10398.74003149897, 10472.266941314036, 10481.109105726098, 10059.446730429603, 10238.590456381662, 10324.0, 10446.42544660051, 10521.4739263035, 10399.376037437778, 10694.57221711154, 10724.410157441416, 10933.18001149933, 10941.343519388862, 14461.49384771528, 14578.708425831212, 14825.555233343017, 14926.402943882124, 15149.772753408928, 15154.3180556873, 15234.466793662168, 15262.618434539225, 15391.615209619402, 15586.688266234838], "unit": "score", "name": "jquery.html", "value": 8044.720422819832}, {"lowerIsBetter": false, "replicates": [1440.251069443889, 1465.3186268385198, 1597.2812234494472, 1736.4096207289535, 1771.725382565702, 6751.156105486814, 6838.931610683891, 7460.403167746581, 7637.23627637236, 7657.578833164173, 7215.747448839292, 7278.454115941299, 7322.890156647654, 7324.670389832457, 7367.8158046048875, 2269.546090781842, 2281.167373908528, 2289.221664634024, 2296.540691861626, 2312.1791763923816, 2303.3780879162614, 2337.030132495021, 2340.5903966805827, 2341.590221711202, 2343.039353864916, 2302.458922153293, 2313.803326717231, 2320.709911261092, 2338.286822519131, 2343.9179628713, 2284.680144779732, 2308.0998410619786, 2332.370260029791, 2335.252719129879, 2343.8593684378993, 2300.608896487601, 2323.0707716913203, 2328.7671232876746, 2330.6154484510034, 2340.8829558522007, 7793.142754297023, 7879.527228366259, 7894.842103157962, 7906.64420101091, 7911.367090632735, 4718.292256161569, 4750.786214620351, 4754.904901901942, 4781.689190202661, 4801.0, 3103.7982531135403, 3143.3241853001487, 3144.921376965571, 3160.478521044048, 3183.4269831430565, 1027.696829435311, 1034.0745033195324, 1044.7544826965657, 1057.318029870729, 1061.8247989081792, 10902.127829773599, 10948.3978381189, 11002.50488728009, 11011.83482247767, 11043.558257669683, 4316.266234740039, 4337.7397356158735, 4376.081022985209, 4425.159219748238, 4441.555844415532, 9348.485833279236, 9384.155426011692, 9404.90595094054, 9446.574904129331, 9470.0, 4874.098291816025, 4897.730624815598, 4914.8771280718265, 4918.8770280743265, 4920.926186107211, 4201.390798334224, 4265.53079161292, 4270.829166833354, 4287.185434767384, 4392.450943632046, 3522.1018640246575, 3536.929261414809, 3558.0749005258817, 3567.94648080279, 3568.37553428149, 1091.5251865438559, 1104.7017305327518, 1108.7394462301352, 1116.4864162485185, 1118.7370967822555, 1266.1453518874907, 1273.866244044362, 1292.5605294200018, 1344.6907211341447, 1346.5421756602802, 7263.0, 7296.6716497757725, 7314.561126332437, 7319.926800732031, 7327.413806895435, 487.48570258377043, 494.7130664214747, 496.95278948500555, 496.9577585905166, 497.20943699517215, 5768.336641286306, 5830.8542286442325, 5839.445252700986, 5840.328362238312, 5855.443732845373, 8843.646254149891, 9282.932462766868, 9293.90706092944, 9307.488088155216, 9425.575849086808, 9128.680496182735, 9150.725478235663, 9152.130547597968, 9244.445333280024, 9261.861072083924, 6683.632400217937, 6838.692258848463, 6850.520463567503, 6851.965740171367, 7056.50604457683, 7256.455765817479, 7361.668724907285, 7366.152892417441, 7371.557706537625, 7391.704331826667, 8145.592720364077, 8223.17768223173, 8404.033536143423, 8417.663293468193, 8429.536375499407, 8638.91361086381, 8723.389362744547, 8728.91271087281, 8740.694075707319, 8775.0, 6488.772892948724, 6601.075849381186, 6615.5038372123245, 6666.83332916681, 6691.364320389555, 7431.331180193809, 7450.95686603865, 7466.440016998638, 7487.625618719151, 7500.062492188476, 6508.121403610452, 6578.868422631616, 6664.633445160563, 6768.424683901923, 6860.656967151523, 6830.5218634697085, 6872.175338959357, 6875.449964002968, 6947.305269473012, 6965.930340696528, 6868.107146070979, 6908.3091690830515, 6919.896201557081, 6958.304169583002, 7000.964995174992, 6556.672166391566, 6582.473402127723, 6598.934010660024, 6602.735890564516, 6610.305917878553, 6549.541532092708, 6560.081588577698, 6585.5719378240265, 6604.570702904296, 6616.536842420985], "unit": "score", "name": "mootools.html", "value": 4406.337976779597}, {"lowerIsBetter": false, "replicates": [340.09873834339, 344.83620280366813, 347.4076699227817, 348.81687114265026, 355.02545512567997, 6175.969120154404, 6209.844753881155, 6307.211598550187, 6310.810675679725, 6366.5861718988235, 6216.222972128484, 6227.5952063115865, 6252.124702541648, 6254.280757712864, 6265.498760099193, 4781.115493633672, 4781.378420805299, 4784.138855006097, 4794.2329227323635, 4795.712257264575, 4783.330333753277, 4794.472608013116, 4798.928016079744, 4803.327534145223, 4804.351412559295, 4664.207084795593, 4678.929816052745, 4719.598834099105, 4736.52634736527, 4750.144973904696, 4723.7874295656775, 4728.125296820082, 4734.0, 4734.053189362107, 4738.976305118486, 4098.52866920305, 4121.732087414309, 4139.19285739281, 4143.461350024508, 4146.875593732163, 5942.613730107572, 5944.762209511658, 5945.078512830518, 5963.880722385571, 5964.194833697438, 5362.276092727471, 5461.371942226655, 5473.042217611902, 5475.315585551806, 5504.669719816784, 6555.475561955032, 6561.868762624768, 6572.967135164341, 6575.11235983141, 6586.440152587036, 4523.321501774727, 4535.569120933506, 4543.477500087499, 4549.385832912548, 4551.886202844922, 6699.3300669933105, 6781.8643627127185, 6844.623545704984, 6849.349311815419, 6852.074969879102, 4637.8840528986375, 4650.255959046536, 4657.3246879202325, 4660.0, 4663.603593694574, 4704.529547045268, 4713.08094921487, 4715.174844402284, 4716.504766999485, 4721.362616046858, 5453.10023846061, 5462.590305727007, 5469.097598896217, 5478.863028424321, 5484.341878974469, 6451.225852897588, 6590.2421221560135, 6655.201375834834, 6669.366410191024, 6671.46628269747, 1632.2328505602347, 1656.1057029204094, 1665.9750103748454, 1669.732842745155, 1670.3736098962888, 1099.9010089092021, 1118.3737107219983, 1119.4290911635126, 1121.170333952869, 1129.2772625519674, 6190.535709821691, 6246.312905580383, 6248.0, 6262.780802671885, 6269.8746025079245, 6661.4004739573675, 6681.966590167115, 6694.196696396366, 6703.162104736908, 6704.2625311215725, 6088.969555152196, 6253.343398943045, 6255.718492667841, 6258.624482531062, 6261.530385221035, 3606.441001644749, 3621.0766254604905, 3623.1847834237087, 3624.7643903146213, 3635.9818200908826, 7026.297370262932, 7038.331358520933, 7050.435965122778, 7060.54106483077, 7061.223265440797, 6743.865122697519, 6840.897386539206, 6869.7595584154315, 6884.965575172092, 6894.13823272091, 7053.858922821515, 7061.0, 7077.84125841613, 7081.044059052065, 7090.787276381717, 6612.768553100618, 6631.0716499689115, 6648.135742353463, 6669.566478178903, 6701.765438209639, 6537.5750576212395, 6583.30875258091, 6625.900611490928, 6650.800475985729, 6661.666916654245, 6997.090378250795, 7021.1574611047, 7034.47241456903, 7034.718611255493, 7060.71757129709, 4598.494165641843, 4625.491195968508, 4626.1904166771355, 4634.37435946143, 4641.791119399568, 6678.83302917431, 6722.0, 6724.865502690017, 6733.831654208684, 6828.760993365208, 6631.933680663132, 6661.500387470862, 6664.66676666155, 6691.364320389555, 6697.531172817856, 6637.137172167587, 6665.800025999228, 6672.366125218096, 6673.5318229989325, 6677.9332206679255, 6436.774712885027, 6503.057056726842, 6504.544681872224, 6534.411902928759, 6540.640264785482, 6653.367930046637, 6675.532712710258, 6680.933190668031, 6682.83292917681, 6719.092922455406, 6523.739050437929, 6535.934640653722, 6538.280789113099, 6540.967295163494, 6558.901616475852], "unit": "score", "name": "prototype.html", "value": 4960.409482053728}, {"lowerIsBetter": false, "replicates": [754.6792613139417, 786.2255678157014, 816.3591580609223, 822.9012518497777, 847.9024912135106, 12378.38108094595, 12515.374231288444, 12547.623571292865, 12618.936905315484, 12668.49326026959, 12337.691557711061, 12363.072769542276, 12439.0, 12446.81329780054, 12456.439460224288, 786.850498405304, 805.730080423059, 807.6728924785472, 815.7104227999034, 816.7958010497375, 805.6938363421891, 809.6882700160422, 812.0215140755375, 812.8740045292959, 813.4712436916022, 854.0520022774715, 854.9273311768476, 855.9358048146382, 857.0615176381851, 857.5069335132292, 846.7925358287259, 848.5375470368664, 848.961796719146, 849.7280870121564, 859.1151114352195, 621.2606997672755, 625.9812205633838, 626.0702856258453, 631.3780925788095, 633.8637193003526, 13558.525451609245, 13669.521566745216, 13689.726205475934, 13692.931535342359, 13723.0, 11630.0, 11700.297982121016, 11821.881781182165, 12239.938800305941, 12434.253944763253, 9725.56234969428, 9872.950635246849, 10338.638147664871, 10443.791124177475, 10514.474276286155, 3637.6180501047274, 3647.562292524914, 3654.707623390149, 3709.7217708671956, 3770.472133901256, 43447.348289775364, 43463.78268108671, 43489.130217395475, 43844.342334865, 43939.12121757547, 9270.165685088374, 9584.472853992958, 9605.615775369046, 9920.305578609428, 10018.448985305879, 16400.26198821056, 16498.67002659964, 16588.58528536796, 16620.83379166217, 17242.0, 7026.578405295699, 7339.7064117435775, 7362.595057271901, 7481.438892083115, 7614.505057171266, 4293.935590966138, 4319.935200971988, 4334.566543345641, 4393.362962370438, 4403.955960440355, 3111.0977816433433, 3125.9218519537194, 3135.561021456998, 3137.074563003919, 3137.8901738439044, 560.2520634952302, 562.2971285892634, 568.2101878389043, 571.3657839797821, 582.5659883386819, 640.1805688718448, 679.4971720926577, 687.8540242929441, 691.4399336537421, 702.1143101851387, 8476.915230847735, 8510.78723031929, 9091.409058411182, 9124.817503650023, 9461.810763784824, 557.5790278339908, 569.5699746691305, 574.6035235687363, 583.5681595619211, 633.9587926784744, 3807.2956503047026, 3813.5423749149722, 4055.959440405617, 4114.382842573638, 4153.626173644326, 52965.0, 53742.0, 53916.0, 54489.72755136199, 57500.0, 44660.55339446629, 45815.77092114585, 51655.22517162246, 52175.47824521706, 52304.21543676848, 45904.540954590695, 46101.76949115233, 46832.29751553729, 47010.76494617573, 47127.76436117797, 8245.0, 8325.54209518458, 8562.400631955703, 8637.870431943651, 8734.868976965223, 30530.236744081576, 30690.0, 30896.382072358876, 32424.675753243107, 32878.17804554905, 42422.575774243094, 45245.321320179566, 46937.0, 47072.0, 47228.52771472379, 10554.78890422172, 10945.890541094806, 10984.340939543334, 11158.44207789591, 11338.943305283421, 12127.939360303142, 12238.632841014783, 12332.876671233173, 12350.258984460961, 12499.500019999461, 11267.605633802777, 11378.772424551627, 11420.828687569527, 11533.250338728292, 11829.231099978819, 11321.0, 11594.478248479007, 11618.825717614412, 11977.700557486132, 12007.279563226235, 11212.55149793999, 11498.77002459963, 11662.300261984308, 11920.821187682019, 11932.28406295625, 9674.70975870725, 9858.55636496345, 9873.210143188671, 10210.897891020995, 10268.486575671335, 9108.608740023554, 9422.434653920787, 9492.240620750184, 9900.603975840886, 10058.29591928558], "unit": "score", "name": "yui.html", "value": 6234.814469201682}], "name": "dromaeo_css", "value": 6899.421170119017}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 113.0, 109.0, 109.0, 119.0, 109.0, 112.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [150.0, 135.0, 150.0, 165.0, 139.0, 151.0, 160.0, 126.0, 173.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 163.0, 162.0, 165.0, 167.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 75.0, 132.0, 73.0, 73.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 147.0, 96.0, 97.0, 97.0, 142.0, 97.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [104.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [59.0, 62.0, 62.0, 59.0, 58.0, 61.0, 58.0, 60.0, 63.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [95.0, 86.0, 87.0, 86.0, 85.0, 85.0, 86.0, 88.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 120.0, 130.0, 124.0, 126.0, 121.0, 126.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [143.0, 154.0, 163.0, 157.0, 154.0, 155.0, 158.0, 153.0, 155.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 69.0, 78.0, 69.0, 69.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1526.1000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [196.30938358853552], "unit": "score", "name": "DeltaBlue", "value": 336.80509200000006}, {"lowerIsBetter": false, "replicates": [283.84899233607723], "unit": "score", "name": "Encrypt", "value": 937.7556629999997}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [725.6894049346879], "unit": "score", "name": "Earley", "value": 918.3860139999999}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [592.0663114268798], "unit": "score", "name": "Splay", "value": 137.63829900000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21222.825621415028}]} 07:10:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21222.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1526.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6899.42"}}} 07:10:40 INFO - Return code: 0 07:10:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:40 INFO - # TBPL SUCCESS # 07:10:40 INFO - Running post-action listener: _resource_record_post_action 07:10:40 INFO - Running post-run listener: _resource_record_post_run 07:10:41 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556269568; Read time: 8; Write time: 464236 07:10:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235282432; Read time: 0; Write time: 286004 07:10:41 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320704512; Read time: 8; Write time: 178204 07:10:41 INFO - Running post-run listener: _upload_blobber_files 07:10:41 INFO - Blob upload gear active. 07:10:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:10:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:10:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:10:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:10:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:10:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:10:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:42 INFO - (blobuploader) - INFO - Done attempting. 07:10:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:10:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:10:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:43 INFO - (blobuploader) - INFO - Done attempting. 07:10:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:43 INFO - Return code: 0 07:10:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:10:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/684695a84fda3927133782eafacb6c4610a0afcbe876b2365d990c1b2f4630fa7a3728533336ae5df8bfc54aba821c4789e796e46757eff7fa45c9b9d920c9e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ed6755ef7f2a9b91d6ca40fad05c273d1260e98db391bf97f5e3493ead3a7167e0c88d0566bcecafafe212c11e3916299b4653a52009d5a685c81d796926be6"} 07:10:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:10:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:10:43 INFO - Contents: 07:10:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/684695a84fda3927133782eafacb6c4610a0afcbe876b2365d990c1b2f4630fa7a3728533336ae5df8bfc54aba821c4789e796e46757eff7fa45c9b9d920c9e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ed6755ef7f2a9b91d6ca40fad05c273d1260e98db391bf97f5e3493ead3a7167e0c88d0566bcecafafe212c11e3916299b4653a52009d5a685c81d796926be6"} 07:10:43 INFO - Copying logs to upload dir... 07:10:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.611681 ========= master_lag: 72.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2016-01-02 07:11:55.058152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 07:11:55.061840) ========= 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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 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/684695a84fda3927133782eafacb6c4610a0afcbe876b2365d990c1b2f4630fa7a3728533336ae5df8bfc54aba821c4789e796e46757eff7fa45c9b9d920c9e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ed6755ef7f2a9b91d6ca40fad05c273d1260e98db391bf97f5e3493ead3a7167e0c88d0566bcecafafe212c11e3916299b4653a52009d5a685c81d796926be6"} build_url:https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/BnuutvNfQgSnDGCABRD5mQ/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/684695a84fda3927133782eafacb6c4610a0afcbe876b2365d990c1b2f4630fa7a3728533336ae5df8bfc54aba821c4789e796e46757eff7fa45c9b9d920c9e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ed6755ef7f2a9b91d6ca40fad05c273d1260e98db391bf97f5e3493ead3a7167e0c88d0566bcecafafe212c11e3916299b4653a52009d5a685c81d796926be6"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 07:11:55.200186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 07:11:55.200569) ========= 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=21869f6c619b95355032545b000001da-1451743405.95587-1018975679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 07:11:55.227090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 07:11:55.227414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 07:11:55.227721) ========= ========= Total master_lag: 72.87 =========