builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1454417935.02 results: success (0) buildid: 20160202021619 builduid: 42ecc05a29b346b9949f71395e419cd6 revision: a718e60e2967bef3a810859f031550b3491f3d49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.024234) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.024837) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.025191) ========= 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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006485 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.048620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.048950) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.062553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.062946) ========= 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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004728 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.116317) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.116646) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.117260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.117547) ========= 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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-02 04:58:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 170K=0.07s 2016-02-02 04:58:56 (170 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.222026 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.352540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.352860) ========= 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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015405 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:55.403006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 04:58:55.403407) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a718e60e2967bef3a810859f031550b3491f3d49 --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 a718e60e2967bef3a810859f031550b3491f3d49 --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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-02 04:58:56,364 truncating revision to first 12 chars 2016-02-02 04:58:56,364 Setting DEBUG logging. 2016-02-02 04:58:56,364 attempt 1/10 2016-02-02 04:58:56,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a718e60e2967?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 04:58:57,256 unpacking tar archive at: mozilla-aurora-a718e60e2967/testing/mozharness/ program finished with exit code 0 elapsedTime=1.177869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 04:58:56.595459) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:56.595791) ========= echo a718e60e2967bef3a810859f031550b3491f3d49 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a718e60e2967bef3a810859f031550b3491f3d49'] 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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a718e60e2967bef3a810859f031550b3491f3d49 program finished with exit code 0 elapsedTime=0.004682 script_repo_revision: 'a718e60e2967bef3a810859f031550b3491f3d49' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:56.647839) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:56.648133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 04:58:56.658113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-02 04:58:56.658523) ========= /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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:58:57 INFO - MultiFileLogger online at 20160202 04:58:57 in /builds/slave/test-pgo 04:58:57 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 04:58:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:58:57 INFO - {'append_to_log': False, 04:58:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:58:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:58:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:58:57 INFO - 'branch': 'Mozilla-Aurora', 04:58:57 INFO - 'buildbot_json_path': 'buildprops.json', 04:58:57 INFO - 'config_files': ('talos/linux_config.py',), 04:58:57 INFO - 'default_actions': ('clobber', 04:58:57 INFO - 'read-buildbot-config', 04:58:57 INFO - 'download-and-extract', 04:58:57 INFO - 'populate-webroot', 04:58:57 INFO - 'create-virtualenv', 04:58:57 INFO - 'install', 04:58:57 INFO - 'run-tests'), 04:58:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:58:57 INFO - 'download_minidump_stackwalk': True, 04:58:57 INFO - 'download_symbols': 'ondemand', 04:58:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:58:57 INFO - 'tooltool.py': '/tools/tooltool.py', 04:58:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:58:57 INFO - '/tools/misc-python/virtualenv.py')}, 04:58:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:58:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:58:57 INFO - 'installer_path': 'installer.exe', 04:58:57 INFO - 'log_level': 'info', 04:58:57 INFO - 'log_name': 'talos', 04:58:57 INFO - 'log_to_console': True, 04:58:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:58:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:58:57 INFO - 'opt_config_files': (), 04:58:57 INFO - 'pip_index': False, 04:58:57 INFO - 'sps_profile': False, 04:58:57 INFO - 'sps_profile_interval': 0, 04:58:57 INFO - 'suite': 'dromaeojs-e10s', 04:58:57 INFO - 'system_bits': '32', 04:58:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:58:57 INFO - 'title': 'talos-linux64-ix-065', 04:58:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:58:57 INFO - 'use_talos_json': True, 04:58:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:58:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:58:57 INFO - 'work_dir': 'build'} 04:58:57 INFO - ##### 04:58:57 INFO - ##### Running clobber step. 04:58:57 INFO - ##### 04:58:57 INFO - Running pre-action listener: _resource_record_pre_action 04:58:57 INFO - Running main action method: clobber 04:58:57 INFO - rmtree: /builds/slave/test-pgo/build 04:58:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:58:58 INFO - Running post-action listener: _resource_record_post_action 04:58:58 INFO - ##### 04:58:58 INFO - ##### Running read-buildbot-config step. 04:58:58 INFO - ##### 04:58:58 INFO - Running pre-action listener: _resource_record_pre_action 04:58:58 INFO - Running main action method: read_buildbot_config 04:58:58 INFO - Using buildbot properties: 04:58:58 INFO - { 04:58:58 INFO - "project": "", 04:58:58 INFO - "product": "firefox", 04:58:58 INFO - "script_repo_revision": "production", 04:58:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:58:58 INFO - "repository": "", 04:58:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:58:58 INFO - "buildid": "20160202021619", 04:58:58 INFO - "pgo_build": "True", 04:58:58 INFO - "basedir": "/builds/slave/test-pgo", 04:58:58 INFO - "buildnumber": 29, 04:58:58 INFO - "slavename": "talos-linux64-ix-065", 04:58:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:58:58 INFO - "platform": "ubuntu64_hw", 04:58:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:58:58 INFO - "branch": "mozilla-aurora", 04:58:58 INFO - "repo_path": "releases/mozilla-aurora", 04:58:58 INFO - "revision": "a718e60e2967bef3a810859f031550b3491f3d49", 04:58:58 INFO - "stage_platform": "linux64-pgo", 04:58:58 INFO - "builduid": "42ecc05a29b346b9949f71395e419cd6", 04:58:58 INFO - "slavebuilddir": "test" 04:58:58 INFO - } 04:58:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 04:58:58 INFO - Running post-action listener: _resource_record_post_action 04:58:58 INFO - ##### 04:58:58 INFO - ##### Running download-and-extract step. 04:58:58 INFO - ##### 04:58:58 INFO - Running pre-action listener: _resource_record_pre_action 04:58:58 INFO - Running main action method: download_and_extract 04:58:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:58:58 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')]} 04:58:58 INFO - https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/test_packages.json 04:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/test_packages.json 04:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:58:59 INFO - Downloaded 1448 bytes. 04:58:59 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:58:59 INFO - Using the following test package requirements: 04:58:59 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:58:59 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:58:59 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:58:59 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'jsshell-linux-x86_64.zip'], 04:58:59 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:58:59 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:58:59 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:58:59 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:58:59 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:58:59 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:58:59 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:58:59 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:58:59 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:59 INFO - https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:01 INFO - Downloaded 22398375 bytes. 04:59:01 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'] 04:59:01 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 04:59:02 INFO - Return code: 0 04:59:02 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 04:59:02 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')]} 04:59:02 INFO - https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:59:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:59:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:15 INFO - Downloaded 22398375 bytes. 04:59:15 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'] 04:59:15 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 04:59:16 INFO - Return code: 0 04:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:16 INFO - https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:59:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:59:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:59:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:17 INFO - Downloaded 10706572 bytes. 04:59:17 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'] 04:59:17 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 04:59:17 INFO - Return code: 0 04:59:17 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')]} 04:59:17 INFO - https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:59:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:59:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:59:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:19 INFO - Downloaded 59587161 bytes. 04:59:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:59:19 INFO - mkdir: /builds/slave/test-pgo/properties 04:59:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:59:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:59:19 INFO - Contents: 04:59:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:59:19 INFO - Running post-action listener: _resource_record_post_action 04:59:19 INFO - Running post-action listener: set_extra_try_arguments 04:59:19 INFO - ##### 04:59:19 INFO - ##### Running populate-webroot step. 04:59:19 INFO - ##### 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: populate_webroot 04:59:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:59:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:59:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:59:19 INFO - '--tppagecycles', 04:59:19 INFO - '7'], 04:59:19 INFO - 'tests': ['tsvgm']}}, 04:59:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:59:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:59:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:59:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:59:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'tests': ['damp', 'tps']}, 04:59:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['damp', 'tps']}, 04:59:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:59:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:59:19 INFO - 'other': {'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore']}, 04:59:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore']}, 04:59:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore']}, 04:59:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore']}, 04:59:19 INFO - 'other_l64': {'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore']}, 04:59:19 INFO - 'other_nol64': {'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore']}, 04:59:19 INFO - 'svgr': {'tests': ['tsvgx', 04:59:19 INFO - 'tsvgr_opacity', 04:59:19 INFO - 'tart', 04:59:19 INFO - 'tscrollx', 04:59:19 INFO - 'cart']}, 04:59:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['tsvgx', 04:59:19 INFO - 'tsvgr_opacity', 04:59:19 INFO - 'tart', 04:59:19 INFO - 'tscrollx', 04:59:19 INFO - 'cart']}, 04:59:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'tests': ['tp5o']}, 04:59:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'talos_options': ['--e10s'], 04:59:19 INFO - 'tests': ['tp5o']}, 04:59:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'talos_options': ['--xperf_path', 04:59:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:19 INFO - 'tests': ['tp5n']}, 04:59:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:19 INFO - 'talos_options': ['--e10s', 04:59:19 INFO - '--xperf_path', 04:59:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:19 INFO - 'tests': ['tp5n']}}, 04:59:19 INFO - 'talos.zip': {'path': '', 04:59:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:59:19 INFO - Running post-action listener: _resource_record_post_action 04:59:19 INFO - ##### 04:59:19 INFO - ##### Running create-virtualenv step. 04:59:19 INFO - ##### 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: create_virtualenv 04:59:19 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:59:19 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 04:59:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:59:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:59:19 INFO - Using real prefix '/usr' 04:59:19 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:59:19 INFO - Installing distribute.............................................................................................................................................................................................done. 04:59:21 INFO - Installing pip.................done. 04:59:21 INFO - Return code: 0 04:59:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:59:21 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')]} 04:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:21 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')]} 04:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:21 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:21 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 04:59:21 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 04:59:21 INFO - Using env: {'DISPLAY': ':0', 04:59:21 INFO - 'HOME': '/home/cltbld', 04:59:21 INFO - 'LANG': 'en_US.UTF-8', 04:59:21 INFO - 'LANGUAGE': 'en_US:en', 04:59:21 INFO - 'LOGNAME': 'cltbld', 04:59:21 INFO - 'MAIL': '/var/mail/cltbld', 04:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:21 INFO - 'MOZ_NO_REMOTE': '1', 04:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:21 INFO - 'NO_EM_RESTART': '1', 04:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:21 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:21 INFO - 'SHELL': '/bin/bash', 04:59:21 INFO - 'SHLVL': '1', 04:59:21 INFO - 'TERM': 'linux', 04:59:21 INFO - 'TMOUT': '86400', 04:59:21 INFO - 'USER': 'cltbld', 04:59:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:21 INFO - '_': '/tools/buildbot/bin/python'} 04:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:22 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 04:59:22 INFO - Cleaning up... 04:59:22 INFO - Return code: 0 04:59:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:59:22 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')]} 04:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:22 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')]} 04:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:22 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:22 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 04:59:22 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 04:59:22 INFO - Using env: {'DISPLAY': ':0', 04:59:22 INFO - 'HOME': '/home/cltbld', 04:59:22 INFO - 'LANG': 'en_US.UTF-8', 04:59:22 INFO - 'LANGUAGE': 'en_US:en', 04:59:22 INFO - 'LOGNAME': 'cltbld', 04:59:22 INFO - 'MAIL': '/var/mail/cltbld', 04:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:22 INFO - 'MOZ_NO_REMOTE': '1', 04:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:22 INFO - 'NO_EM_RESTART': '1', 04:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:22 INFO - 'SHELL': '/bin/bash', 04:59:22 INFO - 'SHLVL': '1', 04:59:22 INFO - 'TERM': 'linux', 04:59:22 INFO - 'TMOUT': '86400', 04:59:22 INFO - 'USER': 'cltbld', 04:59:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:22 INFO - '_': '/tools/buildbot/bin/python'} 04:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:22 INFO - Downloading/unpacking psutil>=0.7.1 04:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:59:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:24 INFO - Installing collected packages: psutil 04:59:24 INFO - Running setup.py install for psutil 04:59:24 INFO - building 'psutil._psutil_linux' extension 04:59:24 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 04:59:24 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 04:59:24 INFO - building 'psutil._psutil_posix' extension 04:59:24 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 04:59:24 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 04:59:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:24 INFO - Successfully installed psutil 04:59:24 INFO - Cleaning up... 04:59:24 INFO - Return code: 0 04:59:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:24 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:24 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 04:59:24 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 04:59:24 INFO - Using env: {'DISPLAY': ':0', 04:59:24 INFO - 'HOME': '/home/cltbld', 04:59:24 INFO - 'LANG': 'en_US.UTF-8', 04:59:24 INFO - 'LANGUAGE': 'en_US:en', 04:59:24 INFO - 'LOGNAME': 'cltbld', 04:59:24 INFO - 'MAIL': '/var/mail/cltbld', 04:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:24 INFO - 'MOZ_NO_REMOTE': '1', 04:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:24 INFO - 'NO_EM_RESTART': '1', 04:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:24 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:24 INFO - 'SHELL': '/bin/bash', 04:59:24 INFO - 'SHLVL': '1', 04:59:24 INFO - 'TERM': 'linux', 04:59:24 INFO - 'TMOUT': '86400', 04:59:24 INFO - 'USER': 'cltbld', 04:59:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:24 INFO - '_': '/tools/buildbot/bin/python'} 04:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:59:24 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 04:59:24 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 04:59:24 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 04:59:24 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 04:59:24 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 04:59:24 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 04:59:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:59:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:59:26 INFO - Installing collected packages: mozsystemmonitor 04:59:26 INFO - Running setup.py install for mozsystemmonitor 04:59:26 INFO - Successfully installed mozsystemmonitor 04:59:26 INFO - Cleaning up... 04:59:26 INFO - Return code: 0 04:59:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:26 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:26 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 04:59:26 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 04:59:26 INFO - Using env: {'DISPLAY': ':0', 04:59:26 INFO - 'HOME': '/home/cltbld', 04:59:26 INFO - 'LANG': 'en_US.UTF-8', 04:59:26 INFO - 'LANGUAGE': 'en_US:en', 04:59:26 INFO - 'LOGNAME': 'cltbld', 04:59:26 INFO - 'MAIL': '/var/mail/cltbld', 04:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:26 INFO - 'MOZ_NO_REMOTE': '1', 04:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:26 INFO - 'NO_EM_RESTART': '1', 04:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:26 INFO - 'SHELL': '/bin/bash', 04:59:26 INFO - 'SHLVL': '1', 04:59:26 INFO - 'TERM': 'linux', 04:59:26 INFO - 'TMOUT': '86400', 04:59:26 INFO - 'USER': 'cltbld', 04:59:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:26 INFO - '_': '/tools/buildbot/bin/python'} 04:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:27 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 04:59:27 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 04:59:27 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 04:59:27 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 04:59:27 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 04:59:27 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 04:59:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:59:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59:29 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 04:59:29 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 04:59:29 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 04:59:29 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 04:59:29 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 04:59:29 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 04:59:29 INFO - Downloading docopt-0.6.1.tar.gz 04:59:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:29 INFO - Running setup.py install for blobuploader 04:59:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:59:29 INFO - Running setup.py install for requests 04:59:30 INFO - Running setup.py install for docopt 04:59:30 INFO - Successfully installed blobuploader requests docopt 04:59:30 INFO - Cleaning up... 04:59:30 INFO - Return code: 0 04:59:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:59:30 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')]} 04:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:30 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')]} 04:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:30 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:30 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 04:59:30 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 04:59:30 INFO - Using env: {'DISPLAY': ':0', 04:59:30 INFO - 'HOME': '/home/cltbld', 04:59:30 INFO - 'LANG': 'en_US.UTF-8', 04:59:30 INFO - 'LANGUAGE': 'en_US:en', 04:59:30 INFO - 'LOGNAME': 'cltbld', 04:59:30 INFO - 'MAIL': '/var/mail/cltbld', 04:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:30 INFO - 'MOZ_NO_REMOTE': '1', 04:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:30 INFO - 'NO_EM_RESTART': '1', 04:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:30 INFO - 'SHELL': '/bin/bash', 04:59:30 INFO - 'SHLVL': '1', 04:59:30 INFO - 'TERM': 'linux', 04:59:30 INFO - 'TMOUT': '86400', 04:59:30 INFO - 'USER': 'cltbld', 04:59:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:30 INFO - '_': '/tools/buildbot/bin/python'} 04:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:30 INFO - Running setup.py (path:/tmp/pip-T6RzTY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:30 INFO - Running setup.py (path:/tmp/pip-NKjjlX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:30 INFO - Running setup.py (path:/tmp/pip-JZLB9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:30 INFO - Running setup.py (path:/tmp/pip-1Z34Fk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:30 INFO - Running setup.py (path:/tmp/pip-UglyGe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:30 INFO - Running setup.py (path:/tmp/pip-DGNPQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:30 INFO - Running setup.py (path:/tmp/pip-aVOLBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:30 INFO - Running setup.py (path:/tmp/pip-ix2JHz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:31 INFO - Running setup.py (path:/tmp/pip-cgHW1u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:31 INFO - Running setup.py (path:/tmp/pip-7lJyNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:31 INFO - Running setup.py (path:/tmp/pip-xd5JfI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:31 INFO - Running setup.py (path:/tmp/pip-i9zTgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:31 INFO - Running setup.py (path:/tmp/pip-QcYrIh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:31 INFO - Running setup.py (path:/tmp/pip-QRrotA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:31 INFO - Running setup.py (path:/tmp/pip-1kkg2L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:31 INFO - Running setup.py (path:/tmp/pip-IEsI5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:31 INFO - Running setup.py (path:/tmp/pip-tI7a_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:31 INFO - Running setup.py install for manifestparser 04:59:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:59:31 INFO - Running setup.py install for mozcrash 04:59:31 INFO - Running setup.py install for mozdebug 04:59:31 INFO - Running setup.py install for mozdevice 04:59:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Running setup.py install for mozfile 04:59:32 INFO - Running setup.py install for mozhttpd 04:59:32 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Running setup.py install for mozinfo 04:59:32 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Running setup.py install for mozInstall 04:59:32 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Running setup.py install for mozleak 04:59:32 INFO - Running setup.py install for mozlog 04:59:32 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Running setup.py install for moznetwork 04:59:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Running setup.py install for mozprocess 04:59:32 INFO - Running setup.py install for mozprofile 04:59:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:59:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:59:33 INFO - Running setup.py install for mozrunner 04:59:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:59:33 INFO - Running setup.py install for mozscreenshot 04:59:33 INFO - Running setup.py install for moztest 04:59:33 INFO - Running setup.py install for mozversion 04:59:33 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:59:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:59:33 INFO - Cleaning up... 04:59:33 INFO - Return code: 0 04:59:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04: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')]} 04:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:33 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:33 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 04:59:33 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 04:59:33 INFO - Using env: {'DISPLAY': ':0', 04:59:33 INFO - 'HOME': '/home/cltbld', 04:59:33 INFO - 'LANG': 'en_US.UTF-8', 04:59:33 INFO - 'LANGUAGE': 'en_US:en', 04:59:33 INFO - 'LOGNAME': 'cltbld', 04:59:33 INFO - 'MAIL': '/var/mail/cltbld', 04:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:33 INFO - 'MOZ_NO_REMOTE': '1', 04:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:33 INFO - 'NO_EM_RESTART': '1', 04:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:33 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:33 INFO - 'SHELL': '/bin/bash', 04:59:33 INFO - 'SHLVL': '1', 04:59:33 INFO - 'TERM': 'linux', 04:59:33 INFO - 'TMOUT': '86400', 04:59:33 INFO - 'USER': 'cltbld', 04:59:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:33 INFO - '_': '/tools/buildbot/bin/python'} 04:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:33 INFO - Running setup.py (path:/tmp/pip-wxuMyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:59:33 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)) 04:59:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:33 INFO - Running setup.py (path:/tmp/pip-vqtOfY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:59:33 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)) 04:59:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:33 INFO - Running setup.py (path:/tmp/pip-T6YzcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:59:33 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)) 04:59:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:33 INFO - Running setup.py (path:/tmp/pip-GVX8a1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:59:33 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)) 04:59:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:33 INFO - Running setup.py (path:/tmp/pip-qAi5EC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:34 INFO - Running setup.py (path:/tmp/pip-xOvKWT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:34 INFO - Running setup.py (path:/tmp/pip-nz2xaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:34 INFO - Running setup.py (path:/tmp/pip-fbpETs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:34 INFO - Running setup.py (path:/tmp/pip-FYzQtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:34 INFO - Running setup.py (path:/tmp/pip-898qcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:34 INFO - Running setup.py (path:/tmp/pip-EjvnEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:34 INFO - Running setup.py (path:/tmp/pip-xB3s1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:34 INFO - Running setup.py (path:/tmp/pip-pomeJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:34 INFO - Running setup.py (path:/tmp/pip-JGM1FU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:34 INFO - Running setup.py (path:/tmp/pip-_xTZvU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:34 INFO - Running setup.py (path:/tmp/pip-6l8Jax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:59:34 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)) 04:59:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:34 INFO - Running setup.py (path:/tmp/pip-gsjwxs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:59:34 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)) 04:59:34 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)) 04:59:34 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)) 04:59:34 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)) 04:59:34 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)) 04:59:34 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)) 04:59:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:36 INFO - Downloading blessings-1.6.tar.gz 04:59:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:59:36 INFO - Installing collected packages: blessings 04:59:36 INFO - Running setup.py install for blessings 04:59:36 INFO - Successfully installed blessings 04:59:36 INFO - Cleaning up... 04:59:36 INFO - Return code: 0 04:59:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:59:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:59:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:59:37 INFO - Reading from file tmpfile_stdout 04:59:37 INFO - Current package versions: 04:59:37 INFO - argparse == 1.2.1 04:59:37 INFO - blessings == 1.6 04:59:37 INFO - blobuploader == 1.2.4 04:59:37 INFO - docopt == 0.6.1 04:59:37 INFO - manifestparser == 1.1 04:59:37 INFO - mozInstall == 1.12 04:59:37 INFO - mozcrash == 0.16 04:59:37 INFO - mozdebug == 0.1 04:59:37 INFO - mozdevice == 0.48 04:59:37 INFO - mozfile == 1.2 04:59:37 INFO - mozhttpd == 0.7 04:59:37 INFO - mozinfo == 0.9 04:59:37 INFO - mozleak == 0.1 04:59:37 INFO - mozlog == 3.1 04:59:37 INFO - moznetwork == 0.27 04:59:37 INFO - mozprocess == 0.22 04:59:37 INFO - mozprofile == 0.28 04:59:37 INFO - mozrunner == 6.11 04:59:37 INFO - mozscreenshot == 0.1 04:59:37 INFO - mozsystemmonitor == 0.0 04:59:37 INFO - moztest == 0.7 04:59:37 INFO - mozversion == 1.4 04:59:37 INFO - psutil == 3.1.1 04:59:37 INFO - requests == 1.2.3 04:59:37 INFO - wsgiref == 0.1.2 04:59:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:37 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 04:59:37 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 04:59:37 INFO - Using env: {'DISPLAY': ':0', 04:59:37 INFO - 'HOME': '/home/cltbld', 04:59:37 INFO - 'LANG': 'en_US.UTF-8', 04:59:37 INFO - 'LANGUAGE': 'en_US:en', 04:59:37 INFO - 'LOGNAME': 'cltbld', 04:59:37 INFO - 'MAIL': '/var/mail/cltbld', 04:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:37 INFO - 'MOZ_NO_REMOTE': '1', 04:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:37 INFO - 'NO_EM_RESTART': '1', 04:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:37 INFO - 'SHELL': '/bin/bash', 04:59:37 INFO - 'SHLVL': '1', 04:59:37 INFO - 'TERM': 'linux', 04:59:37 INFO - 'TMOUT': '86400', 04:59:37 INFO - 'USER': 'cltbld', 04:59:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:37 INFO - '_': '/tools/buildbot/bin/python'} 04:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 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)) 04:59:37 INFO - Cleaning up... 04:59:37 INFO - Return code: 0 04:59:37 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:37 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 04:59:37 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 04:59:37 INFO - Using env: {'DISPLAY': ':0', 04:59:37 INFO - 'HOME': '/home/cltbld', 04:59:37 INFO - 'LANG': 'en_US.UTF-8', 04:59:37 INFO - 'LANGUAGE': 'en_US:en', 04:59:37 INFO - 'LOGNAME': 'cltbld', 04:59:37 INFO - 'MAIL': '/var/mail/cltbld', 04:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:37 INFO - 'MOZ_NO_REMOTE': '1', 04:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:37 INFO - 'NO_EM_RESTART': '1', 04:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:37 INFO - 'SHELL': '/bin/bash', 04:59:37 INFO - 'SHLVL': '1', 04:59:37 INFO - 'TERM': 'linux', 04:59:37 INFO - 'TMOUT': '86400', 04:59:37 INFO - 'USER': 'cltbld', 04:59:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:37 INFO - '_': '/tools/buildbot/bin/python'} 04:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:37 INFO - Downloading/unpacking jsonschema 04:59:37 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 04:59:37 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 04:59:37 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 04:59:37 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 04:59:37 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 04:59:37 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 04:59:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:59:39 INFO - Downloading/unpacking functools32 (from jsonschema) 04:59:39 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 04:59:39 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 04:59:39 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 04:59:39 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 04:59:39 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 04:59:39 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 04:59:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:59:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:59:39 INFO - warning: no files found matching '*.txt' 04:59:39 INFO - no previously-included directories found matching 'build' 04:59:39 INFO - no previously-included directories found matching 'dist' 04:59:39 INFO - no previously-included directories found matching '.git*' 04:59:39 INFO - Installing collected packages: jsonschema, functools32 04:59:39 INFO - Running setup.py install for functools32 04:59:39 INFO - warning: no files found matching '*.txt' 04:59:39 INFO - no previously-included directories found matching 'build' 04:59:39 INFO - no previously-included directories found matching 'dist' 04:59:39 INFO - no previously-included directories found matching '.git*' 04:59:39 INFO - Successfully installed jsonschema functools32 04:59:39 INFO - Cleaning up... 04:59:39 INFO - Return code: 0 04:59:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:59:39 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')]} 04:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:39 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')]} 04:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:39 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 0x7f6a8d7e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, '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-1454417549.776854-238078821', '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 04:59:39 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 04:59:39 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 04:59:39 INFO - Using env: {'DISPLAY': ':0', 04:59:39 INFO - 'HOME': '/home/cltbld', 04:59:39 INFO - 'LANG': 'en_US.UTF-8', 04:59:39 INFO - 'LANGUAGE': 'en_US:en', 04:59:39 INFO - 'LOGNAME': 'cltbld', 04:59:39 INFO - 'MAIL': '/var/mail/cltbld', 04:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:39 INFO - 'MOZ_NO_REMOTE': '1', 04:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:39 INFO - 'NO_EM_RESTART': '1', 04:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:39 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:39 INFO - 'SHELL': '/bin/bash', 04:59:39 INFO - 'SHLVL': '1', 04:59:39 INFO - 'TERM': 'linux', 04:59:39 INFO - 'TMOUT': '86400', 04:59:39 INFO - 'USER': 'cltbld', 04:59:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:39 INFO - '_': '/tools/buildbot/bin/python'} 04:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:40 INFO - Downloading/unpacking flake8 04:59:40 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 04:59:40 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 04:59:40 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 04:59:40 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 04:59:40 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 04:59:40 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 04:59:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:59:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04: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 04: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 04: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 04: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 04: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 04: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 04:59:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:59:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04: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 04: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 04: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 04: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 04: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 04: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 04:59:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:59:42 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 04:59:42 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 04:59:42 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 04:59:42 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 04:59:42 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 04:59:42 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 04:59:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:59:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:42 INFO - no previously-included directories found matching 'docs/_build' 04:59:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:59:42 INFO - Running setup.py install for pep8 04:59:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:42 INFO - no previously-included directories found matching 'docs/_build' 04:59:42 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:59:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:59:42 INFO - Cleaning up... 04:59:42 INFO - Return code: 0 04:59:42 INFO - Running post-action listener: _resource_record_post_action 04:59:42 INFO - Running post-action listener: _start_resource_monitoring 04:59:42 INFO - Starting resource monitoring. 04:59:42 INFO - ##### 04:59:42 INFO - ##### Running install step. 04:59:42 INFO - ##### 04:59:42 INFO - Running pre-action listener: _resource_record_pre_action 04:59:42 INFO - Running main action method: install 04:59:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:59:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:59:42 INFO - Reading from file tmpfile_stdout 04:59:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:59:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:59:43 INFO - Reading from file tmpfile_stdout 04:59:43 INFO - Output received: 04:59:43 INFO - Usage: mozinstall [options] installer 04:59:43 INFO - Options: 04:59:43 INFO - -h, --help show this help message and exit 04:59:43 INFO - -d DEST, --destination=DEST 04:59:43 INFO - Directory to install application into. [default: 04:59:43 INFO - "/builds/slave/test-pgo"] 04:59:43 INFO - --app=APP Application being installed. [default: firefox] 04:59:43 INFO - mkdir: /builds/slave/test-pgo/build/application 04:59:43 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'] 04:59:43 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 04:59:57 INFO - Reading from file tmpfile_stdout 04:59:57 INFO - Output received: 04:59:57 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:59:57 INFO - Running post-action listener: _resource_record_post_action 04:59:57 INFO - ##### 04:59:57 INFO - ##### Running run-tests step. 04:59:57 INFO - ##### 04:59:57 INFO - Running pre-action listener: _resource_record_pre_action 04:59:57 INFO - Running main action method: run_tests 04:59:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:59:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:59:57 INFO - Python 2.7.3 04:59:57 INFO - Return code: 0 04:59:57 INFO - grabbing minidump binary from tooltool 04:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:57 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 0x1df0660>, '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 0x1df1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:59:57 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 04:59:57 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 04:59:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:58 INFO - Return code: 0 04:59:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:59:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:59:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:59:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:59:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:59:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:59:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:59:59 INFO - Return code: 0 04:59:59 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/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:59 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/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:59 INFO - Using env: {'DISPLAY': ':0', 04:59:59 INFO - 'HOME': '/home/cltbld', 04:59:59 INFO - 'LANG': 'en_US.UTF-8', 04:59:59 INFO - 'LANGUAGE': 'en_US:en', 04:59:59 INFO - 'LOGNAME': 'cltbld', 04:59:59 INFO - 'MAIL': '/var/mail/cltbld', 04:59:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:59:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:59 INFO - 'MOZ_NO_REMOTE': '1', 04:59:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:59 INFO - 'NO_EM_RESTART': '1', 04:59:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:59:59 INFO - 'SHELL': '/bin/bash', 04:59:59 INFO - 'SHLVL': '1', 04:59:59 INFO - 'TERM': 'linux', 04:59:59 INFO - 'TMOUT': '86400', 04:59:59 INFO - 'USER': 'cltbld', 04:59:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1454417549.776854-238078821', 04:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:59 INFO - '_': '/tools/buildbot/bin/python'} 04:59:59 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/Fg78qDabSW-IMuhwOU2_1Q/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 04:59:59 INFO - mozversion application_buildid: 20160202021619 04:59:59 INFO - mozversion application_changeset: a718e60e2967bef3a810859f031550b3491f3d49 04:59:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:59:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:59 INFO - mozversion application_name: Firefox 04:59:59 INFO - mozversion application_remotingname: firefox-dev 04:59:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:59:59 INFO - mozversion application_vendor: Mozilla 04:59:59 INFO - mozversion application_version: 46.0a2 04:59:59 INFO - mozversion platform_buildid: 20160202021619 04:59:59 INFO - mozversion platform_changeset: a718e60e2967bef3a810859f031550b3491f3d49 04:59:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:59:59 INFO - mozversion platform_version: 46.0a2 04:59:59 INFO - using testdate: 1454417999 04:59:59 INFO - actual date: 1454417999 04:59:59 INFO - starting webserver on 'localhost:57154' 04:59:59 INFO - SUITE-START | Running 3 tests 04:59:59 INFO - TEST-START | dromaeo_css 04:59:59 INFO - operating with platform_type : linux_ 04:59:59 INFO - Initialising browser for dromaeo_css test... 04:59:59 INFO - TEST-INFO | started process 2698 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfUs77y/profile http://localhost:57154/getInfo.html) 05:00:02 INFO - PROCESS | 2698 | 05:00:02 INFO - PROCESS | 2698 | (process:2857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:03 INFO - PROCESS | 2698 | __metrics Screen width/height:1600/1200 05:00:03 INFO - PROCESS | 2698 | colorDepth:24 05:00:03 INFO - PROCESS | 2698 | Browser inner width/height: 1024/697 05:00:03 INFO - PROCESS | 2698 | __metrics 05:00:04 INFO - TEST-INFO | 2698: exit 0 05:00:04 INFO - Browser initialized. 05:00:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:04 INFO - TEST-INFO | started process 2924 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfUs77y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:05 INFO - PROCESS | 2924 | 05:00:05 INFO - PROCESS | 2924 | (process:2992): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:16 INFO - PROCESS | 2924 | RSS: Main: 140292096 05:00:16 INFO - PROCESS | 2924 | 05:01:05 INFO - PROCESS | 2924 | 1454418065887 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:03:13 INFO - PROCESS | 2924 | Cycle 1(1): loaded http://localhost:57154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57154/tests/dromaeo/cssquery-ext.html) 05:03:15 INFO - PROCESS | 2924 | RSS: Main: 145821696 05:03:15 INFO - PROCESS | 2924 | 05:06:17 INFO - PROCESS | 2924 | Cycle 1(1): loaded http://localhost:57154/tests/dromaeo/cssquery-ext.html (next: http://localhost:57154/tests/dromaeo/cssquery-jquery.html) 05:06:17 INFO - PROCESS | 2924 | RSS: Main: 144625664 05:06:17 INFO - PROCESS | 2924 | 05:09:19 INFO - PROCESS | 2924 | Cycle 1(1): loaded http://localhost:57154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57154/tests/dromaeo/cssquery-mootools.html) 05:09:19 INFO - PROCESS | 2924 | RSS: Main: 143740928 05:09:19 INFO - PROCESS | 2924 | 05:12:21 INFO - PROCESS | 2924 | Cycle 1(1): loaded http://localhost:57154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57154/tests/dromaeo/cssquery-prototype.html) 05:12:22 INFO - PROCESS | 2924 | RSS: Main: 142532608 05:12:22 INFO - PROCESS | 2924 | 05:15:24 INFO - PROCESS | 2924 | Cycle 1(1): loaded http://localhost:57154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57154/tests/dromaeo/cssquery-yui.html) 05:15:25 INFO - PROCESS | 2924 | RSS: Main: 144498688 05:15:25 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | Cycle 1(1): loaded http://localhost:57154/tests/dromaeo/cssquery-yui.html (next: http://localhost:57154/tests/dromaeo/cssquery-dojo.html) 05:18:27 INFO - PROCESS | 2924 | RSS: Main: 145883136 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | __start_tp_report 05:18:27 INFO - PROCESS | 2924 | _x_x_mozilla_page_load 05:18:27 INFO - PROCESS | 2924 | _x_x_mozilla_page_load_details 05:18:27 INFO - PROCESS | 2924 | |i|pagename|runs| 05:18:27 INFO - PROCESS | 2924 | |0;dojo.html;3370.848311825968;3378.7128094111986;3400.013995941177;3416.1971936594896;3432.244906120654;5497.285352904117;5511.944880551193;5514.228008078872;5530.5022547970675;5576.832695019146;5514.862128446791;5582.190582365554;5583.553315734742;5586.441355864412;5613.747381367838;5072.3405957225605;5113.386393632769;5143.408508021588;5170.121079416508;5272.841814745564;4920.852374428755;5090.236464530331;5094.84715458535;5098.311727916739;5196.480351964792;5176.404713457944;5185.688858668473;5185.896282074356;5215.739213039333;5244.213367994812;5171.120909445403;5180;5181.999999999963;5189.247559103909;5222.895542089175;4928.679635823696;4935.605151587864;4971.751412429364;5084.339035925343;5096.719680417576;5334.786608535654;5356.330458692663;5356.705381204032;5378.8924221515745;5411.83764487066;5910.8817823643285;5953.58324917256;6005.939940600625;6013.488853447462;6018.638881667114;5880.705964701748;5941.792037278675;6044.304904935944;6055.939440605582;6090.421409966046;5678.233438485793;5685.118806584986;5689.601727879091;5697.658140511582;5719.942800571983;6172.567920245539;6187.412195841388;6198.659073750897;6201.441870231701;6202.193714817045;5745.913811292834;5830.4461076197695;5839.124131380327;5965.343812180657;5967.492763115097;6013.398660134039;6021.3677563856045;6025.66858822769;6026.668533230627;6032.3967603239325;5913.379095194942;5925.170476133345;5955.196048533479;5970.76116955317;5987.43119403656;5616.634918730269;5770.913436298459;5945.1973983512535;6041.154238406627;6072.149899014142;4562.087582483517;4585.495595484494;4609.492955774862;4616.515265897099;4639.257718764981;4031;4115.444415003996;4131.938020929689;4151.916961660811;4163.7293575917465;5575.135853942646;5677.829665110054;5718.828435146952;5765.1928729977835;5791.160281759121;5931.40685931412;5962.284525856925;5999.340072592011;5999.820005399845;6007.639541627516;5568.443155684399;5656.321241451053;5658;5678.77284908599;5686.692060826033;5117.257997590403;5163.251328557413;5166.6125040621355;5168.3539557555305;5206.297149884717;6132.662703551258;6152;6220.813375598739;6231.345708700521;6238.875222495525;5852.092925596369;5869.031609784338;6008.849778755566;6059.787907423219;6065.636061836304;6175.598586092069;6176.938230617637;6203.410675985774;6214.223222097238;6227.9377206227355;5880.294364676266;6017.368176341596;6018.398160183947;6025.939740602538;6048.153258543719;5908.084246941731;5985.551083668655;6006.129111278928;6009.969950150221;6095.299040610386;5752.13717942312;5782.739776710142;5814.418558144152;5822.097574875901;5847.38602446737;5873.882522349614;5883.2057672213705;5895.410458954242;5898.498627616701;5904.173415721888;5702.6863522506665;5727.198192253171;5745.798897038583;5757.798477053283;5758.769649214152;5789.594728369142;5894.174815525744;5898.997170480942;5911.142884281841;5919.31927828288;5811.94188058114;5819.679917604572;5828.154917536848;5833.445822646841;5837.211976383134 05:18:27 INFO - PROCESS | 2924 | |1;ext.html;556.6214973817803;571.8884817460595;580.1877371679645;584.0538327908788;585.6690969602174;37935.62064379359;38972.80513597432;38993.61006389935;39176.216475670466;39187;41453.58546414535;41499.58500414995;41500.58499415005;41760.95597610061;41849.790751046276;8734.213920747132;8963.507007114606;8976.685815996441;8978.191962723353;8997.325200609948;8841.73474795754;9019.684311049115;9061.50161741104;9065.18413342799;9105.863412048824;9045.412048216878;9118.361714679975;9120.17918387345;9120.680776172836;9137.451752894847;8935.821283574325;9010.414323069012;9051.502167380791;9097.545122743837;9116.680916167968;8914.554272286425;8976.685815996474;9002.234810041155;9037.638494460214;9055.683051093247;40910.38634420486;40976.38535421971;41292.38061429081;41318.38022429666;41381.172376552604;3588.5155504006884;3597.0647631615707;3616.3129005488872;3776;3830.80845957701;31055.378892422024;31259.531107033414;31435.214119646964;31648.841755791073;32111.6788832111;3615;3644.2529281497227;3688.3360995020885;3689.5203623529037;3772.7170462215167;212012;213154;213989;214385;214561;44001.77999109984;44089.338659920126;44471;44555.55444445579;44686;42397.36403953943;42527.14945701069;42601.36097958533;42646;42698.78650606727;16345.591360216089;16508;16549.172541372882;16550.50348489547;16636.33454661824;13526.59420217395;13552.051356404956;13576.660583485294;13627.591172264649;13936.512222072179;14873.479428220176;15038.097714137186;15051.774223386657;15056.548303550911;15079.924600377148;5928.229330187048;6012.549058820518;6066.48434883031;6135.5398345124295;6179.146256123145;1005.2912696548915;1008.0574662690408;1122.5958654884234;1145.7135716070982;1147.949626092133;30472.54291185634;31236.84381578123;33090.66909330876;33303.666963330055;33337.83331083329;1201.9699507512207;1242.993785031087;1276.9528986231387;1324.6291038509232;1350.9256990865597;15663.68672626541;15707;15891.594384644704;15949.20253987296;16249;566803;820190;840862;906839;909046;55778;55930.44069559334;56016.43983560194;56131;56395;1508.6605513759316;1526.282647155835;1528.7936128622493;1532.1802835483186;1535.3474773221337;30890;31365.529517056806;31848.840755796075;31993.36013279768;32126.678733212368;48931.26603101027;49134.75432622814;49143.508564915326;49319.26021109758;49335.75332123316;307708;309806;311985;312450;312708;33383.66616333806;33787.32425351528;33955.3208935815;34228;34650.13374665654;44454.333185001604;45301.64095077153;45374.31938520859;45816.77091614521;45983;38305.80847095858;39065.60934390734;39145.217095658496;39444.80277598594;39579.80210099046;38506.80746596249;38688.41967370548;39107.80446097751;39342.40986385264;39395.40906886342;39004.219915602094;39494.60505394909;39603;39846.60153398429;40074.59925400709;33959.66040339565;34414.11596675325;34906.65093349034;35082.29835403227;35096.29807403889;27067.72932270652;27476.862615686794;27735.167944961682;27762.305942351602;27830.582541261494 05:18:27 INFO - PROCESS | 2924 | |2;jquery.html;395.5629029921937;398.12412692077436;399.6483094876508;400.4673783867457;401.8975161333859;14819.555413337617;15370.69258614827;17377.565560860985;17896.642067158664;17983.82016179838;11223.38271395073;11597.246178998359;15371.84628153718;16835.32658693654;16947.91526042371;4963.032208719292;5196.454372290912;5628.859278518029;5631.1271752878165;5640.435956404368;5243.3970093439175;5391.272178255925;5454.945450545503;5455.563554915617;5457.181422786594;5431.782728690868;5464.562834973192;5659.60382773206;5866.853328666774;5962.135490353896;5751.827445176651;5813.244278243801;6111.297200821896;6179.721912513947;6202.069689546559;5546.417626149237;5571.721413929328;5579.553635709174;5580.107182850725;5632.633878797865;15785.763213551805;20182.293619723237;20652.380428587017;20735.68896466539;21032.894835525876;2147.4309308033385;2223.5108276179217;2257.2099765082253;2310.953780924372;2389.51015041916;9913.603455861758;9922.355046921999;9980.401175929468;10073.798524029551;10152.23858210637;1901.7242499837585;2031.3601215617034;2047.948801279965;2048.9487762806048;2121.4802373418456;59362.406375936116;59498;60722.69638651778;61135.694321528106;61308.69345653288;10564.313319634199;10910.399928003877;10992.835107473395;11010.174236932102;11012;13697.726045479234;13879;13881.167129972235;13922.791158132635;13974.860251397558;8273;8344;8364.58177091143;8378.204070613281;8394.076651568323;8098.595070246464;8198.098209197104;8245.670173193004;8272.8345433091;8307.709230176915;4577.267637178035;4677.695949763254;4730.455997560324;4776.23580227162;4789.95210047895;1897.2924368068573;1904.190718944443;1913.2538310059088;1917.9712304315447;1938.3409640722223;965.2760429677742;990.6087095597198;997.187292356727;1022.6829682798357;1025.5692609104194;16073.276702548179;16859;17039.14804259782;17980.784500555746;18255.36106236302;983.852422136671;1028.4908970059869;1036.7304500829687;1079.7894410589859;1106.623747925709;9939.552720127467;10452.529636166391;10502.789944201073;10507.159427245802;10604.363738175734;607045;626026;632632;636707;647232;47346;54527;74830;75491.62254188694;79332.6033369841;1162.91859569831;1186.762647470492;1188.6968822950093;1202.0213094656715;1211.4003568233782;16036;16063;16080.758788618414;16125.435609753602;16340.754888676916;21883.562328753655;22411.551768964204;31609.841950790098;33443.49834752432;34729.305413892085;42482.78758606187;43134.35298470588;43356;43780.34329485124;44076.67769966906;3001.8198908065588;6589.45147890255;7102.644867756695;7170.1754298256365;7251.1298644163035;10576.788464230825;10685.679429616814;10948;11057.778844423228;11196.328220306808;3149.952750708787;3221.436248656523;8259.463134896212;10119.217215265566;10231.334963227366;10243.487825608541;10248.333858299187;10347.43089130075;10418.531166097393;10530.31552949056;10528.420936848546;10572.418516981332;10611.575536978435;10699.197560183173;10719.89280107189;7721.729739459092;7819.257170568787;7842.176571459914;7868.72459463939;7876.133625301098;9300.255979521757;10487.528061237415;10494.632687855888;10632.202584806017;10659.14726821868 05:18:27 INFO - PROCESS | 2924 | |3;mootools.html;1550.736374816281;1579.2972127403307;1776.294757033248;1861.9534511637216;1895.658781419344;7197.064381630394;7296.744613938513;8328.08391076981;8439.662413503453;8556.101609331025;7776.105747839;7877.369810415167;7903.960480197606;7967.20327967203;7978.042634883807;2488.390344365633;2504.8371855829405;2521.0546045233036;2524.911628093017;2531.2659328794625;2378.203301893859;2387.415083304584;2391.940201494968;2393.772591603795;2405.1461731085474;2357.834951553392;2402.8798560071928;2407.6027455469916;2420.1287536486852;2424.696912885889;2409.590369637157;2419.576574099543;2421.1767998880377;2435.074671624789;2435.3546310227803;2397.520495900827;2406.374342670918;2416.589179839414;2419.1774796569252;2419.395151212197;8445.071042185355;8463.534505602189;8469.83060338796;8491.320694344438;8518.616662250213;5142.331496905415;5183.2743415921805;5221;5252.789888404459;5268.973655131738;3440.122768693992;3495.4057810172076;3544.6987006104255;3561.3589553880292;3576.6065732769375;1181.1790805390258;1192.272713644676;1202.8496437945257;1222.7004383925996;1222.8532576090838;11961.581344652895;12002.819957700642;12070.698232544257;12151.149419540636;12191.695207619792;4746.264329029006;4788.545088216614;4795.664303498791;4875.976045030512;4876.097921884463;10103.19174466041;10187.032231937954;10192.490375481197;10193.337433066976;10195.031472010147;5342.5993050521365;5384.596155288369;5390.595705322116;5398.001369746609;5404.054290499147;4748.216544270226;4846.273059041172;4880.902381952341;4902.754862256873;4910.656254062182;3876.8836934891997;3899;3914.236723838881;3914.2954268231424;3964.385520244367;1161.3960740415105;1170.7307319316435;1177.8174382970483;1194.1939191046008;1199.7660456211129;1402.6647660905528;1402.8386735525341;1414.476643641859;1431.7923901034292;1440.4454285100312;8164.75505734817;8172.754817355489;8192.18078192188;8237.341012718967;8269.131741167092;530.2708775433779;534.1347017831139;539.9784008639689;542.6391449685993;543.323562165107;6073.362296958844;6108.786192483241;6152.323244443108;6181.196444462191;6209.254889413209;10367.740806479747;10455.790884182274;10569.101626361691;10605.204609654307;10607.734806629896;9887;10243.743906402251;10312.793744125076;10329.793404131875;10490.370577765358;7929.5242285463055;8068.273855353046;8068.3948703847445;8085.959570202229;8116.066652334939;7717.922820771721;7741.729039483591;7814.4529882907655;7860.213978602094;7860.646270917937;8966.372353935423;9187.310951678517;9259;9322.440653560809;9332.860007099764;9334.813303734023;9405.106514881076;9554.474503902353;9596.66411675588;9643.469609171283;6476.5466417350335;6627.3372662733345;7388.335049845539;7400.259974002557;7483.812904677427;7933.920660793318;7957.920420795949;7998.9200108000505;8014.158513356247;8079.87880181786;7367.189609143097;7480.952666626786;7584.962075189589;7596.050493688289;7639.732609358646;7337.119545654556;7413.147488038944;7441.590712510864;7529.774106776806;7531.322181003736;7654.158042615197;7724.729634462767;7755.069391673035;7838.137804841349;7861.056673199024;6426.228852537725;6568.441682457044;7070.611116388648;7088.972099045506;7119.430445564239;7027.894581581382;7110.288971102848;7116.8932466014085;7123.643817809192;7152.213256541672 05:18:27 INFO - PROCESS | 2924 | |4;prototype.html;365.77139287945033;371.67849809914424;373.6170425314053;375.54746530430816;384.5020698195837;6247.406496382842;6307.211598550181;6310.305866354697;6352.237731472224;6502.934970650292;6316.652584107872;6318.715657795398;6362.1093046973465;6366.777162799303;6376.39424254695;4784.545468180518;4807.399075115602;4822.324874517552;4829.68607040543;4829.951700483003;4799.928001079969;4821.349117869096;4844.394450693663;4847.781849816767;4870.756462176894;4720.622350211992;4811.59101476375;4815.229563269878;4824.4210694716685;4825.420949486049;4801.423829140491;4807.230843065127;4816.44610869751;4828.010257897158;4828.106800241966;4192.056787222881;4194.370844373338;4207.221663992141;4209.3896385024;4211.768352740598;5963.254593175853;5971.0744834550715;6002.129691194796;6003.909941350883;6018.638881667071;5462.781488740446;5615.241942337814;5669.177969194485;5672.290963629546;5687;6682.699278532477;6688.130543029423;6733.595984240961;6735;6738.124043874314;4673.322368256584;4677.695949763254;4677.695949763254;4683.250679891201;4703.247480403119;6914;7007.299270073003;7072.3634872861685;7081.645917704094;7085.43316534676;4583.770811459481;4592.540745925381;4602.424696912886;4608.976955115203;4611.492735799059;4665.6967297125575;4666.533346665374;4669.41632295963;4700.106979673919;4714.858554243378;5512.724363781795;5518.475744804237;5527.668339899619;5528.06022976095;5536.640118392292;6565.161754708689;6790.796276111724;6792;6800.08198893153;6819.863602727918;1672.1221358786734;1692.5768557860536;1711.8630509559205;1714.579927917668;1717.9398721044704;1108.562117963416;1110.5224753356135;1110.650145204258;1113.7271368514766;1128.5880653561555;6327.240731112204;6382.329855365213;6390.9360906391275;6398.29618741938;6431.356864313531;6891.414229790524;6902.344277293649;6917.239103698589;6927.896081558781;6936.895946560806;6379.872402551923;6398.840028999312;6410.967945160244;6414.294427612959;6419.903701444482;3737.364648009845;3778.5654649715084;3787.981060094682;3798.088458769875;3798.3352913240624;7264;7283.8543229136185;7295.124585049828;7308.37878780299;7315.743948961761;7119.181294151135;7249.456290778213;7270.091238595176;7289.271072892774;7327.487075904742;7197.676104575306;7204.24355442671;7225.096862892034;7250.383717384081;7256.6734496947765;7041.683124259318;7042.894356584758;7066.964665176642;7084.079069720903;7093.929060709327;6730.360615741497;6916.55042422241;6951.582905025714;6957.617331046638;6982.755603553851;7141.571505709674;7218.061651985208;7219.241979592067;7225.349718525358;7243.963780181065;4823.5658790709;4863.927041094315;4866.051120031701;4869.513048695102;4871.902561948812;6830.897536537055;6907.067545881242;6985.650717464005;6995.930040699732;7051.048108505286;6832.897506537306;6833.658317084225;6863.725450981905;6866.244713081657;6911.7926462206215;6828.658567071726;6859.828504287233;6869.862602748017;6872.450203983769;6899.448044156355;6520.087187793808;6626.072349871119;6684.933150668431;6686.765963191265;6695.531312808252;6863.725450981905;6887.345702158287;6891.689873955785;6900.206476255295;6918.481113916376;6705.0612914193025;6738.292479289604;6739.595624262364;6739.764108256188;6749.966250168718 05:18:27 INFO - PROCESS | 2924 | |5;yui.html;857.3441317392194;934.6308208257742;936.9390989585677;950.1733491862082;973.1971123822846;15499.535013949586;15592.610184745387;15620.843791562082;15672.373105075783;15731.764023539656;15455.613609659737;15474;15521.301541430634;15524.301406436709;15528.844711552882;882.5410786391072;885.7342797160842;895.1317222294364;904.3307952115421;907.2061945797427;902.3908861518448;904.4663648447415;909.8134882349136;912.320321360584;913.968011119611;939.2908354192575;940.5250348573995;944.032366824004;947.4173383369213;947.9573419196153;938.7653086728318;939.0703203828161;939.1406862720603;940.7083804020775;942.6559305853383;644.2912795924492;652.6214795418646;654.7741029344868;671.2649648634737;697.3793323941696;14884.553463396116;14890.255487225704;14910.105393676415;14945.775813362809;15038.398464061424;13694;13916.930415347959;13923.791143132861;13937.303134843318;13951.232682202475;10775.5689772409;11003.394813285266;11007.724806879893;11048.06091482225;11083;3741.251749650081;3777.6411240932066;3785.0348161218712;3788.9431658525145;3804.5624753153465;50801;51136;52102.73948630271;52162.478375216524;52329.215061774106;10950.671479855617;10970.835437468444;11203.271787333797;11297.322160670386;11350.318980861175;19036.238550457827;19055.80944190568;19122.904385477985;19155.13801878919;19188.13653385601;7987.241212084843;8295.751127466187;8333.624986875606;8343.332533397313;8520.914790852135;4603.723776573416;4780.976095119502;4785.59322457588;4786.305985632133;4811.9518804812205;3318.5685860837934;3358.4962255661844;3385.9830700846337;3388.15296175956;3412.19813343864;617.1606615003592;645.5545673485374;649.399305642279;652.5530011941835;658.0819756439836;659.1431139518606;722.8156820010863;725.3073314984177;731.989020164698;754.9471536992357;8832.470051796912;8923.063078376807;8950.140745778914;9197.908020919838;9457.43255404678;714.0824041107256;718.9065421495172;737.4874462248686;738.8670039392961;761.8666733321758;4225.9788701056295;4499.550044995474;4585.862424127282;4599.2871104978785;4624.514425985223;55785.44214557884;56009.719951400795;56379.15431268534;56410.43589564134;56608.30175094754;53482;54395;54774;55082.72458637761;55115.724421377636;47276.7636161817;49581.752091240036;50033.9993200134;50120;50348.244776328385;8901.421407608485;9098.863517047117;9133.086691330815;9155.13026262504;9215.539223038688;36227.818860906584;36278.27443451169;36340;36392.636073638925;36967.630323696416;42834;50426.24360634667;51387.48612513977;51737.22394164015;51740.48259517357;11196.776064478501;11730.296182229093;12274.386280686109;12279.079069070034;12466.314352710326;13226.404811783685;13379.264140472367;13478.393472293574;13880.583582492542;14211.928940355232;12231.816522751988;12344.321062341658;12391.318477483825;12593.811092833797;12694.301813400352;11633.59282425111;11712.941435292769;11972.401379930794;11978.161528692908;12149.453274602487;12525.624231273076;12808.743825123633;13031.087823852618;13091.345432728516;13141.080124391201;9740.561674724513;9905.108540231413;10063.094321511098;10132.645357412455;10280.485975701335;11090.334579925231;11101.50043248072;11107.611233606785;11166.218364714392;11239.66281011571 05:18:27 INFO - PROCESS | 2924 | __end_tp_report 05:18:27 INFO - PROCESS | 2924 | __start_cc_report 05:18:27 INFO - PROCESS | 2924 | _x_x_mozilla_cycle_collect,300 05:18:27 INFO - PROCESS | 2924 | __end_cc_report 05:18:27 INFO - PROCESS | 2924 | __startTimestamp1454419107568__endTimestamp 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | ------- Summary: start ------- 05:18:27 INFO - PROCESS | 2924 | Number of tests: 6 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | [#0] dojo.html Cycles:165 Average:5570.58 Median:5770.91 stddev:610.79 (10.6%) stddev-sans-first:587.78 05:18:27 INFO - PROCESS | 2924 | Values: 3370.8 3378.7 3400.0 3416.2 3432.2 5497.3 5511.9 5514.2 5530.5 5576.8 5514.9 5582.2 5583.6 5586.4 5613.7 5072.3 5113.4 5143.4 5170.1 5272.8 4920.9 5090.2 5094.8 5098.3 5196.5 5176.4 5185.7 5185.9 5215.7 5244.2 5171.1 5180.0 5182.0 5189.2 5222.9 4928.7 4935.6 4971.8 5084.3 5096.7 5334.8 5356.3 5356.7 5378.9 5411.8 5910.9 5953.6 6005.9 6013.5 6018.6 5880.7 5941.8 6044.3 6055.9 6090.4 5678.2 5685.1 5689.6 5697.7 5719.9 6172.6 6187.4 6198.7 6201.4 6202.2 5745.9 5830.4 5839.1 5965.3 5967.5 6013.4 6021.4 6025.7 6026.7 6032.4 5913.4 5925.2 5955.2 5970.8 5987.4 5616.6 5770.9 5945.2 6041.2 6072.1 4562.1 4585.5 4609.5 4616.5 4639.3 4031.0 4115.4 4131.9 4151.9 4163.7 5575.1 5677.8 5718.8 5765.2 5791.2 5931.4 5962.3 5999.3 5999.8 6007.6 5568.4 5656.3 5658.0 5678.8 5686.7 5117.3 5163.3 5166.6 5168.4 5206.3 6132.7 6152.0 6220.8 6231.3 6238.9 5852.1 5869.0 6008.8 6059.8 6065.6 6175.6 6176.9 6203.4 6214.2 6227.9 5880.3 6017.4 6018.4 6025.9 6048.2 5908.1 5985.6 6006.1 6010.0 6095.3 5752.1 5782.7 5814.4 5822.1 5847.4 5873.9 5883.2 5895.4 5898.5 5904.2 5702.7 5727.2 5745.8 5757.8 5758.8 5789.6 5894.2 5899.0 5911.1 5919.3 5811.9 5819.7 5828.2 5833.4 5837.2 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | [#1] ext.html Cycles:180 Average:59054.86 Median:38998.91 stddev:141346.88 (362.4%) stddev-sans-first:141675.16 05:18:27 INFO - PROCESS | 2924 | Values: 556.6 571.9 580.2 584.1 585.7 37935.6 38972.8 38993.6 39176.2 39187.0 41453.6 41499.6 41500.6 41761.0 41849.8 8734.2 8963.5 8976.7 8978.2 8997.3 8841.7 9019.7 9061.5 9065.2 9105.9 9045.4 9118.4 9120.2 9120.7 9137.5 8935.8 9010.4 9051.5 9097.5 9116.7 8914.6 8976.7 9002.2 9037.6 9055.7 40910.4 40976.4 41292.4 41318.4 41381.2 3588.5 3597.1 3616.3 3776.0 3830.8 31055.4 31259.5 31435.2 31648.8 32111.7 3615.0 3644.3 3688.3 3689.5 3772.7 212012.0 213154.0 213989.0 214385.0 214561.0 44001.8 44089.3 44471.0 44555.6 44686.0 42397.4 42527.1 42601.4 42646.0 42698.8 16345.6 16508.0 16549.2 16550.5 16636.3 13526.6 13552.1 13576.7 13627.6 13936.5 14873.5 15038.1 15051.8 15056.5 15079.9 5928.2 6012.5 6066.5 6135.5 6179.1 1005.3 1008.1 1122.6 1145.7 1147.9 30472.5 31236.8 33090.7 33303.7 33337.8 1202.0 1243.0 1277.0 1324.6 1350.9 15663.7 15707.0 15891.6 15949.2 16249.0 566803.0 820190.0 840862.0 906839.0 909046.0 55778.0 55930.4 56016.4 56131.0 56395.0 1508.7 1526.3 1528.8 1532.2 1535.3 30890.0 31365.5 31848.8 31993.4 32126.7 48931.3 49134.8 49143.5 49319.3 49335.8 307708.0 309806.0 311985.0 312450.0 312708.0 33383.7 33787.3 33955.3 34228.0 34650.1 44454.3 45301.6 45374.3 45816.8 45983.0 38305.8 39065.6 39145.2 39444.8 39579.8 38506.8 38688.4 39107.8 39342.4 39395.4 39004.2 39494.6 39603.0 39846.6 40074.6 33959.7 34414.1 34906.7 35082.3 35096.3 27067.7 27476.9 27735.2 27762.3 27830.6 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | [#2] jquery.html Cycles:180 Average:30016.26 Median:3075.89 stddev:102811.05 (3342.5%) stddev-sans-first:103075.40 05:18:27 INFO - PROCESS | 2924 | Values: 395.6 398.1 399.6 400.5 401.9 14819.6 15370.7 17377.6 17896.6 17983.8 11223.4 11597.2 15371.8 16835.3 16947.9 4963.0 5196.5 5628.9 5631.1 5640.4 5243.4 5391.3 5454.9 5455.6 5457.2 5431.8 5464.6 5659.6 5866.9 5962.1 5751.8 5813.2 6111.3 6179.7 6202.1 5546.4 5571.7 5579.6 5580.1 5632.6 15785.8 20182.3 20652.4 20735.7 21032.9 2147.4 2223.5 2257.2 2311.0 2389.5 9913.6 9922.4 9980.4 10073.8 10152.2 1901.7 2031.4 2047.9 2048.9 2121.5 59362.4 59498.0 60722.7 61135.7 61308.7 10564.3 10910.4 10992.8 11010.2 11012.0 13697.7 13879.0 13881.2 13922.8 13974.9 8273.0 8344.0 8364.6 8378.2 8394.1 8098.6 8198.1 8245.7 8272.8 8307.7 4577.3 4677.7 4730.5 4776.2 4790.0 1897.3 1904.2 1913.3 1918.0 1938.3 965.3 990.6 997.2 1022.7 1025.6 16073.3 16859.0 17039.1 17980.8 18255.4 983.9 1028.5 1036.7 1079.8 1106.6 9939.6 10452.5 10502.8 10507.2 10604.4 607045.0 626026.0 632632.0 636707.0 647232.0 47346.0 54527.0 74830.0 75491.6 79332.6 1162.9 1186.8 1188.7 1202.0 1211.4 16036.0 16063.0 16080.8 16125.4 16340.8 21883.6 22411.6 31609.8 33443.5 34729.3 42482.8 43134.4 43356.0 43780.3 44076.7 3001.8 6589.5 7102.6 7170.2 7251.1 10576.8 10685.7 10948.0 11057.8 11196.3 3150.0 3221.4 8259.5 10119.2 10231.3 10243.5 10248.3 10347.4 10418.5 10530.3 10528.4 10572.4 10611.6 10699.2 10719.9 7721.7 7819.3 7842.2 7868.7 7876.1 9300.3 10487.5 10494.6 10632.2 10659.1 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | [#3] mootools.html Cycles:180 Average:5944.52 Median:2938.37 stddev:3126.82 (106.4%) stddev-sans-first:3118.15 05:18:27 INFO - PROCESS | 2924 | Values: 1550.7 1579.3 1776.3 1862.0 1895.7 7197.1 7296.7 8328.1 8439.7 8556.1 7776.1 7877.4 7904.0 7967.2 7978.0 2488.4 2504.8 2521.1 2524.9 2531.3 2378.2 2387.4 2391.9 2393.8 2405.1 2357.8 2402.9 2407.6 2420.1 2424.7 2409.6 2419.6 2421.2 2435.1 2435.4 2397.5 2406.4 2416.6 2419.2 2419.4 8445.1 8463.5 8469.8 8491.3 8518.6 5142.3 5183.3 5221.0 5252.8 5269.0 3440.1 3495.4 3544.7 3561.4 3576.6 1181.2 1192.3 1202.8 1222.7 1222.9 11961.6 12002.8 12070.7 12151.1 12191.7 4746.3 4788.5 4795.7 4876.0 4876.1 10103.2 10187.0 10192.5 10193.3 10195.0 5342.6 5384.6 5390.6 5398.0 5404.1 4748.2 4846.3 4880.9 4902.8 4910.7 3876.9 3899.0 3914.2 3914.3 3964.4 1161.4 1170.7 1177.8 1194.2 1199.8 1402.7 1402.8 1414.5 1431.8 1440.4 8164.8 8172.8 8192.2 8237.3 8269.1 530.3 534.1 540.0 542.6 543.3 6073.4 6108.8 6152.3 6181.2 6209.3 10367.7 10455.8 10569.1 10605.2 10607.7 9887.0 10243.7 10312.8 10329.8 10490.4 7929.5 8068.3 8068.4 8086.0 8116.1 7717.9 7741.7 7814.5 7860.2 7860.6 8966.4 9187.3 9259.0 9322.4 9332.9 9334.8 9405.1 9554.5 9596.7 9643.5 6476.5 6627.3 7388.3 7400.3 7483.8 7933.9 7957.9 7998.9 8014.2 8079.9 7367.2 7481.0 7585.0 7596.1 7639.7 7337.1 7413.1 7441.6 7529.8 7531.3 7654.2 7724.7 7755.1 7838.1 7861.1 6426.2 6568.4 7070.6 7089.0 7119.4 7027.9 7110.3 7116.9 7123.6 7152.2 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | [#4] prototype.html Cycles:180 Average:5644.70 Median:6381.10 stddev:1722.53 (27.0%) stddev-sans-first:1681.17 05:18:27 INFO - PROCESS | 2924 | Values: 365.8 371.7 373.6 375.5 384.5 6247.4 6307.2 6310.3 6352.2 6502.9 6316.7 6318.7 6362.1 6366.8 6376.4 4784.5 4807.4 4822.3 4829.7 4830.0 4799.9 4821.3 4844.4 4847.8 4870.8 4720.6 4811.6 4815.2 4824.4 4825.4 4801.4 4807.2 4816.4 4828.0 4828.1 4192.1 4194.4 4207.2 4209.4 4211.8 5963.3 5971.1 6002.1 6003.9 6018.6 5462.8 5615.2 5669.2 5672.3 5687.0 6682.7 6688.1 6733.6 6735.0 6738.1 4673.3 4677.7 4677.7 4683.3 4703.2 6914.0 7007.3 7072.4 7081.6 7085.4 4583.8 4592.5 4602.4 4609.0 4611.5 4665.7 4666.5 4669.4 4700.1 4714.9 5512.7 5518.5 5527.7 5528.1 5536.6 6565.2 6790.8 6792.0 6800.1 6819.9 1672.1 1692.6 1711.9 1714.6 1717.9 1108.6 1110.5 1110.7 1113.7 1128.6 6327.2 6382.3 6390.9 6398.3 6431.4 6891.4 6902.3 6917.2 6927.9 6936.9 6379.9 6398.8 6411.0 6414.3 6419.9 3737.4 3778.6 3788.0 3798.1 3798.3 7264.0 7283.9 7295.1 7308.4 7315.7 7119.2 7249.5 7270.1 7289.3 7327.5 7197.7 7204.2 7225.1 7250.4 7256.7 7041.7 7042.9 7067.0 7084.1 7093.9 6730.4 6916.6 6951.6 6957.6 6982.8 7141.6 7218.1 7219.2 7225.3 7244.0 4823.6 4863.9 4866.1 4869.5 4871.9 6830.9 6907.1 6985.7 6995.9 7051.0 6832.9 6833.7 6863.7 6866.2 6911.8 6828.7 6859.8 6869.9 6872.5 6899.4 6520.1 6626.1 6684.9 6686.8 6695.5 6863.7 6887.3 6891.7 6900.2 6918.5 6705.1 6738.3 6739.6 6739.8 6750.0 05:18:27 INFO - PROCESS | 2924 | 05:18:27 INFO - PROCESS | 2924 | [#5] yui.html Cycles:180 Average:14821.04 Median:26028.87 stddev:16709.66 (64.2%) stddev-sans-first:16723.63 05:18:27 INFO - PROCESS | 2924 | Values: 857.3 934.6 936.9 950.2 973.2 15499.5 15592.6 15620.8 15672.4 15731.8 15455.6 15474.0 15521.3 15524.3 15528.8 882.5 885.7 895.1 904.3 907.2 902.4 904.5 909.8 912.3 914.0 939.3 940.5 944.0 947.4 948.0 938.8 939.1 939.1 940.7 942.7 644.3 652.6 654.8 671.3 697.4 14884.6 14890.3 14910.1 14945.8 15038.4 13694.0 13916.9 13923.8 13937.3 13951.2 10775.6 11003.4 11007.7 11048.1 11083.0 3741.3 3777.6 3785.0 3788.9 3804.6 50801.0 51136.0 52102.7 52162.5 52329.2 10950.7 10970.8 11203.3 11297.3 11350.3 19036.2 19055.8 19122.9 19155.1 19188.1 7987.2 8295.8 8333.6 8343.3 8520.9 4603.7 4781.0 4785.6 4786.3 4812.0 3318.6 3358.5 3386.0 3388.2 3412.2 617.2 645.6 649.4 652.6 658.1 659.1 722.8 725.3 732.0 754.9 8832.5 8923.1 8950.1 9197.9 9457.4 714.1 718.9 737.5 738.9 761.9 4226.0 4499.6 4585.9 4599.3 4624.5 55785.4 56009.7 56379.2 56410.4 56608.3 53482.0 54395.0 54774.0 55082.7 55115.7 47276.8 49581.8 50034.0 50120.0 50348.2 8901.4 9098.9 9133.1 9155.1 9215.5 36227.8 36278.3 36340.0 36392.6 36967.6 42834.0 50426.2 51387.5 51737.2 51740.5 11196.8 11730.3 12274.4 12279.1 12466.3 13226.4 13379.3 13478.4 13880.6 14211.9 12231.8 12344.3 12391.3 12593.8 12694.3 11633.6 11712.9 11972.4 11978.2 12149.5 12525.6 12808.7 13031.1 13091.3 13141.1 9740.6 9905.1 10063.1 10132.6 10280.5 11090.3 11101.5 11107.6 11166.2 11239.7 05:18:27 INFO - PROCESS | 2924 | -------- Summary: end -------- 05:18:27 INFO - PROCESS | 2924 | 05:18:28 INFO - TEST-INFO | 2924: exit 0 05:18:28 INFO - TEST-OK | dromaeo_css | took 1108876ms 05:18:28 INFO - TEST-START | kraken 05:18:28 INFO - operating with platform_type : linux_ 05:18:28 INFO - Initialising browser for kraken test... 05:18:28 INFO - TEST-INFO | started process 3177 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq3grlj/profile http://localhost:57154/getInfo.html) 05:18:31 INFO - PROCESS | 3177 | 05:18:31 INFO - PROCESS | 3177 | (process:3257): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:32 INFO - PROCESS | 3177 | __metrics Screen width/height:1600/1200 05:18:32 INFO - PROCESS | 3177 | colorDepth:24 05:18:32 INFO - PROCESS | 3177 | Browser inner width/height: 1024/697 05:18:32 INFO - PROCESS | 3177 | __metrics 05:18:33 INFO - TEST-INFO | 3177: exit 0 05:18:33 INFO - Browser initialized. 05:18:33 INFO - Running cycle 1/1 for kraken test... 05:18:33 INFO - TEST-INFO | started process 3306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq3grlj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:34 INFO - PROCESS | 3306 | 05:18:34 INFO - PROCESS | 3306 | (process:3370): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:45 INFO - PROCESS | 3306 | RSS: Main: 140505088 05:18:45 INFO - PROCESS | 3306 | 05:18:47 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57154/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:48 INFO - PROCESS | 3306 | RSS: Main: 143917056 05:18:48 INFO - PROCESS | 3306 | 05:18:50 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57154/tests/kraken/driver.html?testName=audio-dft) 05:18:51 INFO - PROCESS | 3306 | RSS: Main: 143171584 05:18:51 INFO - PROCESS | 3306 | 05:18:54 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57154/tests/kraken/driver.html?testName=audio-fft) 05:18:54 INFO - PROCESS | 3306 | RSS: Main: 145125376 05:18:54 INFO - PROCESS | 3306 | 05:18:56 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57154/tests/kraken/driver.html?testName=audio-oscillator) 05:18:57 INFO - PROCESS | 3306 | RSS: Main: 144728064 05:18:57 INFO - PROCESS | 3306 | 05:18:59 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:00 INFO - PROCESS | 3306 | RSS: Main: 144642048 05:19:00 INFO - PROCESS | 3306 | 05:19:03 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57154/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:03 INFO - PROCESS | 3306 | RSS: Main: 146432000 05:19:03 INFO - PROCESS | 3306 | 05:19:07 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57154/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:07 INFO - PROCESS | 3306 | RSS: Main: 145682432 05:19:07 INFO - PROCESS | 3306 | 05:19:10 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57154/tests/kraken/driver.html?testName=json-parse-financial) 05:19:11 INFO - PROCESS | 3306 | RSS: Main: 145838080 05:19:11 INFO - PROCESS | 3306 | 05:19:12 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:13 INFO - PROCESS | 3306 | RSS: Main: 146173952 05:19:13 INFO - PROCESS | 3306 | 05:19:15 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:19:15 INFO - PROCESS | 3306 | RSS: Main: 145825792 05:19:15 INFO - PROCESS | 3306 | 05:19:17 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:18 INFO - PROCESS | 3306 | RSS: Main: 145719296 05:19:18 INFO - PROCESS | 3306 | 05:19:20 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:21 INFO - PROCESS | 3306 | RSS: Main: 145207296 05:19:21 INFO - PROCESS | 3306 | 05:19:23 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:19:24 INFO - PROCESS | 3306 | RSS: Main: 144728064 05:19:24 INFO - PROCESS | 3306 | 05:19:25 INFO - PROCESS | 3306 | Cycle 1(1): loaded http://localhost:57154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57154/tests/kraken/driver.html?testName=ai-astar) 05:19:26 INFO - PROCESS | 3306 | RSS: Main: 146919424 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | __start_tp_report 05:19:26 INFO - PROCESS | 3306 | _x_x_mozilla_page_load 05:19:26 INFO - PROCESS | 3306 | _x_x_mozilla_page_load_details 05:19:26 INFO - PROCESS | 3306 | |i|pagename|runs| 05:19:26 INFO - PROCESS | 3306 | |0;ai-astar;110;105;110;111;113;119;110;108;109;108 05:19:26 INFO - PROCESS | 3306 | |1;audio-beat-detection;152;127;163;169;127;152;149;131;167;131 05:19:26 INFO - PROCESS | 3306 | |2;audio-dft;162;162;163;161;163;163;163;163;164;162 05:19:26 INFO - PROCESS | 3306 | |3;audio-fft;74;77;73;145;74;73;76;76;152;74 05:19:26 INFO - PROCESS | 3306 | |4;audio-oscillator;95;95;145;94;96;96;141;94;95;143 05:19:26 INFO - PROCESS | 3306 | |5;imaging-gaussian-blur;110;110;110;110;109;113;111;111;109;109 05:19:26 INFO - PROCESS | 3306 | |6;imaging-darkroom;148;146;147;148;147;146;147;147;146;147 05:19:26 INFO - PROCESS | 3306 | |7;imaging-desaturate;97;96;96;96;96;97;98;97;96;96 05:19:26 INFO - PROCESS | 3306 | |8;json-parse-financial;53;56;55;57;55;60;56;59;53;54 05:19:26 INFO - PROCESS | 3306 | |9;json-stringify-tinderbox;63;65;63;64;65;66;67;64;65;64 05:19:26 INFO - PROCESS | 3306 | |10;stanford-crypto-aes;82;80;82;82;82;81;87;81;83;80 05:19:26 INFO - PROCESS | 3306 | |11;stanford-crypto-ccm;116;113;115;125;117;117;123;110;118;111 05:19:26 INFO - PROCESS | 3306 | |12;stanford-crypto-pbkdf2;138;138;139;149;136;136;134;136;137;136 05:19:26 INFO - PROCESS | 3306 | |13;stanford-crypto-sha256-iterative;65;66;65;68;68;64;63;66;66;66 05:19:26 INFO - PROCESS | 3306 | __end_tp_report 05:19:26 INFO - PROCESS | 3306 | __start_cc_report 05:19:26 INFO - PROCESS | 3306 | _x_x_mozilla_cycle_collect,736 05:19:26 INFO - PROCESS | 3306 | __end_cc_report 05:19:26 INFO - PROCESS | 3306 | __startTimestamp1454419166168__endTimestamp 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | ------- Summary: start ------- 05:19:26 INFO - PROCESS | 3306 | Number of tests: 14 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:3.71 (3.4%) stddev-sans-first:3.94 05:19:26 INFO - PROCESS | 3306 | Values: 110.0 105.0 110.0 111.0 113.0 119.0 110.0 108.0 109.0 108.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:152.00 stddev:16.69 (11.0%) stddev-sans-first:17.59 05:19:26 INFO - PROCESS | 3306 | Values: 152.0 127.0 163.0 169.0 127.0 152.0 149.0 131.0 167.0 131.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 05:19:26 INFO - PROCESS | 3306 | Values: 162.0 162.0 163.0 161.0 163.0 163.0 163.0 163.0 164.0 162.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#3] audio-fft Cycles:10 Average:89.40 Median:74.00 stddev:31.22 (42.2%) stddev-sans-first:32.61 05:19:26 INFO - PROCESS | 3306 | Values: 74.0 77.0 73.0 145.0 74.0 73.0 76.0 76.0 152.0 74.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:95.00 stddev:23.21 (24.4%) stddev-sans-first:24.03 05:19:26 INFO - PROCESS | 3306 | Values: 95.0 95.0 145.0 94.0 96.0 96.0 141.0 94.0 95.0 143.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.23 (1.1%) stddev-sans-first:1.30 05:19:26 INFO - PROCESS | 3306 | Values: 110.0 110.0 110.0 110.0 109.0 113.0 111.0 111.0 109.0 109.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 05:19:26 INFO - PROCESS | 3306 | Values: 148.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 146.0 147.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:19:26 INFO - PROCESS | 3306 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 98.0 97.0 96.0 96.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:2.35 (4.2%) stddev-sans-first:2.26 05:19:26 INFO - PROCESS | 3306 | Values: 53.0 56.0 55.0 57.0 55.0 60.0 56.0 59.0 53.0 54.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.20 05:19:26 INFO - PROCESS | 3306 | Values: 63.0 65.0 63.0 64.0 65.0 66.0 67.0 64.0 65.0 64.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:2.00 (2.4%) stddev-sans-first:2.12 05:19:26 INFO - PROCESS | 3306 | Values: 82.0 80.0 82.0 82.0 82.0 81.0 87.0 81.0 83.0 80.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:117.00 stddev:4.77 (4.1%) stddev-sans-first:5.05 05:19:26 INFO - PROCESS | 3306 | Values: 116.0 113.0 115.0 125.0 117.0 117.0 123.0 110.0 118.0 111.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.90 Median:137.50 stddev:4.15 (3.0%) stddev-sans-first:4.40 05:19:26 INFO - PROCESS | 3306 | Values: 138.0 138.0 139.0 149.0 136.0 136.0 134.0 136.0 137.0 136.0 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - PROCESS | 3306 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.64 05:19:26 INFO - PROCESS | 3306 | Values: 65.0 66.0 65.0 68.0 68.0 64.0 63.0 66.0 66.0 66.0 05:19:26 INFO - PROCESS | 3306 | -------- Summary: end -------- 05:19:26 INFO - PROCESS | 3306 | 05:19:26 INFO - TEST-INFO | 3306: exit 0 05:19:27 INFO - TEST-OK | kraken | took 58830ms 05:19:27 INFO - TEST-START | v8_7 05:19:27 INFO - operating with platform_type : linux_ 05:19:27 INFO - Initialising browser for v8_7 test... 05:19:27 INFO - TEST-INFO | started process 3598 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_VGzZW/profile http://localhost:57154/getInfo.html) 05:19:30 INFO - PROCESS | 3598 | 05:19:30 INFO - PROCESS | 3598 | (process:3678): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:31 INFO - PROCESS | 3598 | __metrics Screen width/height:1600/1200 05:19:31 INFO - PROCESS | 3598 | colorDepth:24 05:19:31 INFO - PROCESS | 3598 | Browser inner width/height: 1024/697 05:19:31 INFO - PROCESS | 3598 | __metrics 05:19:32 INFO - TEST-INFO | 3598: exit 0 05:19:32 INFO - Browser initialized. 05:19:32 INFO - Running cycle 1/1 for v8_7 test... 05:19:32 INFO - TEST-INFO | started process 3727 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_VGzZW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:33 INFO - PROCESS | 3727 | 05:19:33 INFO - PROCESS | 3727 | (process:3791): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:43 INFO - PROCESS | 3727 | RSS: Main: 140361728 05:19:43 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:57154/tests/v8_7/run.html (next: http://localhost:57154/tests/v8_7/run.html) 05:20:06 INFO - PROCESS | 3727 | RSS: Main: 143929344 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | __start_tp_report 05:20:06 INFO - PROCESS | 3727 | _x_x_mozilla_page_load 05:20:06 INFO - PROCESS | 3727 | _x_x_mozilla_page_load_details 05:20:06 INFO - PROCESS | 3727 | |i|pagename|runs| 05:20:06 INFO - PROCESS | 3727 | |0;Richards;167.33601070950468 05:20:06 INFO - PROCESS | 3727 | |1;DeltaBlue;170.2127659574468 05:20:06 INFO - PROCESS | 3727 | |2;Encrypt;280.8199943836001 05:20:06 INFO - PROCESS | 3727 | |3;Decrypt;5223.958333333333 05:20:06 INFO - PROCESS | 3727 | |4;RayTrace;930.2325581395348 05:20:06 INFO - PROCESS | 3727 | |5;Earley;570.1254275940707 05:20:06 INFO - PROCESS | 3727 | |6;Boyer;11133.333333333334 05:20:06 INFO - PROCESS | 3727 | |7;RegExp;39423.07692307692 05:20:06 INFO - PROCESS | 3727 | |8;Splay;524.9343832020998 05:20:06 INFO - PROCESS | 3727 | |9;NavierStokes;4822.115384615385 05:20:06 INFO - PROCESS | 3727 | __end_tp_report 05:20:06 INFO - PROCESS | 3727 | __startTimestamp1454419206534__endTimestamp 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | ------- Summary: start ------- 05:20:06 INFO - PROCESS | 3727 | Number of tests: 10 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 167.3 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#1] DeltaBlue Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 170.2 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 280.8 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 5224.0 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#4] RayTrace Cycles:1 Average:930.23 Median:930.23 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 930.2 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#5] Earley Cycles:1 Average:570.13 Median:570.13 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 570.1 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#6] Boyer Cycles:1 Average:11133.33 Median:11133.33 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 11133.3 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#7] RegExp Cycles:1 Average:39423.08 Median:39423.08 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 39423.1 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#8] Splay Cycles:1 Average:524.93 Median:524.93 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 524.9 05:20:06 INFO - PROCESS | 3727 | 05:20:06 INFO - PROCESS | 3727 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:20:06 INFO - PROCESS | 3727 | Values: 4822.1 05:20:06 INFO - PROCESS | 3727 | -------- Summary: end -------- 05:20:06 INFO - PROCESS | 3727 | 05:20:07 INFO - TEST-INFO | 3727: exit 0 05:20:07 INFO - TEST-OK | v8_7 | took 40412ms 05:20:07 INFO - SUITE-END | took 1208s 05:20:07 INFO - Completed test suite (00:20:08) 05:20:07 INFO - Working with test: dromaeo_css 05:20:07 INFO - Generating results file: dromaeo_css 05:20:07 INFO - Working with test: kraken 05:20:07 INFO - Generating results file: kraken 05:20:07 INFO - javascript benchmark 05:20:07 INFO - Working with test: v8_7 05:20:07 INFO - Generating results file: v8_7 05:20:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:20:07 INFO - process_Request line: dromaeo_css 7302.67 graph.html#tests=[[72,52,43]] 05:20:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:08 INFO - process_Request line: kraken 1494.60 graph.html#tests=[[232,52,43]] 05:20:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:08 INFO - process_Request line: v8_7 21923.14 graph.html#tests=[[230,52,43]] 05:20:08 INFO - RETURN: dromaeo_css: 7302.67 05:20:08 INFO - RETURN: kraken: 1494.60 05:20:08 INFO - RETURN: v8_7: 21923.14 05:20:08 INFO - javascript benchmark 05:20:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3370.848311825968, 3378.7128094111986, 3400.013995941177, 3416.1971936594896, 3432.244906120654, 5497.285352904117, 5511.944880551193, 5514.228008078872, 5530.5022547970675, 5576.832695019146, 5514.862128446791, 5582.190582365554, 5583.553315734742, 5586.441355864412, 5613.747381367838, 5072.3405957225605, 5113.386393632769, 5143.408508021588, 5170.121079416508, 5272.841814745564, 4920.852374428755, 5090.236464530331, 5094.84715458535, 5098.311727916739, 5196.480351964792, 5176.404713457944, 5185.688858668473, 5185.896282074356, 5215.739213039333, 5244.213367994812, 5171.120909445403, 5180.0, 5181.999999999963, 5189.247559103909, 5222.895542089175, 4928.679635823696, 4935.605151587864, 4971.751412429364, 5084.339035925343, 5096.719680417576, 5334.786608535654, 5356.330458692663, 5356.705381204032, 5378.8924221515745, 5411.83764487066, 5910.8817823643285, 5953.58324917256, 6005.939940600625, 6013.488853447462, 6018.638881667114, 5880.705964701748, 5941.792037278675, 6044.304904935944, 6055.939440605582, 6090.421409966046, 5678.233438485793, 5685.118806584986, 5689.601727879091, 5697.658140511582, 5719.942800571983, 6172.567920245539, 6187.412195841388, 6198.659073750897, 6201.441870231701, 6202.193714817045, 5745.913811292834, 5830.4461076197695, 5839.124131380327, 5965.343812180657, 5967.492763115097, 6013.398660134039, 6021.3677563856045, 6025.66858822769, 6026.668533230627, 6032.3967603239325, 5913.379095194942, 5925.170476133345, 5955.196048533479, 5970.76116955317, 5987.43119403656, 5616.634918730269, 5770.913436298459, 5945.1973983512535, 6041.154238406627, 6072.149899014142, 4562.087582483517, 4585.495595484494, 4609.492955774862, 4616.515265897099, 4639.257718764981, 4031.0, 4115.444415003996, 4131.938020929689, 4151.916961660811, 4163.7293575917465, 5575.135853942646, 5677.829665110054, 5718.828435146952, 5765.1928729977835, 5791.160281759121, 5931.40685931412, 5962.284525856925, 5999.340072592011, 5999.820005399845, 6007.639541627516, 5568.443155684399, 5656.321241451053, 5658.0, 5678.77284908599, 5686.692060826033, 5117.257997590403, 5163.251328557413, 5166.6125040621355, 5168.3539557555305, 5206.297149884717, 6132.662703551258, 6152.0, 6220.813375598739, 6231.345708700521, 6238.875222495525, 5852.092925596369, 5869.031609784338, 6008.849778755566, 6059.787907423219, 6065.636061836304, 6175.598586092069, 6176.938230617637, 6203.410675985774, 6214.223222097238, 6227.9377206227355, 5880.294364676266, 6017.368176341596, 6018.398160183947, 6025.939740602538, 6048.153258543719, 5908.084246941731, 5985.551083668655, 6006.129111278928, 6009.969950150221, 6095.299040610386, 5752.13717942312, 5782.739776710142, 5814.418558144152, 5822.097574875901, 5847.38602446737, 5873.882522349614, 5883.2057672213705, 5895.410458954242, 5898.498627616701, 5904.173415721888, 5702.6863522506665, 5727.198192253171, 5745.798897038583, 5757.798477053283, 5758.769649214152, 5789.594728369142, 5894.174815525744, 5898.997170480942, 5911.142884281841, 5919.31927828288, 5811.94188058114, 5819.679917604572, 5828.154917536848, 5833.445822646841, 5837.211976383134], "unit": "score", "name": "dojo.html", "value": 5531.638176117056}, {"lowerIsBetter": false, "replicates": [556.6214973817803, 571.8884817460595, 580.1877371679645, 584.0538327908788, 585.6690969602174, 37935.62064379359, 38972.80513597432, 38993.61006389935, 39176.216475670466, 39187.0, 41453.58546414535, 41499.58500414995, 41500.58499415005, 41760.95597610061, 41849.790751046276, 8734.213920747132, 8963.507007114606, 8976.685815996441, 8978.191962723353, 8997.325200609948, 8841.73474795754, 9019.684311049115, 9061.50161741104, 9065.18413342799, 9105.863412048824, 9045.412048216878, 9118.361714679975, 9120.17918387345, 9120.680776172836, 9137.451752894847, 8935.821283574325, 9010.414323069012, 9051.502167380791, 9097.545122743837, 9116.680916167968, 8914.554272286425, 8976.685815996474, 9002.234810041155, 9037.638494460214, 9055.683051093247, 40910.38634420486, 40976.38535421971, 41292.38061429081, 41318.38022429666, 41381.172376552604, 3588.5155504006884, 3597.0647631615707, 3616.3129005488872, 3776.0, 3830.80845957701, 31055.378892422024, 31259.531107033414, 31435.214119646964, 31648.841755791073, 32111.6788832111, 3615.0, 3644.2529281497227, 3688.3360995020885, 3689.5203623529037, 3772.7170462215167, 212012.0, 213154.0, 213989.0, 214385.0, 214561.0, 44001.77999109984, 44089.338659920126, 44471.0, 44555.55444445579, 44686.0, 42397.36403953943, 42527.14945701069, 42601.36097958533, 42646.0, 42698.78650606727, 16345.591360216089, 16508.0, 16549.172541372882, 16550.50348489547, 16636.33454661824, 13526.59420217395, 13552.051356404956, 13576.660583485294, 13627.591172264649, 13936.512222072179, 14873.479428220176, 15038.097714137186, 15051.774223386657, 15056.548303550911, 15079.924600377148, 5928.229330187048, 6012.549058820518, 6066.48434883031, 6135.5398345124295, 6179.146256123145, 1005.2912696548915, 1008.0574662690408, 1122.5958654884234, 1145.7135716070982, 1147.949626092133, 30472.54291185634, 31236.84381578123, 33090.66909330876, 33303.666963330055, 33337.83331083329, 1201.9699507512207, 1242.993785031087, 1276.9528986231387, 1324.6291038509232, 1350.9256990865597, 15663.68672626541, 15707.0, 15891.594384644704, 15949.20253987296, 16249.0, 566803.0, 820190.0, 840862.0, 906839.0, 909046.0, 55778.0, 55930.44069559334, 56016.43983560194, 56131.0, 56395.0, 1508.6605513759316, 1526.282647155835, 1528.7936128622493, 1532.1802835483186, 1535.3474773221337, 30890.0, 31365.529517056806, 31848.840755796075, 31993.36013279768, 32126.678733212368, 48931.26603101027, 49134.75432622814, 49143.508564915326, 49319.26021109758, 49335.75332123316, 307708.0, 309806.0, 311985.0, 312450.0, 312708.0, 33383.66616333806, 33787.32425351528, 33955.3208935815, 34228.0, 34650.13374665654, 44454.333185001604, 45301.64095077153, 45374.31938520859, 45816.77091614521, 45983.0, 38305.80847095858, 39065.60934390734, 39145.217095658496, 39444.80277598594, 39579.80210099046, 38506.80746596249, 38688.41967370548, 39107.80446097751, 39342.40986385264, 39395.40906886342, 39004.219915602094, 39494.60505394909, 39603.0, 39846.60153398429, 40074.59925400709, 33959.66040339565, 34414.11596675325, 34906.65093349034, 35082.29835403227, 35096.29807403889, 27067.72932270652, 27476.862615686794, 27735.167944961682, 27762.305942351602, 27830.582541261494], "unit": "score", "name": "ext.html", "value": 19247.953567578734}, {"lowerIsBetter": false, "replicates": [395.5629029921937, 398.12412692077436, 399.6483094876508, 400.4673783867457, 401.8975161333859, 14819.555413337617, 15370.69258614827, 17377.565560860985, 17896.642067158664, 17983.82016179838, 11223.38271395073, 11597.246178998359, 15371.84628153718, 16835.32658693654, 16947.91526042371, 4963.032208719292, 5196.454372290912, 5628.859278518029, 5631.1271752878165, 5640.435956404368, 5243.3970093439175, 5391.272178255925, 5454.945450545503, 5455.563554915617, 5457.181422786594, 5431.782728690868, 5464.562834973192, 5659.60382773206, 5866.853328666774, 5962.135490353896, 5751.827445176651, 5813.244278243801, 6111.297200821896, 6179.721912513947, 6202.069689546559, 5546.417626149237, 5571.721413929328, 5579.553635709174, 5580.107182850725, 5632.633878797865, 15785.763213551805, 20182.293619723237, 20652.380428587017, 20735.68896466539, 21032.894835525876, 2147.4309308033385, 2223.5108276179217, 2257.2099765082253, 2310.953780924372, 2389.51015041916, 9913.603455861758, 9922.355046921999, 9980.401175929468, 10073.798524029551, 10152.23858210637, 1901.7242499837585, 2031.3601215617034, 2047.948801279965, 2048.9487762806048, 2121.4802373418456, 59362.406375936116, 59498.0, 60722.69638651778, 61135.694321528106, 61308.69345653288, 10564.313319634199, 10910.399928003877, 10992.835107473395, 11010.174236932102, 11012.0, 13697.726045479234, 13879.0, 13881.167129972235, 13922.791158132635, 13974.860251397558, 8273.0, 8344.0, 8364.58177091143, 8378.204070613281, 8394.076651568323, 8098.595070246464, 8198.098209197104, 8245.670173193004, 8272.8345433091, 8307.709230176915, 4577.267637178035, 4677.695949763254, 4730.455997560324, 4776.23580227162, 4789.95210047895, 1897.2924368068573, 1904.190718944443, 1913.2538310059088, 1917.9712304315447, 1938.3409640722223, 965.2760429677742, 990.6087095597198, 997.187292356727, 1022.6829682798357, 1025.5692609104194, 16073.276702548179, 16859.0, 17039.14804259782, 17980.784500555746, 18255.36106236302, 983.852422136671, 1028.4908970059869, 1036.7304500829687, 1079.7894410589859, 1106.623747925709, 9939.552720127467, 10452.529636166391, 10502.789944201073, 10507.159427245802, 10604.363738175734, 607045.0, 626026.0, 632632.0, 636707.0, 647232.0, 47346.0, 54527.0, 74830.0, 75491.62254188694, 79332.6033369841, 1162.91859569831, 1186.762647470492, 1188.6968822950093, 1202.0213094656715, 1211.4003568233782, 16036.0, 16063.0, 16080.758788618414, 16125.435609753602, 16340.754888676916, 21883.562328753655, 22411.551768964204, 31609.841950790098, 33443.49834752432, 34729.305413892085, 42482.78758606187, 43134.35298470588, 43356.0, 43780.34329485124, 44076.67769966906, 3001.8198908065588, 6589.45147890255, 7102.644867756695, 7170.1754298256365, 7251.1298644163035, 10576.788464230825, 10685.679429616814, 10948.0, 11057.778844423228, 11196.328220306808, 3149.952750708787, 3221.436248656523, 8259.463134896212, 10119.217215265566, 10231.334963227366, 10243.487825608541, 10248.333858299187, 10347.43089130075, 10418.531166097393, 10530.31552949056, 10528.420936848546, 10572.418516981332, 10611.575536978435, 10699.197560183173, 10719.89280107189, 7721.729739459092, 7819.257170568787, 7842.176571459914, 7868.72459463939, 7876.133625301098, 9300.255979521757, 10487.528061237415, 10494.632687855888, 10632.202584806017, 10659.14726821868], "unit": "score", "name": "jquery.html", "value": 8434.778736475768}, {"lowerIsBetter": false, "replicates": [1550.736374816281, 1579.2972127403307, 1776.294757033248, 1861.9534511637216, 1895.658781419344, 7197.064381630394, 7296.744613938513, 8328.08391076981, 8439.662413503453, 8556.101609331025, 7776.105747839, 7877.369810415167, 7903.960480197606, 7967.20327967203, 7978.042634883807, 2488.390344365633, 2504.8371855829405, 2521.0546045233036, 2524.911628093017, 2531.2659328794625, 2378.203301893859, 2387.415083304584, 2391.940201494968, 2393.772591603795, 2405.1461731085474, 2357.834951553392, 2402.8798560071928, 2407.6027455469916, 2420.1287536486852, 2424.696912885889, 2409.590369637157, 2419.576574099543, 2421.1767998880377, 2435.074671624789, 2435.3546310227803, 2397.520495900827, 2406.374342670918, 2416.589179839414, 2419.1774796569252, 2419.395151212197, 8445.071042185355, 8463.534505602189, 8469.83060338796, 8491.320694344438, 8518.616662250213, 5142.331496905415, 5183.2743415921805, 5221.0, 5252.789888404459, 5268.973655131738, 3440.122768693992, 3495.4057810172076, 3544.6987006104255, 3561.3589553880292, 3576.6065732769375, 1181.1790805390258, 1192.272713644676, 1202.8496437945257, 1222.7004383925996, 1222.8532576090838, 11961.581344652895, 12002.819957700642, 12070.698232544257, 12151.149419540636, 12191.695207619792, 4746.264329029006, 4788.545088216614, 4795.664303498791, 4875.976045030512, 4876.097921884463, 10103.19174466041, 10187.032231937954, 10192.490375481197, 10193.337433066976, 10195.031472010147, 5342.5993050521365, 5384.596155288369, 5390.595705322116, 5398.001369746609, 5404.054290499147, 4748.216544270226, 4846.273059041172, 4880.902381952341, 4902.754862256873, 4910.656254062182, 3876.8836934891997, 3899.0, 3914.236723838881, 3914.2954268231424, 3964.385520244367, 1161.3960740415105, 1170.7307319316435, 1177.8174382970483, 1194.1939191046008, 1199.7660456211129, 1402.6647660905528, 1402.8386735525341, 1414.476643641859, 1431.7923901034292, 1440.4454285100312, 8164.75505734817, 8172.754817355489, 8192.18078192188, 8237.341012718967, 8269.131741167092, 530.2708775433779, 534.1347017831139, 539.9784008639689, 542.6391449685993, 543.323562165107, 6073.362296958844, 6108.786192483241, 6152.323244443108, 6181.196444462191, 6209.254889413209, 10367.740806479747, 10455.790884182274, 10569.101626361691, 10605.204609654307, 10607.734806629896, 9887.0, 10243.743906402251, 10312.793744125076, 10329.793404131875, 10490.370577765358, 7929.5242285463055, 8068.273855353046, 8068.3948703847445, 8085.959570202229, 8116.066652334939, 7717.922820771721, 7741.729039483591, 7814.4529882907655, 7860.213978602094, 7860.646270917937, 8966.372353935423, 9187.310951678517, 9259.0, 9322.440653560809, 9332.860007099764, 9334.813303734023, 9405.106514881076, 9554.474503902353, 9596.66411675588, 9643.469609171283, 6476.5466417350335, 6627.3372662733345, 7388.335049845539, 7400.259974002557, 7483.812904677427, 7933.920660793318, 7957.920420795949, 7998.9200108000505, 8014.158513356247, 8079.87880181786, 7367.189609143097, 7480.952666626786, 7584.962075189589, 7596.050493688289, 7639.732609358646, 7337.119545654556, 7413.147488038944, 7441.590712510864, 7529.774106776806, 7531.322181003736, 7654.158042615197, 7724.729634462767, 7755.069391673035, 7838.137804841349, 7861.056673199024, 6426.228852537725, 6568.441682457044, 7070.611116388648, 7088.972099045506, 7119.430445564239, 7027.894581581382, 7110.288971102848, 7116.8932466014085, 7123.643817809192, 7152.213256541672], "unit": "score", "name": "mootools.html", "value": 4802.122604760155}, {"lowerIsBetter": false, "replicates": [365.77139287945033, 371.67849809914424, 373.6170425314053, 375.54746530430816, 384.5020698195837, 6247.406496382842, 6307.211598550181, 6310.305866354697, 6352.237731472224, 6502.934970650292, 6316.652584107872, 6318.715657795398, 6362.1093046973465, 6366.777162799303, 6376.39424254695, 4784.545468180518, 4807.399075115602, 4822.324874517552, 4829.68607040543, 4829.951700483003, 4799.928001079969, 4821.349117869096, 4844.394450693663, 4847.781849816767, 4870.756462176894, 4720.622350211992, 4811.59101476375, 4815.229563269878, 4824.4210694716685, 4825.420949486049, 4801.423829140491, 4807.230843065127, 4816.44610869751, 4828.010257897158, 4828.106800241966, 4192.056787222881, 4194.370844373338, 4207.221663992141, 4209.3896385024, 4211.768352740598, 5963.254593175853, 5971.0744834550715, 6002.129691194796, 6003.909941350883, 6018.638881667071, 5462.781488740446, 5615.241942337814, 5669.177969194485, 5672.290963629546, 5687.0, 6682.699278532477, 6688.130543029423, 6733.595984240961, 6735.0, 6738.124043874314, 4673.322368256584, 4677.695949763254, 4677.695949763254, 4683.250679891201, 4703.247480403119, 6914.0, 7007.299270073003, 7072.3634872861685, 7081.645917704094, 7085.43316534676, 4583.770811459481, 4592.540745925381, 4602.424696912886, 4608.976955115203, 4611.492735799059, 4665.6967297125575, 4666.533346665374, 4669.41632295963, 4700.106979673919, 4714.858554243378, 5512.724363781795, 5518.475744804237, 5527.668339899619, 5528.06022976095, 5536.640118392292, 6565.161754708689, 6790.796276111724, 6792.0, 6800.08198893153, 6819.863602727918, 1672.1221358786734, 1692.5768557860536, 1711.8630509559205, 1714.579927917668, 1717.9398721044704, 1108.562117963416, 1110.5224753356135, 1110.650145204258, 1113.7271368514766, 1128.5880653561555, 6327.240731112204, 6382.329855365213, 6390.9360906391275, 6398.29618741938, 6431.356864313531, 6891.414229790524, 6902.344277293649, 6917.239103698589, 6927.896081558781, 6936.895946560806, 6379.872402551923, 6398.840028999312, 6410.967945160244, 6414.294427612959, 6419.903701444482, 3737.364648009845, 3778.5654649715084, 3787.981060094682, 3798.088458769875, 3798.3352913240624, 7264.0, 7283.8543229136185, 7295.124585049828, 7308.37878780299, 7315.743948961761, 7119.181294151135, 7249.456290778213, 7270.091238595176, 7289.271072892774, 7327.487075904742, 7197.676104575306, 7204.24355442671, 7225.096862892034, 7250.383717384081, 7256.6734496947765, 7041.683124259318, 7042.894356584758, 7066.964665176642, 7084.079069720903, 7093.929060709327, 6730.360615741497, 6916.55042422241, 6951.582905025714, 6957.617331046638, 6982.755603553851, 7141.571505709674, 7218.061651985208, 7219.241979592067, 7225.349718525358, 7243.963780181065, 4823.5658790709, 4863.927041094315, 4866.051120031701, 4869.513048695102, 4871.902561948812, 6830.897536537055, 6907.067545881242, 6985.650717464005, 6995.930040699732, 7051.048108505286, 6832.897506537306, 6833.658317084225, 6863.725450981905, 6866.244713081657, 6911.7926462206215, 6828.658567071726, 6859.828504287233, 6869.862602748017, 6872.450203983769, 6899.448044156355, 6520.087187793808, 6626.072349871119, 6684.933150668431, 6686.765963191265, 6695.531312808252, 6863.725450981905, 6887.345702158287, 6891.689873955785, 6900.206476255295, 6918.481113916376, 6705.0612914193025, 6738.292479289604, 6739.595624262364, 6739.764108256188, 6749.966250168718], "unit": "score", "name": "prototype.html", "value": 5088.678460327007}, {"lowerIsBetter": false, "replicates": [857.3441317392194, 934.6308208257742, 936.9390989585677, 950.1733491862082, 973.1971123822846, 15499.535013949586, 15592.610184745387, 15620.843791562082, 15672.373105075783, 15731.764023539656, 15455.613609659737, 15474.0, 15521.301541430634, 15524.301406436709, 15528.844711552882, 882.5410786391072, 885.7342797160842, 895.1317222294364, 904.3307952115421, 907.2061945797427, 902.3908861518448, 904.4663648447415, 909.8134882349136, 912.320321360584, 913.968011119611, 939.2908354192575, 940.5250348573995, 944.032366824004, 947.4173383369213, 947.9573419196153, 938.7653086728318, 939.0703203828161, 939.1406862720603, 940.7083804020775, 942.6559305853383, 644.2912795924492, 652.6214795418646, 654.7741029344868, 671.2649648634737, 697.3793323941696, 14884.553463396116, 14890.255487225704, 14910.105393676415, 14945.775813362809, 15038.398464061424, 13694.0, 13916.930415347959, 13923.791143132861, 13937.303134843318, 13951.232682202475, 10775.5689772409, 11003.394813285266, 11007.724806879893, 11048.06091482225, 11083.0, 3741.251749650081, 3777.6411240932066, 3785.0348161218712, 3788.9431658525145, 3804.5624753153465, 50801.0, 51136.0, 52102.73948630271, 52162.478375216524, 52329.215061774106, 10950.671479855617, 10970.835437468444, 11203.271787333797, 11297.322160670386, 11350.318980861175, 19036.238550457827, 19055.80944190568, 19122.904385477985, 19155.13801878919, 19188.13653385601, 7987.241212084843, 8295.751127466187, 8333.624986875606, 8343.332533397313, 8520.914790852135, 4603.723776573416, 4780.976095119502, 4785.59322457588, 4786.305985632133, 4811.9518804812205, 3318.5685860837934, 3358.4962255661844, 3385.9830700846337, 3388.15296175956, 3412.19813343864, 617.1606615003592, 645.5545673485374, 649.399305642279, 652.5530011941835, 658.0819756439836, 659.1431139518606, 722.8156820010863, 725.3073314984177, 731.989020164698, 754.9471536992357, 8832.470051796912, 8923.063078376807, 8950.140745778914, 9197.908020919838, 9457.43255404678, 714.0824041107256, 718.9065421495172, 737.4874462248686, 738.8670039392961, 761.8666733321758, 4225.9788701056295, 4499.550044995474, 4585.862424127282, 4599.2871104978785, 4624.514425985223, 55785.44214557884, 56009.719951400795, 56379.15431268534, 56410.43589564134, 56608.30175094754, 53482.0, 54395.0, 54774.0, 55082.72458637761, 55115.724421377636, 47276.7636161817, 49581.752091240036, 50033.9993200134, 50120.0, 50348.244776328385, 8901.421407608485, 9098.863517047117, 9133.086691330815, 9155.13026262504, 9215.539223038688, 36227.818860906584, 36278.27443451169, 36340.0, 36392.636073638925, 36967.630323696416, 42834.0, 50426.24360634667, 51387.48612513977, 51737.22394164015, 51740.48259517357, 11196.776064478501, 11730.296182229093, 12274.386280686109, 12279.079069070034, 12466.314352710326, 13226.404811783685, 13379.264140472367, 13478.393472293574, 13880.583582492542, 14211.928940355232, 12231.816522751988, 12344.321062341658, 12391.318477483825, 12593.811092833797, 12694.301813400352, 11633.59282425111, 11712.941435292769, 11972.401379930794, 11978.161528692908, 12149.453274602487, 12525.624231273076, 12808.743825123633, 13031.087823852618, 13091.345432728516, 13141.080124391201, 9740.561674724513, 9905.108540231413, 10063.094321511098, 10132.645357412455, 10280.485975701335, 11090.334579925231, 11101.50043248072, 11107.611233606785, 11166.218364714392, 11239.66281011571], "unit": "score", "name": "yui.html", "value": 6910.425599933769}], "name": "dromaeo_css", "value": 7302.668252666074}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 110.0, 111.0, 113.0, 119.0, 110.0, 108.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 163.0, 169.0, 127.0, 152.0, 149.0, 131.0, 167.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 161.0, 163.0, 163.0, 163.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 73.0, 145.0, 74.0, 73.0, 76.0, 76.0, 152.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 145.0, 94.0, 96.0, 96.0, 141.0, 94.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 113.0, 111.0, 111.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 98.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 55.0, 57.0, 55.0, 60.0, 56.0, 59.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 64.0, 65.0, 66.0, 67.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 82.0, 82.0, 81.0, 87.0, 81.0, 83.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [116.0, 113.0, 115.0, 125.0, 117.0, 117.0, 123.0, 110.0, 118.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.5}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 139.0, 149.0, 136.0, 136.0, 134.0, 136.0, 137.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.9}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 68.0, 68.0, 64.0, 63.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1494.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [170.2127659574468], "unit": "score", "name": "DeltaBlue", "value": 388.4432500000001}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [930.2325581395348], "unit": "score", "name": "RayTrace", "value": 795.4881749999996}, {"lowerIsBetter": false, "replicates": [570.1254275940707], "unit": "score", "name": "Earley", "value": 1168.9761020000003}, {"lowerIsBetter": false, "replicates": [11133.333333333334], "unit": "score", "name": "Boyer", "value": 59.86194610778439}, {"lowerIsBetter": false, "replicates": [39423.07692307692], "unit": "score", "name": "RegExp", "value": 23.107912195121965}, {"lowerIsBetter": false, "replicates": [524.9343832020998], "unit": "score", "name": "Splay", "value": 155.24035499999994}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21923.143341755895}]} 05:20:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21923.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1494.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7302.67"}}} 05:20:08 INFO - Return code: 0 05:20:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:20:08 INFO - # TBPL SUCCESS # 05:20:08 INFO - Running post-action listener: _resource_record_post_action 05:20:08 INFO - Running post-run listener: _resource_record_post_run 05:20:09 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497008640; Read time: 12; Write time: 373216 05:20:09 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 239480832; Read time: 0; Write time: 236576 05:20:09 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257527808; Read time: 12; Write time: 136640 05:20:09 INFO - Running post-run listener: _upload_blobber_files 05:20:09 INFO - Blob upload gear active. 05:20:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:20:09 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:20:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:20:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:20:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:10 INFO - (blobuploader) - INFO - Done attempting. 05:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:11 INFO - (blobuploader) - INFO - Done attempting. 05:20:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:11 INFO - Return code: 0 05:20:11 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:20:11 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4bbb22a2e236bf26b9a3f821701f9f86366a39e87f2cf594ee337580768a31e3e76337d7a84c0101fe2bdf181872e0b6d082aa2ff2f67693b3c6d4195efa567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d65e904d0637cb711a2f42ad858f32c6075bea84bfcdc40e51a25c8dc1868c70f7ac1e05f5db1f8f44c2fe1c62df4e5ded2deb56a46da109d27d7a5435f6c8b6"} 05:20:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:20:11 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:20:11 INFO - Contents: 05:20:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4bbb22a2e236bf26b9a3f821701f9f86366a39e87f2cf594ee337580768a31e3e76337d7a84c0101fe2bdf181872e0b6d082aa2ff2f67693b3c6d4195efa567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d65e904d0637cb711a2f42ad858f32c6075bea84bfcdc40e51a25c8dc1868c70f7ac1e05f5db1f8f44c2fe1c62df4e5ded2deb56a46da109d27d7a5435f6c8b6"} 05:20:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:11 INFO - Copying logs to upload dir... 05:20:11 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:20:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.041218 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-02 05:20:10.708234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 05:20:10.712181) ========= 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-1454417549.776854-238078821 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/a4bbb22a2e236bf26b9a3f821701f9f86366a39e87f2cf594ee337580768a31e3e76337d7a84c0101fe2bdf181872e0b6d082aa2ff2f67693b3c6d4195efa567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d65e904d0637cb711a2f42ad858f32c6075bea84bfcdc40e51a25c8dc1868c70f7ac1e05f5db1f8f44c2fe1c62df4e5ded2deb56a46da109d27d7a5435f6c8b6"} build_url:https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/Fg78qDabSW-IMuhwOU2_1Q/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/a4bbb22a2e236bf26b9a3f821701f9f86366a39e87f2cf594ee337580768a31e3e76337d7a84c0101fe2bdf181872e0b6d082aa2ff2f67693b3c6d4195efa567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d65e904d0637cb711a2f42ad858f32c6075bea84bfcdc40e51a25c8dc1868c70f7ac1e05f5db1f8f44c2fe1c62df4e5ded2deb56a46da109d27d7a5435f6c8b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 05:20:10.743934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:20:10.744599) ========= 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-1454417549.776854-238078821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:20:10.826952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 05:20:10.827596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 05:20:10.828264) ========= ========= Total master_lag: 0.28 =========