builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1454415318.26 results: success (0) buildid: 20160201161019 builduid: c8d00bf2f8e346559045d3946233336e revision: 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.256384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.256870) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.257189) ========= 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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004316 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.273804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.274122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.293061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.293597) ========= 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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021039 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.344112) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.344491) ========= 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:15:18.345009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.345400) ========= 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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-02 04:15:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.0M=0s 2016-02-02 04:15:18 (35.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.523967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.524279) ========= 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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.140296 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:18.675293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 04:15:18.675682) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 --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 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 --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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-02 04:15:18,863 truncating revision to first 12 chars 2016-02-02 04:15:18,863 Setting DEBUG logging. 2016-02-02 04:15:18,863 attempt 1/10 2016-02-02 04:15:18,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/980fea2f7011?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 04:15:19,673 unpacking tar archive at: mozilla-aurora-980fea2f7011/testing/mozharness/ program finished with exit code 0 elapsedTime=1.089987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 04:15:19.777845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:19.778222) ========= echo 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'980fea2f7011680074bf2f0941ee7e5d0eb3c4a3'] 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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 program finished with exit code 0 elapsedTime=0.003781 script_repo_revision: '980fea2f7011680074bf2f0941ee7e5d0eb3c4a3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:19.827749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:19.828084) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 04:15:19.838393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-02 04:15:19.838726) ========= /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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:15:20 INFO - MultiFileLogger online at 20160202 04:15:20 in /builds/slave/test-pgo 04:15:20 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:15:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:15:20 INFO - {'append_to_log': False, 04:15:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:15:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:15:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:15:20 INFO - 'branch': 'Mozilla-Aurora', 04:15:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:20 INFO - 'config_files': ('talos/linux_config.py',), 04:15:20 INFO - 'default_actions': ('clobber', 04:15:20 INFO - 'read-buildbot-config', 04:15:20 INFO - 'download-and-extract', 04:15:20 INFO - 'populate-webroot', 04:15:20 INFO - 'create-virtualenv', 04:15:20 INFO - 'install', 04:15:20 INFO - 'run-tests'), 04:15:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:20 INFO - 'download_minidump_stackwalk': True, 04:15:20 INFO - 'download_symbols': 'ondemand', 04:15:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:20 INFO - 'installer_path': 'installer.exe', 04:15:20 INFO - 'log_level': 'info', 04:15:20 INFO - 'log_name': 'talos', 04:15:20 INFO - 'log_to_console': True, 04:15:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:15:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:15:20 INFO - 'opt_config_files': (), 04:15:20 INFO - 'pip_index': False, 04:15:20 INFO - 'sps_profile': False, 04:15:20 INFO - 'sps_profile_interval': 0, 04:15:20 INFO - 'suite': 'dromaeojs-e10s', 04:15:20 INFO - 'system_bits': '32', 04:15:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:20 INFO - 'title': 'talos-linux64-ix-050', 04:15:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:20 INFO - 'use_talos_json': True, 04:15:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:15:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:20 INFO - 'work_dir': 'build'} 04:15:20 INFO - ##### 04:15:20 INFO - ##### Running clobber step. 04:15:20 INFO - ##### 04:15:20 INFO - Running pre-action listener: _resource_record_pre_action 04:15:20 INFO - Running main action method: clobber 04:15:20 INFO - rmtree: /builds/slave/test-pgo/build 04:15:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:15:21 INFO - Running post-action listener: _resource_record_post_action 04:15:21 INFO - ##### 04:15:21 INFO - ##### Running read-buildbot-config step. 04:15:21 INFO - ##### 04:15:21 INFO - Running pre-action listener: _resource_record_pre_action 04:15:21 INFO - Running main action method: read_buildbot_config 04:15:21 INFO - Using buildbot properties: 04:15:21 INFO - { 04:15:21 INFO - "project": "", 04:15:21 INFO - "product": "firefox", 04:15:21 INFO - "script_repo_revision": "production", 04:15:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:15:21 INFO - "repository": "", 04:15:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:15:21 INFO - "buildid": "20160201161019", 04:15:21 INFO - "pgo_build": "True", 04:15:21 INFO - "basedir": "/builds/slave/test-pgo", 04:15:21 INFO - "buildnumber": 104, 04:15:21 INFO - "slavename": "talos-linux64-ix-050", 04:15:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:15:21 INFO - "platform": "ubuntu64_hw", 04:15:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:15:21 INFO - "branch": "mozilla-aurora", 04:15:21 INFO - "repo_path": "releases/mozilla-aurora", 04:15:21 INFO - "revision": "980fea2f7011680074bf2f0941ee7e5d0eb3c4a3", 04:15:21 INFO - "stage_platform": "linux64-pgo", 04:15:21 INFO - "builduid": "c8d00bf2f8e346559045d3946233336e", 04:15:21 INFO - "slavebuilddir": "test" 04:15:21 INFO - } 04:15:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 04:15:21 INFO - Running post-action listener: _resource_record_post_action 04:15:21 INFO - ##### 04:15:21 INFO - ##### Running download-and-extract step. 04:15:21 INFO - ##### 04:15:21 INFO - Running pre-action listener: _resource_record_pre_action 04:15:21 INFO - Running main action method: download_and_extract 04:15:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:15: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:15:21 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json 04:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json 04:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:15:22 INFO - Downloaded 1448 bytes. 04:15:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:15:22 INFO - Using the following test package requirements: 04:15:22 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:15:22 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:15:22 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:15:22 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'jsshell-linux-x86_64.zip'], 04:15:22 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:15:22 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:15:22 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:15:22 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:15:22 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:15:22 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:15:22 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:15:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:15:22 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:15: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:15:22 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:15:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:15:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:23 INFO - Downloaded 22398540 bytes. 04:15:23 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:15:23 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:15:24 INFO - Return code: 0 04:15:24 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:15: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:15:24 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:15:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:15:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:25 INFO - Downloaded 22398540 bytes. 04:15:25 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:15:25 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:15:26 INFO - Return code: 0 04:15: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:15:26 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:27 INFO - Downloaded 10706572 bytes. 04:15:27 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:15:27 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:15:27 INFO - Return code: 0 04:15:27 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:15:27 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:15:29 INFO - Downloaded 59583586 bytes. 04:15:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:15:29 INFO - mkdir: /builds/slave/test-pgo/properties 04:15:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:15:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:15:29 INFO - Contents: 04:15:29 INFO - build_url:https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:15:29 INFO - Running post-action listener: _resource_record_post_action 04:15:29 INFO - Running post-action listener: set_extra_try_arguments 04:15:29 INFO - ##### 04:15:29 INFO - ##### Running populate-webroot step. 04:15:29 INFO - ##### 04:15:29 INFO - Running pre-action listener: _resource_record_pre_action 04:15:29 INFO - Running main action method: populate_webroot 04:15:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:15:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:15:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:15:29 INFO - '--tppagecycles', 04:15:29 INFO - '7'], 04:15:29 INFO - 'tests': ['tsvgm']}}, 04:15:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:15:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:15:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:15:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:15:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'tests': ['damp', 'tps']}, 04:15:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['damp', 'tps']}, 04:15:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:15:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:15:29 INFO - 'other': {'tests': ['a11yr', 04:15:29 INFO - 'ts_paint', 04:15:29 INFO - 'tpaint', 04:15:29 INFO - 'sessionrestore', 04:15:29 INFO - 'sessionrestore_no_auto_restore']}, 04:15:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['a11yr', 04:15:29 INFO - 'ts_paint', 04:15:29 INFO - 'tpaint', 04:15:29 INFO - 'sessionrestore', 04:15:29 INFO - 'sessionrestore_no_auto_restore']}, 04:15:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['a11yr', 04:15:29 INFO - 'ts_paint', 04:15:29 INFO - 'tpaint', 04:15:29 INFO - 'sessionrestore', 04:15:29 INFO - 'sessionrestore_no_auto_restore']}, 04:15:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['a11yr', 04:15:29 INFO - 'ts_paint', 04:15:29 INFO - 'tpaint', 04:15:29 INFO - 'sessionrestore', 04:15:29 INFO - 'sessionrestore_no_auto_restore']}, 04:15:29 INFO - 'other_l64': {'tests': ['a11yr', 04:15:29 INFO - 'ts_paint', 04:15:29 INFO - 'tpaint', 04:15:29 INFO - 'sessionrestore', 04:15:29 INFO - 'sessionrestore_no_auto_restore']}, 04:15:29 INFO - 'other_nol64': {'tests': ['a11yr', 04:15:29 INFO - 'ts_paint', 04:15:29 INFO - 'tpaint', 04:15:29 INFO - 'sessionrestore', 04:15:29 INFO - 'sessionrestore_no_auto_restore']}, 04:15:29 INFO - 'svgr': {'tests': ['tsvgx', 04:15:29 INFO - 'tsvgr_opacity', 04:15:29 INFO - 'tart', 04:15:29 INFO - 'tscrollx', 04:15:29 INFO - 'cart']}, 04:15:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['tsvgx', 04:15:29 INFO - 'tsvgr_opacity', 04:15:29 INFO - 'tart', 04:15:29 INFO - 'tscrollx', 04:15:29 INFO - 'cart']}, 04:15:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'tests': ['tp5o']}, 04:15:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'talos_options': ['--e10s'], 04:15:29 INFO - 'tests': ['tp5o']}, 04:15:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'talos_options': ['--xperf_path', 04:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:29 INFO - 'tests': ['tp5n']}, 04:15:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:29 INFO - 'talos_options': ['--e10s', 04:15:29 INFO - '--xperf_path', 04:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:29 INFO - 'tests': ['tp5n']}}, 04:15:29 INFO - 'talos.zip': {'path': '', 04:15:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:15:29 INFO - Running post-action listener: _resource_record_post_action 04:15:29 INFO - ##### 04:15:29 INFO - ##### Running create-virtualenv step. 04:15:29 INFO - ##### 04:15:29 INFO - Running pre-action listener: _resource_record_pre_action 04:15:29 INFO - Running main action method: create_virtualenv 04:15:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:15:29 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:15:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:15:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:15:29 INFO - Using real prefix '/usr' 04:15:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:15:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:15:32 INFO - Installing pip.................done. 04:15:32 INFO - Return code: 0 04:15:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:32 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:32 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:15:32 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:15:32 INFO - Using env: {'DISPLAY': ':0', 04:15:32 INFO - 'HOME': '/home/cltbld', 04:15:32 INFO - 'LANG': 'en_US.UTF-8', 04:15:32 INFO - 'LANGUAGE': 'en_US:en', 04:15:32 INFO - 'LOGNAME': 'cltbld', 04:15:32 INFO - 'MAIL': '/var/mail/cltbld', 04:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:32 INFO - 'MOZ_NO_REMOTE': '1', 04:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:32 INFO - 'NO_EM_RESTART': '1', 04:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:32 INFO - 'SHELL': '/bin/bash', 04:15:32 INFO - 'SHLVL': '1', 04:15:32 INFO - 'TERM': 'linux', 04:15:32 INFO - 'TMOUT': '86400', 04:15:32 INFO - 'USER': 'cltbld', 04:15:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:32 INFO - '_': '/tools/buildbot/bin/python'} 04:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:32 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:15:32 INFO - Cleaning up... 04:15:32 INFO - Return code: 0 04:15:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:32 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:32 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:15:32 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:15:32 INFO - Using env: {'DISPLAY': ':0', 04:15:32 INFO - 'HOME': '/home/cltbld', 04:15:32 INFO - 'LANG': 'en_US.UTF-8', 04:15:32 INFO - 'LANGUAGE': 'en_US:en', 04:15:32 INFO - 'LOGNAME': 'cltbld', 04:15:32 INFO - 'MAIL': '/var/mail/cltbld', 04:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:32 INFO - 'MOZ_NO_REMOTE': '1', 04:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:32 INFO - 'NO_EM_RESTART': '1', 04:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:32 INFO - 'SHELL': '/bin/bash', 04:15:32 INFO - 'SHLVL': '1', 04:15:32 INFO - 'TERM': 'linux', 04:15:32 INFO - 'TMOUT': '86400', 04:15:32 INFO - 'USER': 'cltbld', 04:15:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:32 INFO - '_': '/tools/buildbot/bin/python'} 04:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:32 INFO - Downloading/unpacking psutil>=0.7.1 04:15:32 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:15:32 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:15:32 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:15:32 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:15:32 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:15:32 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:15:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:34 INFO - Installing collected packages: psutil 04:15:34 INFO - Running setup.py install for psutil 04:15:34 INFO - building 'psutil._psutil_linux' extension 04:15:34 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:15:34 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:15:34 INFO - building 'psutil._psutil_posix' extension 04:15:34 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:15:34 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:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:34 INFO - Successfully installed psutil 04:15:34 INFO - Cleaning up... 04:15:34 INFO - Return code: 0 04:15:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:15:34 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:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:34 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:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:34 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:34 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:15:34 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:15:34 INFO - Using env: {'DISPLAY': ':0', 04:15:34 INFO - 'HOME': '/home/cltbld', 04:15:34 INFO - 'LANG': 'en_US.UTF-8', 04:15:34 INFO - 'LANGUAGE': 'en_US:en', 04:15:34 INFO - 'LOGNAME': 'cltbld', 04:15:34 INFO - 'MAIL': '/var/mail/cltbld', 04:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:34 INFO - 'MOZ_NO_REMOTE': '1', 04:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:34 INFO - 'NO_EM_RESTART': '1', 04:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:34 INFO - 'SHELL': '/bin/bash', 04:15:34 INFO - 'SHLVL': '1', 04:15:34 INFO - 'TERM': 'linux', 04:15:34 INFO - 'TMOUT': '86400', 04:15:34 INFO - 'USER': 'cltbld', 04:15:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:34 INFO - '_': '/tools/buildbot/bin/python'} 04:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:35 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:15:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:15:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:15:36 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:15:36 INFO - Installing collected packages: mozsystemmonitor 04:15:36 INFO - Running setup.py install for mozsystemmonitor 04:15:37 INFO - Successfully installed mozsystemmonitor 04:15:37 INFO - Cleaning up... 04:15:37 INFO - Return code: 0 04:15:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:15: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:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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', '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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:15: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 blobuploader==1.2.4 04:15:37 INFO - Using env: {'DISPLAY': ':0', 04:15:37 INFO - 'HOME': '/home/cltbld', 04:15:37 INFO - 'LANG': 'en_US.UTF-8', 04:15:37 INFO - 'LANGUAGE': 'en_US:en', 04:15:37 INFO - 'LOGNAME': 'cltbld', 04:15:37 INFO - 'MAIL': '/var/mail/cltbld', 04:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:37 INFO - 'MOZ_NO_REMOTE': '1', 04:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:37 INFO - 'NO_EM_RESTART': '1', 04:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:37 INFO - 'SHELL': '/bin/bash', 04:15:37 INFO - 'SHLVL': '1', 04:15:37 INFO - 'TERM': 'linux', 04:15:37 INFO - 'TMOUT': '86400', 04:15:37 INFO - 'USER': 'cltbld', 04:15:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:37 INFO - '_': '/tools/buildbot/bin/python'} 04:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:15:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:15:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:15: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:15: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:15: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:15: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:15: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:15: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:15:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:15:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:15: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:15: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:15: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:15: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:15: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:15: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:15:40 INFO - Downloading docopt-0.6.1.tar.gz 04:15:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:15:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:15:40 INFO - Running setup.py install for blobuploader 04:15:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:15:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:15:40 INFO - Running setup.py install for requests 04:15:40 INFO - Running setup.py install for docopt 04:15:41 INFO - Successfully installed blobuploader requests docopt 04:15:41 INFO - Cleaning up... 04:15:41 INFO - Return code: 0 04:15:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:41 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:41 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:15:41 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:15:41 INFO - Using env: {'DISPLAY': ':0', 04:15:41 INFO - 'HOME': '/home/cltbld', 04:15:41 INFO - 'LANG': 'en_US.UTF-8', 04:15:41 INFO - 'LANGUAGE': 'en_US:en', 04:15:41 INFO - 'LOGNAME': 'cltbld', 04:15:41 INFO - 'MAIL': '/var/mail/cltbld', 04:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:41 INFO - 'MOZ_NO_REMOTE': '1', 04:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:41 INFO - 'NO_EM_RESTART': '1', 04:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:41 INFO - 'SHELL': '/bin/bash', 04:15:41 INFO - 'SHLVL': '1', 04:15:41 INFO - 'TERM': 'linux', 04:15:41 INFO - 'TMOUT': '86400', 04:15:41 INFO - 'USER': 'cltbld', 04:15:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:41 INFO - '_': '/tools/buildbot/bin/python'} 04:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:15:41 INFO - Running setup.py (path:/tmp/pip-l0sj2p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:15:41 INFO - Running setup.py (path:/tmp/pip-_yvP60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:15:41 INFO - Running setup.py (path:/tmp/pip-aytQx_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:15:41 INFO - Running setup.py (path:/tmp/pip-L6t3xj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:15:41 INFO - Running setup.py (path:/tmp/pip-XWJEzV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:15:41 INFO - Running setup.py (path:/tmp/pip-KQGlP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:15:41 INFO - Running setup.py (path:/tmp/pip-HbMka5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:15:41 INFO - Running setup.py (path:/tmp/pip-h7_sjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:15:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:15:41 INFO - Running setup.py (path:/tmp/pip-sZbexd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:15:42 INFO - Running setup.py (path:/tmp/pip-m4HCzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:15:42 INFO - Running setup.py (path:/tmp/pip-KhShVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:15:42 INFO - Running setup.py (path:/tmp/pip-y3wuPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:15:42 INFO - Running setup.py (path:/tmp/pip-loKN9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:15:42 INFO - Running setup.py (path:/tmp/pip-54E_Hz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:15:42 INFO - Running setup.py (path:/tmp/pip-ccJmLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:15:42 INFO - Running setup.py (path:/tmp/pip-Qj7Ej3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:15:42 INFO - Running setup.py (path:/tmp/pip-tS2w5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:15:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:15:42 INFO - Running setup.py install for manifestparser 04:15:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:15:42 INFO - Running setup.py install for mozcrash 04:15:42 INFO - Running setup.py install for mozdebug 04:15:42 INFO - Running setup.py install for mozdevice 04:15:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Running setup.py install for mozfile 04:15:43 INFO - Running setup.py install for mozhttpd 04:15:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Running setup.py install for mozinfo 04:15:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Running setup.py install for mozInstall 04:15:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Running setup.py install for mozleak 04:15:43 INFO - Running setup.py install for mozlog 04:15:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Running setup.py install for moznetwork 04:15:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Running setup.py install for mozprocess 04:15:43 INFO - Running setup.py install for mozprofile 04:15:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:15:43 INFO - Running setup.py install for mozrunner 04:15:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:15:44 INFO - Running setup.py install for mozscreenshot 04:15:44 INFO - Running setup.py install for moztest 04:15:44 INFO - Running setup.py install for mozversion 04:15:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:15:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:15:44 INFO - Cleaning up... 04:15:44 INFO - Return code: 0 04:15:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:44 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:44 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:15:44 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:15:44 INFO - Using env: {'DISPLAY': ':0', 04:15:44 INFO - 'HOME': '/home/cltbld', 04:15:44 INFO - 'LANG': 'en_US.UTF-8', 04:15:44 INFO - 'LANGUAGE': 'en_US:en', 04:15:44 INFO - 'LOGNAME': 'cltbld', 04:15:44 INFO - 'MAIL': '/var/mail/cltbld', 04:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:44 INFO - 'MOZ_NO_REMOTE': '1', 04:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:44 INFO - 'NO_EM_RESTART': '1', 04:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:44 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:44 INFO - 'SHELL': '/bin/bash', 04:15:44 INFO - 'SHLVL': '1', 04:15:44 INFO - 'TERM': 'linux', 04:15:44 INFO - 'TMOUT': '86400', 04:15:44 INFO - 'USER': 'cltbld', 04:15:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:44 INFO - '_': '/tools/buildbot/bin/python'} 04:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:15:44 INFO - Running setup.py (path:/tmp/pip-YMhk6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:15:44 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:15:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:15:44 INFO - Running setup.py (path:/tmp/pip-fT0rCG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:15:44 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:15:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:15:44 INFO - Running setup.py (path:/tmp/pip-PHklQl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:15:44 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:15:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:15:44 INFO - Running setup.py (path:/tmp/pip-QWs1Wm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:15:44 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:15:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:15:44 INFO - Running setup.py (path:/tmp/pip-hASyiq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:15:44 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:15:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:15:44 INFO - Running setup.py (path:/tmp/pip-LDLSFT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:15:45 INFO - Running setup.py (path:/tmp/pip-e2qAwp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:15:45 INFO - Running setup.py (path:/tmp/pip-BF0u9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:15:45 INFO - Running setup.py (path:/tmp/pip-OY7qki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:15:45 INFO - Running setup.py (path:/tmp/pip-NyHkM9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:15:45 INFO - Running setup.py (path:/tmp/pip-8_sAoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:15:45 INFO - Running setup.py (path:/tmp/pip-ekVHC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:15:45 INFO - Running setup.py (path:/tmp/pip-jNZVLL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:15:45 INFO - Running setup.py (path:/tmp/pip-UXP_XX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:15:45 INFO - Running setup.py (path:/tmp/pip-kkh6XO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:15:45 INFO - Running setup.py (path:/tmp/pip-npub78-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:15:45 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:15:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:15:45 INFO - Running setup.py (path:/tmp/pip-TxLAKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:15:45 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:15:45 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:15:45 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:15:45 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:15:45 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:15:45 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:15:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:47 INFO - Downloading blessings-1.6.tar.gz 04:15:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:15:47 INFO - Installing collected packages: blessings 04:15:47 INFO - Running setup.py install for blessings 04:15:47 INFO - Successfully installed blessings 04:15:47 INFO - Cleaning up... 04:15:47 INFO - Return code: 0 04:15:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:15:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:15:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:15:48 INFO - Reading from file tmpfile_stdout 04:15:48 INFO - Current package versions: 04:15:48 INFO - argparse == 1.2.1 04:15:48 INFO - blessings == 1.6 04:15:48 INFO - blobuploader == 1.2.4 04:15:48 INFO - docopt == 0.6.1 04:15:48 INFO - manifestparser == 1.1 04:15:48 INFO - mozInstall == 1.12 04:15:48 INFO - mozcrash == 0.16 04:15:48 INFO - mozdebug == 0.1 04:15:48 INFO - mozdevice == 0.48 04:15:48 INFO - mozfile == 1.2 04:15:48 INFO - mozhttpd == 0.7 04:15:48 INFO - mozinfo == 0.9 04:15:48 INFO - mozleak == 0.1 04:15:48 INFO - mozlog == 3.1 04:15:48 INFO - moznetwork == 0.27 04:15:48 INFO - mozprocess == 0.22 04:15:48 INFO - mozprofile == 0.28 04:15:48 INFO - mozrunner == 6.11 04:15:48 INFO - mozscreenshot == 0.1 04:15:48 INFO - mozsystemmonitor == 0.0 04:15:48 INFO - moztest == 0.7 04:15:48 INFO - mozversion == 1.4 04:15:48 INFO - psutil == 3.1.1 04:15:48 INFO - requests == 1.2.3 04:15:48 INFO - wsgiref == 0.1.2 04:15:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:48 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:48 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:15:48 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:15:48 INFO - Using env: {'DISPLAY': ':0', 04:15:48 INFO - 'HOME': '/home/cltbld', 04:15:48 INFO - 'LANG': 'en_US.UTF-8', 04:15:48 INFO - 'LANGUAGE': 'en_US:en', 04:15:48 INFO - 'LOGNAME': 'cltbld', 04:15:48 INFO - 'MAIL': '/var/mail/cltbld', 04:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:48 INFO - 'MOZ_NO_REMOTE': '1', 04:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:48 INFO - 'NO_EM_RESTART': '1', 04:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:48 INFO - 'SHELL': '/bin/bash', 04:15:48 INFO - 'SHLVL': '1', 04:15:48 INFO - 'TERM': 'linux', 04:15:48 INFO - 'TMOUT': '86400', 04:15:48 INFO - 'USER': 'cltbld', 04:15:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:48 INFO - '_': '/tools/buildbot/bin/python'} 04:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 INFO - Cleaning up... 04:15:48 INFO - Return code: 0 04:15:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:48 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:48 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:15:48 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:15:48 INFO - Using env: {'DISPLAY': ':0', 04:15:48 INFO - 'HOME': '/home/cltbld', 04:15:48 INFO - 'LANG': 'en_US.UTF-8', 04:15:48 INFO - 'LANGUAGE': 'en_US:en', 04:15:48 INFO - 'LOGNAME': 'cltbld', 04:15:48 INFO - 'MAIL': '/var/mail/cltbld', 04:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:48 INFO - 'MOZ_NO_REMOTE': '1', 04:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:48 INFO - 'NO_EM_RESTART': '1', 04:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:48 INFO - 'SHELL': '/bin/bash', 04:15:48 INFO - 'SHLVL': '1', 04:15:48 INFO - 'TERM': 'linux', 04:15:48 INFO - 'TMOUT': '86400', 04:15:48 INFO - 'USER': 'cltbld', 04:15:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:48 INFO - '_': '/tools/buildbot/bin/python'} 04:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:48 INFO - Downloading/unpacking jsonschema 04:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:15:50 INFO - Downloading/unpacking functools32 (from jsonschema) 04:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:15:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:15:50 INFO - warning: no files found matching '*.txt' 04:15:50 INFO - no previously-included directories found matching 'build' 04:15:50 INFO - no previously-included directories found matching 'dist' 04:15:50 INFO - no previously-included directories found matching '.git*' 04:15:50 INFO - Installing collected packages: jsonschema, functools32 04:15:50 INFO - Running setup.py install for functools32 04:15:50 INFO - warning: no files found matching '*.txt' 04:15:50 INFO - no previously-included directories found matching 'build' 04:15:50 INFO - no previously-included directories found matching 'dist' 04:15:50 INFO - no previously-included directories found matching '.git*' 04:15:50 INFO - Successfully installed jsonschema functools32 04:15:50 INFO - Cleaning up... 04:15:50 INFO - Return code: 0 04:15:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:50 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 0x7f98a3c34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1787230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, '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': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', '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:15:50 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:15:50 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:15:50 INFO - Using env: {'DISPLAY': ':0', 04:15:50 INFO - 'HOME': '/home/cltbld', 04:15:50 INFO - 'LANG': 'en_US.UTF-8', 04:15:50 INFO - 'LANGUAGE': 'en_US:en', 04:15:50 INFO - 'LOGNAME': 'cltbld', 04:15:50 INFO - 'MAIL': '/var/mail/cltbld', 04:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:50 INFO - 'MOZ_NO_REMOTE': '1', 04:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:50 INFO - 'NO_EM_RESTART': '1', 04:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:50 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:50 INFO - 'SHELL': '/bin/bash', 04:15:50 INFO - 'SHLVL': '1', 04:15:50 INFO - 'TERM': 'linux', 04:15:50 INFO - 'TMOUT': '86400', 04:15:50 INFO - 'USER': 'cltbld', 04:15:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:50 INFO - '_': '/tools/buildbot/bin/python'} 04:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:50 INFO - Downloading/unpacking flake8 04:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:15:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:15:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:53 INFO - no previously-included directories found matching 'docs/_build' 04:15:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:15:53 INFO - Running setup.py install for pep8 04:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:53 INFO - no previously-included directories found matching 'docs/_build' 04:15:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:15:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:15:53 INFO - Cleaning up... 04:15:53 INFO - Return code: 0 04:15:53 INFO - Running post-action listener: _resource_record_post_action 04:15:53 INFO - Running post-action listener: _start_resource_monitoring 04:15:53 INFO - Starting resource monitoring. 04:15:53 INFO - ##### 04:15:53 INFO - ##### Running install step. 04:15:53 INFO - ##### 04:15:53 INFO - Running pre-action listener: _resource_record_pre_action 04:15:53 INFO - Running main action method: install 04:15:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:15:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:15:53 INFO - Reading from file tmpfile_stdout 04:15:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:15:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:15:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:15:53 INFO - Reading from file tmpfile_stdout 04:15:53 INFO - Output received: 04:15:53 INFO - Usage: mozinstall [options] installer 04:15:53 INFO - Options: 04:15:53 INFO - -h, --help show this help message and exit 04:15:53 INFO - -d DEST, --destination=DEST 04:15:53 INFO - Directory to install application into. [default: 04:15:53 INFO - "/builds/slave/test-pgo"] 04:15:53 INFO - --app=APP Application being installed. [default: firefox] 04:15:53 INFO - mkdir: /builds/slave/test-pgo/build/application 04:15:53 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:15:53 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:16:08 INFO - Reading from file tmpfile_stdout 04:16:08 INFO - Output received: 04:16:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:16:08 INFO - Running post-action listener: _resource_record_post_action 04:16:08 INFO - ##### 04:16:08 INFO - ##### Running run-tests step. 04:16:08 INFO - ##### 04:16:08 INFO - Running pre-action listener: _resource_record_pre_action 04:16:08 INFO - Running main action method: run_tests 04:16:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:16:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:16:08 INFO - Python 2.7.3 04:16:08 INFO - Return code: 0 04:16:08 INFO - grabbing minidump binary from tooltool 04:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:08 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 0x18197f0>, '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 0x17852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1785760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:16:08 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:16:08 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:16:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:16:08 INFO - Return code: 0 04:16:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:16:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:16:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:16:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:16:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:16:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:16:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:16:09 INFO - Return code: 0 04:16:09 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/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:16:09 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/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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:16:10 INFO - Using env: {'DISPLAY': ':0', 04:16:10 INFO - 'HOME': '/home/cltbld', 04:16:10 INFO - 'LANG': 'en_US.UTF-8', 04:16:10 INFO - 'LANGUAGE': 'en_US:en', 04:16:10 INFO - 'LOGNAME': 'cltbld', 04:16:10 INFO - 'MAIL': '/var/mail/cltbld', 04:16:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:16:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:10 INFO - 'MOZ_NO_REMOTE': '1', 04:16:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:10 INFO - 'NO_EM_RESTART': '1', 04:16:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:16:10 INFO - 'SHELL': '/bin/bash', 04:16:10 INFO - 'SHLVL': '1', 04:16:10 INFO - 'TERM': 'linux', 04:16:10 INFO - 'TMOUT': '86400', 04:16:10 INFO - 'USER': 'cltbld', 04:16:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239', 04:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:10 INFO - '_': '/tools/buildbot/bin/python'} 04:16:10 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/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:16:10 INFO - mozversion application_buildid: 20160201161019 04:16:10 INFO - mozversion application_changeset: 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 04:16:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:16:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:16:10 INFO - mozversion application_name: Firefox 04:16:10 INFO - mozversion application_remotingname: firefox-dev 04:16:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:16:10 INFO - mozversion application_vendor: Mozilla 04:16:10 INFO - mozversion application_version: 46.0a2 04:16:10 INFO - mozversion platform_buildid: 20160201161019 04:16:10 INFO - mozversion platform_changeset: 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 04:16:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:16:10 INFO - mozversion platform_version: 46.0a2 04:16:10 INFO - using testdate: 1454415370 04:16:10 INFO - actual date: 1454415370 04:16:10 INFO - starting webserver on 'localhost:56792' 04:16:10 INFO - SUITE-START | Running 3 tests 04:16:10 INFO - TEST-START | dromaeo_css 04:16:10 INFO - operating with platform_type : linux_ 04:16:10 INFO - Initialising browser for dromaeo_css test... 04:16:10 INFO - TEST-INFO | started process 4909 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMfgoUa/profile http://localhost:56792/getInfo.html) 04:16:13 INFO - PROCESS | 4909 | 04:16:13 INFO - PROCESS | 4909 | (process:4988): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:16:14 INFO - PROCESS | 4909 | __metrics Screen width/height:1600/1200 04:16:14 INFO - PROCESS | 4909 | colorDepth:24 04:16:14 INFO - PROCESS | 4909 | Browser inner width/height: 1024/697 04:16:14 INFO - PROCESS | 4909 | __metrics 04:16:15 INFO - TEST-INFO | 4909: exit 0 04:16:15 INFO - Browser initialized. 04:16:15 INFO - Running cycle 1/1 for dromaeo_css test... 04:16:15 INFO - TEST-INFO | started process 5037 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMfgoUa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:17 INFO - PROCESS | 5037 | 04:16:17 INFO - PROCESS | 5037 | (process:5103): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:16:27 INFO - PROCESS | 5037 | RSS: Main: 139669504 04:16:27 INFO - PROCESS | 5037 | 04:17:17 INFO - PROCESS | 5037 | 1454415437162 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] 04:19:25 INFO - PROCESS | 5037 | Cycle 1(1): loaded http://localhost:56792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56792/tests/dromaeo/cssquery-ext.html) 04:19:26 INFO - PROCESS | 5037 | RSS: Main: 144125952 04:19:26 INFO - PROCESS | 5037 | 04:22:28 INFO - PROCESS | 5037 | Cycle 1(1): loaded http://localhost:56792/tests/dromaeo/cssquery-ext.html (next: http://localhost:56792/tests/dromaeo/cssquery-jquery.html) 04:22:28 INFO - PROCESS | 5037 | RSS: Main: 142323712 04:22:28 INFO - PROCESS | 5037 | 04:25:30 INFO - PROCESS | 5037 | Cycle 1(1): loaded http://localhost:56792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56792/tests/dromaeo/cssquery-mootools.html) 04:25:31 INFO - PROCESS | 5037 | RSS: Main: 142471168 04:25:31 INFO - PROCESS | 5037 | 04:28:32 INFO - PROCESS | 5037 | Cycle 1(1): loaded http://localhost:56792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56792/tests/dromaeo/cssquery-prototype.html) 04:28:33 INFO - PROCESS | 5037 | RSS: Main: 142938112 04:28:33 INFO - PROCESS | 5037 | 04:31:35 INFO - PROCESS | 5037 | Cycle 1(1): loaded http://localhost:56792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56792/tests/dromaeo/cssquery-yui.html) 04:31:36 INFO - PROCESS | 5037 | RSS: Main: 144494592 04:31:36 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | Cycle 1(1): loaded http://localhost:56792/tests/dromaeo/cssquery-yui.html (next: http://localhost:56792/tests/dromaeo/cssquery-dojo.html) 04:34:38 INFO - PROCESS | 5037 | RSS: Main: 146010112 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | __start_tp_report 04:34:38 INFO - PROCESS | 5037 | _x_x_mozilla_page_load 04:34:38 INFO - PROCESS | 5037 | _x_x_mozilla_page_load_details 04:34:38 INFO - PROCESS | 5037 | |i|pagename|runs| 04:34:38 INFO - PROCESS | 5037 | |0;dojo.html;3342.699157075864;3355.731541476682;3374.190194353353;3374.6456622054684;3386.8137252451115;5450.945490545093;5460.863478413036;5469.15228139638;5488.945110548893;5524.66851988881;5451.236826844245;5483.972580137094;5497.697626630534;5513.476219759116;5558.082916318813;4933.038057578765;5008.924866127011;5104.5405913467785;5121.129408000649;5155.226715992593;4967.10592093423;5160.329157209576;5167.431582525938;5171.767270472819;5182.6631268967585;5059.949400506003;5062.367204099488;5112.079825631385;5162.328897243353;5186.844394668166;5107.38711354638;5107.565856902168;5111.4121875984365;5126.410462796789;5153.149730294497;4946.455889852114;5028.120078986163;5037.974810125963;5081.695098294077;5114.411842638107;5339.065663508871;5393.1370980643305;5421.512063914267;5423.891522169534;5446.700431476267;5876.177335173036;5911.054231323011;5919.408059194089;5919.733611987471;5943.881122377571;5828.9417105828825;5939.109133629947;5944.375840536724;5948.2862056553495;5968.1644569760265;5599.272094627713;5655.575831812631;5656.038473459522;5659.886802263932;5687.516561092312;6038.516918646497;6073.1497590337385;6075.605085669506;6077.179580756541;6089.725962331617;5726.398728133569;5903.645781253139;5904.527637788967;5911;5924.555658325643;6040.969795151084;6054.939450605526;6055.515558755289;6057.727402266909;6080.75676972925;5980.312264089598;6012.488938440194;6018.037114061729;6027.095935609694;6034.366391528914;5907.172995780594;5995.850103747442;6009.278886533557;6009.879802404015;6073.848153796191;4579.771011449481;4595.425571803525;4604.079184163181;4612.215923292981;4629.051044535862;4099.569545197771;4141.875743727693;4143.81352839123;4158.168366326747;4166.604172603597;5628.577856660767;5663.1505274208375;5705.71471426427;5726.627769194989;5821.708914554255;5934.465898069195;5991.7902873399225;6016.2479690038745;6019.759209631653;6041.879162416815;5583.0787919992745;5686.516646085046;5705.4579814917515;5711.371749107595;5712.428757124254;5029.06962211992;5089.898202035939;5146;5149.562287205629;5212.192110222922;6155.045967874987;6178.073289006595;6199.473044791153;6206.534509911775;6221.595596286227;5843.707814609337;5955.583109182316;6011.248593925759;6015.097735339559;6038.305594856472;6161.199044124235;6274.717637706223;6280.246370435577;6320.5891617044745;6322.462590679844;5963.73163207648;5984.850378740566;6021.638701677914;6051.727672254847;6073.817785466443;5963.671998040149;6002.939970600238;6059.848503787264;6096.0855871619615;6112.786052488142;5806.2451881255165;5814.30228372598;5836.328822185503;5901.940980590139;5906.379830117948;5811.593188476766;5813.709314534341;5862.12068189775;5893.499052580579;5908.084246941731;5748.712564371848;5754.712264386848;5782.074868021096;5817.767289308549;5901.232839730807;5864.296284445893;5911.438413350725;5934.525237980864;5984.251968503937;5987.790427335022;5693.800716974886;5773.942260577509;5792.218050563289;5816.360200377871;5828.562857785768 04:34:38 INFO - PROCESS | 5037 | |1;ext.html;516.1432022842083;557.5010365722678;567.3305499510576;577.1285359107746;584.771938943812;30650.23374415638;38034.80982595087;38398;38449.23101537968;38653.806730966375;41686.79156604213;42296.577034229646;43001.35497967533;43001.78499107508;43069;8741.431806932545;8953.149450802164;9006.954965225164;9060.275177985744;9075.092490750905;8803.383763136582;8868.8669669955;8880.822383552326;8914.687985920495;9071.228945539637;9093.590788414504;9116.225120864734;9121.908780912172;9124.771880703001;9146.725598232064;9039.954800225989;9077.183053525214;9129.543522823898;9133.908660913372;9142.908570914306;8888.466691998436;9085.04607016267;9097.590608422637;9105.863412048824;9153.22197613197;42327.57672423298;42665;42745.1450970982;42767.78616106931;42798.786006070084;3645.908852278688;3751.212245428463;3802.7727930247656;3806.581276059659;4155.958440415588;30429.69570304313;30742.538861917088;30783.846080769454;30788.384232315228;31553.21116972071;4189.245935731567;4208.915821683579;4256.191323648497;4264.125854199912;4329.610335069828;285864;287151.56424217956;288553;289234;290141;45449.31826022612;45836.3124553132;45886.31170532378;45906;45945.54054459413;43742.56257437448;43985.34021989673;44025.339619905724;44051;44076.77961610172;15205.467808626645;15274.083554986737;15306.158161301235;15318.157501337533;15360.23198840076;12046.518139274505;12054.156209065457;12140.514379424723;12162.391880405945;12412;15344.386224550894;15491.147986860606;15584.532464026097;15738.213089345487;15757.68484630301;6164.291106522807;6227.564070515021;6233.844153896098;6266.905996410058;6339.207599050119;1040.8542804007445;1065.733566608348;1150.7065698246893;1156.5720683347215;1161.5237752521425;30835.691643083283;30954;31056.22359441032;31304;31641.208969775478;1095.0746619106842;1149.7240662241002;1198.6344165029575;1201.2072032458536;1245.2155142260317;15050.247487625575;15383.61540961485;17571.121443927754;17668;17812.732809007874;504631;534997;535841;538987;541744;57482.7125864368;57847;57923;57993.42006579965;58091.70954145287;1471.7865909443071;1479.2086233865045;1483.8887083468783;1500.6923580665937;1524.3140586736013;32511.349773003934;32881.835590821895;33015.33969320648;33141.502877456376;33945.66054339425;48871.5112848867;49320.75339623279;49351.753241233564;49360;49426.75286623544;306703;315475;317371;318915;319103;44257;45264.32103518384;45818.541814581426;46004.30993535033;46420;48033.5196648029;48084.519154808004;49066.75466622644;49128.2630760546;49380.50619493903;41429.171416572106;42629.36055959101;43326.78336608297;43489;44526.55473445224;36389.45415818818;36749.08127296732;41728.3740743883;45643.77178114088;46886.76556617195;40394;42468.57531424646;42810.14379712326;43009.56990430056;43724.781376094186;35801.28397432089;38795;39579.406308905964;39921.60078399295;41087.589124108374;27051.1884643461;27357.316067098483;27367.178984630493;27432.451350973268;27593.724062759116 04:34:38 INFO - PROCESS | 5037 | |2;jquery.html;397.1283033740936;400.07382908566666;406.48985523168426;406.5690368209697;407.40925657796186;17181.656366872656;17586.384476543306;17843.821561784396;17874.55313617157;18647.533811654714;13294.601161965156;17091;17120.657586848287;17655.73516397255;17869.553261168476;5143.305653736745;5334.093204155283;5362.91955620666;5376.4085950545405;5377.435369286227;5112.539871411572;5249.606279529032;5357.303550538424;5361.758720857551;5363.061464243761;5330.600204984622;5354.9196762048605;6212.9068063979075;6470;6514.57655252407;6423.614583125004;6426.1003459515705;6560;6885.208201056842;6892.862142757167;6329.177206963065;6522.673866306665;6569.113169722122;6599.47204223661;6619.106420633201;21936.232231871807;21958;22198.223062192745;22294.88852555743;22757.658635120486;2388.450656349032;2425.260295609838;2454.987725061363;2457.9016839326405;2542.453372524916;13900.374483148282;14290.285485725672;14407.927960360235;14862.777058344134;14878;2006.378022812918;2038.0930485933766;2055.722477465538;2064.9277275295294;2106.24175296893;53437;53850;53939.46060539383;53940.73029634866;55377.16934245989;14876.776848347283;15575.61060973462;15577.14325712074;15630.06219626826;15654.530364089096;24082.63876041861;24124.155654552007;24275;24339.513209735705;24372.634410483857;7684.654190561439;7774.6890124394395;7808.68765249395;7902.130765615778;9459.716208513755;7444.255574442513;7470.5144165630145;7494.925050749532;7519.812004699927;7525.698972041167;4710.646701497401;4762.666613337033;4807.687500312469;4814.470408255089;4874.195757699939;1919.6640587897061;1924.1052910396734;1980.5241800639785;2000.2699014859472;2004.0981558298824;986.487026746088;995.4276291132628;998.7752755629925;1022.325265324882;1083.7453198498347;16893.493195204162;17316;17317;17925.103744812706;17958.19188136537;1009.4448053570507;1019;1027.6814187601867;1045.451138152476;1054.056619325699;10159.796804063877;10340.741481463023;10378.948105259426;10388.272820902464;10463.476826158661;394101;398330;400377;589964;590993;70942;72990;75089.62455187799;75210.62394687992;77362.22637773663;1031.0359813574332;1033.4729288062993;1170.7599942011866;1202.725111381938;1208.1784386617185;15934.203289835694;15944.202789860692;16029.35882564731;16050.678986419973;16271.837281627033;32872;33893.152671183416;35015.82492087523;35227.29545409129;35440.64559354477;44756.55243447524;45731;46044;46205.306920395546;46566;7621.961890190513;7922.049354077317;7992.240737129963;8000.879986800086;8027.357811374959;8317.209865062809;8573.22840944318;11119.332840029625;11460.656180314603;11705.535430949356;7885.1720569339395;7913.327367173854;7939.404544659289;8001.399895007781;8036.517808931483;7787.260210280015;7951.840963180588;8098.87851682237;8106.148854370442;8106.635201415833;8388.370872184489;8417.87373189415;8425.789355266168;8503.617337219963;8507.106753790762;10763;11105.05607023412;11175.608853690082;11195.552177912792;11346.149038822286;11388.470280459333;11421.200515963803;11454.427278636202;11517.366544840113;11593.536258549564 04:34:38 INFO - PROCESS | 5037 | |3;mootools.html;1524.0246242404862;1525.6185953511626;1702.6764914666212;1810.782706075271;1813.619139980604;7526.059242594662;7539.0576177977755;8427.367947403945;8606.139386061399;8626.827463450734;8069.233422824822;8289;8321.209485098922;8341.040780310252;8414.621342039607;2367.751386104456;2409.4578719788083;2418.5767490689145;2420.4674971506242;2424.442378253003;2453.0800949643885;2456.520978409211;2493.2520243926842;2501.3246423465653;2503.5368456835454;2472.6414669872947;2479.219046000513;2511.4977004599064;2539.8222124451295;2548.24826676131;2463.039414628305;2490.8007359411295;2501.3496490912494;2503.0238207099246;2508.0344067533947;2449.9877500612383;2450.791682706972;2454.7913427358694;2472.678551788256;2537.3276081838326;8729.170728780819;8775.956120219358;8777.034526202113;8817.911820881838;8825.602847871862;5208.374995000624;5290.947090529084;5331.2003199519995;5337.412884582693;5337.492938170868;3400.795952242873;3412.181076541612;3455.188030812757;3463.79217246966;3483.2511010132944;1042.374575254841;1057.3550134417999;1074.312440038376;1081.7181639756834;1092.071739021833;12133.696657583543;12300.138990270685;12309.384530773426;12335.75328493434;12337.198082124723;4816.807327706852;4828;4830.8164499697095;4877.073356062408;4896.314515967767;10169.54237059334;10244.846327305097;10293.43386113771;10295.43375114361;10366.118879895294;5323.3079699639575;5327.946720532745;5364.490373414519;5368.4631536846;5384.19237114436;4612.930806037912;4763.666543342002;4796.784144713496;4859.222524396079;4875.049365373789;3942.0342016206214;3942.1327307992196;3968.3650615901315;3972.8875914743917;4002.4996875390575;1217.993910030444;1221.2977537915733;1222.0284873525568;1233.1614502138632;1240.2558464921156;1408.2325132802648;1431.5991522373545;1432.7850822376517;1456.8980171388114;1495.5139579636661;8095.635696393559;8260.958695206486;8284.420090593601;8304.70933517336;8306.044804847399;506.5137468030658;507.4925074925075;507.81718581310696;511.92577076323727;522.3992408729991;6101.115338275925;6170.969145154246;6235.501159907197;6264.248290205204;6278.121063051177;10230.795384092276;10631.096356809603;10679.83980240297;10773.192010599236;10886.129109671365;10482.73793155162;10588.894111058946;10590.364578125336;10679;10723.46382680863;7843.9215607844335;7890.723824666109;7933.52398856059;7952.32405245549;7987.56068416231;7891.881621775563;7961.522308661499;7991.880121798062;8026.43814932949;8049.758507244792;9355.345125841126;9368.95315523418;9383.436993780122;9403.106704863027;9525.333226674065;9587;9611.134997850228;9735.123838854537;9783.510824458606;10034.69895903124;6555.082288479522;6692.297308782508;6911.067005954333;7231.891521627074;7360.521566098187;8030.759077227459;8095.352371810359;8106.959465202636;8123.75628731139;8139.959300203461;7507.436942229246;7648.770536883902;7700.4224683150105;7763.92236077632;7764.572948487661;7275.308845659654;7280.672369743268;7285.7814265572115;7414.184439711519;7420.443466739908;7326.523775954546;7563.773086807405;7576.356009739234;7604.201558836464;7608.97278867368;7025.613591252326;7048.471364647569;7133.536320139175;7160.57036577807;7235.2041275458605;7252.818679533054;7275.017872587345;7281.927180728125;7285.854282914418;7311.341979221896 04:34:38 INFO - PROCESS | 5037 | |4;prototype.html;359.9856005759769;372.5957336290126;375.18023119483945;377.582771038003;380.3515006913212;6345.4923606111515;6359.236891573012;6403.74385024599;6450.064740612608;6544.574602650824;6351.809445716624;6356.459700925416;6374.394432528902;6389.840253993652;6409;4842.757862106898;4868.683535570177;4886.975565122169;4897.167481528131;4900;4862.051899879507;4862.97568512157;4864.246041863516;4917.950820491803;4920.926186107194;4449.243628583133;4684.718916864999;4691.10868934903;4801.135795556798;4805.279208118793;4781.163296423112;4783.808647654089;4794.849236183309;4798.592119669815;4821.5178482151505;4181.832726690929;4195.769232692201;4199.580041995807;4199.68502362324;4227.661787057028;5944.554158438134;5952.107183922403;5990.161377407167;6014.78948236814;6020.789272375489;5539.086050801613;5595;5651.886962260732;5654.9151762723595;5661.5187709044785;6637.701303441357;6648.102506161655;6664.700088496029;6667.733290668368;6672.432843208333;4705.882352941204;4706.95293047072;4708.387909571768;4718.079974404993;4720.716756994591;6908.447324214051;6979.82550436238;7025.297470252934;7042.6830792614455;7072;4692.272697731857;4701.059788042337;4702.059588082398;4710.24636058229;4710.552497512731;4756.239001759702;4758.429718192988;4767.809287628525;4772.0694464579765;4774.164521208774;5509.283793106871;5530.5022547970875;5551.000819852466;5567.192757050205;5578.665280083208;6592.340765923465;6724.327567243335;6756.391924726799;6765.188177418741;6773.966130169318;1718.2783231042742;1745.589786400195;1749.4926471323429;1751.8948863068256;1755.3943889358152;1171.3147808532103;1182.5920057580122;1182.5979167083233;1199.1905463811893;1200.009991756804;6518.348165183538;6533.216014078341;6572.80281591553;6582.539222254396;6595.109660195908;6921.965390173017;6945.652717364112;7010.193827709879;7010.719571217196;7032.367086962198;6412.903806442907;6587.374199451045;6592.538522303393;6599.868002639921;6621.172353455818;3747.2505498900327;3772.3775577029483;3791.734578579473;3792.58281589025;3809.542854857435;7269.563826170341;7284.235155308722;7302.160251571031;7338.082739657543;7351.154617218981;7113.53762005468;7237.529560578546;7242.13094428672;7271.3455788979245;7281.854362912818;7250.057492525938;7281.05346304977;7291.416686665054;7294.817629559304;7338.633068346669;7017.122859642544;7026.508144429841;7032.085828842218;7057.470689698191;7072.611006394698;6764.93235067643;6976.895346569704;7014.158301003912;7024.859502810017;7031.472639551952;7327.194008658937;7346.52247603904;7368.263173682589;7391.0761154855645;7407.740729074457;4937.530934561211;4951.72765497901;4979.576735977483;4992.350994370709;5003.624728145331;6911.861762764616;6975.337342952412;6976.267491913276;6982.092327997328;6995.825104372431;6765.052892595139;6784.423324017514;6809.591424514545;6825.249222585412;6847.931520684929;6687.63218022994;6779.694913728993;6850.314968503109;6858.519903606899;6880.552764070319;6699;6707.262201157771;6711.026901099216;6722.798316050526;6727.428168605723;6781.42357899584;6835.624040677811;6852.897206541807;6856.142982127234;6861.828454288683;6563.442107420923;6589.341065893373;6660.267370589135;6691.397774200345;6785.626790526569 04:34:38 INFO - PROCESS | 5037 | |5;yui.html;744.13680131048;864.4942708515522;954.0657112758643;955.7849483866131;957.760559860035;13191.736165276689;13270.668233294173;13332.333383330819;13404.932975335121;14795;15452.459163929265;15543.14512701801;15545.06729596225;15548;15565.37738490462;868.5179725252482;894.1639567004838;904.5115637555712;907.5552979040289;916.5875356089753;905.1536813079758;907.2605826251616;908.2733812949647;908.3913777768911;908.7818923458389;935.4761333653142;936.0405584276103;937.142514599141;937.2876613773548;940.5344354544476;918.0406475233331;919.9218066464392;924.8890133183994;928.9535523223846;929.2798081486868;685.5235611250183;685.694865784726;687.8314812870829;689.3244620272161;689.9931000689979;14872.776908346383;14952.252387380588;15002.474913378088;15094.924525377302;15109.39562417502;13337.599872003855;13339.53311634098;13865.168089914638;13990.950678699139;14020.649483762885;10091.899081009244;10439.843402348972;10882;11298.096152307879;11466.713332166679;3633.255182687543;3641.8361173747244;3672.081979505124;3678.5769636491877;3729.7948612826285;52246.47753522454;52473;52486.21270680943;52689.47310526884;52874.20688689711;10745.677629671123;11076.280041797258;11130.666080017612;11137.77484476707;11302;19093.522661933563;19404.417867464;19919.800801992085;19924.50188745293;19971;8229.177082291722;8276.586170691442;8302.584870756558;8334.416590838704;8388.790280243044;4565.703229290086;4577.336286238543;4590.013147173307;4614.192516309632;4729.314249433813;3233.1270556949494;3251.2034551534553;3258.625258095302;3266.1508007918114;3284.967150328514;669.8794217040979;672.7040102354948;674.6694119881223;689.5070024932097;690.1511141296234;595.4045954045954;628.6825153297556;641.4515589171191;643.2409756487297;643.9130717353191;7555.395568354518;7609.239076092346;7640.770776876702;7957.164497727771;7963.362930965509;524.4336116993637;532.7975369359618;554.7697705452273;578.8871170121786;661.5699795133106;4092.6930480214105;4122.91754164915;4232.9629240835575;4308.80610372534;4345.152695224401;60751.392486074576;61750.0737488938;61964;63210;63214.36785632177;52401;53317;53809;53937.730311348976;55726.44273557213;47635.5236447638;47931;48019;48668.7566562172;50566.24150637743;8352.540610266493;8688.435251708619;8702.912970870464;8820.470771753715;8959.148880856308;36714.8164259177;40728.79635601803;41095.1780964385;41409.79295103505;41486.17027659369;51962.740186298826;52004.47995519996;52031;52230.21654675107;53756.731216343665;11904.285742855456;11947.342896140795;12190.329531875832;12241.20432171906;12291.877081229073;12306.200096993667;12400;12751.936240318739;13015.095471358743;13044.347782611021;11918.404079795802;12045.51817927273;12209.145359824726;12244.265344079384;12337.50649973991;11743.823842642538;11857.16999810005;11865;11889.702757431134;12002.879971200176;11060.446977651247;11072.723181920517;11622.128340374336;11859.229150105215;12098.939505302416;8984.640614375352;9304.627814887599;9373.81252374935;9473.857892131762;9739.9026009739;9537.952310238405;9604.807903841744;9956.601735930482;10133.341332813343;10171.186305095427 04:34:38 INFO - PROCESS | 5037 | __end_tp_report 04:34:38 INFO - PROCESS | 5037 | __start_cc_report 04:34:38 INFO - PROCESS | 5037 | _x_x_mozilla_cycle_collect,287 04:34:38 INFO - PROCESS | 5037 | __end_cc_report 04:34:38 INFO - PROCESS | 5037 | __startTimestamp1454416478527__endTimestamp 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | ------- Summary: start ------- 04:34:38 INFO - PROCESS | 5037 | Number of tests: 6 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | [#0] dojo.html Cycles:165 Average:5567.48 Median:5811.59 stddev:619.07 (10.7%) stddev-sans-first:595.86 04:34:38 INFO - PROCESS | 5037 | Values: 3342.7 3355.7 3374.2 3374.6 3386.8 5450.9 5460.9 5469.2 5488.9 5524.7 5451.2 5484.0 5497.7 5513.5 5558.1 4933.0 5008.9 5104.5 5121.1 5155.2 4967.1 5160.3 5167.4 5171.8 5182.7 5059.9 5062.4 5112.1 5162.3 5186.8 5107.4 5107.6 5111.4 5126.4 5153.1 4946.5 5028.1 5038.0 5081.7 5114.4 5339.1 5393.1 5421.5 5423.9 5446.7 5876.2 5911.1 5919.4 5919.7 5943.9 5828.9 5939.1 5944.4 5948.3 5968.2 5599.3 5655.6 5656.0 5659.9 5687.5 6038.5 6073.1 6075.6 6077.2 6089.7 5726.4 5903.6 5904.5 5911.0 5924.6 6041.0 6054.9 6055.5 6057.7 6080.8 5980.3 6012.5 6018.0 6027.1 6034.4 5907.2 5995.9 6009.3 6009.9 6073.8 4579.8 4595.4 4604.1 4612.2 4629.1 4099.6 4141.9 4143.8 4158.2 4166.6 5628.6 5663.2 5705.7 5726.6 5821.7 5934.5 5991.8 6016.2 6019.8 6041.9 5583.1 5686.5 5705.5 5711.4 5712.4 5029.1 5089.9 5146.0 5149.6 5212.2 6155.0 6178.1 6199.5 6206.5 6221.6 5843.7 5955.6 6011.2 6015.1 6038.3 6161.2 6274.7 6280.2 6320.6 6322.5 5963.7 5984.9 6021.6 6051.7 6073.8 5963.7 6002.9 6059.8 6096.1 6112.8 5806.2 5814.3 5836.3 5901.9 5906.4 5811.6 5813.7 5862.1 5893.5 5908.1 5748.7 5754.7 5782.1 5817.8 5901.2 5864.3 5911.4 5934.5 5984.3 5987.8 5693.8 5773.9 5792.2 5816.4 5828.6 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | [#1] ext.html Cycles:180 Average:54455.27 Median:23362.38 stddev:104322.65 (446.5%) stddev-sans-first:104536.69 04:34:38 INFO - PROCESS | 5037 | Values: 516.1 557.5 567.3 577.1 584.8 30650.2 38034.8 38398.0 38449.2 38653.8 41686.8 42296.6 43001.4 43001.8 43069.0 8741.4 8953.1 9007.0 9060.3 9075.1 8803.4 8868.9 8880.8 8914.7 9071.2 9093.6 9116.2 9121.9 9124.8 9146.7 9040.0 9077.2 9129.5 9133.9 9142.9 8888.5 9085.0 9097.6 9105.9 9153.2 42327.6 42665.0 42745.1 42767.8 42798.8 3645.9 3751.2 3802.8 3806.6 4156.0 30429.7 30742.5 30783.8 30788.4 31553.2 4189.2 4208.9 4256.2 4264.1 4329.6 285864.0 287151.6 288553.0 289234.0 290141.0 45449.3 45836.3 45886.3 45906.0 45945.5 43742.6 43985.3 44025.3 44051.0 44076.8 15205.5 15274.1 15306.2 15318.2 15360.2 12046.5 12054.2 12140.5 12162.4 12412.0 15344.4 15491.1 15584.5 15738.2 15757.7 6164.3 6227.6 6233.8 6266.9 6339.2 1040.9 1065.7 1150.7 1156.6 1161.5 30835.7 30954.0 31056.2 31304.0 31641.2 1095.1 1149.7 1198.6 1201.2 1245.2 15050.2 15383.6 17571.1 17668.0 17812.7 504631.0 534997.0 535841.0 538987.0 541744.0 57482.7 57847.0 57923.0 57993.4 58091.7 1471.8 1479.2 1483.9 1500.7 1524.3 32511.3 32881.8 33015.3 33141.5 33945.7 48871.5 49320.8 49351.8 49360.0 49426.8 306703.0 315475.0 317371.0 318915.0 319103.0 44257.0 45264.3 45818.5 46004.3 46420.0 48033.5 48084.5 49066.8 49128.3 49380.5 41429.2 42629.4 43326.8 43489.0 44526.6 36389.5 36749.1 41728.4 45643.8 46886.8 40394.0 42468.6 42810.1 43009.6 43724.8 35801.3 38795.0 39579.4 39921.6 41087.6 27051.2 27357.3 27367.2 27432.5 27593.7 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | [#2] jquery.html Cycles:180 Average:26766.85 Median:197249.06 stddev:79108.83 (40.1%) stddev-sans-first:79305.97 04:34:38 INFO - PROCESS | 5037 | Values: 397.1 400.1 406.5 406.6 407.4 17181.7 17586.4 17843.8 17874.6 18647.5 13294.6 17091.0 17120.7 17655.7 17869.6 5143.3 5334.1 5362.9 5376.4 5377.4 5112.5 5249.6 5357.3 5361.8 5363.1 5330.6 5354.9 6212.9 6470.0 6514.6 6423.6 6426.1 6560.0 6885.2 6892.9 6329.2 6522.7 6569.1 6599.5 6619.1 21936.2 21958.0 22198.2 22294.9 22757.7 2388.5 2425.3 2455.0 2457.9 2542.5 13900.4 14290.3 14407.9 14862.8 14878.0 2006.4 2038.1 2055.7 2064.9 2106.2 53437.0 53850.0 53939.5 53940.7 55377.2 14876.8 15575.6 15577.1 15630.1 15654.5 24082.6 24124.2 24275.0 24339.5 24372.6 7684.7 7774.7 7808.7 7902.1 9459.7 7444.3 7470.5 7494.9 7519.8 7525.7 4710.6 4762.7 4807.7 4814.5 4874.2 1919.7 1924.1 1980.5 2000.3 2004.1 986.5 995.4 998.8 1022.3 1083.7 16893.5 17316.0 17317.0 17925.1 17958.2 1009.4 1019.0 1027.7 1045.5 1054.1 10159.8 10340.7 10378.9 10388.3 10463.5 394101.0 398330.0 400377.0 589964.0 590993.0 70942.0 72990.0 75089.6 75210.6 77362.2 1031.0 1033.5 1170.8 1202.7 1208.2 15934.2 15944.2 16029.4 16050.7 16271.8 32872.0 33893.2 35015.8 35227.3 35440.6 44756.6 45731.0 46044.0 46205.3 46566.0 7622.0 7922.0 7992.2 8000.9 8027.4 8317.2 8573.2 11119.3 11460.7 11705.5 7885.2 7913.3 7939.4 8001.4 8036.5 7787.3 7951.8 8098.9 8106.1 8106.6 8388.4 8417.9 8425.8 8503.6 8507.1 10763.0 11105.1 11175.6 11195.6 11346.1 11388.5 11421.2 11454.4 11517.4 11593.5 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | [#3] mootools.html Cycles:180 Average:6015.01 Median:2865.39 stddev:3195.27 (111.5%) stddev-sans-first:3186.40 04:34:38 INFO - PROCESS | 5037 | Values: 1524.0 1525.6 1702.7 1810.8 1813.6 7526.1 7539.1 8427.4 8606.1 8626.8 8069.2 8289.0 8321.2 8341.0 8414.6 2367.8 2409.5 2418.6 2420.5 2424.4 2453.1 2456.5 2493.3 2501.3 2503.5 2472.6 2479.2 2511.5 2539.8 2548.2 2463.0 2490.8 2501.3 2503.0 2508.0 2450.0 2450.8 2454.8 2472.7 2537.3 8729.2 8776.0 8777.0 8817.9 8825.6 5208.4 5290.9 5331.2 5337.4 5337.5 3400.8 3412.2 3455.2 3463.8 3483.3 1042.4 1057.4 1074.3 1081.7 1092.1 12133.7 12300.1 12309.4 12335.8 12337.2 4816.8 4828.0 4830.8 4877.1 4896.3 10169.5 10244.8 10293.4 10295.4 10366.1 5323.3 5327.9 5364.5 5368.5 5384.2 4612.9 4763.7 4796.8 4859.2 4875.0 3942.0 3942.1 3968.4 3972.9 4002.5 1218.0 1221.3 1222.0 1233.2 1240.3 1408.2 1431.6 1432.8 1456.9 1495.5 8095.6 8261.0 8284.4 8304.7 8306.0 506.5 507.5 507.8 511.9 522.4 6101.1 6171.0 6235.5 6264.2 6278.1 10230.8 10631.1 10679.8 10773.2 10886.1 10482.7 10588.9 10590.4 10679.0 10723.5 7843.9 7890.7 7933.5 7952.3 7987.6 7891.9 7961.5 7991.9 8026.4 8049.8 9355.3 9369.0 9383.4 9403.1 9525.3 9587.0 9611.1 9735.1 9783.5 10034.7 6555.1 6692.3 6911.1 7231.9 7360.5 8030.8 8095.4 8107.0 8123.8 8140.0 7507.4 7648.8 7700.4 7763.9 7764.6 7275.3 7280.7 7285.8 7414.2 7420.4 7326.5 7563.8 7576.4 7604.2 7609.0 7025.6 7048.5 7133.5 7160.6 7235.2 7252.8 7275.0 7281.9 7285.9 7311.3 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | [#4] prototype.html Cycles:180 Average:5670.23 Median:6525.78 stddev:1718.63 (26.3%) stddev-sans-first:1676.60 04:34:38 INFO - PROCESS | 5037 | Values: 360.0 372.6 375.2 377.6 380.4 6345.5 6359.2 6403.7 6450.1 6544.6 6351.8 6356.5 6374.4 6389.8 6409.0 4842.8 4868.7 4887.0 4897.2 4900.0 4862.1 4863.0 4864.2 4918.0 4920.9 4449.2 4684.7 4691.1 4801.1 4805.3 4781.2 4783.8 4794.8 4798.6 4821.5 4181.8 4195.8 4199.6 4199.7 4227.7 5944.6 5952.1 5990.2 6014.8 6020.8 5539.1 5595.0 5651.9 5654.9 5661.5 6637.7 6648.1 6664.7 6667.7 6672.4 4705.9 4707.0 4708.4 4718.1 4720.7 6908.4 6979.8 7025.3 7042.7 7072.0 4692.3 4701.1 4702.1 4710.2 4710.6 4756.2 4758.4 4767.8 4772.1 4774.2 5509.3 5530.5 5551.0 5567.2 5578.7 6592.3 6724.3 6756.4 6765.2 6774.0 1718.3 1745.6 1749.5 1751.9 1755.4 1171.3 1182.6 1182.6 1199.2 1200.0 6518.3 6533.2 6572.8 6582.5 6595.1 6922.0 6945.7 7010.2 7010.7 7032.4 6412.9 6587.4 6592.5 6599.9 6621.2 3747.3 3772.4 3791.7 3792.6 3809.5 7269.6 7284.2 7302.2 7338.1 7351.2 7113.5 7237.5 7242.1 7271.3 7281.9 7250.1 7281.1 7291.4 7294.8 7338.6 7017.1 7026.5 7032.1 7057.5 7072.6 6764.9 6976.9 7014.2 7024.9 7031.5 7327.2 7346.5 7368.3 7391.1 7407.7 4937.5 4951.7 4979.6 4992.4 5003.6 6911.9 6975.3 6976.3 6982.1 6995.8 6765.1 6784.4 6809.6 6825.2 6847.9 6687.6 6779.7 6850.3 6858.5 6880.6 6699.0 6707.3 6711.0 6722.8 6727.4 6781.4 6835.6 6852.9 6856.1 6861.8 6563.4 6589.3 6660.3 6691.4 6785.6 04:34:38 INFO - PROCESS | 5037 | 04:34:38 INFO - PROCESS | 5037 | [#5] yui.html Cycles:180 Average:14903.74 Median:49617.50 stddev:17465.78 (35.2%) stddev-sans-first:17482.41 04:34:38 INFO - PROCESS | 5037 | Values: 744.1 864.5 954.1 955.8 957.8 13191.7 13270.7 13332.3 13404.9 14795.0 15452.5 15543.1 15545.1 15548.0 15565.4 868.5 894.2 904.5 907.6 916.6 905.2 907.3 908.3 908.4 908.8 935.5 936.0 937.1 937.3 940.5 918.0 919.9 924.9 929.0 929.3 685.5 685.7 687.8 689.3 690.0 14872.8 14952.3 15002.5 15094.9 15109.4 13337.6 13339.5 13865.2 13991.0 14020.6 10091.9 10439.8 10882.0 11298.1 11466.7 3633.3 3641.8 3672.1 3678.6 3729.8 52246.5 52473.0 52486.2 52689.5 52874.2 10745.7 11076.3 11130.7 11137.8 11302.0 19093.5 19404.4 19919.8 19924.5 19971.0 8229.2 8276.6 8302.6 8334.4 8388.8 4565.7 4577.3 4590.0 4614.2 4729.3 3233.1 3251.2 3258.6 3266.2 3285.0 669.9 672.7 674.7 689.5 690.2 595.4 628.7 641.5 643.2 643.9 7555.4 7609.2 7640.8 7957.2 7963.4 524.4 532.8 554.8 578.9 661.6 4092.7 4122.9 4233.0 4308.8 4345.2 60751.4 61750.1 61964.0 63210.0 63214.4 52401.0 53317.0 53809.0 53937.7 55726.4 47635.5 47931.0 48019.0 48668.8 50566.2 8352.5 8688.4 8702.9 8820.5 8959.1 36714.8 40728.8 41095.2 41409.8 41486.2 51962.7 52004.5 52031.0 52230.2 53756.7 11904.3 11947.3 12190.3 12241.2 12291.9 12306.2 12400.0 12751.9 13015.1 13044.3 11918.4 12045.5 12209.1 12244.3 12337.5 11743.8 11857.2 11865.0 11889.7 12002.9 11060.4 11072.7 11622.1 11859.2 12098.9 8984.6 9304.6 9373.8 9473.9 9739.9 9538.0 9604.8 9956.6 10133.3 10171.2 04:34:38 INFO - PROCESS | 5037 | -------- Summary: end -------- 04:34:38 INFO - PROCESS | 5037 | 04:34:39 INFO - TEST-INFO | 5037: exit 0 04:34:39 INFO - TEST-OK | dromaeo_css | took 1109022ms 04:34:39 INFO - TEST-START | kraken 04:34:39 INFO - operating with platform_type : linux_ 04:34:39 INFO - Initialising browser for kraken test... 04:34:39 INFO - TEST-INFO | started process 5290 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmput6hPg/profile http://localhost:56792/getInfo.html) 04:34:42 INFO - PROCESS | 5290 | 04:34:42 INFO - PROCESS | 5290 | (process:5367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:34:43 INFO - PROCESS | 5290 | __metrics Screen width/height:1600/1200 04:34:43 INFO - PROCESS | 5290 | colorDepth:24 04:34:43 INFO - PROCESS | 5290 | Browser inner width/height: 1024/697 04:34:43 INFO - PROCESS | 5290 | __metrics 04:34:44 INFO - TEST-INFO | 5290: exit 0 04:34:44 INFO - Browser initialized. 04:34:44 INFO - Running cycle 1/1 for kraken test... 04:34:44 INFO - TEST-INFO | started process 5416 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmput6hPg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:45 INFO - PROCESS | 5416 | 04:34:45 INFO - PROCESS | 5416 | (process:5483): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:34:56 INFO - PROCESS | 5416 | RSS: Main: 139341824 04:34:56 INFO - PROCESS | 5416 | 04:34:58 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56792/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:59 INFO - PROCESS | 5416 | RSS: Main: 144109568 04:34:59 INFO - PROCESS | 5416 | 04:35:01 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56792/tests/kraken/driver.html?testName=audio-dft) 04:35:02 INFO - PROCESS | 5416 | RSS: Main: 143368192 04:35:02 INFO - PROCESS | 5416 | 04:35:05 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56792/tests/kraken/driver.html?testName=audio-fft) 04:35:05 INFO - PROCESS | 5416 | RSS: Main: 145690624 04:35:05 INFO - PROCESS | 5416 | 04:35:07 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56792/tests/kraken/driver.html?testName=audio-oscillator) 04:35:08 INFO - PROCESS | 5416 | RSS: Main: 145809408 04:35:08 INFO - PROCESS | 5416 | 04:35:10 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:11 INFO - PROCESS | 5416 | RSS: Main: 145825792 04:35:11 INFO - PROCESS | 5416 | 04:35:14 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56792/tests/kraken/driver.html?testName=imaging-darkroom) 04:35:14 INFO - PROCESS | 5416 | RSS: Main: 144232448 04:35:14 INFO - PROCESS | 5416 | 04:35:18 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56792/tests/kraken/driver.html?testName=imaging-desaturate) 04:35:18 INFO - PROCESS | 5416 | RSS: Main: 144494592 04:35:18 INFO - PROCESS | 5416 | 04:35:21 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56792/tests/kraken/driver.html?testName=json-parse-financial) 04:35:21 INFO - PROCESS | 5416 | RSS: Main: 144343040 04:35:21 INFO - PROCESS | 5416 | 04:35:23 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:35:24 INFO - PROCESS | 5416 | RSS: Main: 144474112 04:35:24 INFO - PROCESS | 5416 | 04:35:25 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:35:26 INFO - PROCESS | 5416 | RSS: Main: 145571840 04:35:26 INFO - PROCESS | 5416 | 04:35:28 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:35:29 INFO - PROCESS | 5416 | RSS: Main: 145674240 04:35:29 INFO - PROCESS | 5416 | 04:35:31 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:35:32 INFO - PROCESS | 5416 | RSS: Main: 146145280 04:35:32 INFO - PROCESS | 5416 | 04:35:34 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:35:35 INFO - PROCESS | 5416 | RSS: Main: 145367040 04:35:35 INFO - PROCESS | 5416 | 04:35:36 INFO - PROCESS | 5416 | Cycle 1(1): loaded http://localhost:56792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56792/tests/kraken/driver.html?testName=ai-astar) 04:35:37 INFO - PROCESS | 5416 | RSS: Main: 145719296 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | __start_tp_report 04:35:37 INFO - PROCESS | 5416 | _x_x_mozilla_page_load 04:35:37 INFO - PROCESS | 5416 | _x_x_mozilla_page_load_details 04:35:37 INFO - PROCESS | 5416 | |i|pagename|runs| 04:35:37 INFO - PROCESS | 5416 | |0;ai-astar;110;105;110;110;110;122;109;108;108;109 04:35:37 INFO - PROCESS | 5416 | |1;audio-beat-detection;149;135;150;165;129;157;158;127;173;128 04:35:37 INFO - PROCESS | 5416 | |2;audio-dft;163;161;161;163;162;160;160;168;165;162 04:35:37 INFO - PROCESS | 5416 | |3;audio-fft;73;74;74;146;74;73;74;73;158;75 04:35:37 INFO - PROCESS | 5416 | |4;audio-oscillator;96;95;143;96;96;97;143;94;95;139 04:35:37 INFO - PROCESS | 5416 | |5;imaging-gaussian-blur;109;109;110;110;110;110;110;109;110;111 04:35:37 INFO - PROCESS | 5416 | |6;imaging-darkroom;148;146;147;147;147;147;147;146;147;146 04:35:37 INFO - PROCESS | 5416 | |7;imaging-desaturate;97;96;96;97;96;96;99;97;101;96 04:35:37 INFO - PROCESS | 5416 | |8;json-parse-financial;59;56;59;57;58;55;59;54;56;53 04:35:37 INFO - PROCESS | 5416 | |9;json-stringify-tinderbox;65;69;64;65;65;65;63;64;64;64 04:35:37 INFO - PROCESS | 5416 | |10;stanford-crypto-aes;82;80;82;82;83;82;83;84;82;83 04:35:37 INFO - PROCESS | 5416 | |11;stanford-crypto-ccm;121;125;114;119;117;114;126;113;109;115 04:35:37 INFO - PROCESS | 5416 | |12;stanford-crypto-pbkdf2;125;138;135;129;136;138;145;141;134;136 04:35:37 INFO - PROCESS | 5416 | |13;stanford-crypto-sha256-iterative;67;65;65;77;64;65;65;66;66;63 04:35:37 INFO - PROCESS | 5416 | __end_tp_report 04:35:37 INFO - PROCESS | 5416 | __start_cc_report 04:35:37 INFO - PROCESS | 5416 | _x_x_mozilla_cycle_collect,700 04:35:37 INFO - PROCESS | 5416 | __end_cc_report 04:35:37 INFO - PROCESS | 5416 | __startTimestamp1454416536998__endTimestamp 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | ------- Summary: start ------- 04:35:37 INFO - PROCESS | 5416 | Number of tests: 14 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:4.46 (4.1%) stddev-sans-first:4.73 04:35:37 INFO - PROCESS | 5416 | Values: 110.0 105.0 110.0 110.0 110.0 122.0 109.0 108.0 108.0 109.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:153.50 stddev:16.54 (10.8%) stddev-sans-first:17.53 04:35:37 INFO - PROCESS | 5416 | Values: 149.0 135.0 150.0 165.0 129.0 157.0 158.0 127.0 173.0 128.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.46 (1.5%) stddev-sans-first:2.60 04:35:37 INFO - PROCESS | 5416 | Values: 163.0 161.0 161.0 163.0 162.0 160.0 160.0 168.0 165.0 162.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#3] audio-fft Cycles:10 Average:89.40 Median:74.00 stddev:33.12 (44.8%) stddev-sans-first:34.59 04:35:37 INFO - PROCESS | 5416 | Values: 73.0 74.0 74.0 146.0 74.0 73.0 74.0 73.0 158.0 75.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:95.50 stddev:22.31 (23.4%) stddev-sans-first:23.13 04:35:37 INFO - PROCESS | 5416 | Values: 96.0 95.0 143.0 96.0 96.0 97.0 143.0 94.0 95.0 139.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 04:35:37 INFO - PROCESS | 5416 | Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 111.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 04:35:37 INFO - PROCESS | 5416 | Values: 148.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.50 stddev:1.66 (1.7%) stddev-sans-first:1.76 04:35:37 INFO - PROCESS | 5416 | Values: 97.0 96.0 96.0 97.0 96.0 96.0 99.0 97.0 101.0 96.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.50 stddev:2.17 (3.8%) stddev-sans-first:2.12 04:35:37 INFO - PROCESS | 5416 | Values: 59.0 56.0 59.0 57.0 58.0 55.0 59.0 54.0 56.0 53.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:1.62 (2.5%) stddev-sans-first:1.72 04:35:37 INFO - PROCESS | 5416 | Values: 65.0 69.0 64.0 65.0 65.0 65.0 63.0 64.0 64.0 64.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.06 (1.3%) stddev-sans-first:1.12 04:35:37 INFO - PROCESS | 5416 | Values: 82.0 80.0 82.0 82.0 83.0 82.0 83.0 84.0 82.0 83.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:118.00 stddev:5.44 (4.6%) stddev-sans-first:5.60 04:35:37 INFO - PROCESS | 5416 | Values: 121.0 125.0 114.0 119.0 117.0 114.0 126.0 113.0 109.0 115.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.70 Median:137.00 stddev:5.66 (4.1%) stddev-sans-first:4.48 04:35:37 INFO - PROCESS | 5416 | Values: 125.0 138.0 135.0 129.0 136.0 138.0 145.0 141.0 134.0 136.0 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - PROCESS | 5416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:65.50 stddev:3.92 (6.0%) stddev-sans-first:4.15 04:35:37 INFO - PROCESS | 5416 | Values: 67.0 65.0 65.0 77.0 64.0 65.0 65.0 66.0 66.0 63.0 04:35:37 INFO - PROCESS | 5416 | -------- Summary: end -------- 04:35:37 INFO - PROCESS | 5416 | 04:35:37 INFO - TEST-INFO | 5416: exit 0 04:35:37 INFO - TEST-OK | kraken | took 58685ms 04:35:37 INFO - TEST-START | v8_7 04:35:37 INFO - operating with platform_type : linux_ 04:35:37 INFO - Initialising browser for v8_7 test... 04:35:37 INFO - TEST-INFO | started process 5712 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_Lz5WZ/profile http://localhost:56792/getInfo.html) 04:35:41 INFO - PROCESS | 5712 | 04:35:41 INFO - PROCESS | 5712 | (process:5794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:35:42 INFO - PROCESS | 5712 | __metrics Screen width/height:1600/1200 04:35:42 INFO - PROCESS | 5712 | colorDepth:24 04:35:42 INFO - PROCESS | 5712 | Browser inner width/height: 1024/697 04:35:42 INFO - PROCESS | 5712 | __metrics 04:35:43 INFO - TEST-INFO | 5712: exit 0 04:35:43 INFO - Browser initialized. 04:35:43 INFO - Running cycle 1/1 for v8_7 test... 04:35:43 INFO - TEST-INFO | started process 5843 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_Lz5WZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:44 INFO - PROCESS | 5843 | 04:35:44 INFO - PROCESS | 5843 | (process:5910): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:35:54 INFO - PROCESS | 5843 | RSS: Main: 139501568 04:35:54 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | Cycle 1(1): loaded http://localhost:56792/tests/v8_7/run.html (next: http://localhost:56792/tests/v8_7/run.html) 04:36:17 INFO - PROCESS | 5843 | RSS: Main: 143691776 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | __start_tp_report 04:36:17 INFO - PROCESS | 5843 | _x_x_mozilla_page_load 04:36:17 INFO - PROCESS | 5843 | _x_x_mozilla_page_load_details 04:36:17 INFO - PROCESS | 5843 | |i|pagename|runs| 04:36:17 INFO - PROCESS | 5843 | |0;Richards;165.50810989738497 04:36:17 INFO - PROCESS | 5843 | |1;DeltaBlue;170.35775127768312 04:36:17 INFO - PROCESS | 5843 | |2;Encrypt;279.72027972027973 04:36:17 INFO - PROCESS | 5843 | |3;Decrypt;5246.073298429319 04:36:17 INFO - PROCESS | 5843 | |4;RayTrace;933.7068160597572 04:36:17 INFO - PROCESS | 5843 | |5;Earley;563.6978579481398 04:36:17 INFO - PROCESS | 5843 | |6;Boyer;11032.967032967033 04:36:17 INFO - PROCESS | 5843 | |7;RegExp;39153.846153846156 04:36:17 INFO - PROCESS | 5843 | |8;Splay;518.4033177812338 04:36:17 INFO - PROCESS | 5843 | |9;NavierStokes;4817.307692307692 04:36:17 INFO - PROCESS | 5843 | __end_tp_report 04:36:17 INFO - PROCESS | 5843 | __startTimestamp1454416577594__endTimestamp 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | ------- Summary: start ------- 04:36:17 INFO - PROCESS | 5843 | Number of tests: 10 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#0] Richards Cycles:1 Average:165.51 Median:165.51 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 165.5 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#1] DeltaBlue Cycles:1 Average:170.36 Median:170.36 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 170.4 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 279.7 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 5246.1 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#4] RayTrace Cycles:1 Average:933.71 Median:933.71 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 933.7 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#5] Earley Cycles:1 Average:563.70 Median:563.70 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 563.7 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#6] Boyer Cycles:1 Average:11032.97 Median:11032.97 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 11033.0 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#7] RegExp Cycles:1 Average:39153.85 Median:39153.85 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 39153.8 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#8] Splay Cycles:1 Average:518.40 Median:518.40 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 518.4 04:36:17 INFO - PROCESS | 5843 | 04:36:17 INFO - PROCESS | 5843 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 04:36:17 INFO - PROCESS | 5843 | Values: 4817.3 04:36:17 INFO - PROCESS | 5843 | -------- Summary: end -------- 04:36:17 INFO - PROCESS | 5843 | 04:36:18 INFO - TEST-INFO | 5843: exit 0 04:36:18 INFO - TEST-OK | v8_7 | took 40488ms 04:36:18 INFO - SUITE-END | took 1208s 04:36:18 INFO - Completed test suite (00:20:08) 04:36:18 INFO - Working with test: dromaeo_css 04:36:18 INFO - Generating results file: dromaeo_css 04:36:18 INFO - Working with test: kraken 04:36:18 INFO - Generating results file: kraken 04:36:18 INFO - javascript benchmark 04:36:18 INFO - Working with test: v8_7 04:36:18 INFO - Generating results file: v8_7 04:36:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:36:18 INFO - process_Request line: dromaeo_css 7377.40 graph.html#tests=[[72,52,43]] 04:36:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:18 INFO - process_Request line: kraken 1495.20 graph.html#tests=[[232,52,43]] 04:36:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:18 INFO - process_Request line: v8_7 22025.52 graph.html#tests=[[230,52,43]] 04:36:18 INFO - RETURN: dromaeo_css: 7377.40 04:36:18 INFO - RETURN: kraken: 1495.20 04:36:18 INFO - RETURN: v8_7: 22025.52 04:36:18 INFO - javascript benchmark 04:36:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3342.699157075864, 3355.731541476682, 3374.190194353353, 3374.6456622054684, 3386.8137252451115, 5450.945490545093, 5460.863478413036, 5469.15228139638, 5488.945110548893, 5524.66851988881, 5451.236826844245, 5483.972580137094, 5497.697626630534, 5513.476219759116, 5558.082916318813, 4933.038057578765, 5008.924866127011, 5104.5405913467785, 5121.129408000649, 5155.226715992593, 4967.10592093423, 5160.329157209576, 5167.431582525938, 5171.767270472819, 5182.6631268967585, 5059.949400506003, 5062.367204099488, 5112.079825631385, 5162.328897243353, 5186.844394668166, 5107.38711354638, 5107.565856902168, 5111.4121875984365, 5126.410462796789, 5153.149730294497, 4946.455889852114, 5028.120078986163, 5037.974810125963, 5081.695098294077, 5114.411842638107, 5339.065663508871, 5393.1370980643305, 5421.512063914267, 5423.891522169534, 5446.700431476267, 5876.177335173036, 5911.054231323011, 5919.408059194089, 5919.733611987471, 5943.881122377571, 5828.9417105828825, 5939.109133629947, 5944.375840536724, 5948.2862056553495, 5968.1644569760265, 5599.272094627713, 5655.575831812631, 5656.038473459522, 5659.886802263932, 5687.516561092312, 6038.516918646497, 6073.1497590337385, 6075.605085669506, 6077.179580756541, 6089.725962331617, 5726.398728133569, 5903.645781253139, 5904.527637788967, 5911.0, 5924.555658325643, 6040.969795151084, 6054.939450605526, 6055.515558755289, 6057.727402266909, 6080.75676972925, 5980.312264089598, 6012.488938440194, 6018.037114061729, 6027.095935609694, 6034.366391528914, 5907.172995780594, 5995.850103747442, 6009.278886533557, 6009.879802404015, 6073.848153796191, 4579.771011449481, 4595.425571803525, 4604.079184163181, 4612.215923292981, 4629.051044535862, 4099.569545197771, 4141.875743727693, 4143.81352839123, 4158.168366326747, 4166.604172603597, 5628.577856660767, 5663.1505274208375, 5705.71471426427, 5726.627769194989, 5821.708914554255, 5934.465898069195, 5991.7902873399225, 6016.2479690038745, 6019.759209631653, 6041.879162416815, 5583.0787919992745, 5686.516646085046, 5705.4579814917515, 5711.371749107595, 5712.428757124254, 5029.06962211992, 5089.898202035939, 5146.0, 5149.562287205629, 5212.192110222922, 6155.045967874987, 6178.073289006595, 6199.473044791153, 6206.534509911775, 6221.595596286227, 5843.707814609337, 5955.583109182316, 6011.248593925759, 6015.097735339559, 6038.305594856472, 6161.199044124235, 6274.717637706223, 6280.246370435577, 6320.5891617044745, 6322.462590679844, 5963.73163207648, 5984.850378740566, 6021.638701677914, 6051.727672254847, 6073.817785466443, 5963.671998040149, 6002.939970600238, 6059.848503787264, 6096.0855871619615, 6112.786052488142, 5806.2451881255165, 5814.30228372598, 5836.328822185503, 5901.940980590139, 5906.379830117948, 5811.593188476766, 5813.709314534341, 5862.12068189775, 5893.499052580579, 5908.084246941731, 5748.712564371848, 5754.712264386848, 5782.074868021096, 5817.767289308549, 5901.232839730807, 5864.296284445893, 5911.438413350725, 5934.525237980864, 5984.251968503937, 5987.790427335022, 5693.800716974886, 5773.942260577509, 5792.218050563289, 5816.360200377871, 5828.562857785768], "unit": "score", "name": "dojo.html", "value": 5527.396252854786}, {"lowerIsBetter": false, "replicates": [516.1432022842083, 557.5010365722678, 567.3305499510576, 577.1285359107746, 584.771938943812, 30650.23374415638, 38034.80982595087, 38398.0, 38449.23101537968, 38653.806730966375, 41686.79156604213, 42296.577034229646, 43001.35497967533, 43001.78499107508, 43069.0, 8741.431806932545, 8953.149450802164, 9006.954965225164, 9060.275177985744, 9075.092490750905, 8803.383763136582, 8868.8669669955, 8880.822383552326, 8914.687985920495, 9071.228945539637, 9093.590788414504, 9116.225120864734, 9121.908780912172, 9124.771880703001, 9146.725598232064, 9039.954800225989, 9077.183053525214, 9129.543522823898, 9133.908660913372, 9142.908570914306, 8888.466691998436, 9085.04607016267, 9097.590608422637, 9105.863412048824, 9153.22197613197, 42327.57672423298, 42665.0, 42745.1450970982, 42767.78616106931, 42798.786006070084, 3645.908852278688, 3751.212245428463, 3802.7727930247656, 3806.581276059659, 4155.958440415588, 30429.69570304313, 30742.538861917088, 30783.846080769454, 30788.384232315228, 31553.21116972071, 4189.245935731567, 4208.915821683579, 4256.191323648497, 4264.125854199912, 4329.610335069828, 285864.0, 287151.56424217956, 288553.0, 289234.0, 290141.0, 45449.31826022612, 45836.3124553132, 45886.31170532378, 45906.0, 45945.54054459413, 43742.56257437448, 43985.34021989673, 44025.339619905724, 44051.0, 44076.77961610172, 15205.467808626645, 15274.083554986737, 15306.158161301235, 15318.157501337533, 15360.23198840076, 12046.518139274505, 12054.156209065457, 12140.514379424723, 12162.391880405945, 12412.0, 15344.386224550894, 15491.147986860606, 15584.532464026097, 15738.213089345487, 15757.68484630301, 6164.291106522807, 6227.564070515021, 6233.844153896098, 6266.905996410058, 6339.207599050119, 1040.8542804007445, 1065.733566608348, 1150.7065698246893, 1156.5720683347215, 1161.5237752521425, 30835.691643083283, 30954.0, 31056.22359441032, 31304.0, 31641.208969775478, 1095.0746619106842, 1149.7240662241002, 1198.6344165029575, 1201.2072032458536, 1245.2155142260317, 15050.247487625575, 15383.61540961485, 17571.121443927754, 17668.0, 17812.732809007874, 504631.0, 534997.0, 535841.0, 538987.0, 541744.0, 57482.7125864368, 57847.0, 57923.0, 57993.42006579965, 58091.70954145287, 1471.7865909443071, 1479.2086233865045, 1483.8887083468783, 1500.6923580665937, 1524.3140586736013, 32511.349773003934, 32881.835590821895, 33015.33969320648, 33141.502877456376, 33945.66054339425, 48871.5112848867, 49320.75339623279, 49351.753241233564, 49360.0, 49426.75286623544, 306703.0, 315475.0, 317371.0, 318915.0, 319103.0, 44257.0, 45264.32103518384, 45818.541814581426, 46004.30993535033, 46420.0, 48033.5196648029, 48084.519154808004, 49066.75466622644, 49128.2630760546, 49380.50619493903, 41429.171416572106, 42629.36055959101, 43326.78336608297, 43489.0, 44526.55473445224, 36389.45415818818, 36749.08127296732, 41728.3740743883, 45643.77178114088, 46886.76556617195, 40394.0, 42468.57531424646, 42810.14379712326, 43009.56990430056, 43724.781376094186, 35801.28397432089, 38795.0, 39579.406308905964, 39921.60078399295, 41087.589124108374, 27051.1884643461, 27357.316067098483, 27367.178984630493, 27432.451350973268, 27593.724062759116], "unit": "score", "name": "ext.html", "value": 19624.990757387306}, {"lowerIsBetter": false, "replicates": [397.1283033740936, 400.07382908566666, 406.48985523168426, 406.5690368209697, 407.40925657796186, 17181.656366872656, 17586.384476543306, 17843.821561784396, 17874.55313617157, 18647.533811654714, 13294.601161965156, 17091.0, 17120.657586848287, 17655.73516397255, 17869.553261168476, 5143.305653736745, 5334.093204155283, 5362.91955620666, 5376.4085950545405, 5377.435369286227, 5112.539871411572, 5249.606279529032, 5357.303550538424, 5361.758720857551, 5363.061464243761, 5330.600204984622, 5354.9196762048605, 6212.9068063979075, 6470.0, 6514.57655252407, 6423.614583125004, 6426.1003459515705, 6560.0, 6885.208201056842, 6892.862142757167, 6329.177206963065, 6522.673866306665, 6569.113169722122, 6599.47204223661, 6619.106420633201, 21936.232231871807, 21958.0, 22198.223062192745, 22294.88852555743, 22757.658635120486, 2388.450656349032, 2425.260295609838, 2454.987725061363, 2457.9016839326405, 2542.453372524916, 13900.374483148282, 14290.285485725672, 14407.927960360235, 14862.777058344134, 14878.0, 2006.378022812918, 2038.0930485933766, 2055.722477465538, 2064.9277275295294, 2106.24175296893, 53437.0, 53850.0, 53939.46060539383, 53940.73029634866, 55377.16934245989, 14876.776848347283, 15575.61060973462, 15577.14325712074, 15630.06219626826, 15654.530364089096, 24082.63876041861, 24124.155654552007, 24275.0, 24339.513209735705, 24372.634410483857, 7684.654190561439, 7774.6890124394395, 7808.68765249395, 7902.130765615778, 9459.716208513755, 7444.255574442513, 7470.5144165630145, 7494.925050749532, 7519.812004699927, 7525.698972041167, 4710.646701497401, 4762.666613337033, 4807.687500312469, 4814.470408255089, 4874.195757699939, 1919.6640587897061, 1924.1052910396734, 1980.5241800639785, 2000.2699014859472, 2004.0981558298824, 986.487026746088, 995.4276291132628, 998.7752755629925, 1022.325265324882, 1083.7453198498347, 16893.493195204162, 17316.0, 17317.0, 17925.103744812706, 17958.19188136537, 1009.4448053570507, 1019.0, 1027.6814187601867, 1045.451138152476, 1054.056619325699, 10159.796804063877, 10340.741481463023, 10378.948105259426, 10388.272820902464, 10463.476826158661, 394101.0, 398330.0, 400377.0, 589964.0, 590993.0, 70942.0, 72990.0, 75089.62455187799, 75210.62394687992, 77362.22637773663, 1031.0359813574332, 1033.4729288062993, 1170.7599942011866, 1202.725111381938, 1208.1784386617185, 15934.203289835694, 15944.202789860692, 16029.35882564731, 16050.678986419973, 16271.837281627033, 32872.0, 33893.152671183416, 35015.82492087523, 35227.29545409129, 35440.64559354477, 44756.55243447524, 45731.0, 46044.0, 46205.306920395546, 46566.0, 7621.961890190513, 7922.049354077317, 7992.240737129963, 8000.879986800086, 8027.357811374959, 8317.209865062809, 8573.22840944318, 11119.332840029625, 11460.656180314603, 11705.535430949356, 7885.1720569339395, 7913.327367173854, 7939.404544659289, 8001.399895007781, 8036.517808931483, 7787.260210280015, 7951.840963180588, 8098.87851682237, 8106.148854370442, 8106.635201415833, 8388.370872184489, 8417.87373189415, 8425.789355266168, 8503.617337219963, 8507.106753790762, 10763.0, 11105.05607023412, 11175.608853690082, 11195.552177912792, 11346.149038822286, 11388.470280459333, 11421.200515963803, 11454.427278636202, 11517.366544840113, 11593.536258549564], "unit": "score", "name": "jquery.html", "value": 8938.637835384437}, {"lowerIsBetter": false, "replicates": [1524.0246242404862, 1525.6185953511626, 1702.6764914666212, 1810.782706075271, 1813.619139980604, 7526.059242594662, 7539.0576177977755, 8427.367947403945, 8606.139386061399, 8626.827463450734, 8069.233422824822, 8289.0, 8321.209485098922, 8341.040780310252, 8414.621342039607, 2367.751386104456, 2409.4578719788083, 2418.5767490689145, 2420.4674971506242, 2424.442378253003, 2453.0800949643885, 2456.520978409211, 2493.2520243926842, 2501.3246423465653, 2503.5368456835454, 2472.6414669872947, 2479.219046000513, 2511.4977004599064, 2539.8222124451295, 2548.24826676131, 2463.039414628305, 2490.8007359411295, 2501.3496490912494, 2503.0238207099246, 2508.0344067533947, 2449.9877500612383, 2450.791682706972, 2454.7913427358694, 2472.678551788256, 2537.3276081838326, 8729.170728780819, 8775.956120219358, 8777.034526202113, 8817.911820881838, 8825.602847871862, 5208.374995000624, 5290.947090529084, 5331.2003199519995, 5337.412884582693, 5337.492938170868, 3400.795952242873, 3412.181076541612, 3455.188030812757, 3463.79217246966, 3483.2511010132944, 1042.374575254841, 1057.3550134417999, 1074.312440038376, 1081.7181639756834, 1092.071739021833, 12133.696657583543, 12300.138990270685, 12309.384530773426, 12335.75328493434, 12337.198082124723, 4816.807327706852, 4828.0, 4830.8164499697095, 4877.073356062408, 4896.314515967767, 10169.54237059334, 10244.846327305097, 10293.43386113771, 10295.43375114361, 10366.118879895294, 5323.3079699639575, 5327.946720532745, 5364.490373414519, 5368.4631536846, 5384.19237114436, 4612.930806037912, 4763.666543342002, 4796.784144713496, 4859.222524396079, 4875.049365373789, 3942.0342016206214, 3942.1327307992196, 3968.3650615901315, 3972.8875914743917, 4002.4996875390575, 1217.993910030444, 1221.2977537915733, 1222.0284873525568, 1233.1614502138632, 1240.2558464921156, 1408.2325132802648, 1431.5991522373545, 1432.7850822376517, 1456.8980171388114, 1495.5139579636661, 8095.635696393559, 8260.958695206486, 8284.420090593601, 8304.70933517336, 8306.044804847399, 506.5137468030658, 507.4925074925075, 507.81718581310696, 511.92577076323727, 522.3992408729991, 6101.115338275925, 6170.969145154246, 6235.501159907197, 6264.248290205204, 6278.121063051177, 10230.795384092276, 10631.096356809603, 10679.83980240297, 10773.192010599236, 10886.129109671365, 10482.73793155162, 10588.894111058946, 10590.364578125336, 10679.0, 10723.46382680863, 7843.9215607844335, 7890.723824666109, 7933.52398856059, 7952.32405245549, 7987.56068416231, 7891.881621775563, 7961.522308661499, 7991.880121798062, 8026.43814932949, 8049.758507244792, 9355.345125841126, 9368.95315523418, 9383.436993780122, 9403.106704863027, 9525.333226674065, 9587.0, 9611.134997850228, 9735.123838854537, 9783.510824458606, 10034.69895903124, 6555.082288479522, 6692.297308782508, 6911.067005954333, 7231.891521627074, 7360.521566098187, 8030.759077227459, 8095.352371810359, 8106.959465202636, 8123.75628731139, 8139.959300203461, 7507.436942229246, 7648.770536883902, 7700.4224683150105, 7763.92236077632, 7764.572948487661, 7275.308845659654, 7280.672369743268, 7285.7814265572115, 7414.184439711519, 7420.443466739908, 7326.523775954546, 7563.773086807405, 7576.356009739234, 7604.201558836464, 7608.97278867368, 7025.613591252326, 7048.471364647569, 7133.536320139175, 7160.57036577807, 7235.2041275458605, 7252.818679533054, 7275.017872587345, 7281.927180728125, 7285.854282914418, 7311.341979221896], "unit": "score", "name": "mootools.html", "value": 4830.789228900361}, {"lowerIsBetter": false, "replicates": [359.9856005759769, 372.5957336290126, 375.18023119483945, 377.582771038003, 380.3515006913212, 6345.4923606111515, 6359.236891573012, 6403.74385024599, 6450.064740612608, 6544.574602650824, 6351.809445716624, 6356.459700925416, 6374.394432528902, 6389.840253993652, 6409.0, 4842.757862106898, 4868.683535570177, 4886.975565122169, 4897.167481528131, 4900.0, 4862.051899879507, 4862.97568512157, 4864.246041863516, 4917.950820491803, 4920.926186107194, 4449.243628583133, 4684.718916864999, 4691.10868934903, 4801.135795556798, 4805.279208118793, 4781.163296423112, 4783.808647654089, 4794.849236183309, 4798.592119669815, 4821.5178482151505, 4181.832726690929, 4195.769232692201, 4199.580041995807, 4199.68502362324, 4227.661787057028, 5944.554158438134, 5952.107183922403, 5990.161377407167, 6014.78948236814, 6020.789272375489, 5539.086050801613, 5595.0, 5651.886962260732, 5654.9151762723595, 5661.5187709044785, 6637.701303441357, 6648.102506161655, 6664.700088496029, 6667.733290668368, 6672.432843208333, 4705.882352941204, 4706.95293047072, 4708.387909571768, 4718.079974404993, 4720.716756994591, 6908.447324214051, 6979.82550436238, 7025.297470252934, 7042.6830792614455, 7072.0, 4692.272697731857, 4701.059788042337, 4702.059588082398, 4710.24636058229, 4710.552497512731, 4756.239001759702, 4758.429718192988, 4767.809287628525, 4772.0694464579765, 4774.164521208774, 5509.283793106871, 5530.5022547970875, 5551.000819852466, 5567.192757050205, 5578.665280083208, 6592.340765923465, 6724.327567243335, 6756.391924726799, 6765.188177418741, 6773.966130169318, 1718.2783231042742, 1745.589786400195, 1749.4926471323429, 1751.8948863068256, 1755.3943889358152, 1171.3147808532103, 1182.5920057580122, 1182.5979167083233, 1199.1905463811893, 1200.009991756804, 6518.348165183538, 6533.216014078341, 6572.80281591553, 6582.539222254396, 6595.109660195908, 6921.965390173017, 6945.652717364112, 7010.193827709879, 7010.719571217196, 7032.367086962198, 6412.903806442907, 6587.374199451045, 6592.538522303393, 6599.868002639921, 6621.172353455818, 3747.2505498900327, 3772.3775577029483, 3791.734578579473, 3792.58281589025, 3809.542854857435, 7269.563826170341, 7284.235155308722, 7302.160251571031, 7338.082739657543, 7351.154617218981, 7113.53762005468, 7237.529560578546, 7242.13094428672, 7271.3455788979245, 7281.854362912818, 7250.057492525938, 7281.05346304977, 7291.416686665054, 7294.817629559304, 7338.633068346669, 7017.122859642544, 7026.508144429841, 7032.085828842218, 7057.470689698191, 7072.611006394698, 6764.93235067643, 6976.895346569704, 7014.158301003912, 7024.859502810017, 7031.472639551952, 7327.194008658937, 7346.52247603904, 7368.263173682589, 7391.0761154855645, 7407.740729074457, 4937.530934561211, 4951.72765497901, 4979.576735977483, 4992.350994370709, 5003.624728145331, 6911.861762764616, 6975.337342952412, 6976.267491913276, 6982.092327997328, 6995.825104372431, 6765.052892595139, 6784.423324017514, 6809.591424514545, 6825.249222585412, 6847.931520684929, 6687.63218022994, 6779.694913728993, 6850.314968503109, 6858.519903606899, 6880.552764070319, 6699.0, 6707.262201157771, 6711.026901099216, 6722.798316050526, 6727.428168605723, 6781.42357899584, 6835.624040677811, 6852.897206541807, 6856.142982127234, 6861.828454288683, 6563.442107420923, 6589.341065893373, 6660.267370589135, 6691.397774200345, 6785.626790526569], "unit": "score", "name": "prototype.html", "value": 5120.4402265457}, {"lowerIsBetter": false, "replicates": [744.13680131048, 864.4942708515522, 954.0657112758643, 955.7849483866131, 957.760559860035, 13191.736165276689, 13270.668233294173, 13332.333383330819, 13404.932975335121, 14795.0, 15452.459163929265, 15543.14512701801, 15545.06729596225, 15548.0, 15565.37738490462, 868.5179725252482, 894.1639567004838, 904.5115637555712, 907.5552979040289, 916.5875356089753, 905.1536813079758, 907.2605826251616, 908.2733812949647, 908.3913777768911, 908.7818923458389, 935.4761333653142, 936.0405584276103, 937.142514599141, 937.2876613773548, 940.5344354544476, 918.0406475233331, 919.9218066464392, 924.8890133183994, 928.9535523223846, 929.2798081486868, 685.5235611250183, 685.694865784726, 687.8314812870829, 689.3244620272161, 689.9931000689979, 14872.776908346383, 14952.252387380588, 15002.474913378088, 15094.924525377302, 15109.39562417502, 13337.599872003855, 13339.53311634098, 13865.168089914638, 13990.950678699139, 14020.649483762885, 10091.899081009244, 10439.843402348972, 10882.0, 11298.096152307879, 11466.713332166679, 3633.255182687543, 3641.8361173747244, 3672.081979505124, 3678.5769636491877, 3729.7948612826285, 52246.47753522454, 52473.0, 52486.21270680943, 52689.47310526884, 52874.20688689711, 10745.677629671123, 11076.280041797258, 11130.666080017612, 11137.77484476707, 11302.0, 19093.522661933563, 19404.417867464, 19919.800801992085, 19924.50188745293, 19971.0, 8229.177082291722, 8276.586170691442, 8302.584870756558, 8334.416590838704, 8388.790280243044, 4565.703229290086, 4577.336286238543, 4590.013147173307, 4614.192516309632, 4729.314249433813, 3233.1270556949494, 3251.2034551534553, 3258.625258095302, 3266.1508007918114, 3284.967150328514, 669.8794217040979, 672.7040102354948, 674.6694119881223, 689.5070024932097, 690.1511141296234, 595.4045954045954, 628.6825153297556, 641.4515589171191, 643.2409756487297, 643.9130717353191, 7555.395568354518, 7609.239076092346, 7640.770776876702, 7957.164497727771, 7963.362930965509, 524.4336116993637, 532.7975369359618, 554.7697705452273, 578.8871170121786, 661.5699795133106, 4092.6930480214105, 4122.91754164915, 4232.9629240835575, 4308.80610372534, 4345.152695224401, 60751.392486074576, 61750.0737488938, 61964.0, 63210.0, 63214.36785632177, 52401.0, 53317.0, 53809.0, 53937.730311348976, 55726.44273557213, 47635.5236447638, 47931.0, 48019.0, 48668.7566562172, 50566.24150637743, 8352.540610266493, 8688.435251708619, 8702.912970870464, 8820.470771753715, 8959.148880856308, 36714.8164259177, 40728.79635601803, 41095.1780964385, 41409.79295103505, 41486.17027659369, 51962.740186298826, 52004.47995519996, 52031.0, 52230.21654675107, 53756.731216343665, 11904.285742855456, 11947.342896140795, 12190.329531875832, 12241.20432171906, 12291.877081229073, 12306.200096993667, 12400.0, 12751.936240318739, 13015.095471358743, 13044.347782611021, 11918.404079795802, 12045.51817927273, 12209.145359824726, 12244.265344079384, 12337.50649973991, 11743.823842642538, 11857.16999810005, 11865.0, 11889.702757431134, 12002.879971200176, 11060.446977651247, 11072.723181920517, 11622.128340374336, 11859.229150105215, 12098.939505302416, 8984.640614375352, 9304.627814887599, 9373.81252374935, 9473.857892131762, 9739.9026009739, 9537.952310238405, 9604.807903841744, 9956.601735930482, 10133.341332813343, 10171.186305095427], "unit": "score", "name": "yui.html", "value": 6721.365492799021}], "name": "dromaeo_css", "value": 7377.399195716992}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 110.0, 110.0, 110.0, 122.0, 109.0, 108.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 135.0, 150.0, 165.0, 129.0, 157.0, 158.0, 127.0, 173.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 163.0, 162.0, 160.0, 160.0, 168.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 146.0, 74.0, 73.0, 74.0, 73.0, 158.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 143.0, 96.0, 96.0, 97.0, 143.0, 94.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 99.0, 97.0, 101.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 59.0, 57.0, 58.0, 55.0, 59.0, 54.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 64.0, 65.0, 65.0, 65.0, 63.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 82.0, 83.0, 82.0, 83.0, 84.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [121.0, 125.0, 114.0, 119.0, 117.0, 114.0, 126.0, 113.0, 109.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [125.0, 138.0, 135.0, 129.0, 136.0, 138.0, 145.0, 141.0, 134.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.7}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 65.0, 77.0, 64.0, 65.0, 65.0, 66.0, 66.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1495.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.50810989738497], "unit": "score", "name": "Richards", "value": 213.294684}, {"lowerIsBetter": false, "replicates": [170.35775127768312], "unit": "score", "name": "DeltaBlue", "value": 388.1126600000002}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [933.7068160597572], "unit": "score", "name": "RayTrace", "value": 792.5282190000003}, {"lowerIsBetter": false, "replicates": [563.6978579481398], "unit": "score", "name": "Earley", "value": 1182.3053619999998}, {"lowerIsBetter": false, "replicates": [11032.967032967033], "unit": "score", "name": "Boyer", "value": 60.40650697211158}, {"lowerIsBetter": false, "replicates": [39153.846153846156], "unit": "score", "name": "RegExp", "value": 23.266807465618847}, {"lowerIsBetter": false, "replicates": [518.4033177812338], "unit": "score", "name": "Splay", "value": 157.19613900000004}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 22025.515395639955}]} 04:36:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22025.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7377.40"}}} 04:36:18 INFO - Return code: 0 04:36:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:36:18 INFO - # TBPL SUCCESS # 04:36:18 INFO - Running post-action listener: _resource_record_post_action 04:36:18 INFO - Running post-run listener: _resource_record_post_run 04:36:20 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 684032; Write bytes: 261947392; Read time: 344; Write time: 116164 04:36:20 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5226496; Read time: 0; Write time: 332 04:36:20 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 684032; Write bytes: 256720896; Read time: 344; Write time: 115832 04:36:20 INFO - Running post-run listener: _upload_blobber_files 04:36:20 INFO - Blob upload gear active. 04:36:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:36:20 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 04:36:20 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'] 04:36:20 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 04:36:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:21 INFO - (blobuploader) - INFO - Done attempting. 04:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:22 INFO - (blobuploader) - INFO - Done attempting. 04:36:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:36:22 INFO - Return code: 0 04:36:22 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:36:22 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:36:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dac061e47672ee92774a91c929c9508c420d41fc38f3f55d36eb387090e2069ec66e71edcdd6d86ead27da0543facf28a149b3a7f15cbf345db537ce82afbf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabef1148f9d284d9fbe546ed60f3b846a2ce3788f12db60381f2b4fbdc11768cb6c91312f014060736ad15f8e0f96a39096153186d22585f2b5feb0e8caa0c5"} 04:36:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:36:22 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:36:22 INFO - Contents: 04:36:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dac061e47672ee92774a91c929c9508c420d41fc38f3f55d36eb387090e2069ec66e71edcdd6d86ead27da0543facf28a149b3a7f15cbf345db537ce82afbf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabef1148f9d284d9fbe546ed60f3b846a2ce3788f12db60381f2b4fbdc11768cb6c91312f014060736ad15f8e0f96a39096153186d22585f2b5feb0e8caa0c5"} 04:36:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:36:22 INFO - Copying logs to upload dir... 04:36:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:36:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.181922 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-02 04:36:22.028931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 04:36:22.032281) ========= 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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 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/2dac061e47672ee92774a91c929c9508c420d41fc38f3f55d36eb387090e2069ec66e71edcdd6d86ead27da0543facf28a149b3a7f15cbf345db537ce82afbf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabef1148f9d284d9fbe546ed60f3b846a2ce3788f12db60381f2b4fbdc11768cb6c91312f014060736ad15f8e0f96a39096153186d22585f2b5feb0e8caa0c5"} build_url:https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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/2dac061e47672ee92774a91c929c9508c420d41fc38f3f55d36eb387090e2069ec66e71edcdd6d86ead27da0543facf28a149b3a7f15cbf345db537ce82afbf1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabef1148f9d284d9fbe546ed60f3b846a2ce3788f12db60381f2b4fbdc11768cb6c91312f014060736ad15f8e0f96a39096153186d22585f2b5feb0e8caa0c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 04:36:22.056694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:36:22.057025) ========= 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=6dbc10da6d83fee962c624be000001a8-1454415317.628604-1243745239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 04:36:22.139521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 04:36:22.139836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 04:36:22.140120) ========= ========= Total master_lag: 0.22 =========