builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1454592522.47 results: success (0) buildid: 20160204025425 builduid: 2e6f53f10ed24606a52b73e173877ac7 revision: 8625dd776a9fe0753c5a9358c067f2fc2a98643b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.474171) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.474707) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.475078) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004420 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.493892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.494240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.507494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.507847) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.569169) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.569478) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.569844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.570173) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-04 05:28:43-- 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% 17.9M=0.001s 2016-02-04 05:28:43 (17.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.709540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.709868) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.760352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:42.760742) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8625dd776a9fe0753c5a9358c067f2fc2a98643b --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 8625dd776a9fe0753c5a9358c067f2fc2a98643b --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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-04 05:28:43,229 truncating revision to first 12 chars 2016-02-04 05:28:43,229 Setting DEBUG logging. 2016-02-04 05:28:43,230 attempt 1/10 2016-02-04 05:28:43,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8625dd776a9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 05:28:43,483 unpacking tar archive at: mozilla-aurora-8625dd776a9f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:43.338011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:43.338438) ========= echo 8625dd776a9fe0753c5a9358c067f2fc2a98643b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8625dd776a9fe0753c5a9358c067f2fc2a98643b'] 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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8625dd776a9fe0753c5a9358c067f2fc2a98643b program finished with exit code 0 elapsedTime=0.004258 script_repo_revision: '8625dd776a9fe0753c5a9358c067f2fc2a98643b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:43.389748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:43.390108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 05:28:43.402570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-04 05:28:43.402990) ========= /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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:28:43 INFO - MultiFileLogger online at 20160204 05:28:43 in /builds/slave/test-pgo 05:28:43 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 05:28:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:28:43 INFO - {'append_to_log': False, 05:28:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:28:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:28:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:28:43 INFO - 'branch': 'Mozilla-Aurora', 05:28:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:28:43 INFO - 'config_files': ('talos/linux_config.py',), 05:28:43 INFO - 'default_actions': ('clobber', 05:28:43 INFO - 'read-buildbot-config', 05:28:43 INFO - 'download-and-extract', 05:28:43 INFO - 'populate-webroot', 05:28:43 INFO - 'create-virtualenv', 05:28:43 INFO - 'install', 05:28:43 INFO - 'run-tests'), 05:28:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:28:43 INFO - 'download_minidump_stackwalk': True, 05:28:43 INFO - 'download_symbols': 'ondemand', 05:28:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:28:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:28:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:28:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:28:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:28:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:28:43 INFO - 'installer_path': 'installer.exe', 05:28:43 INFO - 'log_level': 'info', 05:28:43 INFO - 'log_name': 'talos', 05:28:43 INFO - 'log_to_console': True, 05:28:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:28:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:28:43 INFO - 'opt_config_files': (), 05:28:43 INFO - 'pip_index': False, 05:28:43 INFO - 'sps_profile': False, 05:28:43 INFO - 'sps_profile_interval': 0, 05:28:43 INFO - 'suite': 'dromaeojs-e10s', 05:28:43 INFO - 'system_bits': '32', 05:28:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:28:43 INFO - 'title': 'talos-linux64-ix-049', 05:28:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:28:43 INFO - 'use_talos_json': True, 05:28:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:28:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:28:43 INFO - 'work_dir': 'build'} 05:28:43 INFO - ##### 05:28:43 INFO - ##### Running clobber step. 05:28:43 INFO - ##### 05:28:43 INFO - Running pre-action listener: _resource_record_pre_action 05:28:43 INFO - Running main action method: clobber 05:28:43 INFO - rmtree: /builds/slave/test-pgo/build 05:28:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:28:44 INFO - Running post-action listener: _resource_record_post_action 05:28:44 INFO - ##### 05:28:44 INFO - ##### Running read-buildbot-config step. 05:28:44 INFO - ##### 05:28:44 INFO - Running pre-action listener: _resource_record_pre_action 05:28:44 INFO - Running main action method: read_buildbot_config 05:28:44 INFO - Using buildbot properties: 05:28:44 INFO - { 05:28:44 INFO - "project": "", 05:28:44 INFO - "product": "firefox", 05:28:44 INFO - "script_repo_revision": "production", 05:28:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:28:44 INFO - "repository": "", 05:28:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:28:44 INFO - "buildid": "20160204025425", 05:28:44 INFO - "pgo_build": "True", 05:28:44 INFO - "basedir": "/builds/slave/test-pgo", 05:28:44 INFO - "buildnumber": 126, 05:28:44 INFO - "slavename": "talos-linux64-ix-049", 05:28:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:28:44 INFO - "platform": "ubuntu64_hw", 05:28:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:28:44 INFO - "branch": "mozilla-aurora", 05:28:44 INFO - "repo_path": "releases/mozilla-aurora", 05:28:44 INFO - "revision": "8625dd776a9fe0753c5a9358c067f2fc2a98643b", 05:28:44 INFO - "stage_platform": "linux64-pgo", 05:28:44 INFO - "builduid": "2e6f53f10ed24606a52b73e173877ac7", 05:28:44 INFO - "slavebuilddir": "test" 05:28:44 INFO - } 05:28:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 05:28:44 INFO - Running post-action listener: _resource_record_post_action 05:28:44 INFO - ##### 05:28:44 INFO - ##### Running download-and-extract step. 05:28:44 INFO - ##### 05:28:44 INFO - Running pre-action listener: _resource_record_pre_action 05:28:44 INFO - Running main action method: download_and_extract 05:28:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:44 INFO - https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:28:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/test_packages.json 05:28:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/test_packages.json 05:28:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:28:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:28:47 INFO - Downloaded 1448 bytes. 05:28:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:28:47 INFO - Using the following test package requirements: 05:28:47 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:28:47 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:28:47 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:28:47 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'jsshell-linux-x86_64.zip'], 05:28:47 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:28:47 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:28:47 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:28:47 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:28:47 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:28:47 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:28:47 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:28:47 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:28:47 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:47 INFO - https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:49 INFO - Downloaded 22398891 bytes. 05:28:49 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'] 05:28:49 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 05:28:50 INFO - Return code: 0 05:28:50 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 05:28: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')]} 05:28:50 INFO - https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:28:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:28:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:28:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:53 INFO - Downloaded 22398891 bytes. 05:28:53 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'] 05:28:53 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 05:28:54 INFO - Return code: 0 05:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:54 INFO - https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:28:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:28:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:28:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:55 INFO - Downloaded 10706572 bytes. 05:28:55 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'] 05:28:55 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 05:28:55 INFO - Return code: 0 05:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:55 INFO - https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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 05:28:58 INFO - Downloaded 59581605 bytes. 05:28:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:28:58 INFO - mkdir: /builds/slave/test-pgo/properties 05:28:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:28:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:28:58 INFO - Contents: 05:28:58 INFO - build_url:https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:28:58 INFO - Running post-action listener: _resource_record_post_action 05:28:58 INFO - Running post-action listener: set_extra_try_arguments 05:28:58 INFO - ##### 05:28:58 INFO - ##### Running populate-webroot step. 05:28:58 INFO - ##### 05:28:58 INFO - Running pre-action listener: _resource_record_pre_action 05:28:58 INFO - Running main action method: populate_webroot 05:28:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:58 INFO - '--tppagecycles', 05:28:58 INFO - '7'], 05:28:58 INFO - 'tests': ['tsvgm']}}, 05:28:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:28:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:28:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:28:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:28:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'tests': ['damp', 'tps']}, 05:28:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['damp', 'tps']}, 05:28:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:28:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:58 INFO - 'other': {'tests': ['a11yr', 05:28:58 INFO - 'ts_paint', 05:28:58 INFO - 'tpaint', 05:28:58 INFO - 'sessionrestore', 05:28:58 INFO - 'sessionrestore_no_auto_restore']}, 05:28:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['a11yr', 05:28:58 INFO - 'ts_paint', 05:28:58 INFO - 'tpaint', 05:28:58 INFO - 'sessionrestore', 05:28:58 INFO - 'sessionrestore_no_auto_restore']}, 05:28:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['a11yr', 05:28:58 INFO - 'ts_paint', 05:28:58 INFO - 'tpaint', 05:28:58 INFO - 'sessionrestore', 05:28:58 INFO - 'sessionrestore_no_auto_restore']}, 05:28:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['a11yr', 05:28:58 INFO - 'ts_paint', 05:28:58 INFO - 'tpaint', 05:28:58 INFO - 'sessionrestore', 05:28:58 INFO - 'sessionrestore_no_auto_restore']}, 05:28:58 INFO - 'other_l64': {'tests': ['a11yr', 05:28:58 INFO - 'ts_paint', 05:28:58 INFO - 'tpaint', 05:28:58 INFO - 'sessionrestore', 05:28:58 INFO - 'sessionrestore_no_auto_restore']}, 05:28:58 INFO - 'other_nol64': {'tests': ['a11yr', 05:28:58 INFO - 'ts_paint', 05:28:58 INFO - 'tpaint', 05:28:58 INFO - 'sessionrestore', 05:28:58 INFO - 'sessionrestore_no_auto_restore']}, 05:28:58 INFO - 'svgr': {'tests': ['tsvgx', 05:28:58 INFO - 'tsvgr_opacity', 05:28:58 INFO - 'tart', 05:28:58 INFO - 'tscrollx', 05:28:58 INFO - 'cart']}, 05:28:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['tsvgx', 05:28:58 INFO - 'tsvgr_opacity', 05:28:58 INFO - 'tart', 05:28:58 INFO - 'tscrollx', 05:28:58 INFO - 'cart']}, 05:28:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'tests': ['tp5o']}, 05:28:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'talos_options': ['--e10s'], 05:28:58 INFO - 'tests': ['tp5o']}, 05:28:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'talos_options': ['--xperf_path', 05:28:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:58 INFO - 'tests': ['tp5n']}, 05:28:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:58 INFO - 'talos_options': ['--e10s', 05:28:58 INFO - '--xperf_path', 05:28:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:58 INFO - 'tests': ['tp5n']}}, 05:28:58 INFO - 'talos.zip': {'path': '', 05:28:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:58 INFO - Running post-action listener: _resource_record_post_action 05:28:58 INFO - ##### 05:28:58 INFO - ##### Running create-virtualenv step. 05:28:58 INFO - ##### 05:28:58 INFO - Running pre-action listener: _resource_record_pre_action 05:28:58 INFO - Running main action method: create_virtualenv 05:28:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:28:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:28:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:28:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:58 INFO - Using real prefix '/usr' 05:28:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:28:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:01 INFO - Installing pip.................done. 05:29:01 INFO - Return code: 0 05:29:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:01 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:01 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 05:29:01 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 05:29:01 INFO - Using env: {'DISPLAY': ':0', 05:29:01 INFO - 'HOME': '/home/cltbld', 05:29:01 INFO - 'LANG': 'en_US.UTF-8', 05:29:01 INFO - 'LANGUAGE': 'en_US:en', 05:29:01 INFO - 'LOGNAME': 'cltbld', 05:29:01 INFO - 'MAIL': '/var/mail/cltbld', 05:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:01 INFO - 'MOZ_NO_REMOTE': '1', 05:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:01 INFO - 'NO_EM_RESTART': '1', 05:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:01 INFO - 'SHELL': '/bin/bash', 05:29:01 INFO - 'SHLVL': '1', 05:29:01 INFO - 'TERM': 'linux', 05:29:01 INFO - 'TMOUT': '86400', 05:29:01 INFO - 'USER': 'cltbld', 05:29:01 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:01 INFO - '_': '/tools/buildbot/bin/python'} 05:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:29:01 INFO - Cleaning up... 05:29:01 INFO - Return code: 0 05:29:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:01 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:01 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 05:29:01 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 05:29:01 INFO - Using env: {'DISPLAY': ':0', 05:29:01 INFO - 'HOME': '/home/cltbld', 05:29:01 INFO - 'LANG': 'en_US.UTF-8', 05:29:01 INFO - 'LANGUAGE': 'en_US:en', 05:29:01 INFO - 'LOGNAME': 'cltbld', 05:29:01 INFO - 'MAIL': '/var/mail/cltbld', 05:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:01 INFO - 'MOZ_NO_REMOTE': '1', 05:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:01 INFO - 'NO_EM_RESTART': '1', 05:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:01 INFO - 'SHELL': '/bin/bash', 05:29:01 INFO - 'SHLVL': '1', 05:29:01 INFO - 'TERM': 'linux', 05:29:01 INFO - 'TMOUT': '86400', 05:29:01 INFO - 'USER': 'cltbld', 05:29:01 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:01 INFO - '_': '/tools/buildbot/bin/python'} 05:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:01 INFO - Downloading/unpacking psutil>=0.7.1 05:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:03 INFO - Installing collected packages: psutil 05:29:03 INFO - Running setup.py install for psutil 05:29:03 INFO - building 'psutil._psutil_linux' extension 05:29:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:29:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:29:04 INFO - building 'psutil._psutil_posix' extension 05:29:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:29:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:29:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:04 INFO - Successfully installed psutil 05:29:04 INFO - Cleaning up... 05:29:04 INFO - Return code: 0 05:29:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:04 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:04 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 05:29:04 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 05:29:04 INFO - Using env: {'DISPLAY': ':0', 05:29:04 INFO - 'HOME': '/home/cltbld', 05:29:04 INFO - 'LANG': 'en_US.UTF-8', 05:29:04 INFO - 'LANGUAGE': 'en_US:en', 05:29:04 INFO - 'LOGNAME': 'cltbld', 05:29:04 INFO - 'MAIL': '/var/mail/cltbld', 05:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:04 INFO - 'MOZ_NO_REMOTE': '1', 05:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:04 INFO - 'NO_EM_RESTART': '1', 05:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:04 INFO - 'SHELL': '/bin/bash', 05:29:04 INFO - 'SHLVL': '1', 05:29:04 INFO - 'TERM': 'linux', 05:29:04 INFO - 'TMOUT': '86400', 05:29:04 INFO - 'USER': 'cltbld', 05:29:04 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:04 INFO - '_': '/tools/buildbot/bin/python'} 05:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:29:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:29:06 INFO - Installing collected packages: mozsystemmonitor 05:29:06 INFO - Running setup.py install for mozsystemmonitor 05:29:06 INFO - Successfully installed mozsystemmonitor 05:29:06 INFO - Cleaning up... 05:29:06 INFO - Return code: 0 05:29:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:06 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:06 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 05:29:06 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 05:29:06 INFO - Using env: {'DISPLAY': ':0', 05:29:06 INFO - 'HOME': '/home/cltbld', 05:29:06 INFO - 'LANG': 'en_US.UTF-8', 05:29:06 INFO - 'LANGUAGE': 'en_US:en', 05:29:06 INFO - 'LOGNAME': 'cltbld', 05:29:06 INFO - 'MAIL': '/var/mail/cltbld', 05:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:06 INFO - 'MOZ_NO_REMOTE': '1', 05:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:06 INFO - 'NO_EM_RESTART': '1', 05:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:06 INFO - 'SHELL': '/bin/bash', 05:29:06 INFO - 'SHLVL': '1', 05:29:06 INFO - 'TERM': 'linux', 05:29:06 INFO - 'TMOUT': '86400', 05:29:06 INFO - 'USER': 'cltbld', 05:29:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:06 INFO - '_': '/tools/buildbot/bin/python'} 05:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:29:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:09 INFO - Downloading docopt-0.6.1.tar.gz 05:29:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:09 INFO - Running setup.py install for blobuploader 05:29:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:29:09 INFO - Running setup.py install for requests 05:29:09 INFO - Running setup.py install for docopt 05:29:09 INFO - Successfully installed blobuploader requests docopt 05:29:09 INFO - Cleaning up... 05:29:10 INFO - Return code: 0 05:29:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:10 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:10 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 05:29:10 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 05:29:10 INFO - Using env: {'DISPLAY': ':0', 05:29:10 INFO - 'HOME': '/home/cltbld', 05:29:10 INFO - 'LANG': 'en_US.UTF-8', 05:29:10 INFO - 'LANGUAGE': 'en_US:en', 05:29:10 INFO - 'LOGNAME': 'cltbld', 05:29:10 INFO - 'MAIL': '/var/mail/cltbld', 05:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:10 INFO - 'MOZ_NO_REMOTE': '1', 05:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:10 INFO - 'NO_EM_RESTART': '1', 05:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:10 INFO - 'SHELL': '/bin/bash', 05:29:10 INFO - 'SHLVL': '1', 05:29:10 INFO - 'TERM': 'linux', 05:29:10 INFO - 'TMOUT': '86400', 05:29:10 INFO - 'USER': 'cltbld', 05:29:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:10 INFO - '_': '/tools/buildbot/bin/python'} 05:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:29:10 INFO - Running setup.py (path:/tmp/pip-QBWRwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:29:10 INFO - Running setup.py (path:/tmp/pip-FidD6E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:29:10 INFO - Running setup.py (path:/tmp/pip-zipFc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:29:10 INFO - Running setup.py (path:/tmp/pip-O5GBNz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:29:10 INFO - Running setup.py (path:/tmp/pip-oP9tcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:29:10 INFO - Running setup.py (path:/tmp/pip-Hp7vud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:29:10 INFO - Running setup.py (path:/tmp/pip-Q0BR7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:29:10 INFO - Running setup.py (path:/tmp/pip-OxeyWA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:29:10 INFO - Running setup.py (path:/tmp/pip-yNs2dE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:29:10 INFO - Running setup.py (path:/tmp/pip-Wgz3TB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:29:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:29:10 INFO - Running setup.py (path:/tmp/pip-jDm0Yc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:29:11 INFO - Running setup.py (path:/tmp/pip-qhdMWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:29:11 INFO - Running setup.py (path:/tmp/pip-naIKuJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:29:11 INFO - Running setup.py (path:/tmp/pip-LsYd31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:29:11 INFO - Running setup.py (path:/tmp/pip-s0drSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:29:11 INFO - Running setup.py (path:/tmp/pip-qkWIae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:29:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:29:11 INFO - Running setup.py (path:/tmp/pip-6_m1DJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:29:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:11 INFO - Running setup.py install for manifestparser 05:29:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:29:11 INFO - Running setup.py install for mozcrash 05:29:11 INFO - Running setup.py install for mozdebug 05:29:11 INFO - Running setup.py install for mozdevice 05:29:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:29:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:29:11 INFO - Running setup.py install for mozfile 05:29:12 INFO - Running setup.py install for mozhttpd 05:29:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Running setup.py install for mozinfo 05:29:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Running setup.py install for mozInstall 05:29:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Running setup.py install for mozleak 05:29:12 INFO - Running setup.py install for mozlog 05:29:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Running setup.py install for moznetwork 05:29:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Running setup.py install for mozprocess 05:29:12 INFO - Running setup.py install for mozprofile 05:29:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Running setup.py install for mozrunner 05:29:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:29:12 INFO - Running setup.py install for mozscreenshot 05:29:13 INFO - Running setup.py install for moztest 05:29:13 INFO - Running setup.py install for mozversion 05:29:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:29:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:13 INFO - Cleaning up... 05:29:13 INFO - Return code: 0 05:29:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:13 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:13 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 05:29:13 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 05:29:13 INFO - Using env: {'DISPLAY': ':0', 05:29:13 INFO - 'HOME': '/home/cltbld', 05:29:13 INFO - 'LANG': 'en_US.UTF-8', 05:29:13 INFO - 'LANGUAGE': 'en_US:en', 05:29:13 INFO - 'LOGNAME': 'cltbld', 05:29:13 INFO - 'MAIL': '/var/mail/cltbld', 05:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:13 INFO - 'MOZ_NO_REMOTE': '1', 05:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:13 INFO - 'NO_EM_RESTART': '1', 05:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:13 INFO - 'SHELL': '/bin/bash', 05:29:13 INFO - 'SHLVL': '1', 05:29:13 INFO - 'TERM': 'linux', 05:29:13 INFO - 'TMOUT': '86400', 05:29:13 INFO - 'USER': 'cltbld', 05:29:13 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:13 INFO - '_': '/tools/buildbot/bin/python'} 05:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:29:13 INFO - Running setup.py (path:/tmp/pip-5eU3NF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:29:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:29:13 INFO - Running setup.py (path:/tmp/pip-ppfuYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:29:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:29:13 INFO - Running setup.py (path:/tmp/pip-rEUtjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:29:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:29:13 INFO - Running setup.py (path:/tmp/pip-3sFmVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:29:13 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)) 05:29:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:29:13 INFO - Running setup.py (path:/tmp/pip-NBtB9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:29:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:29:13 INFO - Running setup.py (path:/tmp/pip-23lRSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:29:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:29:13 INFO - Running setup.py (path:/tmp/pip-b0_tTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:29:14 INFO - Running setup.py (path:/tmp/pip-UfIMQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:29:14 INFO - Running setup.py (path:/tmp/pip-UqNqp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:29:14 INFO - Running setup.py (path:/tmp/pip-GJBWLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:29:14 INFO - Running setup.py (path:/tmp/pip-SpJ_G0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:29:14 INFO - Running setup.py (path:/tmp/pip-rBjP6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:29:14 INFO - Running setup.py (path:/tmp/pip-fNPB6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:29:14 INFO - Running setup.py (path:/tmp/pip-SCb0u9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:29:14 INFO - Running setup.py (path:/tmp/pip-tkTDgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:29:14 INFO - Running setup.py (path:/tmp/pip-K2arKC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:29:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:29:14 INFO - Running setup.py (path:/tmp/pip-NVRaCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:29:14 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)) 05:29:14 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)) 05:29:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:16 INFO - Downloading blessings-1.6.tar.gz 05:29:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:29:16 INFO - Installing collected packages: blessings 05:29:16 INFO - Running setup.py install for blessings 05:29:16 INFO - Successfully installed blessings 05:29:16 INFO - Cleaning up... 05:29:16 INFO - Return code: 0 05:29:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:29:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:29:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:29:16 INFO - Reading from file tmpfile_stdout 05:29:16 INFO - Current package versions: 05:29:16 INFO - argparse == 1.2.1 05:29:16 INFO - blessings == 1.6 05:29:16 INFO - blobuploader == 1.2.4 05:29:16 INFO - docopt == 0.6.1 05:29:16 INFO - manifestparser == 1.1 05:29:16 INFO - mozInstall == 1.12 05:29:16 INFO - mozcrash == 0.16 05:29:16 INFO - mozdebug == 0.1 05:29:16 INFO - mozdevice == 0.48 05:29:16 INFO - mozfile == 1.2 05:29:16 INFO - mozhttpd == 0.7 05:29:16 INFO - mozinfo == 0.9 05:29:16 INFO - mozleak == 0.1 05:29:16 INFO - mozlog == 3.1 05:29:16 INFO - moznetwork == 0.27 05:29:16 INFO - mozprocess == 0.22 05:29:16 INFO - mozprofile == 0.28 05:29:16 INFO - mozrunner == 6.11 05:29:16 INFO - mozscreenshot == 0.1 05:29:16 INFO - mozsystemmonitor == 0.0 05:29:16 INFO - moztest == 0.7 05:29:16 INFO - mozversion == 1.4 05:29:16 INFO - psutil == 3.1.1 05:29:16 INFO - requests == 1.2.3 05:29:16 INFO - wsgiref == 0.1.2 05:29:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:16 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:16 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 05:29:16 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 05:29:17 INFO - Using env: {'DISPLAY': ':0', 05:29:17 INFO - 'HOME': '/home/cltbld', 05:29:17 INFO - 'LANG': 'en_US.UTF-8', 05:29:17 INFO - 'LANGUAGE': 'en_US:en', 05:29:17 INFO - 'LOGNAME': 'cltbld', 05:29:17 INFO - 'MAIL': '/var/mail/cltbld', 05:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:17 INFO - 'MOZ_NO_REMOTE': '1', 05:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:17 INFO - 'NO_EM_RESTART': '1', 05:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:17 INFO - 'SHELL': '/bin/bash', 05:29:17 INFO - 'SHLVL': '1', 05:29:17 INFO - 'TERM': 'linux', 05:29:17 INFO - 'TMOUT': '86400', 05:29:17 INFO - 'USER': 'cltbld', 05:29:17 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:17 INFO - '_': '/tools/buildbot/bin/python'} 05:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:29:17 INFO - Cleaning up... 05:29:17 INFO - Return code: 0 05:29:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:17 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:17 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 05:29:17 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 05:29:17 INFO - Using env: {'DISPLAY': ':0', 05:29:17 INFO - 'HOME': '/home/cltbld', 05:29:17 INFO - 'LANG': 'en_US.UTF-8', 05:29:17 INFO - 'LANGUAGE': 'en_US:en', 05:29:17 INFO - 'LOGNAME': 'cltbld', 05:29:17 INFO - 'MAIL': '/var/mail/cltbld', 05:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:17 INFO - 'MOZ_NO_REMOTE': '1', 05:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:17 INFO - 'NO_EM_RESTART': '1', 05:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:17 INFO - 'SHELL': '/bin/bash', 05:29:17 INFO - 'SHLVL': '1', 05:29:17 INFO - 'TERM': 'linux', 05:29:17 INFO - 'TMOUT': '86400', 05:29:17 INFO - 'USER': 'cltbld', 05:29:17 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:17 INFO - '_': '/tools/buildbot/bin/python'} 05:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:17 INFO - Downloading/unpacking jsonschema 05:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:29:19 INFO - Downloading/unpacking functools32 (from jsonschema) 05:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:29:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:29:19 INFO - warning: no files found matching '*.txt' 05:29:19 INFO - no previously-included directories found matching 'build' 05:29:19 INFO - no previously-included directories found matching 'dist' 05:29:19 INFO - no previously-included directories found matching '.git*' 05:29:19 INFO - Installing collected packages: jsonschema, functools32 05:29:19 INFO - Running setup.py install for functools32 05:29:19 INFO - warning: no files found matching '*.txt' 05:29:19 INFO - no previously-included directories found matching 'build' 05:29:19 INFO - no previously-included directories found matching 'dist' 05:29:19 INFO - no previously-included directories found matching '.git*' 05:29:19 INFO - Successfully installed jsonschema functools32 05:29:19 INFO - Cleaning up... 05:29:19 INFO - Return code: 0 05:29:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:19 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 0x7fdb05971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:19 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 05:29:19 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 05:29:19 INFO - Using env: {'DISPLAY': ':0', 05:29:19 INFO - 'HOME': '/home/cltbld', 05:29:19 INFO - 'LANG': 'en_US.UTF-8', 05:29:19 INFO - 'LANGUAGE': 'en_US:en', 05:29:19 INFO - 'LOGNAME': 'cltbld', 05:29:19 INFO - 'MAIL': '/var/mail/cltbld', 05:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:19 INFO - 'MOZ_NO_REMOTE': '1', 05:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:19 INFO - 'NO_EM_RESTART': '1', 05:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:19 INFO - 'SHELL': '/bin/bash', 05:29:19 INFO - 'SHLVL': '1', 05:29:19 INFO - 'TERM': 'linux', 05:29:19 INFO - 'TMOUT': '86400', 05:29:19 INFO - 'USER': 'cltbld', 05:29:19 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:19 INFO - '_': '/tools/buildbot/bin/python'} 05:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:19 INFO - Downloading/unpacking flake8 05:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:29:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:29:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:22 INFO - no previously-included directories found matching 'docs/_build' 05:29:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:29:22 INFO - Running setup.py install for pep8 05:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:22 INFO - no previously-included directories found matching 'docs/_build' 05:29:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:29:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:29:22 INFO - Cleaning up... 05:29:22 INFO - Return code: 0 05:29:22 INFO - Running post-action listener: _resource_record_post_action 05:29:22 INFO - Running post-action listener: _start_resource_monitoring 05:29:22 INFO - Starting resource monitoring. 05:29:22 INFO - ##### 05:29:22 INFO - ##### Running install step. 05:29:22 INFO - ##### 05:29:22 INFO - Running pre-action listener: _resource_record_pre_action 05:29:22 INFO - Running main action method: install 05:29:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:29:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:29:22 INFO - Reading from file tmpfile_stdout 05:29:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:29:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:29:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:29:22 INFO - Reading from file tmpfile_stdout 05:29:22 INFO - Output received: 05:29:22 INFO - Usage: mozinstall [options] installer 05:29:22 INFO - Options: 05:29:22 INFO - -h, --help show this help message and exit 05:29:22 INFO - -d DEST, --destination=DEST 05:29:22 INFO - Directory to install application into. [default: 05:29:22 INFO - "/builds/slave/test-pgo"] 05:29:22 INFO - --app=APP Application being installed. [default: firefox] 05:29:22 INFO - mkdir: /builds/slave/test-pgo/build/application 05:29:22 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'] 05:29:22 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 05:29:37 INFO - Reading from file tmpfile_stdout 05:29:37 INFO - Output received: 05:29:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:29:37 INFO - Running post-action listener: _resource_record_post_action 05:29:37 INFO - ##### 05:29:37 INFO - ##### Running run-tests step. 05:29:37 INFO - ##### 05:29:37 INFO - Running pre-action listener: _resource_record_pre_action 05:29:37 INFO - Running main action method: run_tests 05:29:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:29:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:29:37 INFO - Python 2.7.3 05:29:37 INFO - Return code: 0 05:29:37 INFO - grabbing minidump binary from tooltool 05:29: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')]} 05:29:37 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 0x1d5a7f0>, '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 0x1cc62d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc6760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:29:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:29:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:29:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:37 INFO - Return code: 0 05:29:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:29:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:29:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:29:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:29:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:29:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:29:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:29:38 INFO - Return code: 0 05:29:38 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/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:29:38 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/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:29:38 INFO - Using env: {'DISPLAY': ':0', 05:29:38 INFO - 'HOME': '/home/cltbld', 05:29:38 INFO - 'LANG': 'en_US.UTF-8', 05:29:38 INFO - 'LANGUAGE': 'en_US:en', 05:29:38 INFO - 'LOGNAME': 'cltbld', 05:29:38 INFO - 'MAIL': '/var/mail/cltbld', 05:29:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:29:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:38 INFO - 'MOZ_NO_REMOTE': '1', 05:29:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:38 INFO - 'NO_EM_RESTART': '1', 05:29:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:29:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:29:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:29:38 INFO - 'SHELL': '/bin/bash', 05:29:38 INFO - 'SHLVL': '1', 05:29:38 INFO - 'TERM': 'linux', 05:29:38 INFO - 'TMOUT': '86400', 05:29:38 INFO - 'USER': 'cltbld', 05:29:38 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843', 05:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:38 INFO - '_': '/tools/buildbot/bin/python'} 05:29:38 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/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:29:39 INFO - mozversion application_buildid: 20160204025425 05:29:39 INFO - mozversion application_changeset: 8625dd776a9fe0753c5a9358c067f2fc2a98643b 05:29:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:29:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:39 INFO - mozversion application_name: Firefox 05:29:39 INFO - mozversion application_remotingname: firefox-dev 05:29:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:29:39 INFO - mozversion application_vendor: Mozilla 05:29:39 INFO - mozversion application_version: 46.0a2 05:29:39 INFO - mozversion platform_buildid: 20160204025425 05:29:39 INFO - mozversion platform_changeset: 8625dd776a9fe0753c5a9358c067f2fc2a98643b 05:29:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:29:39 INFO - mozversion platform_version: 46.0a2 05:29:39 INFO - using testdate: 1454592579 05:29:39 INFO - actual date: 1454592579 05:29:39 INFO - starting webserver on 'localhost:39034' 05:29:39 INFO - SUITE-START | Running 3 tests 05:29:39 INFO - TEST-START | dromaeo_css 05:29:39 INFO - operating with platform_type : linux_ 05:29:39 INFO - Initialising browser for dromaeo_css test... 05:29:39 INFO - TEST-INFO | started process 2020 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpATHjDm/profile http://localhost:39034/getInfo.html) 05:29:42 INFO - PROCESS | 2020 | 05:29:42 INFO - PROCESS | 2020 | (process:2099): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:43 INFO - PROCESS | 2020 | __metrics Screen width/height:1600/1200 05:29:43 INFO - PROCESS | 2020 | colorDepth:24 05:29:43 INFO - PROCESS | 2020 | Browser inner width/height: 1024/697 05:29:43 INFO - PROCESS | 2020 | __metrics 05:29:44 INFO - TEST-INFO | 2020: exit 0 05:29:44 INFO - Browser initialized. 05:29:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:44 INFO - TEST-INFO | started process 2148 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpATHjDm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:45 INFO - PROCESS | 2148 | 05:29:45 INFO - PROCESS | 2148 | (process:2209): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:56 INFO - PROCESS | 2148 | RSS: Main: 140414976 05:29:56 INFO - PROCESS | 2148 | 05:30:46 INFO - PROCESS | 2148 | 1454592646079 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:32:53 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:39034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39034/tests/dromaeo/cssquery-ext.html) 05:32:54 INFO - PROCESS | 2148 | RSS: Main: 145629184 05:32:54 INFO - PROCESS | 2148 | 05:35:56 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:39034/tests/dromaeo/cssquery-ext.html (next: http://localhost:39034/tests/dromaeo/cssquery-jquery.html) 05:35:57 INFO - PROCESS | 2148 | RSS: Main: 144535552 05:35:57 INFO - PROCESS | 2148 | 05:38:59 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:39034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39034/tests/dromaeo/cssquery-mootools.html) 05:38:59 INFO - PROCESS | 2148 | RSS: Main: 142839808 05:38:59 INFO - PROCESS | 2148 | 05:42:01 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:39034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39034/tests/dromaeo/cssquery-prototype.html) 05:42:01 INFO - PROCESS | 2148 | RSS: Main: 142241792 05:42:01 INFO - PROCESS | 2148 | 05:45:04 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:39034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39034/tests/dromaeo/cssquery-yui.html) 05:45:04 INFO - PROCESS | 2148 | RSS: Main: 142491648 05:45:04 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | Cycle 1(1): loaded http://localhost:39034/tests/dromaeo/cssquery-yui.html (next: http://localhost:39034/tests/dromaeo/cssquery-dojo.html) 05:48:07 INFO - PROCESS | 2148 | RSS: Main: 145391616 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | __start_tp_report 05:48:07 INFO - PROCESS | 2148 | _x_x_mozilla_page_load 05:48:07 INFO - PROCESS | 2148 | _x_x_mozilla_page_load_details 05:48:07 INFO - PROCESS | 2148 | |i|pagename|runs| 05:48:07 INFO - PROCESS | 2148 | |0;dojo.html;3334.3998080345536;3365.360581489517;3379.6958273755386;3401.676840700133;3403.1832360233534;5378.784848606056;5398.541124004464;5424.728763561816;5432.212329212267;5466.316710411199;5402.756875940582;5424.728763561816;5452.945470545294;5468.0977638689565;5471.452854714526;4985.1026815173345;5023.995200959805;5082.3138876251605;5102.1836506159025;5113.744312784346;4823.710577365352;4981.476944920767;4983.302337672729;4984.352034235562;5082.364704411949;5004.649674522785;5006.173981293082;5047.848564543069;5051.191809310511;5057.41839688435;5014.348134742479;5018.673786203885;5029.245613158019;5033.370828646419;5055.0900837848985;4814.964782571729;4903.63222758291;4916.410030796292;4944.579710724593;4963.478834722338;5245.239440281176;5266.7629956652045;5267.367915850123;5274.97362513185;5321.122014867542;5806.303243610751;5823.388544202882;5843.2695913010875;5853.824385268449;5859.6777177255235;5735.512481439041;5834.708264586754;5846.912296315559;5848.2689663792025;5899.882002359929;5417.241586177938;5420.430854760272;5434.239206511052;5449.536789372908;5458.4814442627885;5916.645001299936;5936.436038576328;5943.732532036069;5945.464908158287;5957.940420595825;5635.408282130399;5702.372738998707;5713.857153571194;5726.141078838207;5832.795852145155;5838.620489668158;5840.211571437886;5842.036064049385;5858.179854820329;5867.823965281048;5764.625299355528;5794.21778059965;5826.737796799154;5827.650340979555;5854.502367298742;5543.390227075019;5642.294713160855;5681.829545113653;5805.651660900359;5813.476787089182;4436.755978421218;4491.079328737601;4497.9325310120375;4505.6846020778885;4507.121111383249;3942.3495123304333;4030.8790736277374;4057.9797101014897;4075.4294398784195;4090.141070375195;5373.38206106295;5479.232907392969;5561.443855614406;5616.66300022;5668.801591944262;5792.362840087587;5823.359430462646;5836.358000619928;5848.8537786554825;5856.209411729362;5391.676499409969;5461.672299662033;5520.144377621395;5543.6396634218645;5545.61180717354;4977.601791856643;5007.324011258506;5037.949620503821;5039.992001599695;5098.107831129611;5913.852153696192;5950.583459157818;5961.314448838439;5999;6008.909866352008;5860.677662728591;5880.500157486662;5887.67617781009;5902.763889444374;5903.085021821625;5796.072628379439;5817.94182058174;5965.940340596539;6068.757249709962;6081.391860813883;5688.089905615082;5689.175069614966;5723.8855222896145;5730.770769169187;5751.884962300815;5718.256626638677;5817.650940943557;5831.562632802642;5848.181254624271;5864.472197502245;5617.606767526234;5630.352509461464;5729.828105156852;5817.272840894888;5872.765089396376;5743.798967036134;5769.884602307847;5771.797987070432;5772.797952071657;5789.421057894177;5619.971900140473;5668.376478587435;5671.347795003628;5692.1461780733225;5693.5445164387575;5558.722063896708;5570.637908535932;5670.489655930986;5678.3186017678145;5712.0860662293835;5604.439556044363;5604.915926261027;5607.579431542569;5644.85887852807;5659.037963546125 05:48:07 INFO - PROCESS | 2148 | |1;ext.html;557.5567423898001;574.8591595059208;577.965322080675;592.8399332180314;596.9462748352651;36324.455133173025;37159.256814863686;37202.813985930035;37289.06777330568;37386.25227495449;40460.393094103536;41025.179496410055;41073;41108.794456027754;41220.38169427453;8695.087015863322;8980.550972451383;9062.909370906305;9087.136722011432;9096.13586709265;8723.825523489526;8836.0722124177;8926.642934282621;8947.731568052968;8975.910240897605;8944.373893827435;8954.417962832395;9022.188003079722;9023.09769023099;9023.864642030341;8741.12588741124;8916.554172291391;8975.640974361051;8980.281577473786;8992.055834137453;8706.434081784664;8823.911760882373;8855.911440885637;8872.645094196225;8881.378303518757;40437.393439098436;40829.38755918664;40968.18063638711;40988.59011409878;40995.795021025006;3657.817109144559;3767.4913886625504;3886.047918260016;4001.6598589119667;4209.452771139763;26596.60105098425;27185.72814271852;27525.44949101027;33144.3371132576;33246.335073298644;3996;4088.795560221977;4104.8152833122285;4112.938305925413;4177.874663760092;229743;234135;236130;237162;237582;46746;47012;60636.696816515636;61885.69057154685;62138.37861621416;46073.76963115163;46441.53558464372;46648.53351466442;46684.5331546687;46840.7657961708;16562.58593535171;16580;16642.16789160537;16682.916585416995;16745.246463909152;13122.934385328012;13198.406071726795;13276.203427794364;13300.866991329964;13338.866611333957;15411.845881541041;15476.458323958832;15778.211089445482;15958;16101.11443870575;6442.452391546677;6469.288378278386;6540.215174179034;6655.301193374626;6658.733650654017;1054.9683509494728;1084.7776205877776;1133.3539882267194;1180.0972256223995;1184.875588063241;27500;32059.51910721341;32100;32425.189370265933;33107.834460828024;1141.092831199182;1207.7403358278013;1251.1992324912064;1257.5221415861913;1265.4368805881295;15707.68584628301;15762.290696918666;15889.126098064717;15921.920390397974;16185;433934;552016;554986;556269;849179;53457.7327113362;53781;53872.76763394209;53888.19167712487;54281;1496.2294418374545;1514.7273490771547;1515.7343618078808;1519.5821149184062;1526.381815364779;29088.56367154452;30038.69961300359;30154.547681784352;31133.53299700461;32360.676393236707;47758.522414775405;47867;47890;48062;48095;311037;311795;314407;315529;317112;43763.78118109517;44364;44515.77742111269;44631.33053004143;44661;41387.7930610345;41617.37573936333;41711;42135;53672;39372;39966.80016599898;40836;40913.33359812579;43658.34512482252;42414.78792606017;42595.78702106594;42688.57311426846;42839.14321713486;43194.56805432031;42367.3644895333;42758.57241427546;43055.354169686856;43268;43511.78244108759;37511.62488375081;37547.436788448744;37547.624523755505;38045.80977095097;38690;28948.27629309284;30064.84967575148;30071;30283.545746813375;30591.54112688267 05:48:07 INFO - PROCESS | 2148 | |2;jquery.html;398.26520070469974;398.4103526780367;402.17554014270746;402.9456023436836;404.1855660843401;14505.274736263198;15267.618309542268;16836.49490515285;17651.73522397165;17756;11589.53641854327;11887.286762794238;16151.919240403782;17583.73624395632;17592;4918.360613120299;5301.390340110898;5487.890242195153;5492.286002819628;5502.064649009678;3883.669888059504;4180.435641188446;5396.568274538027;6090.3909609038965;6099.57302988791;5847.181394604759;6036.547258955574;6068.605540639866;6086.695665216744;6102.847428814271;6070.119832624289;6073.453389194971;6088.45203931646;6107.236595425572;6110.022396416574;5312.150055991062;5419.729013549307;5438.483344082306;5445.074337362618;5452.1276595744885;13627.182369057888;14455.855441445661;20292.08685609151;20805.791942080537;20949.79050209509;2252.5044490212126;2268.126771193086;2345.0519404057427;2351.341624345186;2403.0219670693305;9931.404115753006;12467.501299947991;13646.727065458635;13848.653783655389;13967.231802250872;1828.195593938676;1859.665260253154;1880.4734674291221;1881.5108071901268;1956.491312258823;58549;59852.40147598512;61960;62005.6899715503;62191;10288.588456461808;10695.572177112985;10707.250492465453;10731.517081731341;10841.945790270998;13816.585502434944;13974.720505590034;14021.369038393297;14032.08791428554;14172.362243699059;7888.723894663659;7908.090569584457;7944.324732397696;8177.713780017671;8210.671573137008;7558.58427786466;7574.242575742492;7598.088229412506;7634.961825190839;7987.800304992422;4547.8635640930825;4665.043666048452;4665.136949664323;4763.595094416944;4845.200541910615;1988.2345297060735;2017.3846976671962;2026.1591439552715;2036.521417466894;2038.9184432622528;905.2531661379388;996.2229461020415;1054.9050585447194;1086.1658346038496;1091.4542728635681;16778.58053548671;17190.484285471455;17357;17637.7354339685;17833.46499605014;999.5801763259449;1002.0680766886719;1013.6705570689555;1028.1312291113998;1033.7622346860114;6169.598976066542;6481.837954051187;6507.219133703891;6520.47836173105;9601.32790704644;562613;574646;597452;645320;652363;45534.31698524525;48119.75940120347;50007.24989125166;71733.64133179301;71991.92012119823;488.1262540053336;502.1764306537282;505.89376230991166;507.9111155547764;512.0348143749134;10447.738806529898;10777.353358798497;14999.7000059996;15016.924915375354;15672.451464199154;34150.730487604116;34433.82783086068;35653.46519802257;37858.43212351872;39157.2168556633;42628.78685606552;45768.77115614401;48225.75887120542;48771.5122848767;51343.48656513387;7509.098908131059;7640.9617951912105;7784.377249820114;7861.410394220571;7967.00412448444;3793.146542028132;4490.797914093939;9186.724398268063;11072.224944253825;11468.827967580326;10606.363618182933;10712.089472394622;11054.281471704313;11127.109831213646;11183.72040698989;10223.539940702834;10390;10501.159907207253;10731.248812583044;11121.999020087907;10340.327878687862;10368.740781480523;10409.791804164026;11030.834537482106;11043.503042363274;7494.400447964041;7535.450369482549;7890.566018868788;7929.167437418988;7948.3641308694005;8607.440516366416;10497.632582859564;10640.787184256116;10709.250352475252;10785.245032847626 05:48:07 INFO - PROCESS | 2148 | |3;mootools.html;1541.814982202136;1560.8361122082179;1781.2340693501797;1864.2822513332362;1897.639448504784;8393.370497212703;8493;8616.827663446735;8630.525321107345;8647.69733059343;8647.264982476481;8698.217160455557;8730;8785.560721963891;8809.691660791874;2431.1734010436403;2444.4377793107597;2469.1111199967995;2474.455619763658;2478.764517370847;2487.2413913756295;2499.4001439654535;2518.181590982929;2525.8105642076825;2529.557327467695;1991.163711241275;2037.8981050947393;2402.9639555406684;2446.963295550568;2473.1591258972035;2376.0970831084164;2380.0955636858057;2396.149366974725;2406.5908795504806;2406.7713567211263;2358.127492827665;2413.79482743967;2423.9151629692874;2424.2121310573957;2428.57499937512;8558.315334773204;8559.058503564604;8561.400701950866;8572.485650860906;8591.656333746643;5129.743512824344;5283.973580132113;5306.230596563477;5314.176302673091;5326.041312563737;3219.404410184123;3262.265990152197;3351.8994430167136;3365.9831700841582;3376.40912840252;1103.2056919018373;1122.7698321844002;1130.0676941523277;1144.0390072339276;1161.9883801161964;11507.654770356903;11566.710832229177;11594.188406811527;11633.243839150513;11711.297322160783;4462.509123996358;4481.484629267611;4500.167469018242;4535.659825513099;4548.090381923628;9501.192398646055;9509.857352139723;9510.191633711074;9510.429374237568;9512.762180945394;5074.061298659686;5108.157154069611;5129.076766182048;5132.255822905658;5140.40885298188;4663.976680116578;4721.834735784231;4738.881527961759;4739.644526660514;4751.358566593535;3813.733038687321;3818.0645741792882;3821;3838.654521093115;3865.2269546090893;1167.9708007299885;1171.22699018649;1176.6999415149253;1180.0823661549982;1205.879412058787;948.9430634161972;951.6954574536082;1045.6810672744734;1050.3540322701483;1274.6685861675846;8010.375876088118;8014.679412823539;8096.797580060428;8105.392095592854;8131.2681858633005;1212.921160124589;1224.0574757436902;1226.2948804437485;1226.5461779141774;1251.9749605007848;6437.871242575216;6462.612243265419;6490.967545162244;6503.089567460559;6525.4779617630475;10188.286819922683;10903.34579925207;11005.229633925548;11008;11015.889841101647;10674.466276686135;10804.567817287378;10839.620613278656;10842.457877106113;10931.836022459669;8254.257116859511;8261;8310.875336869953;8351.956005499313;8359.916400836035;7693.076830780342;7711.151773305044;7714.537127772352;7768.300852923264;7823.335016523659;8980.955095224483;9150.359474836698;9606.951965240129;9677.951610241904;9703.9029609703;9300.906990930274;9363.297752668714;9402.059794020543;9504.524773761146;9510.191633711212;7462.365698915653;7494.250574942462;7501.774946751606;7517;7570.9242907570215;8058.3553315733425;8227.177282271725;8254.628541715518;8263.091059983277;8275.793105172419;6868.656567171722;7559.848803023799;7621.3902887769955;7636.847263054597;7762.41781866351;7232.0959880015;7488.475806693479;7538.585377804054;7630.504017238862;7643.961780191064;7639.732609358646;7652.7704168875025;7679.654415551202;7700.422468314787;7732;6827.863442731018;6852.6231057292325;6914.757983470555;6920.446364290945;7112.03987461686;7313.122425308997;7342.743003995049;7367.889481657887;7373.9262607375385;7382.9630851845395 05:48:07 INFO - PROCESS | 2148 | |4;prototype.html;362.3369234301229;369.9944500832487;377.69972871567103;379.59573054696745;383.1799948111041;6326.873462530747;6407.583507072043;6459.677016149197;6474.67626618669;6498.805035848932;6339.732053589278;6343.873122537547;6346.492280617551;6346.841328966778;6382.7446902123975;4847.369841920563;4892.8532144035735;4893.29047288143;4911.8772030699165;4915.778789954461;4869.977304766004;4872.926906096412;4895.31465594817;4900.58345040672;4921.926171107436;4513.3455648930885;4698.624110071203;4777.18787806072;4872.244802055669;4873.805047798084;4826;4853.0779151961015;4863.294822250789;4881.41423029237;4887.902241955158;4235.216484950294;4255.063885945087;4259.020425302167;4265.829366825324;4268.679849011305;5980.461758441761;5981.880362392728;6013.188219590343;6013.308469525973;6042.425969532887;5431.6740995540395;5499.395066542677;5556.972215138939;5647;5688.260526131618;6651.501137414665;6663.566868153603;6685.231198412196;6693.531452798306;6694.866102677968;4638.420197475316;4645.86062418128;4646.186917289461;4651.209294419923;4652.674312798105;6825.542804590344;6984.266652001517;7006.614636194956;7050.153981522199;7058.294170582901;4829.492903245179;4834.734089625104;4837.32277481153;4840.031993601294;4859.562639362474;4899.8285060023445;4901.215805471107;4903.632227582945;4907.779149938261;4915.754212289371;5631.099024156116;5644.858878527987;5645.717714114277;5648;5656.349519805275;6663.6001839888795;6748.29142939994;6769.458443324522;6777.966110169417;6789.626570538668;1697.73685078813;1729.2045658996751;1732.5581976595888;1733.3153404405189;1733.5406117378905;1159.5941420502757;1168.4683469021575;1183.8224266359944;1185.359905650956;1185.5909711149638;6476.384743449365;6510.967445162744;6517.055027021055;6518.315576864361;6519.511036672268;6894.689738961759;6915.930840691529;6924.4114250289285;6925.515213934977;6952.026716259727;6463.256725476536;6511.641859697762;6516.120323756327;6591.505637077238;6601.603903765789;3746.8875933722034;3769.1896242308035;3792.7345085844277;3811.9898226969876;3812.3519001769764;7255.927440725525;7270.127584689871;7278.672459739324;7295.124585049722;7308.049953506116;7109.644517774194;7190.101237345332;7221.747238846615;7281.927180728125;7286.162091359455;7144.857102858018;7260.056192694916;7265.600391978386;7276.927230727731;7288.6720097595735;6989.706904222735;7025.473089518205;7026.086608741035;7040.401565866754;7045.682944267623;6750.392464678006;6960.756373526902;6977.895331569929;6990.790276291719;6998.335158159966;7291.635418229173;7301.634918254173;7311.817204569928;7324.560526368435;7327.4504412168235;4845.9757701211265;4875.585575226146;4876.4392094909535;4878.341423907869;4883.902321953612;6867.278935711678;7036.401905838061;7074.257202993612;7090.1491820979745;7110.288971103055;6837.863242735217;6855.07456493367;6860.656967151523;6879.415249703831;6886.035954966209;6673.299303573055;6824.897626535705;6829.795106146824;6832.555883867532;6840.31596840312;6701.229358623626;6705.4635629150525;6707.396334329934;6714.697838597177;6745.156855393076;6822.317768223138;6824;6849.315068493111;6865.759698410531;6866.588004719732;6541;6656.30108838565;6692.59844409337;6715.026321183499;6730.057791909235 05:48:07 INFO - PROCESS | 2148 | |5;yui.html;916.2074805293423;916.5142474488522;922.4096578189956;924.2811833570008;932.0260327957286;14430.062045967004;14736.926315368408;14763.557093287218;14788.334524946376;14795.630109247275;12815.359232038383;12857.35713214338;12907.483700651963;12954.935225323883;13016.349182540858;869.326272139091;891.6433426629352;906.8458362078462;906.9093090690944;907.8683590879318;885.6103314541614;887.529609307065;891.9910800892005;893.2362829780542;899.0110878034176;903.2322525853006;908.5094049213417;911.8221946720392;912.3704643795793;917.0508523677995;902.733693560398;905.5789058087988;906.9954650226707;907.0657223060225;907.4464576608264;666.1140682891743;668.378408080485;668.5353679192963;673.1014096181603;673.9258681545026;14843.703125937422;14961;14965.551033469013;14985.625359365995;15080.698386032218;13610.944330592565;13639.454421823115;13659.975501837402;13670.248136352497;13894.305284735723;10661.893381066167;10988.670339889815;11470.942645286803;11726.530938762438;11922.642320730392;3834.830376735095;3846.3461211594094;3856.421536769479;3882.1847412043503;3930.9582960515486;51576.22635660468;52009.479905201224;52292.73853630746;52345;52430.21354679645;10354.689359319233;10494.895051049545;10547.472626368652;10556.630517931835;10579.735506612396;18729.344472943652;18747.531311717044;18782.436526904214;18840.05799710009;19259.422217333504;8161.632726527202;8173.223543763333;8312.8337433251;8344.749657510285;8355.164483551718;4649.093426781813;4775.2359622460235;4779.378680771478;4818.229083346648;4908.852734417973;3096.8916087936814;3137.215696075981;3257.4625186843905;3265.6407795142513;3272.689094536015;607.5534482155612;609.0802887639696;613.5858295650418;616.4359610956014;619.2568917299259;689.5931400473745;709.3651182192012;741.4772585327331;742.6472425597906;771.4946709905021;8854.203121719076;9105.271578273721;9171.587278572346;9173.724788256362;9185.357025008185;753.9924600753923;759.369723129801;760.9657565409569;778.1595876453416;783.3185128937747;4490.281554951192;4760.976195119002;4822.324874517571;4867.294242334912;4970.030843985388;60190;60286.39713602896;63005.68497157485;63142.36857631457;63304;53922;55289;55483.72258138764;55515.950187222625;55613;49725.25412118821;50196.49803501918;50265.74867125641;50319.49680503221;50610;8768.386212965032;9037.909620903969;9251.167394934488;9377.437353758796;9412.482313472825;36567.63432365749;36900;37076;37343.81328093342;37639.435408468344;46704.532954670016;47027.059458811316;47469;47775.76112119417;48089.75955120202;11406.828897566376;11753.588624398106;12269.549263648818;12336.198147120409;12463.626091217278;13648.317584120952;13862.93068534651;13937.163770173822;14290.142591444546;14383;13023.934880325538;13350.732985340434;13462.663433414244;13463.259520726062;13691.657708556968;12713.745725085631;12825.679358016125;13128.803067953797;13437.529686460926;13614.115082519604;12702.174358666656;13066.412011459317;13429.194248345131;13546.72906541844;13683.315834208448;10143.442110683984;10237.129843963347;10238;10452.529636166239;10545.841812372668;11060.281081729661;11470.139739519402;11544.59593914209;11610.6516804496;11618.302901825917 05:48:07 INFO - PROCESS | 2148 | __end_tp_report 05:48:07 INFO - PROCESS | 2148 | __start_cc_report 05:48:07 INFO - PROCESS | 2148 | _x_x_mozilla_cycle_collect,319 05:48:07 INFO - PROCESS | 2148 | __end_cc_report 05:48:07 INFO - PROCESS | 2148 | __startTimestamp1454593687311__endTimestamp 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | ------- Summary: start ------- 05:48:07 INFO - PROCESS | 2148 | Number of tests: 6 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | [#0] dojo.html Cycles:165 Average:5419.38 Median:5630.35 stddev:574.51 (10.2%) stddev-sans-first:552.50 05:48:07 INFO - PROCESS | 2148 | Values: 3334.4 3365.4 3379.7 3401.7 3403.2 5378.8 5398.5 5424.7 5432.2 5466.3 5402.8 5424.7 5452.9 5468.1 5471.5 4985.1 5024.0 5082.3 5102.2 5113.7 4823.7 4981.5 4983.3 4984.4 5082.4 5004.6 5006.2 5047.8 5051.2 5057.4 5014.3 5018.7 5029.2 5033.4 5055.1 4815.0 4903.6 4916.4 4944.6 4963.5 5245.2 5266.8 5267.4 5275.0 5321.1 5806.3 5823.4 5843.3 5853.8 5859.7 5735.5 5834.7 5846.9 5848.3 5899.9 5417.2 5420.4 5434.2 5449.5 5458.5 5916.6 5936.4 5943.7 5945.5 5957.9 5635.4 5702.4 5713.9 5726.1 5832.8 5838.6 5840.2 5842.0 5858.2 5867.8 5764.6 5794.2 5826.7 5827.7 5854.5 5543.4 5642.3 5681.8 5805.7 5813.5 4436.8 4491.1 4497.9 4505.7 4507.1 3942.3 4030.9 4058.0 4075.4 4090.1 5373.4 5479.2 5561.4 5616.7 5668.8 5792.4 5823.4 5836.4 5848.9 5856.2 5391.7 5461.7 5520.1 5543.6 5545.6 4977.6 5007.3 5037.9 5040.0 5098.1 5913.9 5950.6 5961.3 5999.0 6008.9 5860.7 5880.5 5887.7 5902.8 5903.1 5796.1 5817.9 5965.9 6068.8 6081.4 5688.1 5689.2 5723.9 5730.8 5751.9 5718.3 5817.7 5831.6 5848.2 5864.5 5617.6 5630.4 5729.8 5817.3 5872.8 5743.8 5769.9 5771.8 5772.8 5789.4 5620.0 5668.4 5671.3 5692.1 5693.5 5558.7 5570.6 5670.5 5678.3 5712.1 5604.4 5604.9 5607.6 5644.9 5659.0 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | [#1] ext.html Cycles:180 Average:54467.25 Median:41010.49 stddev:111417.48 (271.7%) stddev-sans-first:111656.51 05:48:07 INFO - PROCESS | 2148 | Values: 557.6 574.9 578.0 592.8 596.9 36324.5 37159.3 37202.8 37289.1 37386.3 40460.4 41025.2 41073.0 41108.8 41220.4 8695.1 8980.6 9062.9 9087.1 9096.1 8723.8 8836.1 8926.6 8947.7 8975.9 8944.4 8954.4 9022.2 9023.1 9023.9 8741.1 8916.6 8975.6 8980.3 8992.1 8706.4 8823.9 8855.9 8872.6 8881.4 40437.4 40829.4 40968.2 40988.6 40995.8 3657.8 3767.5 3886.0 4001.7 4209.5 26596.6 27185.7 27525.4 33144.3 33246.3 3996.0 4088.8 4104.8 4112.9 4177.9 229743.0 234135.0 236130.0 237162.0 237582.0 46746.0 47012.0 60636.7 61885.7 62138.4 46073.8 46441.5 46648.5 46684.5 46840.8 16562.6 16580.0 16642.2 16682.9 16745.2 13122.9 13198.4 13276.2 13300.9 13338.9 15411.8 15476.5 15778.2 15958.0 16101.1 6442.5 6469.3 6540.2 6655.3 6658.7 1055.0 1084.8 1133.4 1180.1 1184.9 27500.0 32059.5 32100.0 32425.2 33107.8 1141.1 1207.7 1251.2 1257.5 1265.4 15707.7 15762.3 15889.1 15921.9 16185.0 433934.0 552016.0 554986.0 556269.0 849179.0 53457.7 53781.0 53872.8 53888.2 54281.0 1496.2 1514.7 1515.7 1519.6 1526.4 29088.6 30038.7 30154.5 31133.5 32360.7 47758.5 47867.0 47890.0 48062.0 48095.0 311037.0 311795.0 314407.0 315529.0 317112.0 43763.8 44364.0 44515.8 44631.3 44661.0 41387.8 41617.4 41711.0 42135.0 53672.0 39372.0 39966.8 40836.0 40913.3 43658.3 42414.8 42595.8 42688.6 42839.1 43194.6 42367.4 42758.6 43055.4 43268.0 43511.8 37511.6 37547.4 37547.6 38045.8 38690.0 28948.3 30064.8 30071.0 30283.5 30591.5 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | [#2] jquery.html Cycles:180 Average:29349.58 Median:400.29 stddev:99112.31 (24759.9%) stddev-sans-first:99366.50 05:48:07 INFO - PROCESS | 2148 | Values: 398.3 398.4 402.2 402.9 404.2 14505.3 15267.6 16836.5 17651.7 17756.0 11589.5 11887.3 16151.9 17583.7 17592.0 4918.4 5301.4 5487.9 5492.3 5502.1 3883.7 4180.4 5396.6 6090.4 6099.6 5847.2 6036.5 6068.6 6086.7 6102.8 6070.1 6073.5 6088.5 6107.2 6110.0 5312.2 5419.7 5438.5 5445.1 5452.1 13627.2 14455.9 20292.1 20805.8 20949.8 2252.5 2268.1 2345.1 2351.3 2403.0 9931.4 12467.5 13646.7 13848.7 13967.2 1828.2 1859.7 1880.5 1881.5 1956.5 58549.0 59852.4 61960.0 62005.7 62191.0 10288.6 10695.6 10707.3 10731.5 10841.9 13816.6 13974.7 14021.4 14032.1 14172.4 7888.7 7908.1 7944.3 8177.7 8210.7 7558.6 7574.2 7598.1 7635.0 7987.8 4547.9 4665.0 4665.1 4763.6 4845.2 1988.2 2017.4 2026.2 2036.5 2038.9 905.3 996.2 1054.9 1086.2 1091.5 16778.6 17190.5 17357.0 17637.7 17833.5 999.6 1002.1 1013.7 1028.1 1033.8 6169.6 6481.8 6507.2 6520.5 9601.3 562613.0 574646.0 597452.0 645320.0 652363.0 45534.3 48119.8 50007.2 71733.6 71991.9 488.1 502.2 505.9 507.9 512.0 10447.7 10777.4 14999.7 15016.9 15672.5 34150.7 34433.8 35653.5 37858.4 39157.2 42628.8 45768.8 48225.8 48771.5 51343.5 7509.1 7641.0 7784.4 7861.4 7967.0 3793.1 4490.8 9186.7 11072.2 11468.8 10606.4 10712.1 11054.3 11127.1 11183.7 10223.5 10390.0 10501.2 10731.2 11122.0 10340.3 10368.7 10409.8 11030.8 11043.5 7494.4 7535.5 7890.6 7929.2 7948.4 8607.4 10497.6 10640.8 10709.3 10785.2 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | [#3] mootools.html Cycles:180 Average:5996.57 Median:5310.20 stddev:3165.52 (59.6%) stddev-sans-first:3156.69 05:48:07 INFO - PROCESS | 2148 | Values: 1541.8 1560.8 1781.2 1864.3 1897.6 8393.4 8493.0 8616.8 8630.5 8647.7 8647.3 8698.2 8730.0 8785.6 8809.7 2431.2 2444.4 2469.1 2474.5 2478.8 2487.2 2499.4 2518.2 2525.8 2529.6 1991.2 2037.9 2403.0 2447.0 2473.2 2376.1 2380.1 2396.1 2406.6 2406.8 2358.1 2413.8 2423.9 2424.2 2428.6 8558.3 8559.1 8561.4 8572.5 8591.7 5129.7 5284.0 5306.2 5314.2 5326.0 3219.4 3262.3 3351.9 3366.0 3376.4 1103.2 1122.8 1130.1 1144.0 1162.0 11507.7 11566.7 11594.2 11633.2 11711.3 4462.5 4481.5 4500.2 4535.7 4548.1 9501.2 9509.9 9510.2 9510.4 9512.8 5074.1 5108.2 5129.1 5132.3 5140.4 4664.0 4721.8 4738.9 4739.6 4751.4 3813.7 3818.1 3821.0 3838.7 3865.2 1168.0 1171.2 1176.7 1180.1 1205.9 948.9 951.7 1045.7 1050.4 1274.7 8010.4 8014.7 8096.8 8105.4 8131.3 1212.9 1224.1 1226.3 1226.5 1252.0 6437.9 6462.6 6491.0 6503.1 6525.5 10188.3 10903.3 11005.2 11008.0 11015.9 10674.5 10804.6 10839.6 10842.5 10931.8 8254.3 8261.0 8310.9 8352.0 8359.9 7693.1 7711.2 7714.5 7768.3 7823.3 8981.0 9150.4 9607.0 9678.0 9703.9 9300.9 9363.3 9402.1 9504.5 9510.2 7462.4 7494.3 7501.8 7517.0 7570.9 8058.4 8227.2 8254.6 8263.1 8275.8 6868.7 7559.8 7621.4 7636.8 7762.4 7232.1 7488.5 7538.6 7630.5 7644.0 7639.7 7652.8 7679.7 7700.4 7732.0 6827.9 6852.6 6914.8 6920.4 7112.0 7313.1 7342.7 7367.9 7373.9 7383.0 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | [#4] prototype.html Cycles:180 Average:5675.18 Median:6487.59 stddev:1711.32 (26.4%) stddev-sans-first:1669.01 05:48:07 INFO - PROCESS | 2148 | Values: 362.3 370.0 377.7 379.6 383.2 6326.9 6407.6 6459.7 6474.7 6498.8 6339.7 6343.9 6346.5 6346.8 6382.7 4847.4 4892.9 4893.3 4911.9 4915.8 4870.0 4872.9 4895.3 4900.6 4921.9 4513.3 4698.6 4777.2 4872.2 4873.8 4826.0 4853.1 4863.3 4881.4 4887.9 4235.2 4255.1 4259.0 4265.8 4268.7 5980.5 5981.9 6013.2 6013.3 6042.4 5431.7 5499.4 5557.0 5647.0 5688.3 6651.5 6663.6 6685.2 6693.5 6694.9 4638.4 4645.9 4646.2 4651.2 4652.7 6825.5 6984.3 7006.6 7050.2 7058.3 4829.5 4834.7 4837.3 4840.0 4859.6 4899.8 4901.2 4903.6 4907.8 4915.8 5631.1 5644.9 5645.7 5648.0 5656.3 6663.6 6748.3 6769.5 6778.0 6789.6 1697.7 1729.2 1732.6 1733.3 1733.5 1159.6 1168.5 1183.8 1185.4 1185.6 6476.4 6511.0 6517.1 6518.3 6519.5 6894.7 6915.9 6924.4 6925.5 6952.0 6463.3 6511.6 6516.1 6591.5 6601.6 3746.9 3769.2 3792.7 3812.0 3812.4 7255.9 7270.1 7278.7 7295.1 7308.0 7109.6 7190.1 7221.7 7281.9 7286.2 7144.9 7260.1 7265.6 7276.9 7288.7 6989.7 7025.5 7026.1 7040.4 7045.7 6750.4 6960.8 6977.9 6990.8 6998.3 7291.6 7301.6 7311.8 7324.6 7327.5 4846.0 4875.6 4876.4 4878.3 4883.9 6867.3 7036.4 7074.3 7090.1 7110.3 6837.9 6855.1 6860.7 6879.4 6886.0 6673.3 6824.9 6829.8 6832.6 6840.3 6701.2 6705.5 6707.4 6714.7 6745.2 6822.3 6824.0 6849.3 6865.8 6866.6 6541.0 6656.3 6692.6 6715.0 6730.1 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - PROCESS | 2148 | [#5] yui.html Cycles:180 Average:14977.87 Median:4768.11 stddev:17116.75 (359.0%) stddev-sans-first:17132.19 05:48:07 INFO - PROCESS | 2148 | Values: 916.2 916.5 922.4 924.3 932.0 14430.1 14736.9 14763.6 14788.3 14795.6 12815.4 12857.4 12907.5 12954.9 13016.3 869.3 891.6 906.8 906.9 907.9 885.6 887.5 892.0 893.2 899.0 903.2 908.5 911.8 912.4 917.1 902.7 905.6 907.0 907.1 907.4 666.1 668.4 668.5 673.1 673.9 14843.7 14961.0 14965.6 14985.6 15080.7 13610.9 13639.5 13660.0 13670.2 13894.3 10661.9 10988.7 11470.9 11726.5 11922.6 3834.8 3846.3 3856.4 3882.2 3931.0 51576.2 52009.5 52292.7 52345.0 52430.2 10354.7 10494.9 10547.5 10556.6 10579.7 18729.3 18747.5 18782.4 18840.1 19259.4 8161.6 8173.2 8312.8 8344.7 8355.2 4649.1 4775.2 4779.4 4818.2 4908.9 3096.9 3137.2 3257.5 3265.6 3272.7 607.6 609.1 613.6 616.4 619.3 689.6 709.4 741.5 742.6 771.5 8854.2 9105.3 9171.6 9173.7 9185.4 754.0 759.4 761.0 778.2 783.3 4490.3 4761.0 4822.3 4867.3 4970.0 60190.0 60286.4 63005.7 63142.4 63304.0 53922.0 55289.0 55483.7 55516.0 55613.0 49725.3 50196.5 50265.7 50319.5 50610.0 8768.4 9037.9 9251.2 9377.4 9412.5 36567.6 36900.0 37076.0 37343.8 37639.4 46704.5 47027.1 47469.0 47775.8 48089.8 11406.8 11753.6 12269.5 12336.2 12463.6 13648.3 13862.9 13937.2 14290.1 14383.0 13023.9 13350.7 13462.7 13463.3 13691.7 12713.7 12825.7 13128.8 13437.5 13614.1 12702.2 13066.4 13429.2 13546.7 13683.3 10143.4 10237.1 10238.0 10452.5 10545.8 11060.3 11470.1 11544.6 11610.7 11618.3 05:48:07 INFO - PROCESS | 2148 | -------- Summary: end -------- 05:48:07 INFO - PROCESS | 2148 | 05:48:07 INFO - TEST-INFO | 2148: exit 0 05:48:07 INFO - TEST-OK | dromaeo_css | took 1108742ms 05:48:07 INFO - TEST-START | kraken 05:48:07 INFO - operating with platform_type : linux_ 05:48:07 INFO - Initialising browser for kraken test... 05:48:07 INFO - TEST-INFO | started process 2482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7U5hbM/profile http://localhost:39034/getInfo.html) 05:48:11 INFO - PROCESS | 2482 | 05:48:11 INFO - PROCESS | 2482 | (process:2561): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:48:12 INFO - PROCESS | 2482 | __metrics Screen width/height:1600/1200 05:48:12 INFO - PROCESS | 2482 | colorDepth:24 05:48:12 INFO - PROCESS | 2482 | Browser inner width/height: 1024/697 05:48:12 INFO - PROCESS | 2482 | __metrics 05:48:13 INFO - TEST-INFO | 2482: exit 0 05:48:13 INFO - Browser initialized. 05:48:13 INFO - Running cycle 1/1 for kraken test... 05:48:13 INFO - TEST-INFO | started process 2610 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7U5hbM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:14 INFO - PROCESS | 2610 | 05:48:14 INFO - PROCESS | 2610 | (process:2721): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:48:24 INFO - PROCESS | 2610 | RSS: Main: 140705792 05:48:24 INFO - PROCESS | 2610 | 05:48:27 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39034/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:27 INFO - PROCESS | 2610 | RSS: Main: 143933440 05:48:27 INFO - PROCESS | 2610 | 05:48:30 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39034/tests/kraken/driver.html?testName=audio-dft) 05:48:31 INFO - PROCESS | 2610 | RSS: Main: 143208448 05:48:31 INFO - PROCESS | 2610 | 05:48:34 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39034/tests/kraken/driver.html?testName=audio-fft) 05:48:34 INFO - PROCESS | 2610 | RSS: Main: 144670720 05:48:34 INFO - PROCESS | 2610 | 05:48:36 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39034/tests/kraken/driver.html?testName=audio-oscillator) 05:48:37 INFO - PROCESS | 2610 | RSS: Main: 144384000 05:48:37 INFO - PROCESS | 2610 | 05:48:39 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:40 INFO - PROCESS | 2610 | RSS: Main: 144384000 05:48:40 INFO - PROCESS | 2610 | 05:48:42 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39034/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:43 INFO - PROCESS | 2610 | RSS: Main: 145956864 05:48:43 INFO - PROCESS | 2610 | 05:48:46 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39034/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:47 INFO - PROCESS | 2610 | RSS: Main: 145678336 05:48:47 INFO - PROCESS | 2610 | 05:48:50 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39034/tests/kraken/driver.html?testName=json-parse-financial) 05:48:50 INFO - PROCESS | 2610 | RSS: Main: 145559552 05:48:50 INFO - PROCESS | 2610 | 05:48:52 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:52 INFO - PROCESS | 2610 | RSS: Main: 146108416 05:48:52 INFO - PROCESS | 2610 | 05:48:54 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:55 INFO - PROCESS | 2610 | RSS: Main: 144400384 05:48:55 INFO - PROCESS | 2610 | 05:48:57 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:58 INFO - PROCESS | 2610 | RSS: Main: 145735680 05:48:58 INFO - PROCESS | 2610 | 05:49:00 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:00 INFO - PROCESS | 2610 | RSS: Main: 144797696 05:49:00 INFO - PROCESS | 2610 | 05:49:03 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:03 INFO - PROCESS | 2610 | RSS: Main: 146288640 05:49:03 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | Cycle 1(1): loaded http://localhost:39034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39034/tests/kraken/driver.html?testName=ai-astar) 05:49:05 INFO - PROCESS | 2610 | RSS: Main: 147521536 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | __start_tp_report 05:49:05 INFO - PROCESS | 2610 | _x_x_mozilla_page_load 05:49:05 INFO - PROCESS | 2610 | _x_x_mozilla_page_load_details 05:49:05 INFO - PROCESS | 2610 | |i|pagename|runs| 05:49:05 INFO - PROCESS | 2610 | |0;ai-astar;110;104;112;111;110;120;111;112;112;113 05:49:05 INFO - PROCESS | 2610 | |1;audio-beat-detection;153;131;157;162;132;161;163;131;158;126 05:49:05 INFO - PROCESS | 2610 | |2;audio-dft;163;162;161;162;161;168;161;163;163;162 05:49:05 INFO - PROCESS | 2610 | |3;audio-fft;72;72;75;156;72;74;75;73;148;72 05:49:05 INFO - PROCESS | 2610 | |4;audio-oscillator;96;96;138;95;97;96;140;95;96;139 05:49:05 INFO - PROCESS | 2610 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;110 05:49:05 INFO - PROCESS | 2610 | |6;imaging-darkroom;149;146;146;147;146;147;147;150;149;147 05:49:05 INFO - PROCESS | 2610 | |7;imaging-desaturate;96;98;96;97;97;97;98;97;96;97 05:49:05 INFO - PROCESS | 2610 | |8;json-parse-financial;56;58;57;55;59;56;56;56;56;53 05:49:05 INFO - PROCESS | 2610 | |9;json-stringify-tinderbox;64;66;64;64;65;65;64;65;68;66 05:49:05 INFO - PROCESS | 2610 | |10;stanford-crypto-aes;94;83;81;83;83;82;83;82;84;82 05:49:05 INFO - PROCESS | 2610 | |11;stanford-crypto-ccm;107;113;109;113;120;112;116;119;117;111 05:49:05 INFO - PROCESS | 2610 | |12;stanford-crypto-pbkdf2;124;134;136;128;138;138;135;134;137;127 05:49:05 INFO - PROCESS | 2610 | |13;stanford-crypto-sha256-iterative;65;68;70;65;71;65;64;64;66;65 05:49:05 INFO - PROCESS | 2610 | __end_tp_report 05:49:05 INFO - PROCESS | 2610 | __start_cc_report 05:49:05 INFO - PROCESS | 2610 | _x_x_mozilla_cycle_collect,716 05:49:05 INFO - PROCESS | 2610 | __end_cc_report 05:49:05 INFO - PROCESS | 2610 | __startTimestamp1454593745885__endTimestamp 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | ------- Summary: start ------- 05:49:05 INFO - PROCESS | 2610 | Number of tests: 14 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:3.89 (3.5%) stddev-sans-first:4.09 05:49:05 INFO - PROCESS | 2610 | Values: 110.0 104.0 112.0 111.0 110.0 120.0 111.0 112.0 112.0 113.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:157.50 stddev:15.31 (9.7%) stddev-sans-first:16.11 05:49:05 INFO - PROCESS | 2610 | Values: 153.0 131.0 157.0 162.0 132.0 161.0 163.0 131.0 158.0 126.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 05:49:05 INFO - PROCESS | 2610 | Values: 163.0 162.0 161.0 162.0 161.0 168.0 161.0 163.0 163.0 162.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#3] audio-fft Cycles:10 Average:88.90 Median:72.50 stddev:33.33 (46.0%) stddev-sans-first:34.79 05:49:05 INFO - PROCESS | 2610 | Values: 72.0 72.0 75.0 156.0 72.0 74.0 75.0 73.0 148.0 72.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:96.00 stddev:20.85 (21.7%) stddev-sans-first:21.60 05:49:05 INFO - PROCESS | 2610 | Values: 96.0 96.0 138.0 95.0 97.0 96.0 140.0 95.0 96.0 139.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:49:05 INFO - PROCESS | 2610 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.39 05:49:05 INFO - PROCESS | 2610 | Values: 149.0 146.0 146.0 147.0 146.0 147.0 147.0 150.0 149.0 147.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 05:49:05 INFO - PROCESS | 2610 | Values: 96.0 98.0 96.0 97.0 97.0 97.0 98.0 97.0 96.0 97.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.62 (2.9%) stddev-sans-first:1.72 05:49:05 INFO - PROCESS | 2610 | Values: 56.0 58.0 57.0 55.0 59.0 56.0 56.0 56.0 56.0 53.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.30 05:49:05 INFO - PROCESS | 2610 | Values: 64.0 66.0 64.0 64.0 65.0 65.0 64.0 65.0 68.0 66.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.71 (4.5%) stddev-sans-first:0.88 05:49:05 INFO - PROCESS | 2610 | Values: 94.0 83.0 81.0 83.0 83.0 82.0 83.0 82.0 84.0 82.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:114.50 stddev:4.24 (3.7%) stddev-sans-first:3.75 05:49:05 INFO - PROCESS | 2610 | Values: 107.0 113.0 109.0 113.0 120.0 112.0 116.0 119.0 117.0 111.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.10 Median:135.50 stddev:4.98 (3.7%) stddev-sans-first:4.04 05:49:05 INFO - PROCESS | 2610 | Values: 124.0 134.0 136.0 128.0 138.0 138.0 135.0 134.0 137.0 127.0 05:49:05 INFO - PROCESS | 2610 | 05:49:05 INFO - PROCESS | 2610 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:65.50 stddev:2.50 (3.8%) stddev-sans-first:2.60 05:49:05 INFO - PROCESS | 2610 | Values: 65.0 68.0 70.0 65.0 71.0 65.0 64.0 64.0 66.0 65.0 05:49:05 INFO - PROCESS | 2610 | -------- Summary: end -------- 05:49:05 INFO - PROCESS | 2610 | 05:49:06 INFO - TEST-INFO | 2610: exit 0 05:49:06 INFO - TEST-OK | kraken | took 58849ms 05:49:06 INFO - TEST-START | v8_7 05:49:06 INFO - operating with platform_type : linux_ 05:49:06 INFO - Initialising browser for v8_7 test... 05:49:06 INFO - TEST-INFO | started process 3009 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgs4Lql/profile http://localhost:39034/getInfo.html) 05:49:10 INFO - PROCESS | 3009 | 05:49:10 INFO - PROCESS | 3009 | (process:3086): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:49:11 INFO - PROCESS | 3009 | __metrics Screen width/height:1600/1200 05:49:11 INFO - PROCESS | 3009 | colorDepth:24 05:49:11 INFO - PROCESS | 3009 | Browser inner width/height: 1024/697 05:49:11 INFO - PROCESS | 3009 | __metrics 05:49:11 INFO - TEST-INFO | 3009: exit 0 05:49:11 INFO - Browser initialized. 05:49:11 INFO - Running cycle 1/1 for v8_7 test... 05:49:11 INFO - TEST-INFO | started process 3135 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgs4Lql/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:13 INFO - PROCESS | 3135 | 05:49:13 INFO - PROCESS | 3135 | (process:3197): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:49:23 INFO - PROCESS | 3135 | RSS: Main: 141250560 05:49:23 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | Cycle 1(1): loaded http://localhost:39034/tests/v8_7/run.html (next: http://localhost:39034/tests/v8_7/run.html) 05:49:46 INFO - PROCESS | 3135 | RSS: Main: 143499264 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | __start_tp_report 05:49:46 INFO - PROCESS | 3135 | _x_x_mozilla_page_load 05:49:46 INFO - PROCESS | 3135 | _x_x_mozilla_page_load_details 05:49:46 INFO - PROCESS | 3135 | |i|pagename|runs| 05:49:46 INFO - PROCESS | 3135 | |0;Richards;167.64459346186086 05:49:46 INFO - PROCESS | 3135 | |1;DeltaBlue;169.83695652173913 05:49:46 INFO - PROCESS | 3135 | |2;Encrypt;279.4857462269424 05:49:46 INFO - PROCESS | 3135 | |3;Decrypt;5284.210526315789 05:49:46 INFO - PROCESS | 3135 | |4;RayTrace;920.8103130755064 05:49:46 INFO - PROCESS | 3135 | |5;Earley;570.7762557077625 05:49:46 INFO - PROCESS | 3135 | |6;Boyer;11144.444444444445 05:49:46 INFO - PROCESS | 3135 | |7;RegExp;39442.307692307695 05:49:46 INFO - PROCESS | 3135 | |8;Splay;523.5602094240837 05:49:46 INFO - PROCESS | 3135 | |9;NavierStokes;4826.923076923077 05:49:46 INFO - PROCESS | 3135 | __end_tp_report 05:49:46 INFO - PROCESS | 3135 | __startTimestamp1454593786375__endTimestamp 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | ------- Summary: start ------- 05:49:46 INFO - PROCESS | 3135 | Number of tests: 10 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 167.6 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#1] DeltaBlue Cycles:1 Average:169.84 Median:169.84 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 169.8 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 279.5 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 5284.2 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#4] RayTrace Cycles:1 Average:920.81 Median:920.81 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 920.8 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#5] Earley Cycles:1 Average:570.78 Median:570.78 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 570.8 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#6] Boyer Cycles:1 Average:11144.44 Median:11144.44 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 11144.4 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#7] RegExp Cycles:1 Average:39442.31 Median:39442.31 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 39442.3 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#8] Splay Cycles:1 Average:523.56 Median:523.56 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 523.6 05:49:46 INFO - PROCESS | 3135 | 05:49:46 INFO - PROCESS | 3135 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:49:46 INFO - PROCESS | 3135 | Values: 4826.9 05:49:46 INFO - PROCESS | 3135 | -------- Summary: end -------- 05:49:46 INFO - PROCESS | 3135 | 05:49:47 INFO - TEST-INFO | 3135: exit 0 05:49:47 INFO - TEST-OK | v8_7 | took 40402ms 05:49:47 INFO - SUITE-END | took 1207s 05:49:47 INFO - Completed test suite (00:20:08) 05:49:47 INFO - Working with test: dromaeo_css 05:49:47 INFO - Generating results file: dromaeo_css 05:49:47 INFO - Working with test: kraken 05:49:47 INFO - Generating results file: kraken 05:49:47 INFO - javascript benchmark 05:49:47 INFO - Working with test: v8_7 05:49:47 INFO - Generating results file: v8_7 05:49:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:49:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:49:47 INFO - process_Request line: dromaeo_css 7292.96 graph.html#tests=[[72,52,43]] 05:49:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:49:47 INFO - process_Request line: kraken 1490.80 graph.html#tests=[[232,52,43]] 05:49:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:49:47 INFO - process_Request line: v8_7 21929.91 graph.html#tests=[[230,52,43]] 05:49:47 INFO - RETURN: dromaeo_css: 7292.96 05:49:47 INFO - RETURN: kraken: 1490.80 05:49:47 INFO - RETURN: v8_7: 21929.91 05:49:47 INFO - javascript benchmark 05:49:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3334.3998080345536, 3365.360581489517, 3379.6958273755386, 3401.676840700133, 3403.1832360233534, 5378.784848606056, 5398.541124004464, 5424.728763561816, 5432.212329212267, 5466.316710411199, 5402.756875940582, 5424.728763561816, 5452.945470545294, 5468.0977638689565, 5471.452854714526, 4985.1026815173345, 5023.995200959805, 5082.3138876251605, 5102.1836506159025, 5113.744312784346, 4823.710577365352, 4981.476944920767, 4983.302337672729, 4984.352034235562, 5082.364704411949, 5004.649674522785, 5006.173981293082, 5047.848564543069, 5051.191809310511, 5057.41839688435, 5014.348134742479, 5018.673786203885, 5029.245613158019, 5033.370828646419, 5055.0900837848985, 4814.964782571729, 4903.63222758291, 4916.410030796292, 4944.579710724593, 4963.478834722338, 5245.239440281176, 5266.7629956652045, 5267.367915850123, 5274.97362513185, 5321.122014867542, 5806.303243610751, 5823.388544202882, 5843.2695913010875, 5853.824385268449, 5859.6777177255235, 5735.512481439041, 5834.708264586754, 5846.912296315559, 5848.2689663792025, 5899.882002359929, 5417.241586177938, 5420.430854760272, 5434.239206511052, 5449.536789372908, 5458.4814442627885, 5916.645001299936, 5936.436038576328, 5943.732532036069, 5945.464908158287, 5957.940420595825, 5635.408282130399, 5702.372738998707, 5713.857153571194, 5726.141078838207, 5832.795852145155, 5838.620489668158, 5840.211571437886, 5842.036064049385, 5858.179854820329, 5867.823965281048, 5764.625299355528, 5794.21778059965, 5826.737796799154, 5827.650340979555, 5854.502367298742, 5543.390227075019, 5642.294713160855, 5681.829545113653, 5805.651660900359, 5813.476787089182, 4436.755978421218, 4491.079328737601, 4497.9325310120375, 4505.6846020778885, 4507.121111383249, 3942.3495123304333, 4030.8790736277374, 4057.9797101014897, 4075.4294398784195, 4090.141070375195, 5373.38206106295, 5479.232907392969, 5561.443855614406, 5616.66300022, 5668.801591944262, 5792.362840087587, 5823.359430462646, 5836.358000619928, 5848.8537786554825, 5856.209411729362, 5391.676499409969, 5461.672299662033, 5520.144377621395, 5543.6396634218645, 5545.61180717354, 4977.601791856643, 5007.324011258506, 5037.949620503821, 5039.992001599695, 5098.107831129611, 5913.852153696192, 5950.583459157818, 5961.314448838439, 5999.0, 6008.909866352008, 5860.677662728591, 5880.500157486662, 5887.67617781009, 5902.763889444374, 5903.085021821625, 5796.072628379439, 5817.94182058174, 5965.940340596539, 6068.757249709962, 6081.391860813883, 5688.089905615082, 5689.175069614966, 5723.8855222896145, 5730.770769169187, 5751.884962300815, 5718.256626638677, 5817.650940943557, 5831.562632802642, 5848.181254624271, 5864.472197502245, 5617.606767526234, 5630.352509461464, 5729.828105156852, 5817.272840894888, 5872.765089396376, 5743.798967036134, 5769.884602307847, 5771.797987070432, 5772.797952071657, 5789.421057894177, 5619.971900140473, 5668.376478587435, 5671.347795003628, 5692.1461780733225, 5693.5445164387575, 5558.722063896708, 5570.637908535932, 5670.489655930986, 5678.3186017678145, 5712.0860662293835, 5604.439556044363, 5604.915926261027, 5607.579431542569, 5644.85887852807, 5659.037963546125], "unit": "score", "name": "dojo.html", "value": 5384.1308264345535}, {"lowerIsBetter": false, "replicates": [557.5567423898001, 574.8591595059208, 577.965322080675, 592.8399332180314, 596.9462748352651, 36324.455133173025, 37159.256814863686, 37202.813985930035, 37289.06777330568, 37386.25227495449, 40460.393094103536, 41025.179496410055, 41073.0, 41108.794456027754, 41220.38169427453, 8695.087015863322, 8980.550972451383, 9062.909370906305, 9087.136722011432, 9096.13586709265, 8723.825523489526, 8836.0722124177, 8926.642934282621, 8947.731568052968, 8975.910240897605, 8944.373893827435, 8954.417962832395, 9022.188003079722, 9023.09769023099, 9023.864642030341, 8741.12588741124, 8916.554172291391, 8975.640974361051, 8980.281577473786, 8992.055834137453, 8706.434081784664, 8823.911760882373, 8855.911440885637, 8872.645094196225, 8881.378303518757, 40437.393439098436, 40829.38755918664, 40968.18063638711, 40988.59011409878, 40995.795021025006, 3657.817109144559, 3767.4913886625504, 3886.047918260016, 4001.6598589119667, 4209.452771139763, 26596.60105098425, 27185.72814271852, 27525.44949101027, 33144.3371132576, 33246.335073298644, 3996.0, 4088.795560221977, 4104.8152833122285, 4112.938305925413, 4177.874663760092, 229743.0, 234135.0, 236130.0, 237162.0, 237582.0, 46746.0, 47012.0, 60636.696816515636, 61885.69057154685, 62138.37861621416, 46073.76963115163, 46441.53558464372, 46648.53351466442, 46684.5331546687, 46840.7657961708, 16562.58593535171, 16580.0, 16642.16789160537, 16682.916585416995, 16745.246463909152, 13122.934385328012, 13198.406071726795, 13276.203427794364, 13300.866991329964, 13338.866611333957, 15411.845881541041, 15476.458323958832, 15778.211089445482, 15958.0, 16101.11443870575, 6442.452391546677, 6469.288378278386, 6540.215174179034, 6655.301193374626, 6658.733650654017, 1054.9683509494728, 1084.7776205877776, 1133.3539882267194, 1180.0972256223995, 1184.875588063241, 27500.0, 32059.51910721341, 32100.0, 32425.189370265933, 33107.834460828024, 1141.092831199182, 1207.7403358278013, 1251.1992324912064, 1257.5221415861913, 1265.4368805881295, 15707.68584628301, 15762.290696918666, 15889.126098064717, 15921.920390397974, 16185.0, 433934.0, 552016.0, 554986.0, 556269.0, 849179.0, 53457.7327113362, 53781.0, 53872.76763394209, 53888.19167712487, 54281.0, 1496.2294418374545, 1514.7273490771547, 1515.7343618078808, 1519.5821149184062, 1526.381815364779, 29088.56367154452, 30038.69961300359, 30154.547681784352, 31133.53299700461, 32360.676393236707, 47758.522414775405, 47867.0, 47890.0, 48062.0, 48095.0, 311037.0, 311795.0, 314407.0, 315529.0, 317112.0, 43763.78118109517, 44364.0, 44515.77742111269, 44631.33053004143, 44661.0, 41387.7930610345, 41617.37573936333, 41711.0, 42135.0, 53672.0, 39372.0, 39966.80016599898, 40836.0, 40913.33359812579, 43658.34512482252, 42414.78792606017, 42595.78702106594, 42688.57311426846, 42839.14321713486, 43194.56805432031, 42367.3644895333, 42758.57241427546, 43055.354169686856, 43268.0, 43511.78244108759, 37511.62488375081, 37547.436788448744, 37547.624523755505, 38045.80977095097, 38690.0, 28948.27629309284, 30064.84967575148, 30071.0, 30283.545746813375, 30591.54112688267], "unit": "score", "name": "ext.html", "value": 19614.594848158773}, {"lowerIsBetter": false, "replicates": [398.26520070469974, 398.4103526780367, 402.17554014270746, 402.9456023436836, 404.1855660843401, 14505.274736263198, 15267.618309542268, 16836.49490515285, 17651.73522397165, 17756.0, 11589.53641854327, 11887.286762794238, 16151.919240403782, 17583.73624395632, 17592.0, 4918.360613120299, 5301.390340110898, 5487.890242195153, 5492.286002819628, 5502.064649009678, 3883.669888059504, 4180.435641188446, 5396.568274538027, 6090.3909609038965, 6099.57302988791, 5847.181394604759, 6036.547258955574, 6068.605540639866, 6086.695665216744, 6102.847428814271, 6070.119832624289, 6073.453389194971, 6088.45203931646, 6107.236595425572, 6110.022396416574, 5312.150055991062, 5419.729013549307, 5438.483344082306, 5445.074337362618, 5452.1276595744885, 13627.182369057888, 14455.855441445661, 20292.08685609151, 20805.791942080537, 20949.79050209509, 2252.5044490212126, 2268.126771193086, 2345.0519404057427, 2351.341624345186, 2403.0219670693305, 9931.404115753006, 12467.501299947991, 13646.727065458635, 13848.653783655389, 13967.231802250872, 1828.195593938676, 1859.665260253154, 1880.4734674291221, 1881.5108071901268, 1956.491312258823, 58549.0, 59852.40147598512, 61960.0, 62005.6899715503, 62191.0, 10288.588456461808, 10695.572177112985, 10707.250492465453, 10731.517081731341, 10841.945790270998, 13816.585502434944, 13974.720505590034, 14021.369038393297, 14032.08791428554, 14172.362243699059, 7888.723894663659, 7908.090569584457, 7944.324732397696, 8177.713780017671, 8210.671573137008, 7558.58427786466, 7574.242575742492, 7598.088229412506, 7634.961825190839, 7987.800304992422, 4547.8635640930825, 4665.043666048452, 4665.136949664323, 4763.595094416944, 4845.200541910615, 1988.2345297060735, 2017.3846976671962, 2026.1591439552715, 2036.521417466894, 2038.9184432622528, 905.2531661379388, 996.2229461020415, 1054.9050585447194, 1086.1658346038496, 1091.4542728635681, 16778.58053548671, 17190.484285471455, 17357.0, 17637.7354339685, 17833.46499605014, 999.5801763259449, 1002.0680766886719, 1013.6705570689555, 1028.1312291113998, 1033.7622346860114, 6169.598976066542, 6481.837954051187, 6507.219133703891, 6520.47836173105, 9601.32790704644, 562613.0, 574646.0, 597452.0, 645320.0, 652363.0, 45534.31698524525, 48119.75940120347, 50007.24989125166, 71733.64133179301, 71991.92012119823, 488.1262540053336, 502.1764306537282, 505.89376230991166, 507.9111155547764, 512.0348143749134, 10447.738806529898, 10777.353358798497, 14999.7000059996, 15016.924915375354, 15672.451464199154, 34150.730487604116, 34433.82783086068, 35653.46519802257, 37858.43212351872, 39157.2168556633, 42628.78685606552, 45768.77115614401, 48225.75887120542, 48771.5122848767, 51343.48656513387, 7509.098908131059, 7640.9617951912105, 7784.377249820114, 7861.410394220571, 7967.00412448444, 3793.146542028132, 4490.797914093939, 9186.724398268063, 11072.224944253825, 11468.827967580326, 10606.363618182933, 10712.089472394622, 11054.281471704313, 11127.109831213646, 11183.72040698989, 10223.539940702834, 10390.0, 10501.159907207253, 10731.248812583044, 11121.999020087907, 10340.327878687862, 10368.740781480523, 10409.791804164026, 11030.834537482106, 11043.503042363274, 7494.400447964041, 7535.450369482549, 7890.566018868788, 7929.167437418988, 7948.3641308694005, 8607.440516366416, 10497.632582859564, 10640.787184256116, 10709.250352475252, 10785.245032847626], "unit": "score", "name": "jquery.html", "value": 8230.626134702507}, {"lowerIsBetter": false, "replicates": [1541.814982202136, 1560.8361122082179, 1781.2340693501797, 1864.2822513332362, 1897.639448504784, 8393.370497212703, 8493.0, 8616.827663446735, 8630.525321107345, 8647.69733059343, 8647.264982476481, 8698.217160455557, 8730.0, 8785.560721963891, 8809.691660791874, 2431.1734010436403, 2444.4377793107597, 2469.1111199967995, 2474.455619763658, 2478.764517370847, 2487.2413913756295, 2499.4001439654535, 2518.181590982929, 2525.8105642076825, 2529.557327467695, 1991.163711241275, 2037.8981050947393, 2402.9639555406684, 2446.963295550568, 2473.1591258972035, 2376.0970831084164, 2380.0955636858057, 2396.149366974725, 2406.5908795504806, 2406.7713567211263, 2358.127492827665, 2413.79482743967, 2423.9151629692874, 2424.2121310573957, 2428.57499937512, 8558.315334773204, 8559.058503564604, 8561.400701950866, 8572.485650860906, 8591.656333746643, 5129.743512824344, 5283.973580132113, 5306.230596563477, 5314.176302673091, 5326.041312563737, 3219.404410184123, 3262.265990152197, 3351.8994430167136, 3365.9831700841582, 3376.40912840252, 1103.2056919018373, 1122.7698321844002, 1130.0676941523277, 1144.0390072339276, 1161.9883801161964, 11507.654770356903, 11566.710832229177, 11594.188406811527, 11633.243839150513, 11711.297322160783, 4462.509123996358, 4481.484629267611, 4500.167469018242, 4535.659825513099, 4548.090381923628, 9501.192398646055, 9509.857352139723, 9510.191633711074, 9510.429374237568, 9512.762180945394, 5074.061298659686, 5108.157154069611, 5129.076766182048, 5132.255822905658, 5140.40885298188, 4663.976680116578, 4721.834735784231, 4738.881527961759, 4739.644526660514, 4751.358566593535, 3813.733038687321, 3818.0645741792882, 3821.0, 3838.654521093115, 3865.2269546090893, 1167.9708007299885, 1171.22699018649, 1176.6999415149253, 1180.0823661549982, 1205.879412058787, 948.9430634161972, 951.6954574536082, 1045.6810672744734, 1050.3540322701483, 1274.6685861675846, 8010.375876088118, 8014.679412823539, 8096.797580060428, 8105.392095592854, 8131.2681858633005, 1212.921160124589, 1224.0574757436902, 1226.2948804437485, 1226.5461779141774, 1251.9749605007848, 6437.871242575216, 6462.612243265419, 6490.967545162244, 6503.089567460559, 6525.4779617630475, 10188.286819922683, 10903.34579925207, 11005.229633925548, 11008.0, 11015.889841101647, 10674.466276686135, 10804.567817287378, 10839.620613278656, 10842.457877106113, 10931.836022459669, 8254.257116859511, 8261.0, 8310.875336869953, 8351.956005499313, 8359.916400836035, 7693.076830780342, 7711.151773305044, 7714.537127772352, 7768.300852923264, 7823.335016523659, 8980.955095224483, 9150.359474836698, 9606.951965240129, 9677.951610241904, 9703.9029609703, 9300.906990930274, 9363.297752668714, 9402.059794020543, 9504.524773761146, 9510.191633711212, 7462.365698915653, 7494.250574942462, 7501.774946751606, 7517.0, 7570.9242907570215, 8058.3553315733425, 8227.177282271725, 8254.628541715518, 8263.091059983277, 8275.793105172419, 6868.656567171722, 7559.848803023799, 7621.3902887769955, 7636.847263054597, 7762.41781866351, 7232.0959880015, 7488.475806693479, 7538.585377804054, 7630.504017238862, 7643.961780191064, 7639.732609358646, 7652.7704168875025, 7679.654415551202, 7700.422468314787, 7732.0, 6827.863442731018, 6852.6231057292325, 6914.757983470555, 6920.446364290945, 7112.03987461686, 7313.122425308997, 7342.743003995049, 7367.889481657887, 7373.9262607375385, 7382.9630851845395], "unit": "score", "name": "mootools.html", "value": 4877.029865766305}, {"lowerIsBetter": false, "replicates": [362.3369234301229, 369.9944500832487, 377.69972871567103, 379.59573054696745, 383.1799948111041, 6326.873462530747, 6407.583507072043, 6459.677016149197, 6474.67626618669, 6498.805035848932, 6339.732053589278, 6343.873122537547, 6346.492280617551, 6346.841328966778, 6382.7446902123975, 4847.369841920563, 4892.8532144035735, 4893.29047288143, 4911.8772030699165, 4915.778789954461, 4869.977304766004, 4872.926906096412, 4895.31465594817, 4900.58345040672, 4921.926171107436, 4513.3455648930885, 4698.624110071203, 4777.18787806072, 4872.244802055669, 4873.805047798084, 4826.0, 4853.0779151961015, 4863.294822250789, 4881.41423029237, 4887.902241955158, 4235.216484950294, 4255.063885945087, 4259.020425302167, 4265.829366825324, 4268.679849011305, 5980.461758441761, 5981.880362392728, 6013.188219590343, 6013.308469525973, 6042.425969532887, 5431.6740995540395, 5499.395066542677, 5556.972215138939, 5647.0, 5688.260526131618, 6651.501137414665, 6663.566868153603, 6685.231198412196, 6693.531452798306, 6694.866102677968, 4638.420197475316, 4645.86062418128, 4646.186917289461, 4651.209294419923, 4652.674312798105, 6825.542804590344, 6984.266652001517, 7006.614636194956, 7050.153981522199, 7058.294170582901, 4829.492903245179, 4834.734089625104, 4837.32277481153, 4840.031993601294, 4859.562639362474, 4899.8285060023445, 4901.215805471107, 4903.632227582945, 4907.779149938261, 4915.754212289371, 5631.099024156116, 5644.858878527987, 5645.717714114277, 5648.0, 5656.349519805275, 6663.6001839888795, 6748.29142939994, 6769.458443324522, 6777.966110169417, 6789.626570538668, 1697.73685078813, 1729.2045658996751, 1732.5581976595888, 1733.3153404405189, 1733.5406117378905, 1159.5941420502757, 1168.4683469021575, 1183.8224266359944, 1185.359905650956, 1185.5909711149638, 6476.384743449365, 6510.967445162744, 6517.055027021055, 6518.315576864361, 6519.511036672268, 6894.689738961759, 6915.930840691529, 6924.4114250289285, 6925.515213934977, 6952.026716259727, 6463.256725476536, 6511.641859697762, 6516.120323756327, 6591.505637077238, 6601.603903765789, 3746.8875933722034, 3769.1896242308035, 3792.7345085844277, 3811.9898226969876, 3812.3519001769764, 7255.927440725525, 7270.127584689871, 7278.672459739324, 7295.124585049722, 7308.049953506116, 7109.644517774194, 7190.101237345332, 7221.747238846615, 7281.927180728125, 7286.162091359455, 7144.857102858018, 7260.056192694916, 7265.600391978386, 7276.927230727731, 7288.6720097595735, 6989.706904222735, 7025.473089518205, 7026.086608741035, 7040.401565866754, 7045.682944267623, 6750.392464678006, 6960.756373526902, 6977.895331569929, 6990.790276291719, 6998.335158159966, 7291.635418229173, 7301.634918254173, 7311.817204569928, 7324.560526368435, 7327.4504412168235, 4845.9757701211265, 4875.585575226146, 4876.4392094909535, 4878.341423907869, 4883.902321953612, 6867.278935711678, 7036.401905838061, 7074.257202993612, 7090.1491820979745, 7110.288971103055, 6837.863242735217, 6855.07456493367, 6860.656967151523, 6879.415249703831, 6886.035954966209, 6673.299303573055, 6824.897626535705, 6829.795106146824, 6832.555883867532, 6840.31596840312, 6701.229358623626, 6705.4635629150525, 6707.396334329934, 6714.697838597177, 6745.156855393076, 6822.317768223138, 6824.0, 6849.315068493111, 6865.759698410531, 6866.588004719732, 6541.0, 6656.30108838565, 6692.59844409337, 6715.026321183499, 6730.057791909235], "unit": "score", "name": "prototype.html", "value": 5125.926547698922}, {"lowerIsBetter": false, "replicates": [916.2074805293423, 916.5142474488522, 922.4096578189956, 924.2811833570008, 932.0260327957286, 14430.062045967004, 14736.926315368408, 14763.557093287218, 14788.334524946376, 14795.630109247275, 12815.359232038383, 12857.35713214338, 12907.483700651963, 12954.935225323883, 13016.349182540858, 869.326272139091, 891.6433426629352, 906.8458362078462, 906.9093090690944, 907.8683590879318, 885.6103314541614, 887.529609307065, 891.9910800892005, 893.2362829780542, 899.0110878034176, 903.2322525853006, 908.5094049213417, 911.8221946720392, 912.3704643795793, 917.0508523677995, 902.733693560398, 905.5789058087988, 906.9954650226707, 907.0657223060225, 907.4464576608264, 666.1140682891743, 668.378408080485, 668.5353679192963, 673.1014096181603, 673.9258681545026, 14843.703125937422, 14961.0, 14965.551033469013, 14985.625359365995, 15080.698386032218, 13610.944330592565, 13639.454421823115, 13659.975501837402, 13670.248136352497, 13894.305284735723, 10661.893381066167, 10988.670339889815, 11470.942645286803, 11726.530938762438, 11922.642320730392, 3834.830376735095, 3846.3461211594094, 3856.421536769479, 3882.1847412043503, 3930.9582960515486, 51576.22635660468, 52009.479905201224, 52292.73853630746, 52345.0, 52430.21354679645, 10354.689359319233, 10494.895051049545, 10547.472626368652, 10556.630517931835, 10579.735506612396, 18729.344472943652, 18747.531311717044, 18782.436526904214, 18840.05799710009, 19259.422217333504, 8161.632726527202, 8173.223543763333, 8312.8337433251, 8344.749657510285, 8355.164483551718, 4649.093426781813, 4775.2359622460235, 4779.378680771478, 4818.229083346648, 4908.852734417973, 3096.8916087936814, 3137.215696075981, 3257.4625186843905, 3265.6407795142513, 3272.689094536015, 607.5534482155612, 609.0802887639696, 613.5858295650418, 616.4359610956014, 619.2568917299259, 689.5931400473745, 709.3651182192012, 741.4772585327331, 742.6472425597906, 771.4946709905021, 8854.203121719076, 9105.271578273721, 9171.587278572346, 9173.724788256362, 9185.357025008185, 753.9924600753923, 759.369723129801, 760.9657565409569, 778.1595876453416, 783.3185128937747, 4490.281554951192, 4760.976195119002, 4822.324874517571, 4867.294242334912, 4970.030843985388, 60190.0, 60286.39713602896, 63005.68497157485, 63142.36857631457, 63304.0, 53922.0, 55289.0, 55483.72258138764, 55515.950187222625, 55613.0, 49725.25412118821, 50196.49803501918, 50265.74867125641, 50319.49680503221, 50610.0, 8768.386212965032, 9037.909620903969, 9251.167394934488, 9377.437353758796, 9412.482313472825, 36567.63432365749, 36900.0, 37076.0, 37343.81328093342, 37639.435408468344, 46704.532954670016, 47027.059458811316, 47469.0, 47775.76112119417, 48089.75955120202, 11406.828897566376, 11753.588624398106, 12269.549263648818, 12336.198147120409, 12463.626091217278, 13648.317584120952, 13862.93068534651, 13937.163770173822, 14290.142591444546, 14383.0, 13023.934880325538, 13350.732985340434, 13462.663433414244, 13463.259520726062, 13691.657708556968, 12713.745725085631, 12825.679358016125, 13128.803067953797, 13437.529686460926, 13614.115082519604, 12702.174358666656, 13066.412011459317, 13429.194248345131, 13546.72906541844, 13683.315834208448, 10143.442110683984, 10237.129843963347, 10238.0, 10452.529636166239, 10545.841812372668, 11060.281081729661, 11470.139739519402, 11544.59593914209, 11610.6516804496, 11618.302901825917], "unit": "score", "name": "yui.html", "value": 6923.5838469932005}], "name": "dromaeo_css", "value": 7292.9553630605715}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 112.0, 111.0, 110.0, 120.0, 111.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 157.0, 162.0, 132.0, 161.0, 163.0, 131.0, 158.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 162.0, 161.0, 168.0, 161.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 156.0, 72.0, 74.0, 75.0, 73.0, 148.0, 72.0], "unit": "score", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 95.0, 97.0, 96.0, 140.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 150.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 97.0, 97.0, 97.0, 98.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 55.0, 59.0, 56.0, 56.0, 56.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 68.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [94.0, 83.0, 81.0, 83.0, 83.0, 82.0, 83.0, 82.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [107.0, 113.0, 109.0, 113.0, 120.0, 112.0, 116.0, 119.0, 117.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.7}, {"lowerIsBetter": true, "replicates": [124.0, 134.0, 136.0, 128.0, 138.0, 138.0, 135.0, 134.0, 137.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.1}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 70.0, 65.0, 71.0, 65.0, 64.0, 64.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1490.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [169.83695652173913], "unit": "score", "name": "DeltaBlue", "value": 389.302784}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [920.8103130755064], "unit": "score", "name": "RayTrace", "value": 803.6280540000001}, {"lowerIsBetter": false, "replicates": [570.7762557077625], "unit": "score", "name": "Earley", "value": 1167.6431760000005}, {"lowerIsBetter": false, "replicates": [11144.444444444445], "unit": "score", "name": "Boyer", "value": 59.80226321036885}, {"lowerIsBetter": false, "replicates": [39442.307692307695], "unit": "score", "name": "RegExp", "value": 23.096645538761575}, {"lowerIsBetter": false, "replicates": [523.5602094240837], "unit": "score", "name": "Splay", "value": 155.64781000000008}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21929.912643085332}]} 05:49:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21929.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1490.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7292.96"}}} 05:49:47 INFO - Return code: 0 05:49:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:49:47 INFO - # TBPL SUCCESS # 05:49:47 INFO - Running post-action listener: _resource_record_post_action 05:49:47 INFO - Running post-run listener: _resource_record_post_run 05:49:48 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 266240; Write bytes: 497758208; Read time: 192; Write time: 440508 05:49:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 216162304; Read time: 0; Write time: 251544 05:49:48 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 266240; Write bytes: 258183168; Read time: 192; Write time: 168380 05:49:48 INFO - Running post-run listener: _upload_blobber_files 05:49:48 INFO - Blob upload gear active. 05:49:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:49:48 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:49:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:49:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:49:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:50 INFO - (blobuploader) - INFO - Done attempting. 05:49:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:49:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:50 INFO - (blobuploader) - INFO - Done attempting. 05:49:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:50 INFO - Return code: 0 05:49:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:49:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b3d78f7a737efaff24979b307015fd8109d2121fcf2c8c8c609cb338bf7752d81bad1a91e11b7fc6ac526bdbee2c6975c16d767790087dfdf7c47605350b722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f81aa6415df8b04eeae2d909e378f535a25c3b37a3b08a6dca152629abc50c8cc9b37c0ff79c3b5982011472b143b3e22bea384757f982d12c8b89d876fce66"} 05:49:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:49:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:49:50 INFO - Contents: 05:49:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b3d78f7a737efaff24979b307015fd8109d2121fcf2c8c8c609cb338bf7752d81bad1a91e11b7fc6ac526bdbee2c6975c16d767790087dfdf7c47605350b722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f81aa6415df8b04eeae2d909e378f535a25c3b37a3b08a6dca152629abc50c8cc9b37c0ff79c3b5982011472b143b3e22bea384757f982d12c8b89d876fce66"} 05:49:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:50 INFO - Copying logs to upload dir... 05:49:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:49:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.182724 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-04 05:49:50.599243) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 05:49:50.602914) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 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/5b3d78f7a737efaff24979b307015fd8109d2121fcf2c8c8c609cb338bf7752d81bad1a91e11b7fc6ac526bdbee2c6975c16d767790087dfdf7c47605350b722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f81aa6415df8b04eeae2d909e378f535a25c3b37a3b08a6dca152629abc50c8cc9b37c0ff79c3b5982011472b143b3e22bea384757f982d12c8b89d876fce66"} build_url:https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011474 build_url: 'https://queue.taskcluster.net/v1/task/NuOqiTy5RmuaS_EkXm6WUQ/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/5b3d78f7a737efaff24979b307015fd8109d2121fcf2c8c8c609cb338bf7752d81bad1a91e11b7fc6ac526bdbee2c6975c16d767790087dfdf7c47605350b722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f81aa6415df8b04eeae2d909e378f535a25c3b37a3b08a6dca152629abc50c8cc9b37c0ff79c3b5982011472b143b3e22bea384757f982d12c8b89d876fce66"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 05:49:50.767631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:49:50.768009) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454592510.749078-569610843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:49:50.784366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 05:49:50.784686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 05:49:50.784985) ========= ========= Total master_lag: 0.36 =========