builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1456570756.66 results: success (0) buildid: 20160222065616 builduid: 9e95d762599340abad2cb4ba43c2f2b7 revision: 0c7dfc6d57d70816a6b07393f67f8b3747e6486d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.660687) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.661096) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.661391) ========= 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006508 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.727955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.728234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.870807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.871127) ========= 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.940700) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.940959) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.941293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:16.941562) ========= 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 02:59:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-02-27 02:59:17 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182596 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.149817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.150090) ========= 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019676 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.233665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.234008) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0c7dfc6d57d70816a6b07393f67f8b3747e6486d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0c7dfc6d57d70816a6b07393f67f8b3747e6486d --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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 02:59:18,029 truncating revision to first 12 chars 2016-02-27 02:59:18,029 Setting DEBUG logging. 2016-02-27 02:59:18,029 attempt 1/10 2016-02-27 02:59:18,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0c7dfc6d57d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 02:59:18,309 unpacking tar archive at: mozilla-aurora-0c7dfc6d57d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586348 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.833841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.834136) ========= echo 0c7dfc6d57d70816a6b07393f67f8b3747e6486d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0c7dfc6d57d70816a6b07393f67f8b3747e6486d'] 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0c7dfc6d57d70816a6b07393f67f8b3747e6486d program finished with exit code 0 elapsedTime=0.003957 script_repo_revision: '0c7dfc6d57d70816a6b07393f67f8b3747e6486d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.881249) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.881521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 02:59:17.891501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-27 02:59:17.891760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:18 INFO - MultiFileLogger online at 20160227 02:59:18 in /builds/slave/test-pgo 02:59:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:59:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:59:18 INFO - {'append_to_log': False, 02:59:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:59:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:59:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:59:18 INFO - 'branch': 'Mozilla-Aurora', 02:59:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:18 INFO - 'config_files': ('talos/linux_config.py',), 02:59:18 INFO - 'default_actions': ('clobber', 02:59:18 INFO - 'read-buildbot-config', 02:59:18 INFO - 'download-and-extract', 02:59:18 INFO - 'populate-webroot', 02:59:18 INFO - 'create-virtualenv', 02:59:18 INFO - 'install', 02:59:18 INFO - 'run-tests'), 02:59:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:18 INFO - 'download_minidump_stackwalk': True, 02:59:18 INFO - 'download_symbols': 'ondemand', 02:59:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:18 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:18 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:18 INFO - 'installer_path': 'installer.exe', 02:59:18 INFO - 'log_level': 'info', 02:59:18 INFO - 'log_name': 'talos', 02:59:18 INFO - 'log_to_console': True, 02:59:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:18 INFO - 'opt_config_files': (), 02:59:18 INFO - 'pip_index': False, 02:59:18 INFO - 'sps_profile': False, 02:59:18 INFO - 'sps_profile_interval': 0, 02:59:18 INFO - 'suite': 'dromaeojs-e10s', 02:59:18 INFO - 'system_bits': '32', 02:59:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:18 INFO - 'title': 'talos-linux64-ix-065', 02:59:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:18 INFO - 'use_talos_json': True, 02:59:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:59:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:18 INFO - 'work_dir': 'build'} 02:59:18 INFO - ##### 02:59:18 INFO - ##### Running clobber step. 02:59:18 INFO - ##### 02:59:18 INFO - Running pre-action listener: _resource_record_pre_action 02:59:18 INFO - Running main action method: clobber 02:59:18 INFO - rmtree: /builds/slave/test-pgo/build 02:59:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:59:19 INFO - Running post-action listener: _resource_record_post_action 02:59:19 INFO - ##### 02:59:19 INFO - ##### Running read-buildbot-config step. 02:59:19 INFO - ##### 02:59:19 INFO - Running pre-action listener: _resource_record_pre_action 02:59:19 INFO - Running main action method: read_buildbot_config 02:59:19 INFO - Using buildbot properties: 02:59:19 INFO - { 02:59:19 INFO - "project": "", 02:59:19 INFO - "product": "firefox", 02:59:19 INFO - "script_repo_revision": "production", 02:59:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:59:19 INFO - "repository": "", 02:59:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:59:19 INFO - "buildid": "20160222065616", 02:59:19 INFO - "pgo_build": "True", 02:59:19 INFO - "basedir": "/builds/slave/test-pgo", 02:59:19 INFO - "buildnumber": 90, 02:59:19 INFO - "slavename": "talos-linux64-ix-065", 02:59:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:59:19 INFO - "platform": "ubuntu64_hw", 02:59:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:59:19 INFO - "branch": "mozilla-aurora", 02:59:19 INFO - "repo_path": "releases/mozilla-aurora", 02:59:19 INFO - "revision": "0c7dfc6d57d70816a6b07393f67f8b3747e6486d", 02:59:19 INFO - "stage_platform": "linux64-pgo", 02:59:19 INFO - "builduid": "9e95d762599340abad2cb4ba43c2f2b7", 02:59:19 INFO - "slavebuilddir": "test" 02:59:19 INFO - } 02:59:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 02:59:19 INFO - Running post-action listener: _resource_record_post_action 02:59:19 INFO - ##### 02:59:19 INFO - ##### Running download-and-extract step. 02:59:19 INFO - ##### 02:59:19 INFO - Running pre-action listener: _resource_record_pre_action 02:59:19 INFO - Running main action method: download_and_extract 02:59:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:59:19 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')]} 02:59:19 INFO - https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:59:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/test_packages.json 02:59:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/test_packages.json 02:59:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:59:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:59:20 INFO - Downloaded 1448 bytes. 02:59:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:59:20 INFO - Using the following test package requirements: 02:59:20 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:59:20 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:59:20 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:59:20 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'jsshell-linux-x86_64.zip'], 02:59:20 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:59:20 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:59:20 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:59:20 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:59:20 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:59:20 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:59:20 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:59:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:59:20 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:20 INFO - https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:22 INFO - Downloaded 23079161 bytes. 02:59:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:59:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:59:23 INFO - Return code: 0 02:59:23 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:59:23 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')]} 02:59:23 INFO - https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:59:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:59:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:59:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:30 INFO - Downloaded 23079161 bytes. 02:59:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:59:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:59:32 INFO - Return code: 0 02:59: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')]} 02:59:32 INFO - https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:59:33 INFO - Downloaded 10706572 bytes. 02:59:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:59:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 02:59:33 INFO - Return code: 0 02:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:33 INFO - https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:59:35 INFO - Downloaded 59960416 bytes. 02:59:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:59:35 INFO - mkdir: /builds/slave/test-pgo/properties 02:59:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:59:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:59:35 INFO - Contents: 02:59:35 INFO - build_url:https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:59:35 INFO - Running post-action listener: _resource_record_post_action 02:59:35 INFO - Running post-action listener: set_extra_try_arguments 02:59:35 INFO - ##### 02:59:35 INFO - ##### Running populate-webroot step. 02:59:35 INFO - ##### 02:59:35 INFO - Running pre-action listener: _resource_record_pre_action 02:59:35 INFO - Running main action method: populate_webroot 02:59:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:35 INFO - '--tppagecycles', 02:59:35 INFO - '7'], 02:59:35 INFO - 'tests': ['tsvgm']}}, 02:59:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:59:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:59:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:59:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'tests': ['damp', 'tps']}, 02:59:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['damp', 'tps']}, 02:59:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:59:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:35 INFO - 'other': {'tests': ['a11yr', 02:59:35 INFO - 'ts_paint', 02:59:35 INFO - 'tpaint', 02:59:35 INFO - 'sessionrestore', 02:59:35 INFO - 'sessionrestore_no_auto_restore']}, 02:59:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['a11yr', 02:59:35 INFO - 'ts_paint', 02:59:35 INFO - 'tpaint', 02:59:35 INFO - 'sessionrestore', 02:59:35 INFO - 'sessionrestore_no_auto_restore']}, 02:59:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['a11yr', 02:59:35 INFO - 'ts_paint', 02:59:35 INFO - 'tpaint', 02:59:35 INFO - 'sessionrestore', 02:59:35 INFO - 'sessionrestore_no_auto_restore']}, 02:59:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['a11yr', 02:59:35 INFO - 'ts_paint', 02:59:35 INFO - 'tpaint', 02:59:35 INFO - 'sessionrestore', 02:59:35 INFO - 'sessionrestore_no_auto_restore']}, 02:59:35 INFO - 'other_l64': {'tests': ['a11yr', 02:59:35 INFO - 'ts_paint', 02:59:35 INFO - 'tpaint', 02:59:35 INFO - 'sessionrestore', 02:59:35 INFO - 'sessionrestore_no_auto_restore']}, 02:59:35 INFO - 'other_nol64': {'tests': ['a11yr', 02:59:35 INFO - 'ts_paint', 02:59:35 INFO - 'tpaint', 02:59:35 INFO - 'sessionrestore', 02:59:35 INFO - 'sessionrestore_no_auto_restore']}, 02:59:35 INFO - 'svgr': {'tests': ['tsvgx', 02:59:35 INFO - 'tsvgr_opacity', 02:59:35 INFO - 'tart', 02:59:35 INFO - 'tscrollx', 02:59:35 INFO - 'cart']}, 02:59:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['tsvgx', 02:59:35 INFO - 'tsvgr_opacity', 02:59:35 INFO - 'tart', 02:59:35 INFO - 'tscrollx', 02:59:35 INFO - 'cart']}, 02:59:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'tests': ['tp5o']}, 02:59:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'talos_options': ['--e10s'], 02:59:35 INFO - 'tests': ['tp5o']}, 02:59:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'talos_options': ['--xperf_path', 02:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:35 INFO - 'tests': ['tp5n']}, 02:59:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:35 INFO - 'talos_options': ['--e10s', 02:59:35 INFO - '--xperf_path', 02:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:35 INFO - 'tests': ['tp5n']}}, 02:59:35 INFO - 'talos.zip': {'path': '', 02:59:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:35 INFO - Running post-action listener: _resource_record_post_action 02:59:35 INFO - ##### 02:59:35 INFO - ##### Running create-virtualenv step. 02:59:35 INFO - ##### 02:59:35 INFO - Running pre-action listener: _resource_record_pre_action 02:59:35 INFO - Running main action method: create_virtualenv 02:59:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:59:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 02:59:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:59:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:35 INFO - Using real prefix '/usr' 02:59:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:59:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:38 INFO - Installing pip.................done. 02:59:38 INFO - Return code: 0 02:59:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:38 INFO - Using env: {'DISPLAY': ':0', 02:59:38 INFO - 'HOME': '/home/cltbld', 02:59:38 INFO - 'LANG': 'en_US.UTF-8', 02:59:38 INFO - 'LANGUAGE': 'en_US:en', 02:59:38 INFO - 'LOGNAME': 'cltbld', 02:59:38 INFO - 'MAIL': '/var/mail/cltbld', 02:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:38 INFO - 'MOZ_NO_REMOTE': '1', 02:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:38 INFO - 'NO_EM_RESTART': '1', 02:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:38 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:38 INFO - 'SHELL': '/bin/bash', 02:59:38 INFO - 'SHLVL': '1', 02:59:38 INFO - 'TERM': 'linux', 02:59:38 INFO - 'TMOUT': '86400', 02:59:38 INFO - 'USER': 'cltbld', 02:59:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:38 INFO - '_': '/tools/buildbot/bin/python'} 02:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:59:38 INFO - Cleaning up... 02:59:38 INFO - Return code: 0 02:59:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:38 INFO - Using env: {'DISPLAY': ':0', 02:59:38 INFO - 'HOME': '/home/cltbld', 02:59:38 INFO - 'LANG': 'en_US.UTF-8', 02:59:38 INFO - 'LANGUAGE': 'en_US:en', 02:59:38 INFO - 'LOGNAME': 'cltbld', 02:59:38 INFO - 'MAIL': '/var/mail/cltbld', 02:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:38 INFO - 'MOZ_NO_REMOTE': '1', 02:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:38 INFO - 'NO_EM_RESTART': '1', 02:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:38 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:38 INFO - 'SHELL': '/bin/bash', 02:59:38 INFO - 'SHLVL': '1', 02:59:38 INFO - 'TERM': 'linux', 02:59:38 INFO - 'TMOUT': '86400', 02:59:38 INFO - 'USER': 'cltbld', 02:59:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:38 INFO - '_': '/tools/buildbot/bin/python'} 02:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:38 INFO - Downloading/unpacking psutil>=0.7.1 02:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:40 INFO - Installing collected packages: psutil 02:59:40 INFO - Running setup.py install for psutil 02:59:40 INFO - building 'psutil._psutil_linux' extension 02:59:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:59:41 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 02:59:41 INFO - building 'psutil._psutil_posix' extension 02:59:41 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 02:59:41 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 02:59:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:41 INFO - Successfully installed psutil 02:59:41 INFO - Cleaning up... 02:59:41 INFO - Return code: 0 02:59:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:59:41 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')]} 02:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:41 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')]} 02:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:41 INFO - Using env: {'DISPLAY': ':0', 02:59:41 INFO - 'HOME': '/home/cltbld', 02:59:41 INFO - 'LANG': 'en_US.UTF-8', 02:59:41 INFO - 'LANGUAGE': 'en_US:en', 02:59:41 INFO - 'LOGNAME': 'cltbld', 02:59:41 INFO - 'MAIL': '/var/mail/cltbld', 02:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:41 INFO - 'MOZ_NO_REMOTE': '1', 02:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:41 INFO - 'NO_EM_RESTART': '1', 02:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:41 INFO - 'SHELL': '/bin/bash', 02:59:41 INFO - 'SHLVL': '1', 02:59:41 INFO - 'TERM': 'linux', 02:59:41 INFO - 'TMOUT': '86400', 02:59:41 INFO - 'USER': 'cltbld', 02:59:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:41 INFO - '_': '/tools/buildbot/bin/python'} 02:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:59:41 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 02:59:41 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 02:59:41 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 02:59:41 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 02:59:41 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 02:59:41 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 02:59:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:59:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:59:43 INFO - Installing collected packages: mozsystemmonitor 02:59:43 INFO - Running setup.py install for mozsystemmonitor 02:59:43 INFO - Successfully installed mozsystemmonitor 02:59:43 INFO - Cleaning up... 02:59:43 INFO - Return code: 0 02:59:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:59:43 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')]} 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:43 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')]} 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:43 INFO - Using env: {'DISPLAY': ':0', 02:59:43 INFO - 'HOME': '/home/cltbld', 02:59:43 INFO - 'LANG': 'en_US.UTF-8', 02:59:43 INFO - 'LANGUAGE': 'en_US:en', 02:59:43 INFO - 'LOGNAME': 'cltbld', 02:59:43 INFO - 'MAIL': '/var/mail/cltbld', 02:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:43 INFO - 'MOZ_NO_REMOTE': '1', 02:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:43 INFO - 'NO_EM_RESTART': '1', 02:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:43 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:43 INFO - 'SHELL': '/bin/bash', 02:59:43 INFO - 'SHLVL': '1', 02:59:43 INFO - 'TERM': 'linux', 02:59:43 INFO - 'TMOUT': '86400', 02:59:43 INFO - 'USER': 'cltbld', 02:59:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:43 INFO - '_': '/tools/buildbot/bin/python'} 02:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:43 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:45 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:59:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:46 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 02:59:46 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 02:59:46 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 02:59:46 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 02:59:46 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 02:59:46 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 02:59:46 INFO - Downloading docopt-0.6.1.tar.gz 02:59:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:46 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:46 INFO - Running setup.py install for blobuploader 02:59:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:59:46 INFO - Running setup.py install for requests 02:59:46 INFO - Running setup.py install for docopt 02:59:47 INFO - Successfully installed blobuploader requests docopt 02:59:47 INFO - Cleaning up... 02:59:47 INFO - Return code: 0 02:59:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:59: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')]} 02:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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')]} 02:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 02:59:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 02:59:47 INFO - Using env: {'DISPLAY': ':0', 02:59:47 INFO - 'HOME': '/home/cltbld', 02:59:47 INFO - 'LANG': 'en_US.UTF-8', 02:59:47 INFO - 'LANGUAGE': 'en_US:en', 02:59:47 INFO - 'LOGNAME': 'cltbld', 02:59:47 INFO - 'MAIL': '/var/mail/cltbld', 02:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:47 INFO - 'MOZ_NO_REMOTE': '1', 02:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:47 INFO - 'NO_EM_RESTART': '1', 02:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:47 INFO - 'SHELL': '/bin/bash', 02:59:47 INFO - 'SHLVL': '1', 02:59:47 INFO - 'TERM': 'linux', 02:59:47 INFO - 'TMOUT': '86400', 02:59:47 INFO - 'USER': 'cltbld', 02:59:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:47 INFO - '_': '/tools/buildbot/bin/python'} 02:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:59:47 INFO - Running setup.py (path:/tmp/pip-w0J8qy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:59:47 INFO - Running setup.py (path:/tmp/pip-i3aHB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:59:47 INFO - Running setup.py (path:/tmp/pip-gymu_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:59:47 INFO - Running setup.py (path:/tmp/pip-Qc0uWe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:59:47 INFO - Running setup.py (path:/tmp/pip-TmvEeB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:59:47 INFO - Running setup.py (path:/tmp/pip-VHdik6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:59:47 INFO - Running setup.py (path:/tmp/pip-zvkNVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:59:47 INFO - Running setup.py (path:/tmp/pip-TXbdM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:59:47 INFO - Running setup.py (path:/tmp/pip-e55QNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:59:47 INFO - Running setup.py (path:/tmp/pip-tfWq53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:59:48 INFO - Running setup.py (path:/tmp/pip-SHVsAW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:59:48 INFO - Running setup.py (path:/tmp/pip-L_RX9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:59:48 INFO - Running setup.py (path:/tmp/pip-OOVeBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:59:48 INFO - Running setup.py (path:/tmp/pip-jQBohe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:59:48 INFO - Running setup.py (path:/tmp/pip-W3hptz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:59:48 INFO - Running setup.py (path:/tmp/pip-m7Fk25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:59:48 INFO - Running setup.py (path:/tmp/pip-S27xcw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:59:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:48 INFO - Running setup.py install for manifestparser 02:59:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:59:48 INFO - Running setup.py install for mozcrash 02:59:48 INFO - Running setup.py install for mozdebug 02:59:48 INFO - Running setup.py install for mozdevice 02:59:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:59:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:59:48 INFO - Running setup.py install for mozfile 02:59:49 INFO - Running setup.py install for mozhttpd 02:59:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Running setup.py install for mozinfo 02:59:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Running setup.py install for mozInstall 02:59:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Running setup.py install for mozleak 02:59:49 INFO - Running setup.py install for mozlog 02:59:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Running setup.py install for moznetwork 02:59:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Running setup.py install for mozprocess 02:59:49 INFO - Running setup.py install for mozprofile 02:59:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:59:49 INFO - Running setup.py install for mozrunner 02:59:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:59:50 INFO - Running setup.py install for mozscreenshot 02:59:50 INFO - Running setup.py install for moztest 02:59:50 INFO - Running setup.py install for mozversion 02:59:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:59:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:50 INFO - Cleaning up... 02:59:50 INFO - Return code: 0 02:59:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:59:50 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')]} 02:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:50 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')]} 02:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:50 INFO - Using env: {'DISPLAY': ':0', 02:59:50 INFO - 'HOME': '/home/cltbld', 02:59:50 INFO - 'LANG': 'en_US.UTF-8', 02:59:50 INFO - 'LANGUAGE': 'en_US:en', 02:59:50 INFO - 'LOGNAME': 'cltbld', 02:59:50 INFO - 'MAIL': '/var/mail/cltbld', 02:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:50 INFO - 'MOZ_NO_REMOTE': '1', 02:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:50 INFO - 'NO_EM_RESTART': '1', 02:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:50 INFO - 'SHELL': '/bin/bash', 02:59:50 INFO - 'SHLVL': '1', 02:59:50 INFO - 'TERM': 'linux', 02:59:50 INFO - 'TMOUT': '86400', 02:59:50 INFO - 'USER': 'cltbld', 02:59:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:50 INFO - '_': '/tools/buildbot/bin/python'} 02:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:59:50 INFO - Running setup.py (path:/tmp/pip-lu1Y9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:59:50 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)) 02:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:59:50 INFO - Running setup.py (path:/tmp/pip-6Z3_UJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:59:50 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)) 02:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:59:50 INFO - Running setup.py (path:/tmp/pip-u3ag9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:59:50 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)) 02:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:59:50 INFO - Running setup.py (path:/tmp/pip-IfFmdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:59:50 INFO - Running setup.py (path:/tmp/pip-3Qsf8j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:59:50 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)) 02:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:59:50 INFO - Running setup.py (path:/tmp/pip-O3i4Nl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 02:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:59:50 INFO - Running setup.py (path:/tmp/pip-eNBHbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:59:51 INFO - Running setup.py (path:/tmp/pip-V8NL7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:59:51 INFO - Running setup.py (path:/tmp/pip-k_W_63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:59:51 INFO - Running setup.py (path:/tmp/pip-S2GW3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:59:51 INFO - Running setup.py (path:/tmp/pip-UH_V5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:59:51 INFO - Running setup.py (path:/tmp/pip-j34R4t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:59:51 INFO - Running setup.py (path:/tmp/pip-mupBD9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:59:51 INFO - Running setup.py (path:/tmp/pip-piP4Dg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:59:51 INFO - Running setup.py (path:/tmp/pip-JNbmYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:59:51 INFO - Running setup.py (path:/tmp/pip-U7ovbE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:59:51 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)) 02:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:59:51 INFO - Running setup.py (path:/tmp/pip-aYPrq8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:59:51 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)) 02:59:51 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)) 02:59:51 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)) 02:59:51 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)) 02:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:51 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 02:59:51 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 02:59:51 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 02:59:51 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 02:59:51 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 02:59:51 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 02:59:53 INFO - Downloading blessings-1.6.tar.gz 02:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:53 INFO - Installing collected packages: blessings 02:59:53 INFO - Running setup.py install for blessings 02:59:53 INFO - Successfully installed blessings 02:59:53 INFO - Cleaning up... 02:59:53 INFO - Return code: 0 02:59:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:59:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:59:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:59:54 INFO - Reading from file tmpfile_stdout 02:59:54 INFO - Current package versions: 02:59:54 INFO - argparse == 1.2.1 02:59:54 INFO - blessings == 1.6 02:59:54 INFO - blobuploader == 1.2.4 02:59:54 INFO - docopt == 0.6.1 02:59:54 INFO - manifestparser == 1.1 02:59:54 INFO - mozInstall == 1.12 02:59:54 INFO - mozcrash == 0.16 02:59:54 INFO - mozdebug == 0.1 02:59:54 INFO - mozdevice == 0.48 02:59:54 INFO - mozfile == 1.2 02:59:54 INFO - mozhttpd == 0.7 02:59:54 INFO - mozinfo == 0.9 02:59:54 INFO - mozleak == 0.1 02:59:54 INFO - mozlog == 3.1 02:59:54 INFO - moznetwork == 0.27 02:59:54 INFO - mozprocess == 0.22 02:59:54 INFO - mozprofile == 0.28 02:59:54 INFO - mozrunner == 6.11 02:59:54 INFO - mozscreenshot == 0.1 02:59:54 INFO - mozsystemmonitor == 0.0 02:59:54 INFO - moztest == 0.7 02:59:54 INFO - mozversion == 1.4 02:59:54 INFO - psutil == 3.1.1 02:59:54 INFO - requests == 1.2.3 02:59:54 INFO - wsgiref == 0.1.2 02:59:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:54 INFO - Using env: {'DISPLAY': ':0', 02:59:54 INFO - 'HOME': '/home/cltbld', 02:59:54 INFO - 'LANG': 'en_US.UTF-8', 02:59:54 INFO - 'LANGUAGE': 'en_US:en', 02:59:54 INFO - 'LOGNAME': 'cltbld', 02:59:54 INFO - 'MAIL': '/var/mail/cltbld', 02:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:54 INFO - 'MOZ_NO_REMOTE': '1', 02:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:54 INFO - 'NO_EM_RESTART': '1', 02:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:54 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:54 INFO - 'SHELL': '/bin/bash', 02:59:54 INFO - 'SHLVL': '1', 02:59:54 INFO - 'TERM': 'linux', 02:59:54 INFO - 'TMOUT': '86400', 02:59:54 INFO - 'USER': 'cltbld', 02:59:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:54 INFO - '_': '/tools/buildbot/bin/python'} 02:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 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)) 02:59:54 INFO - Cleaning up... 02:59:54 INFO - Return code: 0 02:59:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:54 INFO - Using env: {'DISPLAY': ':0', 02:59:54 INFO - 'HOME': '/home/cltbld', 02:59:54 INFO - 'LANG': 'en_US.UTF-8', 02:59:54 INFO - 'LANGUAGE': 'en_US:en', 02:59:54 INFO - 'LOGNAME': 'cltbld', 02:59:54 INFO - 'MAIL': '/var/mail/cltbld', 02:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:54 INFO - 'MOZ_NO_REMOTE': '1', 02:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:54 INFO - 'NO_EM_RESTART': '1', 02:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:54 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:54 INFO - 'SHELL': '/bin/bash', 02:59:54 INFO - 'SHLVL': '1', 02:59:54 INFO - 'TERM': 'linux', 02:59:54 INFO - 'TMOUT': '86400', 02:59:54 INFO - 'USER': 'cltbld', 02:59:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:54 INFO - '_': '/tools/buildbot/bin/python'} 02:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:54 INFO - Downloading/unpacking jsonschema 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:56 INFO - Downloading/unpacking functools32 (from jsonschema) 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:56 INFO - warning: no files found matching '*.txt' 02:59:56 INFO - no previously-included directories found matching 'build' 02:59:56 INFO - no previously-included directories found matching 'dist' 02:59:56 INFO - no previously-included directories found matching '.git*' 02:59:56 INFO - Installing collected packages: jsonschema, functools32 02:59:56 INFO - Running setup.py install for functools32 02:59:56 INFO - warning: no files found matching '*.txt' 02:59:56 INFO - no previously-included directories found matching 'build' 02:59:56 INFO - no previously-included directories found matching 'dist' 02:59:56 INFO - no previously-included directories found matching '.git*' 02:59:56 INFO - Successfully installed jsonschema functools32 02:59:56 INFO - Cleaning up... 02:59:56 INFO - Return code: 0 02:59:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:59:56 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')]} 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:56 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')]} 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fead1bfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1150230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, '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': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', '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 02:59:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 02:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 02:59:56 INFO - Using env: {'DISPLAY': ':0', 02:59:56 INFO - 'HOME': '/home/cltbld', 02:59:56 INFO - 'LANG': 'en_US.UTF-8', 02:59:56 INFO - 'LANGUAGE': 'en_US:en', 02:59:56 INFO - 'LOGNAME': 'cltbld', 02:59:56 INFO - 'MAIL': '/var/mail/cltbld', 02:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:56 INFO - 'MOZ_NO_REMOTE': '1', 02:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:56 INFO - 'NO_EM_RESTART': '1', 02:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 02:59:56 INFO - 'SHELL': '/bin/bash', 02:59:56 INFO - 'SHLVL': '1', 02:59:56 INFO - 'TERM': 'linux', 02:59:56 INFO - 'TMOUT': '86400', 02:59:56 INFO - 'USER': 'cltbld', 02:59:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 02:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:56 INFO - '_': '/tools/buildbot/bin/python'} 02:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:57 INFO - Downloading/unpacking flake8 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:59:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:59:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:59:59 INFO - no previously-included directories found matching 'docs/_build' 02:59:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:59:59 INFO - Running setup.py install for pep8 02:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:59:59 INFO - no previously-included directories found matching 'docs/_build' 02:59:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:59:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:59:59 INFO - Cleaning up... 02:59:59 INFO - Return code: 0 02:59:59 INFO - Running post-action listener: _resource_record_post_action 02:59:59 INFO - Running post-action listener: _start_resource_monitoring 02:59:59 INFO - Starting resource monitoring. 02:59:59 INFO - ##### 02:59:59 INFO - ##### Running install step. 02:59:59 INFO - ##### 02:59:59 INFO - Running pre-action listener: _resource_record_pre_action 02:59:59 INFO - Running main action method: install 02:59:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:00:00 INFO - Reading from file tmpfile_stdout 03:00:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:00:00 INFO - Reading from file tmpfile_stdout 03:00:00 INFO - Output received: 03:00:00 INFO - Usage: mozinstall [options] installer 03:00:00 INFO - Options: 03:00:00 INFO - -h, --help show this help message and exit 03:00:00 INFO - -d DEST, --destination=DEST 03:00:00 INFO - Directory to install application into. [default: 03:00:00 INFO - "/builds/slave/test-pgo"] 03:00:00 INFO - --app=APP Application being installed. [default: firefox] 03:00:00 INFO - mkdir: /builds/slave/test-pgo/build/application 03:00:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:00:15 INFO - Reading from file tmpfile_stdout 03:00:15 INFO - Output received: 03:00:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:00:15 INFO - Running post-action listener: _resource_record_post_action 03:00:15 INFO - ##### 03:00:15 INFO - ##### Running run-tests step. 03:00:15 INFO - ##### 03:00:15 INFO - Running pre-action listener: _resource_record_pre_action 03:00:15 INFO - Running main action method: run_tests 03:00:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:00:15 INFO - Python 2.7.3 03:00:15 INFO - Return code: 0 03:00:15 INFO - grabbing minidump binary from tooltool 03:00:15 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')]} 03:00:15 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 0x11e27f0>, '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 0x114e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:00:15 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 03:00:15 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 03:00:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:15 INFO - Return code: 0 03:00:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:00:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:00:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:00:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:00:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:00:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:00:16 INFO - Return code: 0 03:00:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:00:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 03:00:16 INFO - Using env: {'DISPLAY': ':0', 03:00:16 INFO - 'HOME': '/home/cltbld', 03:00:16 INFO - 'LANG': 'en_US.UTF-8', 03:00:16 INFO - 'LANGUAGE': 'en_US:en', 03:00:16 INFO - 'LOGNAME': 'cltbld', 03:00:16 INFO - 'MAIL': '/var/mail/cltbld', 03:00:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:00:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:16 INFO - 'MOZ_NO_REMOTE': '1', 03:00:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:16 INFO - 'NO_EM_RESTART': '1', 03:00:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:00:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:00:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:00:16 INFO - 'SHELL': '/bin/bash', 03:00:16 INFO - 'SHLVL': '1', 03:00:16 INFO - 'TERM': 'linux', 03:00:16 INFO - 'TMOUT': '86400', 03:00:16 INFO - 'USER': 'cltbld', 03:00:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375', 03:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:16 INFO - '_': '/tools/buildbot/bin/python'} 03:00:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:00:16 INFO - mozversion application_buildid: 20160222065616 03:00:16 INFO - mozversion application_changeset: 0c7dfc6d57d70816a6b07393f67f8b3747e6486d 03:00:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:00:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:16 INFO - mozversion application_name: Firefox 03:00:16 INFO - mozversion application_remotingname: firefox-dev 03:00:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:00:16 INFO - mozversion application_vendor: Mozilla 03:00:16 INFO - mozversion application_version: 46.0a2 03:00:16 INFO - mozversion platform_buildid: 20160222065616 03:00:16 INFO - mozversion platform_changeset: 0c7dfc6d57d70816a6b07393f67f8b3747e6486d 03:00:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:00:16 INFO - mozversion platform_version: 46.0a2 03:00:16 INFO - using testdate: 1456570816 03:00:16 INFO - actual date: 1456570816 03:00:16 INFO - starting webserver on 'localhost:50837' 03:00:16 INFO - SUITE-START | Running 3 tests 03:00:16 INFO - TEST-START | dromaeo_css 03:00:16 INFO - operating with platform_type : linux_ 03:00:16 INFO - Initialising browser for dromaeo_css test... 03:00:16 INFO - TEST-INFO | started process 9017 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMXZCXo/profile http://localhost:50837/getInfo.html) 03:00:19 INFO - PROCESS | 9017 | 03:00:19 INFO - PROCESS | 9017 | (process:9096): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:00:20 INFO - PROCESS | 9017 | __metrics Screen width/height:1600/1200 03:00:20 INFO - PROCESS | 9017 | colorDepth:24 03:00:20 INFO - PROCESS | 9017 | Browser inner width/height: 1024/697 03:00:20 INFO - PROCESS | 9017 | __metrics 03:00:21 INFO - TEST-INFO | 9017: exit 0 03:00:21 INFO - Browser initialized. 03:00:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:21 INFO - TEST-INFO | started process 9145 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMXZCXo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:23 INFO - PROCESS | 9145 | 03:00:23 INFO - PROCESS | 9145 | (process:9209): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:00:33 INFO - PROCESS | 9145 | RSS: Main: 140881920 03:00:33 INFO - PROCESS | 9145 | 03:01:23 INFO - PROCESS | 9145 | 1456570883322 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] 03:03:30 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:50837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50837/tests/dromaeo/cssquery-ext.html) 03:03:31 INFO - PROCESS | 9145 | RSS: Main: 145321984 03:03:31 INFO - PROCESS | 9145 | 03:06:33 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:50837/tests/dromaeo/cssquery-ext.html (next: http://localhost:50837/tests/dromaeo/cssquery-jquery.html) 03:06:34 INFO - PROCESS | 9145 | RSS: Main: 144535552 03:06:34 INFO - PROCESS | 9145 | 03:09:36 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:50837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50837/tests/dromaeo/cssquery-mootools.html) 03:09:36 INFO - PROCESS | 9145 | RSS: Main: 142807040 03:09:36 INFO - PROCESS | 9145 | 03:12:38 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:50837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50837/tests/dromaeo/cssquery-prototype.html) 03:12:38 INFO - PROCESS | 9145 | RSS: Main: 142864384 03:12:38 INFO - PROCESS | 9145 | 03:15:41 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:50837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50837/tests/dromaeo/cssquery-yui.html) 03:15:41 INFO - PROCESS | 9145 | RSS: Main: 144400384 03:15:41 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:50837/tests/dromaeo/cssquery-yui.html (next: http://localhost:50837/tests/dromaeo/cssquery-dojo.html) 03:18:44 INFO - PROCESS | 9145 | RSS: Main: 146178048 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | __start_tp_report 03:18:44 INFO - PROCESS | 9145 | _x_x_mozilla_page_load 03:18:44 INFO - PROCESS | 9145 | _x_x_mozilla_page_load_details 03:18:44 INFO - PROCESS | 9145 | |i|pagename|runs| 03:18:44 INFO - PROCESS | 9145 | |0;dojo.html;3293.2260918684105;3310.6358300586944;3313.4035873542753;3342.5988881334238;3347.6819702128305;5316.9202461963005;5323.707196104213;5337.572994160468;5345.545628621567;5359.517643412092;5295.8146464873735;5320.494553017466;5354.625176237665;5375.978564072833;5387.649802762828;4851.078295123924;5003;5015.874603134915;5022.673526220802;5055.342805435288;4765.785539650724;4886.1204983103025;4939.012197560484;4942;5007.599392048627;4932.630052746041;4937.2840938063955;4983.551480366767;4999.375078115236;5002.499750025005;4924.384451943489;4927.088488629615;4937.21004639256;4950.381202349707;4957.677750946213;4757.1437141314545;4795.904081918377;4842.782074806642;4866.245731911559;4875.512448755132;5067.898642027176;5102.158143906251;5176.352955880515;5176.585873130178;5197.29836472079;5636.182753500761;5649.915251271234;5673.8297851064535;5681.602287839853;5728.398518155617;5677.574181936371;5702.885942281131;5709.8287051388525;5731.885362292731;5817.592768506206;5335.67985920846;5364.249005139283;5371.811986580451;5376.4085950545405;5384.703841288767;5811.244538210006;5833.766649334064;5834.124881267844;5836.533077353802;5841.649501029951;5568.888622227614;5596.048671725816;5621.213030175779;5640.32316122068;5660.066089095336;5672.858178545569;5706.9714651426475;5720.599558030898;5725.627834190765;5730.5129064030025;5677.261955945701;5684.6589204647025;5686.459786320293;5688.971555142198;5702.087665973424;5607.971960140173;5631.436856314336;5706.80026199081;5725.885482290331;5760.94239057604;4381.6494680425485;4386.188555117314;4420.756858372756;4424.911501770011;4426.070525189746;3980.3631418972827;4001.2597669431248;4005.218982298482;4014.237294913957;4031.9798401008393;5458.754356053987;5477.561795056386;5479.17812328146;5513.145462453326;5543.473370029841;5666.490015898589;5692.743826527816;5755.194272801811;5762.74067666956;5766.769329226784;5302.522772950376;5343.62594618373;5420.295361603045;5463.098588732814;5471.534919531805;4831.855044348676;4916.188828843272;4940.357753492023;4946.480619534969;4946.629002824802;5855.707214639251;5861.794837180678;5866.354700982888;5874.647521148745;5893.174955506232;5673.432656734293;5685.687287199161;5697.515711164598;5721.284839395075;5723.570732195185;5840.970795145997;5856.795012174553;5888.499477544457;5894.793682221101;5923.614965027259;5634.098544232903;5645.4072322405555;5648.124540696199;5661.46216109469;5674.914876276776;5668.574856885833;5727.39862314451;5727.513161381163;5729.369769325454;5765.308163020464;5610.607257491936;5640.435956404327;5643.435656434323;5647.604667673223;5661.773529058792;5563.693996830051;5564.4991950724625;5584.497395234286;5628.60599758013;5640.125780504029;5392;5484.725763711719;5539.639923404966;5540.722963851711;5630.63400878958;5599.80400685974;5613.382527921844;5652.576056795675;5656.830295091154;5675.57433192504;5461.563074954073;5495.53287970527;5511.255980442589;5514.696691681996;5525.696086715269 03:18:44 INFO - PROCESS | 9145 | |1;ext.html;560.5515587529976;560.7897038610523;576.5013263527045;576.6972339521751;592.4460629311594;30783.69216307836;31394.21514462137;37312.25375492489;37647.05882352943;37663.62336376635;41282.7935860321;41513;41630.58369416313;41987.16025679492;42087.158256834846;8690.435121717084;8898.065703101178;8907.599158037872;8909.331800114986;8931.41945773526;8613.956930215372;8635.654573817039;8637.136286371344;8705;8735.95632021839;8690.174433428845;8802.251808596246;9005.054469280696;9005.459672419644;9076.8638470423;8912.598933047995;8928.24109950655;8935.061818509028;8963.551822408854;9062.637494500212;8755;9010.909890901139;9048.502332371718;9060.093990600953;9077.63689452421;41877.162456750695;42417.57582424167;42461;42668.359974600404;42723;3872.845086196549;3931.3906344516645;3951.7036222283155;4208.284591619432;4318.352247162919;31391.84304078465;32025.51961720553;32073.198170045704;32283.83858080718;32506.6749332506;4199.370094485821;4250.511191213019;4292.377605247253;4292.763897985609;4304.117655880568;217951;218611;219920;220389;220961.89519052464;45273;45570;45925.77037114793;62941;64665.353346465934;43479.34780978288;43801.780991095475;43812;43884.78057609691;43964.78017609892;16753.32986680519;16851.57871053209;16858.072805995544;16964.660706785795;16991.320347185974;13450.663733406547;13526.391312390966;13539.796903046463;13547.864521354857;13594.932025340007;15392.923035384976;15413;15454.38182472711;15477.690446191013;15516.844831551765;6118.449339559461;6192.225971753531;6196;6294.716737746812;6310.5267104967315;1080.6757972608186;1114.8104822180248;1125.5835340923747;1168.456667649547;1178.5580407347245;30087.69912300849;30290;30526.54210186849;30907.84546077255;31074.378512430078;1140.4468832616174;1163.5404015413865;1224.4673566998383;1241.3234787041085;1281.7820970435048;17322.653546928992;17395.47813565595;17411.129443527774;17512.562185945197;17633.647327053386;325327;528256;872343;879396;881963;60125.398746012856;60852.391476085555;61028.69485652632;61087.694561527795;61423.38576614266;1480.9333579988927;1505.3451748489442;1509.1624148597414;1518.6355274734206;1522.5812901452189;31667.52498712475;32191.51712724358;32620.673793261765;32749;34794;54046.189307159635;54521.454785451635;54521.72739136279;54539.90920181653;54625.1806222899;328828;335252;336686;337035;338138;44478.55521444744;44721.32918006167;44825.55174448344;44874;44938.55061449343;47305.526944731486;48102.27846582234;48609.51390486192;48709.26936096032;49349;40424;40995.38506922339;41562.792186038874;42192.36711449392;42548.14903701847;41824;41961;42299.57700422956;42353;42388.78805605952;40901;41000.974975625846;41662.37506437467;41761.791191045064;41877.79061104675;36024.27951440904;36607.633923660425;37103.81448092742;37134.81432592928;37456.625433745314;28146.71853281523;28719.42561148807;28819.567706484;28846.278843029093;28923.132306030853 03:18:44 INFO - PROCESS | 9145 | |2;jquery.html;399.7541511970136;405.5559162716825;405.9411385349124;408.6485622364764;408.70981603061824;17800.554986125353;18062.277508899646;18162.27350905964;18467;18613.53466163345;16971.57571060721;17033.659326813457;17105.315787368523;17602.823971760277;17607.73588396172;5271.578273738101;5394.757235924393;5397.7571009304675;5402;5450.5639548836;5345.545628621572;5476.288082549263;5862.267216597926;5867;5881.029630111027;5423.186522021689;5658.264425624663;5803.912941305884;5823.854403639922;5848.67832269225;5580.888382232373;5596.608237423382;5607.943920560783;5630.296212973358;5635.520980716644;5307.469253074701;5542.5565954723525;5543.584231182637;5570.025245582007;5572.60991730579;13321.467141314335;13473.595792126252;14368.78446823288;14383.928080359636;14389.13665180082;2191.9671204931938;2305.0318866076286;2345.597276080571;2367.171489978511;2371.537550177716;10177.389356638625;10443.895561044368;10512.1590272778;10921.508532116073;14233.715325693429;1671.68238034773;1756.5169578365924;1884.547708549952;1923.422973108076;1935.400025991947;60890;61018.38981610171;62722.68638656823;63221.68389158025;63584.36415635831;10976.231663783617;11047.060999814945;11091.22361434708;11129;11217.04655104309;14812.851871481364;14831.18428486422;14863.18252496123;14891.776623350659;14913.776293355608;8733.475991440533;8759.124087591317;8779.473231606124;8795.780105497413;8811.074837142136;8699.347548933856;8751.518666473277;8791.604377802887;8820.2061814437;8865.379423440427;4649.372334734768;4684.81260749573;4718.457377401643;4730.408698912636;4786.234202527578;1935.6515827150965;1956.1001939107884;1963.68581027035;1990.4227773945684;2013.8388928885654;459.5519368615573;484.9709017458893;491.77378405932956;508.7303729023623;513.2711549599578;11575.594854180063;11738.94130529342;11951.402429878472;12087.274763514042;12161;505.38847993927027;522.3522831688679;541.1152765228801;1023.8873723890366;1101.2236373356764;9453.858192127123;9558.426494410358;9637.37357071788;9988.450635214987;10004.294974879409;527030;527084;589161;628861;641231;68701.31298687049;68901.31098689049;72440.63779681173;78750;82760.17239827524;1228.6068458093325;1252.6116903759864;1263.6588121207224;1267.683079230211;1269.0672355818467;16169.110698911203;16180.271887764844;16192.433264835674;16502.092384918946;16513.752293715363;34501;35198.472022919166;35996.28007439889;36510.63489365178;36663.08342291464;47252;48226.27660585024;49216.26175607297;49571.75214123906;49631;7383.667734951832;7473.215312392338;7488.288612581796;7606.125295591078;7855.764327070197;3800.448934904479;6665.433438157617;8915.50964696922;10221.43782091992;10530.894691052992;9204.401713888576;9275.86086208721;10131.113216012645;10251.282410231212;10315.535800888827;10282;10372.11836993864;10430.94784526103;10642.787144256916;10817.621383251548;7485.690004249126;7977.521348719096;10375.792484150426;10676.73308167271;10728.731781705208;10173.135283500986;10376.37741735468;10426.530806113895;10872.836907446554;11130.276532025393;10792.892071079503;10969.83545246806;10992.450377481255;11036.172287078662;11137.498812553617 03:18:44 INFO - PROCESS | 9145 | |3;mootools.html;1557.9143147126906;1583.809942806863;1841.5764374193934;1907.5707965707727;1949.356712284946;7429.702811887525;7659.69361225551;7694.692212311508;7786.610669466519;8023.879641805378;7898.5260884346835;7905.92094079059;7955.681772729084;7956.164602716718;7980.481268717544;2332.918347857825;2379.8096152307776;2381.2975172324204;2383.6543701163323;2387;2373;2387.880605969703;2428.7206971198275;2431.0032886516533;2434.586120359543;2321.1643808229023;2341.473168537074;2366.4438856868624;2369.656399822025;2372.632242002492;2335.2060299498166;2336.9532609347716;2345.8006069484113;2351.8588884666888;2356.658284548731;2365.9171928982573;2368.798652114572;2376.6553849691873;2384.3800611840875;2394.078279862248;7695;7759.612019399007;7784.104827944802;7836.529808211469;7842.215778422169;4817.8313759018265;4923.90152196954;4973.701577905301;4996;5007.023630392075;3087.043016664841;3117.579126817873;3128;3139.5918530590875;3169.8415079245947;1043.8590790243295;1045.7281106912183;1099.6151347028556;1109.040679811965;1143.7598104398087;10771.6229931952;10958.945205274002;10962.561497540168;10986.340819550853;11042.33745975244;4554.749488778149;4602.654800889946;4612.86161415158;4691.906161876744;4718.528147185322;9459.668911588198;9540.761480962892;9546.379485333431;9551.570179341947;9562.521873906277;5044.798208071636;5061.367329083864;5061.645684802029;5075.771590278447;5083.822066227664;4620.491745907947;4645.581897629162;4696.178168820443;4727.078219747185;4753.429588449409;3805.1818858945458;3808.2764274788256;3811.2377524495214;3873.8837834865;3892.902677433087;1190.4047976011993;1214.0348423003734;1234.5555699831218;1240.1628900492312;1249.4002878618314;1264.607971528829;1270.0347735720734;1284.6916739982523;1287.2662582327982;1320.1419077599446;7294.124705035323;7334.706611735471;7390.9260907390235;7421;7506.84986300271;1210.806270996654;1213.5145941623246;1218.1533833985472;1218.6892342452618;1225.8345123408226;5819.330776960619;5835.854103647443;5852.619579727304;5853.590248682636;5882.55880808941;9050.637974481078;9454.101860323259;9514.04859514043;9601.663941762004;9631.181349585224;9451.574679139318;9468.053194680615;9510.524473776284;9524.523773811281;9637.903620963842;7416.22129676387;7663.3103020727285;7679.923200768033;7682.270184332591;7724.691012359555;7181.102362204724;7206.351428371472;7231.240719724353;7276.381507571916;7316.414686825147;8586.570671466527;8689.348298877483;8761.342899282452;8766.474011559327;8799.296056315352;8300.501969881827;8881.467111973303;8939.821203576023;8943.418677786183;9047.321450891079;6975.40709039717;7084.397826184626;7171.390431813355;7227.710891564278;7256.818579535554;7571.772846814604;7585;7663.655135518804;7669.61651917413;7740.883886741816;6985.685644146127;7192.496525243183;7384.96307518459;7391.889121663072;7577;7023.929760702327;7072.08062951813;7080.256573059961;7155.141383034069;7209.71161153548;7104.360607545345;7114.786556403316;7148.9285107150345;7204.9279507204255;7216.386607138452;6340.207474065742;6404.743810247538;6420.807375778734;6430.3891130342545;6431.389018043278;6617.503687223381;6630.635315057718;6638.834029149117;6649.368310010541;6656.633885136364 03:18:44 INFO - PROCESS | 9145 | |4;prototype.html;380.5490493764889;384.5577585776357;386.2834442109884;386.46860566720744;391.8158465521204;6227.782027629034;6272;6332.525060620449;6350.269718982318;6467.870642587145;6154.938450615493;6338.651374174418;6349.841253968653;6371.713272902719;6427;4906.215005599105;4912.263160525923;4912.410510738717;4913.82801601944;4925.876853078684;4904.4605093439695;4919.311296418504;4926.187179115442;4936.851894443154;4941.802327906879;4861.902761944759;4877.268409738532;4881.511848815126;4882.877928051809;4883.853484395474;4812.109759694467;4868.732219727914;4878.4145902491755;4881.219004959189;4886.535779100997;4278.251306021434;4279.229738647043;4279.293916503773;4280.9143817123795;4285.164392943378;6030.728617212236;6042.637441753509;6043.697815109227;6048.697565121726;6055.152278680988;5720.141978703186;5728.083506638918;5729.169270455803;5729.828105156852;5734.684592347461;6618.305077966792;6696.263411024784;6703.262641109474;6734.797956061326;6763.661816909135;4598.425196850394;4614.284785858197;4627.606653434462;4630.930536041962;4648.1400940825715;6981.511294209407;7014.894776578355;7033.366996970297;7059.082319298458;7072.681729322193;4772.236442169236;4839.2983017462275;4859.757012149449;4860.538248866352;4870;4944;4948.876278093005;4950.6782059166035;4957.107720610253;4959.900801984012;5685.772569097273;5702.372738998707;5704.771809127671;5704.828855134353;5715.342735585461;6740;6761.898571521431;6792.558483698544;6806.251312355637;6809.31906809325;1705.0707364486136;1746.7816522934634;1748.5016770220427;1749.1166960685027;1749.195370129729;1138.561653763307;1152.1013609384693;1170.7482891178438;1191.886770756794;1200.2198570928965;6475.222973243147;6476.093346931433;6507.577007494498;6540.313267106885;6570.277269500351;6912.170539535187;6927.272636373209;6963.303669633097;6964.825879353057;6997.475189360818;6447.25856526496;6475.158229430144;6491.8701625967215;6525.902111468332;6555.901661475082;3790.5830358660523;3843.55799083109;3844.3656796628243;3852.747856946504;3853.61463853618;7166.462515311373;7244.4566657499845;7251.057362542836;7276.7453139140935;7283.053203083671;7138.607376594233;7184.209736928934;7254.455915806336;7284.198738138801;7303.59830209333;7221.24176961422;7245.529040612449;7273.981642570045;7277.345038946521;7284.344409003215;6975.895361569682;7046.823829404101;7056.329648683367;7091.893621595577;7104.254053324326;6757.662116894234;6930.792076237721;6944.305569443015;6974.232834388112;6982.825429364307;7187.137543494814;7220.855582888418;7245.420366370572;7257.854842903007;7279.745208917662;4912.582430493448;4954.702717836942;4958.1323268428605;4960.677555958995;4966.304717339503;6886.931130688629;7036.261192574706;7078.539894906815;7159.642017899188;7167;6843.726250950105;6880.899056150992;6892.379685828299;6931.2375638678695;6934.341237582422;6865.828354291183;6900.6204658744255;6918.308169183041;6931.4108300795;6944.444444444332;6599.67001649906;6600.075989361397;6760.797176084725;6763;6775.728970841111;6814.557053791487;6819.829504262433;6832.487563432663;6861.759838405632;6872.41584465306;6708.127943367331;6713.765018224339;6735.326467353226;6744.831379215362;6753.324667533404 03:18:44 INFO - PROCESS | 9145 | |5;yui.html;785;879.6481407437022;937.3719607862736;943.4763706143092;952.7903861150544;14245.928770356146;14476.782848257284;14483.637909052253;14503.782443263359;14574.052686575365;13451.932740336284;13535.661608459794;13549.051566390357;13561.728765424685;13583.117097388687;884.8628462588293;905.2848249882585;921.9953900230523;928.3176865004217;931.8509038553833;922.5341202692631;927.8097989912052;928.9814203715922;931.0549791961131;931.1433481197315;960.0591420408005;963.8313295173351;965.4545181972163;966.4056605187794;966.5940305071852;947.6920000999668;952.6522819171022;957.042957042957;957.7557722780681;959.2805395953035;707.4375871182423;709.7693249693871;713.5005496152662;713.9821504462378;714.7141143542625;14892.106473611619;14983.400663973427;14995.400183992628;15008.849911500854;15077.472288469851;13614.863851361557;13753.518626848012;13829.861701382957;13838.792418113737;13942.442302307896;11697;11727.120465965087;11758.294502329887;11922.761544769057;12127.575534856325;3848.2303539291975;3896.4544963705102;3909.4526766252748;3917.6278253565865;3918.608139186087;53522.19716704253;53655.731721341144;53822;53839;54211.18683219755;9960.501974901226;10068.345557538736;10158.441285729356;10497.737556561147;10839.566417343376;19361.806381936283;19405.902970485058;19436.902815486115;19721.605567888848;19921.402357929284;8068.435209535276;8095.392845536609;8138.348932085419;8260.421770476009;8294.543800091053;4503.166914120832;4549.158405694957;4592.67851250416;4669.322948172496;4678;3010.9247268818017;3032.4844776388068;3044.1932887784756;3046.893358732478;3063.6323641163203;561.2283110722756;575.5596968319155;578.1443463673786;595.9363476625406;610.0422336931065;641.4291280760127;668.0513670587777;704.4998051383575;747.7607165706921;781.9491733037335;9106.453612783254;9482.762930926781;9615.471149086727;9652.565634546463;9746.415215087118;715.3097261143022;759.5785818569221;761.364260842203;790.944089640325;824.2293455619016;4402.911941761146;4534.501204867462;4535.342375355555;4582.564656357641;4632.467266264355;64206.678966604864;65735.67132164404;65749.35626609373;65902.34097658962;65907;56590.434095658515;57106.42893571011;57228.14157787636;57321;57740.711296443245;50234.246486302734;50271.49728502741;50574.747126264134;50610;51019.489805101475;9756.41461512283;9762.554067148083;9767.769037192655;9879.460413364133;9902.653407130716;36568.45147322845;37206.81396593;37961.62038379581;38578.421323679606;39162;47905.54650160253;49858.75070624624;50268;50386.49613503818;50652.74673626608;13075.280859552817;13097.476100955855;13139;13143.474261029452;13318.267495287851;13221.405036773176;13381.799273010718;13461.798073028716;13581.864181358455;13755.31223438804;12992.220466771645;13095.214287142802;13112.213267203999;13372.130811497222;13540;13149.21104733719;13467.326633668474;13536.59390218295;13990.16059036461;14019.228942408265;12647.494100235888;12723.172993755376;13067.738645227233;13279.070465067352;13736;10235.488225588542;10280.537375818256;10412.739681507719;10457.895421045996;10689.839652405064;10819.354967389454;11336.773264534499;11467.025302849352;11630.476628551567;11799.292042477478 03:18:44 INFO - PROCESS | 9145 | __end_tp_report 03:18:44 INFO - PROCESS | 9145 | __start_cc_report 03:18:44 INFO - PROCESS | 9145 | _x_x_mozilla_cycle_collect,300 03:18:44 INFO - PROCESS | 9145 | __end_cc_report 03:18:44 INFO - PROCESS | 9145 | __startTimestamp1456571924330__endTimestamp 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | ------- Summary: start ------- 03:18:44 INFO - PROCESS | 9145 | Number of tests: 6 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | [#0] dojo.html Cycles:165 Average:5326.25 Median:5540.72 stddev:558.77 (10.1%) stddev-sans-first:537.24 03:18:44 INFO - PROCESS | 9145 | Values: 3293.2 3310.6 3313.4 3342.6 3347.7 5316.9 5323.7 5337.6 5345.5 5359.5 5295.8 5320.5 5354.6 5376.0 5387.6 4851.1 5003.0 5015.9 5022.7 5055.3 4765.8 4886.1 4939.0 4942.0 5007.6 4932.6 4937.3 4983.6 4999.4 5002.5 4924.4 4927.1 4937.2 4950.4 4957.7 4757.1 4795.9 4842.8 4866.2 4875.5 5067.9 5102.2 5176.4 5176.6 5197.3 5636.2 5649.9 5673.8 5681.6 5728.4 5677.6 5702.9 5709.8 5731.9 5817.6 5335.7 5364.2 5371.8 5376.4 5384.7 5811.2 5833.8 5834.1 5836.5 5841.6 5568.9 5596.0 5621.2 5640.3 5660.1 5672.9 5707.0 5720.6 5725.6 5730.5 5677.3 5684.7 5686.5 5689.0 5702.1 5608.0 5631.4 5706.8 5725.9 5760.9 4381.6 4386.2 4420.8 4424.9 4426.1 3980.4 4001.3 4005.2 4014.2 4032.0 5458.8 5477.6 5479.2 5513.1 5543.5 5666.5 5692.7 5755.2 5762.7 5766.8 5302.5 5343.6 5420.3 5463.1 5471.5 4831.9 4916.2 4940.4 4946.5 4946.6 5855.7 5861.8 5866.4 5874.6 5893.2 5673.4 5685.7 5697.5 5721.3 5723.6 5841.0 5856.8 5888.5 5894.8 5923.6 5634.1 5645.4 5648.1 5661.5 5674.9 5668.6 5727.4 5727.5 5729.4 5765.3 5610.6 5640.4 5643.4 5647.6 5661.8 5563.7 5564.5 5584.5 5628.6 5640.1 5392.0 5484.7 5539.6 5540.7 5630.6 5599.8 5613.4 5652.6 5656.8 5675.6 5461.6 5495.5 5511.3 5514.7 5525.7 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | [#1] ext.html Cycles:180 Average:58037.22 Median:41877.48 stddev:130667.01 (312.0%) stddev-sans-first:130962.30 03:18:44 INFO - PROCESS | 9145 | Values: 560.6 560.8 576.5 576.7 592.4 30783.7 31394.2 37312.3 37647.1 37663.6 41282.8 41513.0 41630.6 41987.2 42087.2 8690.4 8898.1 8907.6 8909.3 8931.4 8614.0 8635.7 8637.1 8705.0 8736.0 8690.2 8802.3 9005.1 9005.5 9076.9 8912.6 8928.2 8935.1 8963.6 9062.6 8755.0 9010.9 9048.5 9060.1 9077.6 41877.2 42417.6 42461.0 42668.4 42723.0 3872.8 3931.4 3951.7 4208.3 4318.4 31391.8 32025.5 32073.2 32283.8 32506.7 4199.4 4250.5 4292.4 4292.8 4304.1 217951.0 218611.0 219920.0 220389.0 220961.9 45273.0 45570.0 45925.8 62941.0 64665.4 43479.3 43801.8 43812.0 43884.8 43964.8 16753.3 16851.6 16858.1 16964.7 16991.3 13450.7 13526.4 13539.8 13547.9 13594.9 15392.9 15413.0 15454.4 15477.7 15516.8 6118.4 6192.2 6196.0 6294.7 6310.5 1080.7 1114.8 1125.6 1168.5 1178.6 30087.7 30290.0 30526.5 30907.8 31074.4 1140.4 1163.5 1224.5 1241.3 1281.8 17322.7 17395.5 17411.1 17512.6 17633.6 325327.0 528256.0 872343.0 879396.0 881963.0 60125.4 60852.4 61028.7 61087.7 61423.4 1480.9 1505.3 1509.2 1518.6 1522.6 31667.5 32191.5 32620.7 32749.0 34794.0 54046.2 54521.5 54521.7 54539.9 54625.2 328828.0 335252.0 336686.0 337035.0 338138.0 44478.6 44721.3 44825.6 44874.0 44938.6 47305.5 48102.3 48609.5 48709.3 49349.0 40424.0 40995.4 41562.8 42192.4 42548.1 41824.0 41961.0 42299.6 42353.0 42388.8 40901.0 41001.0 41662.4 41761.8 41877.8 36024.3 36607.6 37103.8 37134.8 37456.6 28146.7 28719.4 28819.6 28846.3 28923.1 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | [#2] jquery.html Cycles:180 Average:29294.59 Median:20231.77 stddev:95554.23 (472.3%) stddev-sans-first:95797.65 03:18:44 INFO - PROCESS | 9145 | Values: 399.8 405.6 405.9 408.6 408.7 17800.6 18062.3 18162.3 18467.0 18613.5 16971.6 17033.7 17105.3 17602.8 17607.7 5271.6 5394.8 5397.8 5402.0 5450.6 5345.5 5476.3 5862.3 5867.0 5881.0 5423.2 5658.3 5803.9 5823.9 5848.7 5580.9 5596.6 5607.9 5630.3 5635.5 5307.5 5542.6 5543.6 5570.0 5572.6 13321.5 13473.6 14368.8 14383.9 14389.1 2192.0 2305.0 2345.6 2367.2 2371.5 10177.4 10443.9 10512.2 10921.5 14233.7 1671.7 1756.5 1884.5 1923.4 1935.4 60890.0 61018.4 62722.7 63221.7 63584.4 10976.2 11047.1 11091.2 11129.0 11217.0 14812.9 14831.2 14863.2 14891.8 14913.8 8733.5 8759.1 8779.5 8795.8 8811.1 8699.3 8751.5 8791.6 8820.2 8865.4 4649.4 4684.8 4718.5 4730.4 4786.2 1935.7 1956.1 1963.7 1990.4 2013.8 459.6 485.0 491.8 508.7 513.3 11575.6 11738.9 11951.4 12087.3 12161.0 505.4 522.4 541.1 1023.9 1101.2 9453.9 9558.4 9637.4 9988.5 10004.3 527030.0 527084.0 589161.0 628861.0 641231.0 68701.3 68901.3 72440.6 78750.0 82760.2 1228.6 1252.6 1263.7 1267.7 1269.1 16169.1 16180.3 16192.4 16502.1 16513.8 34501.0 35198.5 35996.3 36510.6 36663.1 47252.0 48226.3 49216.3 49571.8 49631.0 7383.7 7473.2 7488.3 7606.1 7855.8 3800.4 6665.4 8915.5 10221.4 10530.9 9204.4 9275.9 10131.1 10251.3 10315.5 10282.0 10372.1 10430.9 10642.8 10817.6 7485.7 7977.5 10375.8 10676.7 10728.7 10173.1 10376.4 10426.5 10872.8 11130.3 10792.9 10969.8 10992.5 11036.2 11137.5 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | [#3] mootools.html Cycles:180 Average:5630.47 Median:6372.48 stddev:2851.58 (44.7%) stddev-sans-first:2843.15 03:18:44 INFO - PROCESS | 9145 | Values: 1557.9 1583.8 1841.6 1907.6 1949.4 7429.7 7659.7 7694.7 7786.6 8023.9 7898.5 7905.9 7955.7 7956.2 7980.5 2332.9 2379.8 2381.3 2383.7 2387.0 2373.0 2387.9 2428.7 2431.0 2434.6 2321.2 2341.5 2366.4 2369.7 2372.6 2335.2 2337.0 2345.8 2351.9 2356.7 2365.9 2368.8 2376.7 2384.4 2394.1 7695.0 7759.6 7784.1 7836.5 7842.2 4817.8 4923.9 4973.7 4996.0 5007.0 3087.0 3117.6 3128.0 3139.6 3169.8 1043.9 1045.7 1099.6 1109.0 1143.8 10771.6 10958.9 10962.6 10986.3 11042.3 4554.7 4602.7 4612.9 4691.9 4718.5 9459.7 9540.8 9546.4 9551.6 9562.5 5044.8 5061.4 5061.6 5075.8 5083.8 4620.5 4645.6 4696.2 4727.1 4753.4 3805.2 3808.3 3811.2 3873.9 3892.9 1190.4 1214.0 1234.6 1240.2 1249.4 1264.6 1270.0 1284.7 1287.3 1320.1 7294.1 7334.7 7390.9 7421.0 7506.8 1210.8 1213.5 1218.2 1218.7 1225.8 5819.3 5835.9 5852.6 5853.6 5882.6 9050.6 9454.1 9514.0 9601.7 9631.2 9451.6 9468.1 9510.5 9524.5 9637.9 7416.2 7663.3 7679.9 7682.3 7724.7 7181.1 7206.4 7231.2 7276.4 7316.4 8586.6 8689.3 8761.3 8766.5 8799.3 8300.5 8881.5 8939.8 8943.4 9047.3 6975.4 7084.4 7171.4 7227.7 7256.8 7571.8 7585.0 7663.7 7669.6 7740.9 6985.7 7192.5 7385.0 7391.9 7577.0 7023.9 7072.1 7080.3 7155.1 7209.7 7104.4 7114.8 7148.9 7204.9 7216.4 6340.2 6404.7 6420.8 6430.4 6431.4 6617.5 6630.6 6638.8 6649.4 6656.6 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | [#4] prototype.html Cycles:180 Average:5696.54 Median:6471.51 stddev:1706.98 (26.4%) stddev-sans-first:1664.49 03:18:44 INFO - PROCESS | 9145 | Values: 380.5 384.6 386.3 386.5 391.8 6227.8 6272.0 6332.5 6350.3 6467.9 6154.9 6338.7 6349.8 6371.7 6427.0 4906.2 4912.3 4912.4 4913.8 4925.9 4904.5 4919.3 4926.2 4936.9 4941.8 4861.9 4877.3 4881.5 4882.9 4883.9 4812.1 4868.7 4878.4 4881.2 4886.5 4278.3 4279.2 4279.3 4280.9 4285.2 6030.7 6042.6 6043.7 6048.7 6055.2 5720.1 5728.1 5729.2 5729.8 5734.7 6618.3 6696.3 6703.3 6734.8 6763.7 4598.4 4614.3 4627.6 4630.9 4648.1 6981.5 7014.9 7033.4 7059.1 7072.7 4772.2 4839.3 4859.8 4860.5 4870.0 4944.0 4948.9 4950.7 4957.1 4959.9 5685.8 5702.4 5704.8 5704.8 5715.3 6740.0 6761.9 6792.6 6806.3 6809.3 1705.1 1746.8 1748.5 1749.1 1749.2 1138.6 1152.1 1170.7 1191.9 1200.2 6475.2 6476.1 6507.6 6540.3 6570.3 6912.2 6927.3 6963.3 6964.8 6997.5 6447.3 6475.2 6491.9 6525.9 6555.9 3790.6 3843.6 3844.4 3852.7 3853.6 7166.5 7244.5 7251.1 7276.7 7283.1 7138.6 7184.2 7254.5 7284.2 7303.6 7221.2 7245.5 7274.0 7277.3 7284.3 6975.9 7046.8 7056.3 7091.9 7104.3 6757.7 6930.8 6944.3 6974.2 6982.8 7187.1 7220.9 7245.4 7257.9 7279.7 4912.6 4954.7 4958.1 4960.7 4966.3 6886.9 7036.3 7078.5 7159.6 7167.0 6843.7 6880.9 6892.4 6931.2 6934.3 6865.8 6900.6 6918.3 6931.4 6944.4 6599.7 6600.1 6760.8 6763.0 6775.7 6814.6 6819.8 6832.5 6861.8 6872.4 6708.1 6713.8 6735.3 6744.8 6753.3 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - PROCESS | 9145 | [#5] yui.html Cycles:180 Average:15352.33 Median:4612.57 stddev:17794.73 (385.8%) stddev-sans-first:17811.02 03:18:44 INFO - PROCESS | 9145 | Values: 785.0 879.6 937.4 943.5 952.8 14245.9 14476.8 14483.6 14503.8 14574.1 13451.9 13535.7 13549.1 13561.7 13583.1 884.9 905.3 922.0 928.3 931.9 922.5 927.8 929.0 931.1 931.1 960.1 963.8 965.5 966.4 966.6 947.7 952.7 957.0 957.8 959.3 707.4 709.8 713.5 714.0 714.7 14892.1 14983.4 14995.4 15008.8 15077.5 13614.9 13753.5 13829.9 13838.8 13942.4 11697.0 11727.1 11758.3 11922.8 12127.6 3848.2 3896.5 3909.5 3917.6 3918.6 53522.2 53655.7 53822.0 53839.0 54211.2 9960.5 10068.3 10158.4 10497.7 10839.6 19361.8 19405.9 19436.9 19721.6 19921.4 8068.4 8095.4 8138.3 8260.4 8294.5 4503.2 4549.2 4592.7 4669.3 4678.0 3010.9 3032.5 3044.2 3046.9 3063.6 561.2 575.6 578.1 595.9 610.0 641.4 668.1 704.5 747.8 781.9 9106.5 9482.8 9615.5 9652.6 9746.4 715.3 759.6 761.4 790.9 824.2 4402.9 4534.5 4535.3 4582.6 4632.5 64206.7 65735.7 65749.4 65902.3 65907.0 56590.4 57106.4 57228.1 57321.0 57740.7 50234.2 50271.5 50574.7 50610.0 51019.5 9756.4 9762.6 9767.8 9879.5 9902.7 36568.5 37206.8 37961.6 38578.4 39162.0 47905.5 49858.8 50268.0 50386.5 50652.7 13075.3 13097.5 13139.0 13143.5 13318.3 13221.4 13381.8 13461.8 13581.9 13755.3 12992.2 13095.2 13112.2 13372.1 13540.0 13149.2 13467.3 13536.6 13990.2 14019.2 12647.5 12723.2 13067.7 13279.1 13736.0 10235.5 10280.5 10412.7 10457.9 10689.8 10819.4 11336.8 11467.0 11630.5 11799.3 03:18:44 INFO - PROCESS | 9145 | -------- Summary: end -------- 03:18:44 INFO - PROCESS | 9145 | 03:18:44 INFO - TEST-INFO | 9145: exit 0 03:18:44 INFO - TEST-OK | dromaeo_css | took 1108427ms 03:18:44 INFO - TEST-START | kraken 03:18:44 INFO - operating with platform_type : linux_ 03:18:44 INFO - Initialising browser for kraken test... 03:18:44 INFO - TEST-INFO | started process 9391 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCI96cV/profile http://localhost:50837/getInfo.html) 03:18:48 INFO - PROCESS | 9391 | 03:18:48 INFO - PROCESS | 9391 | (process:9469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:18:49 INFO - PROCESS | 9391 | __metrics Screen width/height:1600/1200 03:18:49 INFO - PROCESS | 9391 | colorDepth:24 03:18:49 INFO - PROCESS | 9391 | Browser inner width/height: 1024/697 03:18:49 INFO - PROCESS | 9391 | __metrics 03:18:50 INFO - TEST-INFO | 9391: exit 0 03:18:50 INFO - Browser initialized. 03:18:50 INFO - Running cycle 1/1 for kraken test... 03:18:50 INFO - TEST-INFO | started process 9518 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCI96cV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:51 INFO - PROCESS | 9518 | 03:18:51 INFO - PROCESS | 9518 | (process:9580): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:19:02 INFO - PROCESS | 9518 | RSS: Main: 140922880 03:19:02 INFO - PROCESS | 9518 | 03:19:04 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50837/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:05 INFO - PROCESS | 9518 | RSS: Main: 145850368 03:19:05 INFO - PROCESS | 9518 | 03:19:07 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50837/tests/kraken/driver.html?testName=audio-dft) 03:19:08 INFO - PROCESS | 9518 | RSS: Main: 144654336 03:19:08 INFO - PROCESS | 9518 | 03:19:11 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50837/tests/kraken/driver.html?testName=audio-fft) 03:19:11 INFO - PROCESS | 9518 | RSS: Main: 147025920 03:19:11 INFO - PROCESS | 9518 | 03:19:13 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50837/tests/kraken/driver.html?testName=audio-oscillator) 03:19:14 INFO - PROCESS | 9518 | RSS: Main: 146485248 03:19:14 INFO - PROCESS | 9518 | 03:19:16 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:17 INFO - PROCESS | 9518 | RSS: Main: 147173376 03:19:17 INFO - PROCESS | 9518 | 03:19:20 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50837/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:20 INFO - PROCESS | 9518 | RSS: Main: 146001920 03:19:20 INFO - PROCESS | 9518 | 03:19:24 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50837/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:24 INFO - PROCESS | 9518 | RSS: Main: 146051072 03:19:24 INFO - PROCESS | 9518 | 03:19:27 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50837/tests/kraken/driver.html?testName=json-parse-financial) 03:19:28 INFO - PROCESS | 9518 | RSS: Main: 146120704 03:19:28 INFO - PROCESS | 9518 | 03:19:29 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:30 INFO - PROCESS | 9518 | RSS: Main: 145002496 03:19:30 INFO - PROCESS | 9518 | 03:19:31 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:32 INFO - PROCESS | 9518 | RSS: Main: 146964480 03:19:32 INFO - PROCESS | 9518 | 03:19:34 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:35 INFO - PROCESS | 9518 | RSS: Main: 145256448 03:19:35 INFO - PROCESS | 9518 | 03:19:37 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:38 INFO - PROCESS | 9518 | RSS: Main: 146579456 03:19:38 INFO - PROCESS | 9518 | 03:19:40 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:41 INFO - PROCESS | 9518 | RSS: Main: 146984960 03:19:41 INFO - PROCESS | 9518 | 03:19:42 INFO - PROCESS | 9518 | Cycle 1(1): loaded http://localhost:50837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50837/tests/kraken/driver.html?testName=ai-astar) 03:19:43 INFO - PROCESS | 9518 | RSS: Main: 148844544 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | __start_tp_report 03:19:43 INFO - PROCESS | 9518 | _x_x_mozilla_page_load 03:19:43 INFO - PROCESS | 9518 | _x_x_mozilla_page_load_details 03:19:43 INFO - PROCESS | 9518 | |i|pagename|runs| 03:19:43 INFO - PROCESS | 9518 | |0;ai-astar;111;105;111;112;113;124;113;109;109;111 03:19:43 INFO - PROCESS | 9518 | |1;audio-beat-detection;151;122;147;165;128;156;147;127;158;130 03:19:43 INFO - PROCESS | 9518 | |2;audio-dft;163;165;161;162;160;161;163;161;165;161 03:19:43 INFO - PROCESS | 9518 | |3;audio-fft;72;75;74;149;74;73;75;73;156;73 03:19:43 INFO - PROCESS | 9518 | |4;audio-oscillator;96;97;136;95;95;96;138;95;96;138 03:19:43 INFO - PROCESS | 9518 | |5;imaging-gaussian-blur;109;110;110;111;109;110;110;110;110;110 03:19:43 INFO - PROCESS | 9518 | |6;imaging-darkroom;147;148;147;147;148;148;147;148;147;146 03:19:43 INFO - PROCESS | 9518 | |7;imaging-desaturate;96;96;96;97;97;96;98;96;96;96 03:19:43 INFO - PROCESS | 9518 | |8;json-parse-financial;57;57;56;57;57;55;55;62;52;61 03:19:43 INFO - PROCESS | 9518 | |9;json-stringify-tinderbox;65;66;64;64;64;68;65;65;65;64 03:19:43 INFO - PROCESS | 9518 | |10;stanford-crypto-aes;81;82;82;82;82;82;81;81;81;82 03:19:43 INFO - PROCESS | 9518 | |11;stanford-crypto-ccm;110;112;114;128;117;129;110;118;118;116 03:19:43 INFO - PROCESS | 9518 | |12;stanford-crypto-pbkdf2;138;139;141;136;142;138;137;141;134;137 03:19:43 INFO - PROCESS | 9518 | |13;stanford-crypto-sha256-iterative;68;65;66;67;68;68;65;67;66;67 03:19:43 INFO - PROCESS | 9518 | __end_tp_report 03:19:43 INFO - PROCESS | 9518 | __start_cc_report 03:19:43 INFO - PROCESS | 9518 | _x_x_mozilla_cycle_collect,737 03:19:43 INFO - PROCESS | 9518 | __end_cc_report 03:19:43 INFO - PROCESS | 9518 | __startTimestamp1456571983164__endTimestamp 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | ------- Summary: start ------- 03:19:43 INFO - PROCESS | 9518 | Number of tests: 14 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:4.89 (4.4%) stddev-sans-first:5.18 03:19:43 INFO - PROCESS | 9518 | Values: 111.0 105.0 111.0 112.0 113.0 124.0 113.0 109.0 109.0 111.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.00 stddev:15.15 (10.2%) stddev-sans-first:15.79 03:19:43 INFO - PROCESS | 9518 | Values: 151.0 122.0 147.0 165.0 128.0 156.0 147.0 127.0 158.0 130.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.75 (1.1%) stddev-sans-first:1.83 03:19:43 INFO - PROCESS | 9518 | Values: 163.0 165.0 161.0 162.0 160.0 161.0 163.0 161.0 165.0 161.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#3] audio-fft Cycles:10 Average:89.40 Median:73.50 stddev:33.31 (45.3%) stddev-sans-first:34.73 03:19:43 INFO - PROCESS | 9518 | Values: 72.0 75.0 74.0 149.0 74.0 73.0 75.0 73.0 156.0 73.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:95.50 stddev:20.12 (21.1%) stddev-sans-first:20.85 03:19:43 INFO - PROCESS | 9518 | Values: 96.0 97.0 136.0 95.0 95.0 96.0 138.0 95.0 96.0 138.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 03:19:43 INFO - PROCESS | 9518 | Values: 109.0 110.0 110.0 111.0 109.0 110.0 110.0 110.0 110.0 110.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:19:43 INFO - PROCESS | 9518 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 147.0 148.0 147.0 146.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:19:43 INFO - PROCESS | 9518 | Values: 96.0 96.0 96.0 97.0 97.0 96.0 98.0 96.0 96.0 96.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.88 (5.1%) stddev-sans-first:3.06 03:19:43 INFO - PROCESS | 9518 | Values: 57.0 57.0 56.0 57.0 57.0 55.0 55.0 62.0 52.0 61.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 03:19:43 INFO - PROCESS | 9518 | Values: 65.0 66.0 64.0 64.0 64.0 68.0 65.0 65.0 65.0 64.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 03:19:43 INFO - PROCESS | 9518 | Values: 81.0 82.0 82.0 82.0 82.0 82.0 81.0 81.0 81.0 82.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:117.50 stddev:6.66 (5.7%) stddev-sans-first:6.54 03:19:43 INFO - PROCESS | 9518 | Values: 110.0 112.0 114.0 128.0 117.0 129.0 110.0 118.0 118.0 116.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:138.50 stddev:2.50 (1.8%) stddev-sans-first:2.65 03:19:43 INFO - PROCESS | 9518 | Values: 138.0 139.0 141.0 136.0 142.0 138.0 137.0 141.0 134.0 137.0 03:19:43 INFO - PROCESS | 9518 | 03:19:43 INFO - PROCESS | 9518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 03:19:43 INFO - PROCESS | 9518 | Values: 68.0 65.0 66.0 67.0 68.0 68.0 65.0 67.0 66.0 67.0 03:19:43 INFO - PROCESS | 9518 | -------- Summary: end -------- 03:19:43 INFO - PROCESS | 9518 | 03:19:44 INFO - TEST-INFO | 9518: exit 0 03:19:44 INFO - TEST-OK | kraken | took 59144ms 03:19:44 INFO - TEST-START | v8_7 03:19:44 INFO - operating with platform_type : linux_ 03:19:44 INFO - Initialising browser for v8_7 test... 03:19:44 INFO - TEST-INFO | started process 9808 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvK8BV/profile http://localhost:50837/getInfo.html) 03:19:47 INFO - PROCESS | 9808 | 03:19:47 INFO - PROCESS | 9808 | (process:9890): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:19:48 INFO - PROCESS | 9808 | __metrics Screen width/height:1600/1200 03:19:48 INFO - PROCESS | 9808 | colorDepth:24 03:19:48 INFO - PROCESS | 9808 | Browser inner width/height: 1024/697 03:19:48 INFO - PROCESS | 9808 | __metrics 03:19:49 INFO - TEST-INFO | 9808: exit 0 03:19:49 INFO - Browser initialized. 03:19:49 INFO - Running cycle 1/1 for v8_7 test... 03:19:49 INFO - TEST-INFO | started process 9939 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvK8BV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:50 INFO - PROCESS | 9939 | 03:19:50 INFO - PROCESS | 9939 | (process:10002): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:20:01 INFO - PROCESS | 9939 | RSS: Main: 141537280 03:20:01 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | Cycle 1(1): loaded http://localhost:50837/tests/v8_7/run.html (next: http://localhost:50837/tests/v8_7/run.html) 03:20:23 INFO - PROCESS | 9939 | RSS: Main: 145084416 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | __start_tp_report 03:20:23 INFO - PROCESS | 9939 | _x_x_mozilla_page_load 03:20:23 INFO - PROCESS | 9939 | _x_x_mozilla_page_load_details 03:20:23 INFO - PROCESS | 9939 | |i|pagename|runs| 03:20:23 INFO - PROCESS | 9939 | |0;Richards;166.30633627141194 03:20:23 INFO - PROCESS | 9939 | |1;DeltaBlue;169.86580601324954 03:20:23 INFO - PROCESS | 9939 | |2;Encrypt;279.6420581655481 03:20:23 INFO - PROCESS | 9939 | |3;Decrypt;5223.958333333333 03:20:23 INFO - PROCESS | 9939 | |4;RayTrace;935.4536950420954 03:20:23 INFO - PROCESS | 9939 | |5;Earley;572.737686139748 03:20:23 INFO - PROCESS | 9939 | |6;Boyer;11122.222222222223 03:20:23 INFO - PROCESS | 9939 | |7;RegExp;39115.38461538462 03:20:23 INFO - PROCESS | 9939 | |8;Splay;515.7297576070139 03:20:23 INFO - PROCESS | 9939 | |9;NavierStokes;4822.115384615385 03:20:23 INFO - PROCESS | 9939 | __end_tp_report 03:20:23 INFO - PROCESS | 9939 | __startTimestamp1456572023794__endTimestamp 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | ------- Summary: start ------- 03:20:23 INFO - PROCESS | 9939 | Number of tests: 10 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 166.3 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#1] DeltaBlue Cycles:1 Average:169.87 Median:169.87 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 169.9 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 279.6 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 5224.0 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#4] RayTrace Cycles:1 Average:935.45 Median:935.45 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 935.5 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#5] Earley Cycles:1 Average:572.74 Median:572.74 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 572.7 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#6] Boyer Cycles:1 Average:11122.22 Median:11122.22 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 11122.2 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#7] RegExp Cycles:1 Average:39115.38 Median:39115.38 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 39115.4 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#8] Splay Cycles:1 Average:515.73 Median:515.73 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 515.7 03:20:23 INFO - PROCESS | 9939 | 03:20:23 INFO - PROCESS | 9939 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 03:20:23 INFO - PROCESS | 9939 | Values: 4822.1 03:20:23 INFO - PROCESS | 9939 | -------- Summary: end -------- 03:20:23 INFO - PROCESS | 9939 | 03:20:24 INFO - TEST-INFO | 9939: exit 0 03:20:24 INFO - TEST-OK | v8_7 | took 40596ms 03:20:24 INFO - SUITE-END | took 1208s 03:20:24 INFO - Completed test suite (00:20:08) 03:20:24 INFO - Working with test: dromaeo_css 03:20:24 INFO - Generating results file: dromaeo_css 03:20:24 INFO - Working with test: kraken 03:20:24 INFO - Generating results file: kraken 03:20:24 INFO - javascript benchmark 03:20:24 INFO - Working with test: v8_7 03:20:24 INFO - Generating results file: v8_7 03:20:24 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:20:25 INFO - process_Request line: dromaeo_css 7276.94 graph.html#tests=[[72,52,43]] 03:20:25 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:25 INFO - process_Request line: kraken 1494.00 graph.html#tests=[[232,52,43]] 03:20:25 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:25 INFO - process_Request line: v8_7 21985.54 graph.html#tests=[[230,52,43]] 03:20:25 INFO - RETURN: dromaeo_css: 7276.94 03:20:25 INFO - RETURN: kraken: 1494.00 03:20:25 INFO - RETURN: v8_7: 21985.54 03:20:25 INFO - javascript benchmark 03:20:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3293.2260918684105, 3310.6358300586944, 3313.4035873542753, 3342.5988881334238, 3347.6819702128305, 5316.9202461963005, 5323.707196104213, 5337.572994160468, 5345.545628621567, 5359.517643412092, 5295.8146464873735, 5320.494553017466, 5354.625176237665, 5375.978564072833, 5387.649802762828, 4851.078295123924, 5003.0, 5015.874603134915, 5022.673526220802, 5055.342805435288, 4765.785539650724, 4886.1204983103025, 4939.012197560484, 4942.0, 5007.599392048627, 4932.630052746041, 4937.2840938063955, 4983.551480366767, 4999.375078115236, 5002.499750025005, 4924.384451943489, 4927.088488629615, 4937.21004639256, 4950.381202349707, 4957.677750946213, 4757.1437141314545, 4795.904081918377, 4842.782074806642, 4866.245731911559, 4875.512448755132, 5067.898642027176, 5102.158143906251, 5176.352955880515, 5176.585873130178, 5197.29836472079, 5636.182753500761, 5649.915251271234, 5673.8297851064535, 5681.602287839853, 5728.398518155617, 5677.574181936371, 5702.885942281131, 5709.8287051388525, 5731.885362292731, 5817.592768506206, 5335.67985920846, 5364.249005139283, 5371.811986580451, 5376.4085950545405, 5384.703841288767, 5811.244538210006, 5833.766649334064, 5834.124881267844, 5836.533077353802, 5841.649501029951, 5568.888622227614, 5596.048671725816, 5621.213030175779, 5640.32316122068, 5660.066089095336, 5672.858178545569, 5706.9714651426475, 5720.599558030898, 5725.627834190765, 5730.5129064030025, 5677.261955945701, 5684.6589204647025, 5686.459786320293, 5688.971555142198, 5702.087665973424, 5607.971960140173, 5631.436856314336, 5706.80026199081, 5725.885482290331, 5760.94239057604, 4381.6494680425485, 4386.188555117314, 4420.756858372756, 4424.911501770011, 4426.070525189746, 3980.3631418972827, 4001.2597669431248, 4005.218982298482, 4014.237294913957, 4031.9798401008393, 5458.754356053987, 5477.561795056386, 5479.17812328146, 5513.145462453326, 5543.473370029841, 5666.490015898589, 5692.743826527816, 5755.194272801811, 5762.74067666956, 5766.769329226784, 5302.522772950376, 5343.62594618373, 5420.295361603045, 5463.098588732814, 5471.534919531805, 4831.855044348676, 4916.188828843272, 4940.357753492023, 4946.480619534969, 4946.629002824802, 5855.707214639251, 5861.794837180678, 5866.354700982888, 5874.647521148745, 5893.174955506232, 5673.432656734293, 5685.687287199161, 5697.515711164598, 5721.284839395075, 5723.570732195185, 5840.970795145997, 5856.795012174553, 5888.499477544457, 5894.793682221101, 5923.614965027259, 5634.098544232903, 5645.4072322405555, 5648.124540696199, 5661.46216109469, 5674.914876276776, 5668.574856885833, 5727.39862314451, 5727.513161381163, 5729.369769325454, 5765.308163020464, 5610.607257491936, 5640.435956404327, 5643.435656434323, 5647.604667673223, 5661.773529058792, 5563.693996830051, 5564.4991950724625, 5584.497395234286, 5628.60599758013, 5640.125780504029, 5392.0, 5484.725763711719, 5539.639923404966, 5540.722963851711, 5630.63400878958, 5599.80400685974, 5613.382527921844, 5652.576056795675, 5656.830295091154, 5675.57433192504, 5461.563074954073, 5495.53287970527, 5511.255980442589, 5514.696691681996, 5525.696086715269], "unit": "score", "name": "dojo.html", "value": 5292.205176046839}, {"lowerIsBetter": false, "replicates": [560.5515587529976, 560.7897038610523, 576.5013263527045, 576.6972339521751, 592.4460629311594, 30783.69216307836, 31394.21514462137, 37312.25375492489, 37647.05882352943, 37663.62336376635, 41282.7935860321, 41513.0, 41630.58369416313, 41987.16025679492, 42087.158256834846, 8690.435121717084, 8898.065703101178, 8907.599158037872, 8909.331800114986, 8931.41945773526, 8613.956930215372, 8635.654573817039, 8637.136286371344, 8705.0, 8735.95632021839, 8690.174433428845, 8802.251808596246, 9005.054469280696, 9005.459672419644, 9076.8638470423, 8912.598933047995, 8928.24109950655, 8935.061818509028, 8963.551822408854, 9062.637494500212, 8755.0, 9010.909890901139, 9048.502332371718, 9060.093990600953, 9077.63689452421, 41877.162456750695, 42417.57582424167, 42461.0, 42668.359974600404, 42723.0, 3872.845086196549, 3931.3906344516645, 3951.7036222283155, 4208.284591619432, 4318.352247162919, 31391.84304078465, 32025.51961720553, 32073.198170045704, 32283.83858080718, 32506.6749332506, 4199.370094485821, 4250.511191213019, 4292.377605247253, 4292.763897985609, 4304.117655880568, 217951.0, 218611.0, 219920.0, 220389.0, 220961.89519052464, 45273.0, 45570.0, 45925.77037114793, 62941.0, 64665.353346465934, 43479.34780978288, 43801.780991095475, 43812.0, 43884.78057609691, 43964.78017609892, 16753.32986680519, 16851.57871053209, 16858.072805995544, 16964.660706785795, 16991.320347185974, 13450.663733406547, 13526.391312390966, 13539.796903046463, 13547.864521354857, 13594.932025340007, 15392.923035384976, 15413.0, 15454.38182472711, 15477.690446191013, 15516.844831551765, 6118.449339559461, 6192.225971753531, 6196.0, 6294.716737746812, 6310.5267104967315, 1080.6757972608186, 1114.8104822180248, 1125.5835340923747, 1168.456667649547, 1178.5580407347245, 30087.69912300849, 30290.0, 30526.54210186849, 30907.84546077255, 31074.378512430078, 1140.4468832616174, 1163.5404015413865, 1224.4673566998383, 1241.3234787041085, 1281.7820970435048, 17322.653546928992, 17395.47813565595, 17411.129443527774, 17512.562185945197, 17633.647327053386, 325327.0, 528256.0, 872343.0, 879396.0, 881963.0, 60125.398746012856, 60852.391476085555, 61028.69485652632, 61087.694561527795, 61423.38576614266, 1480.9333579988927, 1505.3451748489442, 1509.1624148597414, 1518.6355274734206, 1522.5812901452189, 31667.52498712475, 32191.51712724358, 32620.673793261765, 32749.0, 34794.0, 54046.189307159635, 54521.454785451635, 54521.72739136279, 54539.90920181653, 54625.1806222899, 328828.0, 335252.0, 336686.0, 337035.0, 338138.0, 44478.55521444744, 44721.32918006167, 44825.55174448344, 44874.0, 44938.55061449343, 47305.526944731486, 48102.27846582234, 48609.51390486192, 48709.26936096032, 49349.0, 40424.0, 40995.38506922339, 41562.792186038874, 42192.36711449392, 42548.14903701847, 41824.0, 41961.0, 42299.57700422956, 42353.0, 42388.78805605952, 40901.0, 41000.974975625846, 41662.37506437467, 41761.791191045064, 41877.79061104675, 36024.27951440904, 36607.633923660425, 37103.81448092742, 37134.81432592928, 37456.625433745314, 28146.71853281523, 28719.42561148807, 28819.567706484, 28846.278843029093, 28923.132306030853], "unit": "score", "name": "ext.html", "value": 19895.535784290703}, {"lowerIsBetter": false, "replicates": [399.7541511970136, 405.5559162716825, 405.9411385349124, 408.6485622364764, 408.70981603061824, 17800.554986125353, 18062.277508899646, 18162.27350905964, 18467.0, 18613.53466163345, 16971.57571060721, 17033.659326813457, 17105.315787368523, 17602.823971760277, 17607.73588396172, 5271.578273738101, 5394.757235924393, 5397.7571009304675, 5402.0, 5450.5639548836, 5345.545628621572, 5476.288082549263, 5862.267216597926, 5867.0, 5881.029630111027, 5423.186522021689, 5658.264425624663, 5803.912941305884, 5823.854403639922, 5848.67832269225, 5580.888382232373, 5596.608237423382, 5607.943920560783, 5630.296212973358, 5635.520980716644, 5307.469253074701, 5542.5565954723525, 5543.584231182637, 5570.025245582007, 5572.60991730579, 13321.467141314335, 13473.595792126252, 14368.78446823288, 14383.928080359636, 14389.13665180082, 2191.9671204931938, 2305.0318866076286, 2345.597276080571, 2367.171489978511, 2371.537550177716, 10177.389356638625, 10443.895561044368, 10512.1590272778, 10921.508532116073, 14233.715325693429, 1671.68238034773, 1756.5169578365924, 1884.547708549952, 1923.422973108076, 1935.400025991947, 60890.0, 61018.38981610171, 62722.68638656823, 63221.68389158025, 63584.36415635831, 10976.231663783617, 11047.060999814945, 11091.22361434708, 11129.0, 11217.04655104309, 14812.851871481364, 14831.18428486422, 14863.18252496123, 14891.776623350659, 14913.776293355608, 8733.475991440533, 8759.124087591317, 8779.473231606124, 8795.780105497413, 8811.074837142136, 8699.347548933856, 8751.518666473277, 8791.604377802887, 8820.2061814437, 8865.379423440427, 4649.372334734768, 4684.81260749573, 4718.457377401643, 4730.408698912636, 4786.234202527578, 1935.6515827150965, 1956.1001939107884, 1963.68581027035, 1990.4227773945684, 2013.8388928885654, 459.5519368615573, 484.9709017458893, 491.77378405932956, 508.7303729023623, 513.2711549599578, 11575.594854180063, 11738.94130529342, 11951.402429878472, 12087.274763514042, 12161.0, 505.38847993927027, 522.3522831688679, 541.1152765228801, 1023.8873723890366, 1101.2236373356764, 9453.858192127123, 9558.426494410358, 9637.37357071788, 9988.450635214987, 10004.294974879409, 527030.0, 527084.0, 589161.0, 628861.0, 641231.0, 68701.31298687049, 68901.31098689049, 72440.63779681173, 78750.0, 82760.17239827524, 1228.6068458093325, 1252.6116903759864, 1263.6588121207224, 1267.683079230211, 1269.0672355818467, 16169.110698911203, 16180.271887764844, 16192.433264835674, 16502.092384918946, 16513.752293715363, 34501.0, 35198.472022919166, 35996.28007439889, 36510.63489365178, 36663.08342291464, 47252.0, 48226.27660585024, 49216.26175607297, 49571.75214123906, 49631.0, 7383.667734951832, 7473.215312392338, 7488.288612581796, 7606.125295591078, 7855.764327070197, 3800.448934904479, 6665.433438157617, 8915.50964696922, 10221.43782091992, 10530.894691052992, 9204.401713888576, 9275.86086208721, 10131.113216012645, 10251.282410231212, 10315.535800888827, 10282.0, 10372.11836993864, 10430.94784526103, 10642.787144256916, 10817.621383251548, 7485.690004249126, 7977.521348719096, 10375.792484150426, 10676.73308167271, 10728.731781705208, 10173.135283500986, 10376.37741735468, 10426.530806113895, 10872.836907446554, 11130.276532025393, 10792.892071079503, 10969.83545246806, 10992.450377481255, 11036.172287078662, 11137.498812553617], "unit": "score", "name": "jquery.html", "value": 8352.987719184255}, {"lowerIsBetter": false, "replicates": [1557.9143147126906, 1583.809942806863, 1841.5764374193934, 1907.5707965707727, 1949.356712284946, 7429.702811887525, 7659.69361225551, 7694.692212311508, 7786.610669466519, 8023.879641805378, 7898.5260884346835, 7905.92094079059, 7955.681772729084, 7956.164602716718, 7980.481268717544, 2332.918347857825, 2379.8096152307776, 2381.2975172324204, 2383.6543701163323, 2387.0, 2373.0, 2387.880605969703, 2428.7206971198275, 2431.0032886516533, 2434.586120359543, 2321.1643808229023, 2341.473168537074, 2366.4438856868624, 2369.656399822025, 2372.632242002492, 2335.2060299498166, 2336.9532609347716, 2345.8006069484113, 2351.8588884666888, 2356.658284548731, 2365.9171928982573, 2368.798652114572, 2376.6553849691873, 2384.3800611840875, 2394.078279862248, 7695.0, 7759.612019399007, 7784.104827944802, 7836.529808211469, 7842.215778422169, 4817.8313759018265, 4923.90152196954, 4973.701577905301, 4996.0, 5007.023630392075, 3087.043016664841, 3117.579126817873, 3128.0, 3139.5918530590875, 3169.8415079245947, 1043.8590790243295, 1045.7281106912183, 1099.6151347028556, 1109.040679811965, 1143.7598104398087, 10771.6229931952, 10958.945205274002, 10962.561497540168, 10986.340819550853, 11042.33745975244, 4554.749488778149, 4602.654800889946, 4612.86161415158, 4691.906161876744, 4718.528147185322, 9459.668911588198, 9540.761480962892, 9546.379485333431, 9551.570179341947, 9562.521873906277, 5044.798208071636, 5061.367329083864, 5061.645684802029, 5075.771590278447, 5083.822066227664, 4620.491745907947, 4645.581897629162, 4696.178168820443, 4727.078219747185, 4753.429588449409, 3805.1818858945458, 3808.2764274788256, 3811.2377524495214, 3873.8837834865, 3892.902677433087, 1190.4047976011993, 1214.0348423003734, 1234.5555699831218, 1240.1628900492312, 1249.4002878618314, 1264.607971528829, 1270.0347735720734, 1284.6916739982523, 1287.2662582327982, 1320.1419077599446, 7294.124705035323, 7334.706611735471, 7390.9260907390235, 7421.0, 7506.84986300271, 1210.806270996654, 1213.5145941623246, 1218.1533833985472, 1218.6892342452618, 1225.8345123408226, 5819.330776960619, 5835.854103647443, 5852.619579727304, 5853.590248682636, 5882.55880808941, 9050.637974481078, 9454.101860323259, 9514.04859514043, 9601.663941762004, 9631.181349585224, 9451.574679139318, 9468.053194680615, 9510.524473776284, 9524.523773811281, 9637.903620963842, 7416.22129676387, 7663.3103020727285, 7679.923200768033, 7682.270184332591, 7724.691012359555, 7181.102362204724, 7206.351428371472, 7231.240719724353, 7276.381507571916, 7316.414686825147, 8586.570671466527, 8689.348298877483, 8761.342899282452, 8766.474011559327, 8799.296056315352, 8300.501969881827, 8881.467111973303, 8939.821203576023, 8943.418677786183, 9047.321450891079, 6975.40709039717, 7084.397826184626, 7171.390431813355, 7227.710891564278, 7256.818579535554, 7571.772846814604, 7585.0, 7663.655135518804, 7669.61651917413, 7740.883886741816, 6985.685644146127, 7192.496525243183, 7384.96307518459, 7391.889121663072, 7577.0, 7023.929760702327, 7072.08062951813, 7080.256573059961, 7155.141383034069, 7209.71161153548, 7104.360607545345, 7114.786556403316, 7148.9285107150345, 7204.9279507204255, 7216.386607138452, 6340.207474065742, 6404.743810247538, 6420.807375778734, 6430.3891130342545, 6431.389018043278, 6617.503687223381, 6630.635315057718, 6638.834029149117, 6649.368310010541, 6656.633885136364], "unit": "score", "name": "mootools.html", "value": 4674.5824287019095}, {"lowerIsBetter": false, "replicates": [380.5490493764889, 384.5577585776357, 386.2834442109884, 386.46860566720744, 391.8158465521204, 6227.782027629034, 6272.0, 6332.525060620449, 6350.269718982318, 6467.870642587145, 6154.938450615493, 6338.651374174418, 6349.841253968653, 6371.713272902719, 6427.0, 4906.215005599105, 4912.263160525923, 4912.410510738717, 4913.82801601944, 4925.876853078684, 4904.4605093439695, 4919.311296418504, 4926.187179115442, 4936.851894443154, 4941.802327906879, 4861.902761944759, 4877.268409738532, 4881.511848815126, 4882.877928051809, 4883.853484395474, 4812.109759694467, 4868.732219727914, 4878.4145902491755, 4881.219004959189, 4886.535779100997, 4278.251306021434, 4279.229738647043, 4279.293916503773, 4280.9143817123795, 4285.164392943378, 6030.728617212236, 6042.637441753509, 6043.697815109227, 6048.697565121726, 6055.152278680988, 5720.141978703186, 5728.083506638918, 5729.169270455803, 5729.828105156852, 5734.684592347461, 6618.305077966792, 6696.263411024784, 6703.262641109474, 6734.797956061326, 6763.661816909135, 4598.425196850394, 4614.284785858197, 4627.606653434462, 4630.930536041962, 4648.1400940825715, 6981.511294209407, 7014.894776578355, 7033.366996970297, 7059.082319298458, 7072.681729322193, 4772.236442169236, 4839.2983017462275, 4859.757012149449, 4860.538248866352, 4870.0, 4944.0, 4948.876278093005, 4950.6782059166035, 4957.107720610253, 4959.900801984012, 5685.772569097273, 5702.372738998707, 5704.771809127671, 5704.828855134353, 5715.342735585461, 6740.0, 6761.898571521431, 6792.558483698544, 6806.251312355637, 6809.31906809325, 1705.0707364486136, 1746.7816522934634, 1748.5016770220427, 1749.1166960685027, 1749.195370129729, 1138.561653763307, 1152.1013609384693, 1170.7482891178438, 1191.886770756794, 1200.2198570928965, 6475.222973243147, 6476.093346931433, 6507.577007494498, 6540.313267106885, 6570.277269500351, 6912.170539535187, 6927.272636373209, 6963.303669633097, 6964.825879353057, 6997.475189360818, 6447.25856526496, 6475.158229430144, 6491.8701625967215, 6525.902111468332, 6555.901661475082, 3790.5830358660523, 3843.55799083109, 3844.3656796628243, 3852.747856946504, 3853.61463853618, 7166.462515311373, 7244.4566657499845, 7251.057362542836, 7276.7453139140935, 7283.053203083671, 7138.607376594233, 7184.209736928934, 7254.455915806336, 7284.198738138801, 7303.59830209333, 7221.24176961422, 7245.529040612449, 7273.981642570045, 7277.345038946521, 7284.344409003215, 6975.895361569682, 7046.823829404101, 7056.329648683367, 7091.893621595577, 7104.254053324326, 6757.662116894234, 6930.792076237721, 6944.305569443015, 6974.232834388112, 6982.825429364307, 7187.137543494814, 7220.855582888418, 7245.420366370572, 7257.854842903007, 7279.745208917662, 4912.582430493448, 4954.702717836942, 4958.1323268428605, 4960.677555958995, 4966.304717339503, 6886.931130688629, 7036.261192574706, 7078.539894906815, 7159.642017899188, 7167.0, 6843.726250950105, 6880.899056150992, 6892.379685828299, 6931.2375638678695, 6934.341237582422, 6865.828354291183, 6900.6204658744255, 6918.308169183041, 6931.4108300795, 6944.444444444332, 6599.67001649906, 6600.075989361397, 6760.797176084725, 6763.0, 6775.728970841111, 6814.557053791487, 6819.829504262433, 6832.487563432663, 6861.759838405632, 6872.41584465306, 6708.127943367331, 6713.765018224339, 6735.326467353226, 6744.831379215362, 6753.324667533404], "unit": "score", "name": "prototype.html", "value": 5150.7673687740835}, {"lowerIsBetter": false, "replicates": [785.0, 879.6481407437022, 937.3719607862736, 943.4763706143092, 952.7903861150544, 14245.928770356146, 14476.782848257284, 14483.637909052253, 14503.782443263359, 14574.052686575365, 13451.932740336284, 13535.661608459794, 13549.051566390357, 13561.728765424685, 13583.117097388687, 884.8628462588293, 905.2848249882585, 921.9953900230523, 928.3176865004217, 931.8509038553833, 922.5341202692631, 927.8097989912052, 928.9814203715922, 931.0549791961131, 931.1433481197315, 960.0591420408005, 963.8313295173351, 965.4545181972163, 966.4056605187794, 966.5940305071852, 947.6920000999668, 952.6522819171022, 957.042957042957, 957.7557722780681, 959.2805395953035, 707.4375871182423, 709.7693249693871, 713.5005496152662, 713.9821504462378, 714.7141143542625, 14892.106473611619, 14983.400663973427, 14995.400183992628, 15008.849911500854, 15077.472288469851, 13614.863851361557, 13753.518626848012, 13829.861701382957, 13838.792418113737, 13942.442302307896, 11697.0, 11727.120465965087, 11758.294502329887, 11922.761544769057, 12127.575534856325, 3848.2303539291975, 3896.4544963705102, 3909.4526766252748, 3917.6278253565865, 3918.608139186087, 53522.19716704253, 53655.731721341144, 53822.0, 53839.0, 54211.18683219755, 9960.501974901226, 10068.345557538736, 10158.441285729356, 10497.737556561147, 10839.566417343376, 19361.806381936283, 19405.902970485058, 19436.902815486115, 19721.605567888848, 19921.402357929284, 8068.435209535276, 8095.392845536609, 8138.348932085419, 8260.421770476009, 8294.543800091053, 4503.166914120832, 4549.158405694957, 4592.67851250416, 4669.322948172496, 4678.0, 3010.9247268818017, 3032.4844776388068, 3044.1932887784756, 3046.893358732478, 3063.6323641163203, 561.2283110722756, 575.5596968319155, 578.1443463673786, 595.9363476625406, 610.0422336931065, 641.4291280760127, 668.0513670587777, 704.4998051383575, 747.7607165706921, 781.9491733037335, 9106.453612783254, 9482.762930926781, 9615.471149086727, 9652.565634546463, 9746.415215087118, 715.3097261143022, 759.5785818569221, 761.364260842203, 790.944089640325, 824.2293455619016, 4402.911941761146, 4534.501204867462, 4535.342375355555, 4582.564656357641, 4632.467266264355, 64206.678966604864, 65735.67132164404, 65749.35626609373, 65902.34097658962, 65907.0, 56590.434095658515, 57106.42893571011, 57228.14157787636, 57321.0, 57740.711296443245, 50234.246486302734, 50271.49728502741, 50574.747126264134, 50610.0, 51019.489805101475, 9756.41461512283, 9762.554067148083, 9767.769037192655, 9879.460413364133, 9902.653407130716, 36568.45147322845, 37206.81396593, 37961.62038379581, 38578.421323679606, 39162.0, 47905.54650160253, 49858.75070624624, 50268.0, 50386.49613503818, 50652.74673626608, 13075.280859552817, 13097.476100955855, 13139.0, 13143.474261029452, 13318.267495287851, 13221.405036773176, 13381.799273010718, 13461.798073028716, 13581.864181358455, 13755.31223438804, 12992.220466771645, 13095.214287142802, 13112.213267203999, 13372.130811497222, 13540.0, 13149.21104733719, 13467.326633668474, 13536.59390218295, 13990.16059036461, 14019.228942408265, 12647.494100235888, 12723.172993755376, 13067.738645227233, 13279.070465067352, 13736.0, 10235.488225588542, 10280.537375818256, 10412.739681507719, 10457.895421045996, 10689.839652405064, 10819.354967389454, 11336.773264534499, 11467.025302849352, 11630.476628551567, 11799.292042477478], "unit": "score", "name": "yui.html", "value": 7011.403410610167}], "name": "dromaeo_css", "value": 7276.934573236793}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 112.0, 113.0, 124.0, 113.0, 109.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [151.0, 122.0, 147.0, 165.0, 128.0, 156.0, 147.0, 127.0, 158.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 161.0, 162.0, 160.0, 161.0, 163.0, 161.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 74.0, 149.0, 74.0, 73.0, 75.0, 73.0, 156.0, 73.0], "unit": "score", "name": "audio-fft", "value": 89.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 136.0, 95.0, 95.0, 96.0, 138.0, 95.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 98.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 57.0, 55.0, 55.0, 62.0, 52.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 64.0, 64.0, 68.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 82.0, 82.0, 81.0, 81.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 114.0, 128.0, 117.0, 129.0, 110.0, 118.0, 118.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [138.0, 139.0, 141.0, 136.0, 142.0, 138.0, 137.0, 141.0, 134.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 66.0, 67.0, 68.0, 68.0, 65.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1494.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [169.86580601324954], "unit": "score", "name": "DeltaBlue", "value": 389.23666599999996}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [935.4536950420954], "unit": "score", "name": "RayTrace", "value": 791.048241}, {"lowerIsBetter": false, "replicates": [572.737686139748], "unit": "score", "name": "Earley", "value": 1163.6443979999995}, {"lowerIsBetter": false, "replicates": [11122.222222222223], "unit": "score", "name": "Boyer", "value": 59.92174825174829}, {"lowerIsBetter": false, "replicates": [39115.38461538462], "unit": "score", "name": "RegExp", "value": 23.289685349065884}, {"lowerIsBetter": false, "replicates": [515.7297576070139], "unit": "score", "name": "Splay", "value": 158.011049}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21985.53946617616}]} 03:20:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21985.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1494.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7276.94"}}} 03:20:25 INFO - Return code: 0 03:20:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:20:25 INFO - # TBPL SUCCESS # 03:20:25 INFO - Running post-action listener: _resource_record_post_action 03:20:25 INFO - Running post-run listener: _resource_record_post_run 03:20:26 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500072448; Read time: 12; Write time: 416484 03:20:26 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242196480; Read time: 0; Write time: 253124 03:20:26 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257875968; Read time: 12; Write time: 163360 03:20:26 INFO - Running post-run listener: _upload_blobber_files 03:20:26 INFO - Blob upload gear active. 03:20:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:20:26 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 03:20:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:20:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:20:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:27 INFO - (blobuploader) - INFO - Done attempting. 03:20:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:28 INFO - (blobuploader) - INFO - Done attempting. 03:20:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:28 INFO - Return code: 0 03:20:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:20:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0545b43dc7d8e8bbd0574fde746072cf2915b62e055d407585ae81e16a24db2aa7da93890024762481c8c014b5f8743d4556e6212bf164a0f39d82c309b950c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4c484f22c6e60a804cb30d5d507c1a398f3052c17c65ec56af8c2b2e6eae9ea5e2dce2868f153c8e35a953cac76f2efa14c2cca2b56ecba41401f91c0353178"} 03:20:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:20:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:20:28 INFO - Contents: 03:20:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0545b43dc7d8e8bbd0574fde746072cf2915b62e055d407585ae81e16a24db2aa7da93890024762481c8c014b5f8743d4556e6212bf164a0f39d82c309b950c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4c484f22c6e60a804cb30d5d507c1a398f3052c17c65ec56af8c2b2e6eae9ea5e2dce2868f153c8e35a953cac76f2efa14c2cca2b56ecba41401f91c0353178"} 03:20:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:28 INFO - Copying logs to upload dir... 03:20:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:20:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.885101 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-27 03:20:27.781949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 03:20:27.785503) ========= 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 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/Mozilla-Aurora/sha512/0545b43dc7d8e8bbd0574fde746072cf2915b62e055d407585ae81e16a24db2aa7da93890024762481c8c014b5f8743d4556e6212bf164a0f39d82c309b950c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4c484f22c6e60a804cb30d5d507c1a398f3052c17c65ec56af8c2b2e6eae9ea5e2dce2868f153c8e35a953cac76f2efa14c2cca2b56ecba41401f91c0353178"} build_url:https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/ZcMiz-E3TQq-fqKMSmZANA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0545b43dc7d8e8bbd0574fde746072cf2915b62e055d407585ae81e16a24db2aa7da93890024762481c8c014b5f8743d4556e6212bf164a0f39d82c309b950c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4c484f22c6e60a804cb30d5d507c1a398f3052c17c65ec56af8c2b2e6eae9ea5e2dce2868f153c8e35a953cac76f2efa14c2cca2b56ecba41401f91c0353178"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 03:20:27.812349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 03:20:27.812750) ========= 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=523ca41ca1e0623de333ad52000001bf-1456570702.382533-908286375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 03:20:27.867274) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 03:20:27.867550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 03:20:27.867823) ========= ========= Total master_lag: 0.34 =========