builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1457112290.17 results: success (0) buildid: 20160304065240 builduid: d1d8a19f621b41bfac298f3dfc80ab8f revision: 02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.173385) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.173879) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.174242) ========= 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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004302 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.191715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.192055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.203701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.204080) ========= 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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.253718) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.254018) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.254428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.254712) ========= 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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 09:24:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.6M=0s 2016-03-04 09:24:50 (89.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.419947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.420479) ========= 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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023555 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.470528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:50.470883) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f --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 02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f --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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 09:24:50,723 truncating revision to first 12 chars 2016-03-04 09:24:50,724 Setting DEBUG logging. 2016-03-04 09:24:50,724 attempt 1/10 2016-03-04 09:24:50,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/02c5b4300a04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 09:24:50,989 unpacking tar archive at: mozilla-aurora-02c5b4300a04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610304 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:51.094437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:51.094864) ========= echo 02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f'] 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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f program finished with exit code 0 elapsedTime=0.004191 script_repo_revision: '02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:51.144633) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:51.145090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 09:24:51.155061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-04 09:24:51.155447) ========= /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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:24:51 INFO - MultiFileLogger online at 20160304 09:24:51 in /builds/slave/test-pgo 09:24:51 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 09:24:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:24:51 INFO - {'append_to_log': False, 09:24:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:24:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:24:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:24:51 INFO - 'branch': 'Mozilla-Aurora', 09:24:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:51 INFO - 'config_files': ('talos/linux_config.py',), 09:24:51 INFO - 'default_actions': ('clobber', 09:24:51 INFO - 'read-buildbot-config', 09:24:51 INFO - 'download-and-extract', 09:24:51 INFO - 'populate-webroot', 09:24:51 INFO - 'create-virtualenv', 09:24:51 INFO - 'install', 09:24:51 INFO - 'run-tests'), 09:24:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:51 INFO - 'download_minidump_stackwalk': True, 09:24:51 INFO - 'download_symbols': 'ondemand', 09:24:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:51 INFO - 'installer_path': 'installer.exe', 09:24:51 INFO - 'log_level': 'info', 09:24:51 INFO - 'log_name': 'talos', 09:24:51 INFO - 'log_to_console': True, 09:24:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:24:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:24:51 INFO - 'opt_config_files': (), 09:24:51 INFO - 'pip_index': False, 09:24:51 INFO - 'sps_profile': False, 09:24:51 INFO - 'sps_profile_interval': 0, 09:24:51 INFO - 'suite': 'dromaeojs-e10s', 09:24:51 INFO - 'system_bits': '32', 09:24:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:51 INFO - 'title': 'talos-linux64-ix-045', 09:24:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:51 INFO - 'use_talos_json': True, 09:24:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:24:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:51 INFO - 'work_dir': 'build'} 09:24:51 INFO - ##### 09:24:51 INFO - ##### Running clobber step. 09:24:51 INFO - ##### 09:24:51 INFO - Running pre-action listener: _resource_record_pre_action 09:24:51 INFO - Running main action method: clobber 09:24:51 INFO - rmtree: /builds/slave/test-pgo/build 09:24:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:24:51 INFO - Running post-action listener: _resource_record_post_action 09:24:51 INFO - ##### 09:24:51 INFO - ##### Running read-buildbot-config step. 09:24:51 INFO - ##### 09:24:51 INFO - Running pre-action listener: _resource_record_pre_action 09:24:51 INFO - Running main action method: read_buildbot_config 09:24:51 INFO - Using buildbot properties: 09:24:51 INFO - { 09:24:51 INFO - "project": "", 09:24:51 INFO - "product": "firefox", 09:24:51 INFO - "script_repo_revision": "production", 09:24:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:24:51 INFO - "repository": "", 09:24:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:24:51 INFO - "buildid": "20160304065240", 09:24:51 INFO - "pgo_build": "True", 09:24:51 INFO - "basedir": "/builds/slave/test-pgo", 09:24:51 INFO - "buildnumber": 206, 09:24:51 INFO - "slavename": "talos-linux64-ix-045", 09:24:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:24:51 INFO - "platform": "ubuntu64_hw", 09:24:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:24:51 INFO - "branch": "mozilla-aurora", 09:24:51 INFO - "repo_path": "releases/mozilla-aurora", 09:24:51 INFO - "revision": "02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f", 09:24:51 INFO - "stage_platform": "linux64-pgo", 09:24:51 INFO - "builduid": "d1d8a19f621b41bfac298f3dfc80ab8f", 09:24:51 INFO - "slavebuilddir": "test" 09:24:51 INFO - } 09:24:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 09:24:51 INFO - Running post-action listener: _resource_record_post_action 09:24:51 INFO - ##### 09:24:51 INFO - ##### Running download-and-extract step. 09:24:51 INFO - ##### 09:24:51 INFO - Running pre-action listener: _resource_record_pre_action 09:24:51 INFO - Running main action method: download_and_extract 09:24:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:24:51 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')]} 09:24:51 INFO - https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/test_packages.json 09:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/test_packages.json 09:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:24:52 INFO - Downloaded 1448 bytes. 09:24:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:24:52 INFO - Using the following test package requirements: 09:24:52 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:24:52 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:24:52 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:24:52 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'jsshell-linux-x86_64.zip'], 09:24:52 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:24:52 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:24:52 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:24:52 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:24:52 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:24:52 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:24:52 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:52 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:24:52 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:52 INFO - https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:24:53 INFO - Downloaded 23089490 bytes. 09:24: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'] 09:24: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 09:24:54 INFO - Return code: 0 09:24:54 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 09:24: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')]} 09:24:54 INFO - https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:24:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:24:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:24:56 INFO - Downloaded 23089490 bytes. 09:24:56 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'] 09:24:56 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 09:24:57 INFO - Return code: 0 09:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:57 INFO - https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:24:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:24:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:24:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:24:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:24:58 INFO - Downloaded 10801536 bytes. 09:24:58 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'] 09:24:58 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 09:24:59 INFO - Return code: 0 09:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:59 INFO - https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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 09:25:00 INFO - Downloaded 59972996 bytes. 09:25:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:25:00 INFO - mkdir: /builds/slave/test-pgo/properties 09:25:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:25:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:25:00 INFO - Contents: 09:25:00 INFO - build_url:https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:25:01 INFO - Running post-action listener: _resource_record_post_action 09:25:01 INFO - Running post-action listener: set_extra_try_arguments 09:25:01 INFO - ##### 09:25:01 INFO - ##### Running populate-webroot step. 09:25:01 INFO - ##### 09:25:01 INFO - Running pre-action listener: _resource_record_pre_action 09:25:01 INFO - Running main action method: populate_webroot 09:25:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:01 INFO - '--tppagecycles', 09:25:01 INFO - '7'], 09:25:01 INFO - 'tests': ['tsvgm']}}, 09:25:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:25:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:25:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:25:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'tests': ['damp', 'tps']}, 09:25:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['damp', 'tps']}, 09:25:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:25:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:01 INFO - 'other': {'tests': ['a11yr', 09:25:01 INFO - 'ts_paint', 09:25:01 INFO - 'tpaint', 09:25:01 INFO - 'sessionrestore', 09:25:01 INFO - 'sessionrestore_no_auto_restore']}, 09:25:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['a11yr', 09:25:01 INFO - 'ts_paint', 09:25:01 INFO - 'tpaint', 09:25:01 INFO - 'sessionrestore', 09:25:01 INFO - 'sessionrestore_no_auto_restore']}, 09:25:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['a11yr', 09:25:01 INFO - 'ts_paint', 09:25:01 INFO - 'tpaint', 09:25:01 INFO - 'sessionrestore', 09:25:01 INFO - 'sessionrestore_no_auto_restore']}, 09:25:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['a11yr', 09:25:01 INFO - 'ts_paint', 09:25:01 INFO - 'tpaint', 09:25:01 INFO - 'sessionrestore', 09:25:01 INFO - 'sessionrestore_no_auto_restore']}, 09:25:01 INFO - 'other_l64': {'tests': ['a11yr', 09:25:01 INFO - 'ts_paint', 09:25:01 INFO - 'tpaint', 09:25:01 INFO - 'sessionrestore', 09:25:01 INFO - 'sessionrestore_no_auto_restore']}, 09:25:01 INFO - 'other_nol64': {'tests': ['a11yr', 09:25:01 INFO - 'ts_paint', 09:25:01 INFO - 'tpaint', 09:25:01 INFO - 'sessionrestore', 09:25:01 INFO - 'sessionrestore_no_auto_restore']}, 09:25:01 INFO - 'svgr': {'tests': ['tsvgx', 09:25:01 INFO - 'tsvgr_opacity', 09:25:01 INFO - 'tart', 09:25:01 INFO - 'tscrollx', 09:25:01 INFO - 'cart']}, 09:25:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['tsvgx', 09:25:01 INFO - 'tsvgr_opacity', 09:25:01 INFO - 'tart', 09:25:01 INFO - 'tscrollx', 09:25:01 INFO - 'cart']}, 09:25:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'tests': ['tp5o']}, 09:25:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'talos_options': ['--e10s'], 09:25:01 INFO - 'tests': ['tp5o']}, 09:25:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'talos_options': ['--xperf_path', 09:25:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:01 INFO - 'tests': ['tp5n']}, 09:25:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:01 INFO - 'talos_options': ['--e10s', 09:25:01 INFO - '--xperf_path', 09:25:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:01 INFO - 'tests': ['tp5n']}}, 09:25:01 INFO - 'talos.zip': {'path': '', 09:25:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:01 INFO - Running post-action listener: _resource_record_post_action 09:25:01 INFO - ##### 09:25:01 INFO - ##### Running create-virtualenv step. 09:25:01 INFO - ##### 09:25:01 INFO - Running pre-action listener: _resource_record_pre_action 09:25:01 INFO - Running main action method: create_virtualenv 09:25:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:25:01 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 09:25:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:25:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:01 INFO - Using real prefix '/usr' 09:25:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:25:01 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:03 INFO - Installing pip.................done. 09:25:03 INFO - Return code: 0 09:25:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:25:03 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')]} 09:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 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')]} 09:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 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 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25:03 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 09:25:03 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 09:25:03 INFO - Using env: {'DISPLAY': ':0', 09:25:03 INFO - 'HOME': '/home/cltbld', 09:25:03 INFO - 'LANG': 'en_US.UTF-8', 09:25:03 INFO - 'LANGUAGE': 'en_US:en', 09:25:03 INFO - 'LOGNAME': 'cltbld', 09:25:03 INFO - 'MAIL': '/var/mail/cltbld', 09:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:03 INFO - 'MOZ_NO_REMOTE': '1', 09:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:03 INFO - 'NO_EM_RESTART': '1', 09:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:03 INFO - 'SHELL': '/bin/bash', 09:25:03 INFO - 'SHLVL': '1', 09:25:03 INFO - 'TERM': 'linux', 09:25:03 INFO - 'TMOUT': '86400', 09:25:03 INFO - 'USER': 'cltbld', 09:25:03 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:03 INFO - '_': '/tools/buildbot/bin/python'} 09:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:04 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 09:25:04 INFO - Cleaning up... 09:25:04 INFO - Return code: 0 09:25:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:25: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')]} 09:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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', '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 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:25: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 psutil>=0.7.1 09:25:04 INFO - Using env: {'DISPLAY': ':0', 09:25:04 INFO - 'HOME': '/home/cltbld', 09:25:04 INFO - 'LANG': 'en_US.UTF-8', 09:25:04 INFO - 'LANGUAGE': 'en_US:en', 09:25:04 INFO - 'LOGNAME': 'cltbld', 09:25:04 INFO - 'MAIL': '/var/mail/cltbld', 09:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:04 INFO - 'MOZ_NO_REMOTE': '1', 09:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:04 INFO - 'NO_EM_RESTART': '1', 09:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:04 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:04 INFO - 'SHELL': '/bin/bash', 09:25:04 INFO - 'SHLVL': '1', 09:25:04 INFO - 'TERM': 'linux', 09:25:04 INFO - 'TMOUT': '86400', 09:25:04 INFO - 'USER': 'cltbld', 09:25:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:04 INFO - '_': '/tools/buildbot/bin/python'} 09:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:04 INFO - Downloading/unpacking psutil>=0.7.1 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:06 INFO - Installing collected packages: psutil 09:25:06 INFO - Running setup.py install for psutil 09:25:06 INFO - building 'psutil._psutil_linux' extension 09:25:06 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 09:25:06 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 09:25:06 INFO - building 'psutil._psutil_posix' extension 09:25:06 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 09:25:06 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 09:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:06 INFO - Successfully installed psutil 09:25:06 INFO - Cleaning up... 09:25:06 INFO - Return code: 0 09:25:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:25: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')]} 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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', '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 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:25: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 mozsystemmonitor==0.0.0 09:25:06 INFO - Using env: {'DISPLAY': ':0', 09:25:06 INFO - 'HOME': '/home/cltbld', 09:25:06 INFO - 'LANG': 'en_US.UTF-8', 09:25:06 INFO - 'LANGUAGE': 'en_US:en', 09:25:06 INFO - 'LOGNAME': 'cltbld', 09:25:06 INFO - 'MAIL': '/var/mail/cltbld', 09:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:06 INFO - 'MOZ_NO_REMOTE': '1', 09:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:06 INFO - 'NO_EM_RESTART': '1', 09:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:06 INFO - 'SHELL': '/bin/bash', 09:25:06 INFO - 'SHLVL': '1', 09:25:06 INFO - 'TERM': 'linux', 09:25:06 INFO - 'TMOUT': '86400', 09:25:06 INFO - 'USER': 'cltbld', 09:25:06 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:06 INFO - '_': '/tools/buildbot/bin/python'} 09:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:25:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:25:08 INFO - Installing collected packages: mozsystemmonitor 09:25:08 INFO - Running setup.py install for mozsystemmonitor 09:25:08 INFO - Successfully installed mozsystemmonitor 09:25:08 INFO - Cleaning up... 09:25:08 INFO - Return code: 0 09:25:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:08 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 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25:08 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 09:25:08 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 09:25:08 INFO - Using env: {'DISPLAY': ':0', 09:25:08 INFO - 'HOME': '/home/cltbld', 09:25:08 INFO - 'LANG': 'en_US.UTF-8', 09:25:08 INFO - 'LANGUAGE': 'en_US:en', 09:25:08 INFO - 'LOGNAME': 'cltbld', 09:25:08 INFO - 'MAIL': '/var/mail/cltbld', 09:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:08 INFO - 'MOZ_NO_REMOTE': '1', 09:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:08 INFO - 'NO_EM_RESTART': '1', 09:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:08 INFO - 'SHELL': '/bin/bash', 09:25:08 INFO - 'SHLVL': '1', 09:25:08 INFO - 'TERM': 'linux', 09:25:08 INFO - 'TMOUT': '86400', 09:25:08 INFO - 'USER': 'cltbld', 09:25:08 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:08 INFO - '_': '/tools/buildbot/bin/python'} 09:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:10 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:25:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 INFO - Downloading docopt-0.6.1.tar.gz 09:25:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:11 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:11 INFO - Running setup.py install for blobuploader 09:25:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:25:11 INFO - Running setup.py install for requests 09:25:12 INFO - Running setup.py install for docopt 09:25:12 INFO - Successfully installed blobuploader requests docopt 09:25:12 INFO - Cleaning up... 09:25:12 INFO - Return code: 0 09:25:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:25:12 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')]} 09:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:12 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')]} 09:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:12 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 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25:12 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 09:25:12 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 09:25:12 INFO - Using env: {'DISPLAY': ':0', 09:25:12 INFO - 'HOME': '/home/cltbld', 09:25:12 INFO - 'LANG': 'en_US.UTF-8', 09:25:12 INFO - 'LANGUAGE': 'en_US:en', 09:25:12 INFO - 'LOGNAME': 'cltbld', 09:25:12 INFO - 'MAIL': '/var/mail/cltbld', 09:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:12 INFO - 'MOZ_NO_REMOTE': '1', 09:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:12 INFO - 'NO_EM_RESTART': '1', 09:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:12 INFO - 'SHELL': '/bin/bash', 09:25:12 INFO - 'SHLVL': '1', 09:25:12 INFO - 'TERM': 'linux', 09:25:12 INFO - 'TMOUT': '86400', 09:25:12 INFO - 'USER': 'cltbld', 09:25:12 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:12 INFO - '_': '/tools/buildbot/bin/python'} 09:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:25:12 INFO - Running setup.py (path:/tmp/pip-AS0oEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:25:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:25:12 INFO - Running setup.py (path:/tmp/pip-oepPhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:25:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:25:12 INFO - Running setup.py (path:/tmp/pip-M1zYHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:25:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:25:12 INFO - Running setup.py (path:/tmp/pip-ItEcn7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:25:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:25:12 INFO - Running setup.py (path:/tmp/pip-0ir4QX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:25:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:25:12 INFO - Running setup.py (path:/tmp/pip-ZVmzQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:25:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:25:12 INFO - Running setup.py (path:/tmp/pip-KAvUiU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:25:13 INFO - Running setup.py (path:/tmp/pip-wx9Opk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:25:13 INFO - Running setup.py (path:/tmp/pip-M6QwDy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:25:13 INFO - Running setup.py (path:/tmp/pip-lqyIru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:25:13 INFO - Running setup.py (path:/tmp/pip-ConvY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:25:13 INFO - Running setup.py (path:/tmp/pip-TMPoij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:25:13 INFO - Running setup.py (path:/tmp/pip-gAeLQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:25:13 INFO - Running setup.py (path:/tmp/pip-nIm4Pj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:25:13 INFO - Running setup.py (path:/tmp/pip-UdtT7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:25:13 INFO - Running setup.py (path:/tmp/pip-OSmsGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:25:13 INFO - Running setup.py (path:/tmp/pip-Cnql51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:25:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:13 INFO - Running setup.py install for manifestparser 09:25:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:25:13 INFO - Running setup.py install for mozcrash 09:25:13 INFO - Running setup.py install for mozdebug 09:25:14 INFO - Running setup.py install for mozdevice 09:25:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Running setup.py install for mozfile 09:25:14 INFO - Running setup.py install for mozhttpd 09:25:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Running setup.py install for mozinfo 09:25:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Running setup.py install for mozInstall 09:25:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Running setup.py install for mozleak 09:25:14 INFO - Running setup.py install for mozlog 09:25:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Running setup.py install for moznetwork 09:25:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:25:14 INFO - Running setup.py install for mozprocess 09:25:14 INFO - Running setup.py install for mozprofile 09:25:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:25:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:25:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:25:15 INFO - Running setup.py install for mozrunner 09:25:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:25:15 INFO - Running setup.py install for mozscreenshot 09:25:15 INFO - Running setup.py install for moztest 09:25:15 INFO - Running setup.py install for mozversion 09:25:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:25:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:15 INFO - Cleaning up... 09:25:15 INFO - Return code: 0 09:25:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:15 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 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25:15 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 09:25:15 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 09:25:15 INFO - Using env: {'DISPLAY': ':0', 09:25:15 INFO - 'HOME': '/home/cltbld', 09:25:15 INFO - 'LANG': 'en_US.UTF-8', 09:25:15 INFO - 'LANGUAGE': 'en_US:en', 09:25:15 INFO - 'LOGNAME': 'cltbld', 09:25:15 INFO - 'MAIL': '/var/mail/cltbld', 09:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:15 INFO - 'MOZ_NO_REMOTE': '1', 09:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:15 INFO - 'NO_EM_RESTART': '1', 09:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:15 INFO - 'SHELL': '/bin/bash', 09:25:15 INFO - 'SHLVL': '1', 09:25:15 INFO - 'TERM': 'linux', 09:25:15 INFO - 'TMOUT': '86400', 09:25:15 INFO - 'USER': 'cltbld', 09:25:15 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:15 INFO - '_': '/tools/buildbot/bin/python'} 09:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:25:15 INFO - Running setup.py (path:/tmp/pip-KHLx4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:25:15 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)) 09:25:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:25:15 INFO - Running setup.py (path:/tmp/pip-k8DJTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:25:15 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)) 09:25:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:25:15 INFO - Running setup.py (path:/tmp/pip-9yeycR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:25:15 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)) 09:25:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:25:15 INFO - Running setup.py (path:/tmp/pip-h4p77P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:25:16 INFO - Running setup.py (path:/tmp/pip-45G1wr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:25:16 INFO - Running setup.py (path:/tmp/pip-THPRUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:25:16 INFO - Running setup.py (path:/tmp/pip-TsiRRO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:25:16 INFO - Running setup.py (path:/tmp/pip-YYgov9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:25:16 INFO - Running setup.py (path:/tmp/pip-sH2hnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:25:16 INFO - Running setup.py (path:/tmp/pip-7TziAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:25:16 INFO - Running setup.py (path:/tmp/pip-bCW4wW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:25:16 INFO - Running setup.py (path:/tmp/pip-60cO4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:25:16 INFO - Running setup.py (path:/tmp/pip-pdHrom-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:25:16 INFO - Running setup.py (path:/tmp/pip-pHPEjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:25:16 INFO - Running setup.py (path:/tmp/pip-lbUuZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:25:16 INFO - Running setup.py (path:/tmp/pip-1hJHDr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:25:16 INFO - Running setup.py (path:/tmp/pip-RjIny_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:25:16 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)) 09:25:16 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)) 09:25:16 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)) 09:25:16 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)) 09:25:16 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)) 09:25:16 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)) 09:25:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:16 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 09:25:16 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 09:25:16 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 09:25:16 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 09:25:16 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 09:25:16 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 09:25:18 INFO - Downloading blessings-1.6.tar.gz 09:25:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:18 INFO - Installing collected packages: blessings 09:25:18 INFO - Running setup.py install for blessings 09:25:18 INFO - Successfully installed blessings 09:25:18 INFO - Cleaning up... 09:25:19 INFO - Return code: 0 09:25:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:25:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:25:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:25:19 INFO - Reading from file tmpfile_stdout 09:25:19 INFO - Current package versions: 09:25:19 INFO - argparse == 1.2.1 09:25:19 INFO - blessings == 1.6 09:25:19 INFO - blobuploader == 1.2.4 09:25:19 INFO - docopt == 0.6.1 09:25:19 INFO - manifestparser == 1.1 09:25:19 INFO - mozInstall == 1.12 09:25:19 INFO - mozcrash == 0.16 09:25:19 INFO - mozdebug == 0.1 09:25:19 INFO - mozdevice == 0.48 09:25:19 INFO - mozfile == 1.2 09:25:19 INFO - mozhttpd == 0.7 09:25:19 INFO - mozinfo == 0.9 09:25:19 INFO - mozleak == 0.1 09:25:19 INFO - mozlog == 3.1 09:25:19 INFO - moznetwork == 0.27 09:25:19 INFO - mozprocess == 0.22 09:25:19 INFO - mozprofile == 0.28 09:25:19 INFO - mozrunner == 6.11 09:25:19 INFO - mozscreenshot == 0.1 09:25:19 INFO - mozsystemmonitor == 0.0 09:25:19 INFO - moztest == 0.7 09:25:19 INFO - mozversion == 1.4 09:25:19 INFO - psutil == 3.1.1 09:25:19 INFO - requests == 1.2.3 09:25:19 INFO - wsgiref == 0.1.2 09:25:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:25: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')]} 09:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:19 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 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25:19 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 09:25:19 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 09:25:19 INFO - Using env: {'DISPLAY': ':0', 09:25:19 INFO - 'HOME': '/home/cltbld', 09:25:19 INFO - 'LANG': 'en_US.UTF-8', 09:25:19 INFO - 'LANGUAGE': 'en_US:en', 09:25:19 INFO - 'LOGNAME': 'cltbld', 09:25:19 INFO - 'MAIL': '/var/mail/cltbld', 09:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:19 INFO - 'MOZ_NO_REMOTE': '1', 09:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:19 INFO - 'NO_EM_RESTART': '1', 09:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:19 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:19 INFO - 'SHELL': '/bin/bash', 09:25:19 INFO - 'SHLVL': '1', 09:25:19 INFO - 'TERM': 'linux', 09:25:19 INFO - 'TMOUT': '86400', 09:25:19 INFO - 'USER': 'cltbld', 09:25:19 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:19 INFO - '_': '/tools/buildbot/bin/python'} 09:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 INFO - Cleaning up... 09:25:19 INFO - Return code: 0 09:25:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:25: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')]} 09:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25: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', 'jsonschema'] in /builds/slave/test-pgo/build 09:25: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 jsonschema 09:25:19 INFO - Using env: {'DISPLAY': ':0', 09:25:19 INFO - 'HOME': '/home/cltbld', 09:25:19 INFO - 'LANG': 'en_US.UTF-8', 09:25:19 INFO - 'LANGUAGE': 'en_US:en', 09:25:19 INFO - 'LOGNAME': 'cltbld', 09:25:19 INFO - 'MAIL': '/var/mail/cltbld', 09:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:19 INFO - 'MOZ_NO_REMOTE': '1', 09:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:19 INFO - 'NO_EM_RESTART': '1', 09:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:19 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:19 INFO - 'SHELL': '/bin/bash', 09:25:19 INFO - 'SHLVL': '1', 09:25:19 INFO - 'TERM': 'linux', 09:25:19 INFO - 'TMOUT': '86400', 09:25:19 INFO - 'USER': 'cltbld', 09:25:19 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:19 INFO - '_': '/tools/buildbot/bin/python'} 09:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:19 INFO - Downloading/unpacking jsonschema 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:21 INFO - Downloading/unpacking functools32 (from jsonschema) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:21 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:21 INFO - warning: no files found matching '*.txt' 09:25:21 INFO - no previously-included directories found matching 'build' 09:25:21 INFO - no previously-included directories found matching 'dist' 09:25:21 INFO - no previously-included directories found matching '.git*' 09:25:21 INFO - Installing collected packages: jsonschema, functools32 09:25:21 INFO - Running setup.py install for functools32 09:25:21 INFO - warning: no files found matching '*.txt' 09:25:21 INFO - no previously-included directories found matching 'build' 09:25:21 INFO - no previously-included directories found matching 'dist' 09:25:21 INFO - no previously-included directories found matching '.git*' 09:25:21 INFO - Successfully installed jsonschema functools32 09:25:21 INFO - Cleaning up... 09:25:21 INFO - Return code: 0 09:25:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f746b1a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, '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': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', '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 09:25:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:25:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:25:22 INFO - Using env: {'DISPLAY': ':0', 09:25:22 INFO - 'HOME': '/home/cltbld', 09:25:22 INFO - 'LANG': 'en_US.UTF-8', 09:25:22 INFO - 'LANGUAGE': 'en_US:en', 09:25:22 INFO - 'LOGNAME': 'cltbld', 09:25:22 INFO - 'MAIL': '/var/mail/cltbld', 09:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:22 INFO - 'MOZ_NO_REMOTE': '1', 09:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:22 INFO - 'NO_EM_RESTART': '1', 09:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:22 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:22 INFO - 'SHELL': '/bin/bash', 09:25:22 INFO - 'SHLVL': '1', 09:25:22 INFO - 'TERM': 'linux', 09:25:22 INFO - 'TMOUT': '86400', 09:25:22 INFO - 'USER': 'cltbld', 09:25:22 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:22 INFO - '_': '/tools/buildbot/bin/python'} 09:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:22 INFO - Downloading/unpacking flake8 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:25:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:25:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:25:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:24 INFO - no previously-included directories found matching 'docs/_build' 09:25:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:25:24 INFO - Running setup.py install for pep8 09:25:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:24 INFO - no previously-included directories found matching 'docs/_build' 09:25:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:25:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:25:24 INFO - Cleaning up... 09:25:24 INFO - Return code: 0 09:25:24 INFO - Running post-action listener: _resource_record_post_action 09:25:24 INFO - Running post-action listener: _start_resource_monitoring 09:25:24 INFO - Starting resource monitoring. 09:25:24 INFO - ##### 09:25:24 INFO - ##### Running install step. 09:25:24 INFO - ##### 09:25:24 INFO - Running pre-action listener: _resource_record_pre_action 09:25:24 INFO - Running main action method: install 09:25:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:25:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:25:25 INFO - Reading from file tmpfile_stdout 09:25:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:25:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:25:25 INFO - Reading from file tmpfile_stdout 09:25:25 INFO - Output received: 09:25:25 INFO - Usage: mozinstall [options] installer 09:25:25 INFO - Options: 09:25:25 INFO - -h, --help show this help message and exit 09:25:25 INFO - -d DEST, --destination=DEST 09:25:25 INFO - Directory to install application into. [default: 09:25:25 INFO - "/builds/slave/test-pgo"] 09:25:25 INFO - --app=APP Application being installed. [default: firefox] 09:25:25 INFO - mkdir: /builds/slave/test-pgo/build/application 09:25:25 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'] 09:25:25 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 09:25:40 INFO - Reading from file tmpfile_stdout 09:25:40 INFO - Output received: 09:25:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:25:40 INFO - Running post-action listener: _resource_record_post_action 09:25:40 INFO - ##### 09:25:40 INFO - ##### Running run-tests step. 09:25:40 INFO - ##### 09:25:40 INFO - Running pre-action listener: _resource_record_pre_action 09:25:40 INFO - Running main action method: run_tests 09:25:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:25:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:25:40 INFO - Python 2.7.3 09:25:40 INFO - Return code: 0 09:25:40 INFO - grabbing minidump binary from tooltool 09:25:40 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')]} 09:25:40 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 0x1c20850>, '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 0x1b8c330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c7c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:25:40 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 09:25:40 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 09:25:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:40 INFO - Return code: 0 09:25:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:25:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:25:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:25:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:25:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:25:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:25:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:25:41 INFO - Return code: 0 09:25:41 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/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 09:25:41 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/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 09:25:41 INFO - Using env: {'DISPLAY': ':0', 09:25:41 INFO - 'HOME': '/home/cltbld', 09:25:41 INFO - 'LANG': 'en_US.UTF-8', 09:25:41 INFO - 'LANGUAGE': 'en_US:en', 09:25:41 INFO - 'LOGNAME': 'cltbld', 09:25:41 INFO - 'MAIL': '/var/mail/cltbld', 09:25:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:25:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:41 INFO - 'MOZ_NO_REMOTE': '1', 09:25:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:41 INFO - 'NO_EM_RESTART': '1', 09:25:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:25:41 INFO - 'PWD': '/builds/slave/test-pgo', 09:25:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:25:41 INFO - 'SHELL': '/bin/bash', 09:25:41 INFO - 'SHLVL': '1', 09:25:41 INFO - 'TERM': 'linux', 09:25:41 INFO - 'TMOUT': '86400', 09:25:41 INFO - 'USER': 'cltbld', 09:25:41 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314', 09:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:41 INFO - '_': '/tools/buildbot/bin/python'} 09:25:41 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/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 09:25:41 INFO - mozversion application_buildid: 20160304065240 09:25:41 INFO - mozversion application_changeset: 02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f 09:25:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:25:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:41 INFO - mozversion application_name: Firefox 09:25:41 INFO - mozversion application_remotingname: firefox-dev 09:25:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:25:41 INFO - mozversion application_vendor: Mozilla 09:25:41 INFO - mozversion application_version: 46.0a2 09:25:41 INFO - mozversion platform_buildid: 20160304065240 09:25:41 INFO - mozversion platform_changeset: 02c5b4300a048fdbf9bbd6d0ea41d9ec3834095f 09:25:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:25:41 INFO - mozversion platform_version: 46.0a2 09:25:41 INFO - using testdate: 1457112341 09:25:41 INFO - actual date: 1457112341 09:25:41 INFO - starting webserver on 'localhost:47674' 09:25:41 INFO - SUITE-START | Running 3 tests 09:25:41 INFO - TEST-START | dromaeo_css 09:25:41 INFO - operating with platform_type : linux_ 09:25:41 INFO - Initialising browser for dromaeo_css test... 09:25:41 INFO - TEST-INFO | started process 1138 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOT2ums/profile http://localhost:47674/getInfo.html) 09:25:45 INFO - PROCESS | 1138 | 09:25:45 INFO - PROCESS | 1138 | (process:1285): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:25:45 INFO - PROCESS | 1138 | __metrics Screen width/height:1600/1200 09:25:45 INFO - PROCESS | 1138 | colorDepth:24 09:25:45 INFO - PROCESS | 1138 | Browser inner width/height: 1024/697 09:25:45 INFO - PROCESS | 1138 | __metrics 09:25:46 INFO - TEST-INFO | 1138: exit 0 09:25:46 INFO - Browser initialized. 09:25:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:46 INFO - TEST-INFO | started process 1334 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOT2ums/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:48 INFO - PROCESS | 1334 | 09:25:48 INFO - PROCESS | 1334 | (process:1399): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:25:58 INFO - PROCESS | 1334 | RSS: Main: 141533184 09:25:58 INFO - PROCESS | 1334 | 09:26:48 INFO - PROCESS | 1334 | 1457112408271 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] 09:28:55 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:47674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47674/tests/dromaeo/cssquery-ext.html) 09:28:56 INFO - PROCESS | 1334 | RSS: Main: 146845696 09:28:56 INFO - PROCESS | 1334 | 09:31:58 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:47674/tests/dromaeo/cssquery-ext.html (next: http://localhost:47674/tests/dromaeo/cssquery-jquery.html) 09:31:59 INFO - PROCESS | 1334 | RSS: Main: 144883712 09:31:59 INFO - PROCESS | 1334 | 09:35:01 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:47674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47674/tests/dromaeo/cssquery-mootools.html) 09:35:01 INFO - PROCESS | 1334 | RSS: Main: 143646720 09:35:01 INFO - PROCESS | 1334 | 09:38:03 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:47674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47674/tests/dromaeo/cssquery-prototype.html) 09:38:03 INFO - PROCESS | 1334 | RSS: Main: 144384000 09:38:03 INFO - PROCESS | 1334 | 09:41:06 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:47674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47674/tests/dromaeo/cssquery-yui.html) 09:41:06 INFO - PROCESS | 1334 | RSS: Main: 144142336 09:41:06 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | Cycle 1(1): loaded http://localhost:47674/tests/dromaeo/cssquery-yui.html (next: http://localhost:47674/tests/dromaeo/cssquery-dojo.html) 09:44:09 INFO - PROCESS | 1334 | RSS: Main: 146870272 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | __start_tp_report 09:44:09 INFO - PROCESS | 1334 | _x_x_mozilla_page_load 09:44:09 INFO - PROCESS | 1334 | _x_x_mozilla_page_load_details 09:44:09 INFO - PROCESS | 1334 | |i|pagename|runs| 09:44:09 INFO - PROCESS | 1334 | |0;dojo.html;3319.170207448138;3370.0563842124197;3391.7964922104693;3401.897943061709;3410.1474631342157;5429.185622156679;5435.809746658868;5438.293021907151;5457.754401051948;5461.781528738856;5441.428649991753;5449.155380915954;5466.726663666821;5487.5609951203905;5498.147787093007;4929.137400954836;4992.47579004203;5046.495350464943;5080.364954380702;5123;4804.807807687688;4947.901041979158;4991.276264941581;4994.625403094782;5017.147084995559;4943.752812359386;5011.498850114996;5017.172166592508;5022.296878437021;5035.647504674675;4938.580220681247;4981.750912454381;4995.450500444948;5007.37407824022;5019.974900125494;4863.610911127102;4927.1870141426625;4939.209726443788;4964.578010869044;4968.826091086831;5228.8692782680355;5281.656692314988;5295.179247216687;5297.920531192035;5331.093714068617;5858.707064646751;5870.618409803392;5880.088586269135;5880.147378630075;5881.470667639933;5604.3835178130375;5803.274590676166;5808.651480911117;5823.068309070529;5944.821655350346;5534.280543529356;5557.694326812024;5559;5567.8608034799045;5580.525655319303;6039.8490037748525;6043.244594425697;6046.153538504613;6048.6673232971725;6065.878682426327;5691.8861622768145;5773.8267851963665;5785.0454674978155;5811.593188476766;5819.185314055951;5775.768969241183;5783.103618939072;5785.508231800344;5801.361850196475;5839.328477225088;5789.073748200352;5804.796832110856;5806.82579522615;5808.651480911159;5810.4770570648;5638.492535671728;5678.3186017678145;5800.245968024215;5867.589268751147;5894.056950887837;4503.54964503547;4503.594676479132;4511.616512596401;4525.570070843265;4543.704659197141;3969.047428617169;4096.180763847243;4100.979495102505;4111.814968326433;4124.05146816234;5460.099083651233;5485.588580856452;5533.750981205855;5599.8600034998635;5625.859353516113;5858.238429004287;5887.558433117448;5897.115432685132;5914.940850591525;5916.319623243382;5414.485623865727;5501.312335958005;5577.247071645276;5588.720563971785;5593.272874526367;5037.622178336639;5039.294498770175;5065.6200784941275;5074.416442109205;5101.770420331094;5951.583389162717;5954.46409823118;5957.076653118774;5963.135345374896;5988.730507127103;5715.971420142872;5787.884242315215;5804.2744656917885;5806.738696758741;5861.560382971379;5978.850528736816;5981.730822112929;5994.190784244071;6005.339412664691;6031.276246850406;5730.856728581819;5831.475167234969;5831.679257640871;5846.152307915413;5858;5777.075667893285;5824.82525524218;5913;5954.404559544011;6053.182820319201;5814.331351894586;5842.357340692435;5846.503047240862;5851.678157701197;5856.209411729362;5722.885542289047;5783.248177736868;5798.420157984167;5814.331351894417;5840.357560668408;5541.445855414427;5550.944490555043;5637.238972738628;5639.577031722719;5650.745716442852;5680.346760122638;5711.771529138788;5742.655440673406;5743.396943320891;5754.136879468113;5576.33084029919;5620.156976453564;5621.409751976147;5630.85922851932;5639.125935480007 09:44:09 INFO - PROCESS | 1334 | |1;ext.html;554.0758507527902;565.7963133272021;588.6056342250691;605.8243109498243;622.3185611755132;40528.39207411888;41430.37854432182;41535.16929661409;41568.79215603925;41575.58424415755;38901.41647875277;40229.19541609166;40332.59667403325;40363.79818100913;40394.394084088686;8700.43447175933;8817.823643527126;8888.111188881125;8901.243394311492;8937.865932011026;8598.656053757843;8641.827163456726;8667.349948753837;8676;8785.077566855483;8726.389152759277;8744.300455963508;8856.468611883276;9038.367314288002;9060.954695226515;8885.777855553599;8894.86657700135;8922.776930576754;8998.19016288534;9000.964889037714;8703.782405439852;8788.20906118446;8850.73447796567;8878.467291962503;8884.600192991331;41249.38125928114;42061.369079463526;42075.1584968302;42082.158356832995;42113.789431052646;3475.131217195701;3506.982465087658;3650.8357123929486;3874.5156855393075;4334;32252.838735806406;32487.83756081228;33020.50469242963;33077.6692233077;33117.17207069843;4249.32010878258;4290.785460726951;4310.159518893817;4352.825886964518;4360.324149756792;286016;286565;287918;289853.9999999979;290790;64098.679506603105;64271.357286427476;64310;64475.35524644787;64553;65150.34849651538;65711.67144164344;65720.34279657238;66009.00986485207;66117.6694116536;16219.918900405422;16557.42049028278;16563.337466501445;16603.169841507875;16650.3339866404;12886.09797314179;13017.869821301665;13057.151285166434;13075.673108172372;13429.798553021712;21001;21200.893995530234;21333.46666333354;21368.717876927432;21405.571888562143;8161.224683655043;8352.081271060179;8404.36967227448;8466.195711407407;8513.063563008063;957.9760505987406;999.7100840756099;1021.4126877045728;1069.0325255643654;1121.770037142384;30744.53883191754;30748.38503229923;31308.217294567363;31512.212194694857;31518.054458366285;1113.2596823112701;1115.1023426141871;1126.8253420719802;1222.730999180179;1222.8288039674453;14843.257837108102;16880.240389182516;17272.481825545256;17569.56076098108;18256.543586410182;277236;462357;471256;472557;494193;54313;55568;55687;55703.44296557063;55715.44284557102;1501.1218437214352;1507.8314306412399;1521.634807646157;1521.9010764300506;1523.8933274670667;32453.350932980735;32467.188320291236;32664.34671306608;32951.340973179926;33635.66364336325;48752.75623621859;49405.50594494009;49541;49589.25616115833;49676;328329;330734;331928;333040;334264;35109.82445087758;35189.64810351864;35563.466548001285;36007.27985440329;36074.819625901706;46151.53848461472;46582.76708616435;46671.76664116794;47325.52674473211;47675.28487072766;41591.1681766369;42137.789311053246;42544.78727606342;43578.51532657836;47682.28476572924;39108.80445597868;40063.39904901487;40204;40393.1921361577;40470.59529404668;40365.79817101013;42661.95384204078;42901.570984289756;43275.567244327154;43821.561784383026;32958.835205823816;34559.65440345564;35292.64707352893;35325.82337088401;35613;28156.155315340573;28397.574036389058;28404.85797570999;28573.28566785847;28595.714042859305 09:44:09 INFO - PROCESS | 1334 | |2;jquery.html;386.5689755922146;388.0976729104832;399.6083837838918;400.98797036088894;403.2519676001017;15166.469173578927;15585.064896106242;17173;17791.377301794422;17855.55361115971;11746.882531174686;12518.374081295944;15699;17386;17441.21514531846;5134.4095429025765;5397.919031214535;5666.801661941833;5668.829935101933;5690.715464226792;3858.131920317934;3968.72218944674;5509.311336082989;5976.850578735544;6160.383961603849;6056.303525094604;6175.845603859894;6202.286737025254;6266.749330026793;6321.494280457576;6157.907631385533;6160.722767475474;6165.537584681145;6220.191375121205;6236.87526249477;5370.624056316059;5606.411326810667;5624.803131890364;5624.91562626561;5627.409122042168;12458.12793104483;12990.480380784757;13016.60950171487;13018.544350947672;21175.788242117535;2287.553926984239;2377.9405514862265;2386.200622791367;2412.9517409651885;2413.3966508372905;10030.749231269203;10286.897131028669;12527.812082818766;12726.363681815872;13105.279209643466;1995.1520603743352;2016.596680663873;2018.8082132197417;2042.1627132875599;2062.618415593105;58018.70990645062;58196.41803581952;58873.41126588722;59779.70110149465;59926.70036649833;10863.728406789893;10874.565017399374;10949.890501095046;10985.285956412808;11052.889471105185;14520.056196347203;14553.708925821637;14577.198254095914;14633.780493292608;14654.63363415923;8155.34757219421;8303.916960830435;8411.411201215979;8415.326773858076;8450.492970421672;8076.071251806;8120.309773669304;8139.4709343892455;8161;8179.182081791892;4621.722696638212;4687.7343117358805;4690.64820138491;4702.459217190067;4714.693544919569;1938.3990962801577;2030.6344857925715;2034.4100210938957;2041.5202427429542;2051.6101940631233;956.9904300956902;1044.3264094658903;1088.8094583447864;1095.5727266366123;1104.7790441911488;17441.82558174402;17561.648767024588;17642;17826.10869456522;18255.26978920855;1015.1168483419473;1025.3437799808128;1035.2287545778443;1040.552562398161;1049.0925349572565;9949.950250248847;10139;10162.18702503798;10185.287029907835;10328.431936243578;497187;508196;526676;535207;539530;71495;75308.62345688237;75508;75546;76196.23803762002;1153.9095554700896;1175.5121624525725;1178.988210117905;1180.8582970043649;1195.1753290229713;15634.609134771721;15686.607834803764;15738.606534836263;15906.920465398061;16101.436449724672;32503.512447313784;35627;36544.45183322306;37986.24027519379;38436.42345364878;43324.783376082916;43893.341599876665;45161.548384515736;45359.319610206534;45453.772731137455;3108.5026395777472;3158.5262210668584;6825.624590647363;7138.750718624324;7902.644381002984;11252.943735281271;11302.491387887729;11322.830157547478;11502.769944600894;11586.188966772244;10194.490275486345;10292.419873156374;10635.096016838655;10801.729956751144;10808;10219.642312519027;10447.216458765775;10484.580616775243;10557.683269501927;10747.193960452842;10048.598056077675;10586.364818110938;10842;10870.347779133277;10944.452777361259;7910.169432209766;8032.799180020546;8067.435279530377;8078.071021832329;8103.959480202561;9886.110250077527;10030;10581.788364232827;10859.945700271448;10889.346639201673 09:44:09 INFO - PROCESS | 1334 | |3;mootools.html;1506.8041154649893;1527.6028232659512;1731.5930756272273;1813.1659436659136;1852.1017306606293;7405.111386633612;7528.209537998499;8126.756197314083;8385.329173666107;8414.621342039607;8035.116137224915;8096.43324967251;8176.91823081769;8216.630251638675;8272.958635206816;2391.629297458897;2412.0472413396787;2428.6842710447704;2436.512697460515;2437.597796363598;2394.5330660521204;2397.1969390254285;2430.8419952703016;2433.3916520869693;2436.0986435019067;2329.5108027314286;2334.241371554243;2353.576356255873;2421.842580232288;2447.7674620910984;2420.407000284924;2430.7569243075727;2444.327809852296;2453.521563295158;2454.1165180534995;2376.572217000939;2382.5949588569983;2392.509535545209;2401.183597576832;2411.288669842401;8240;8300.2114799094;8325.791855203608;8348.666053357858;8351.498910065415;5026.095302845486;5074.695518268915;5106.770195341219;5114.309568208281;5186.766595503173;3184.792988455743;3224.629167645727;3233.725133363667;3241.578594782663;3277.73778097754;1052.3896140238644;1984.0575726529928;2020.6160829442358;2139.229877244191;2147.0231044874545;11155.27490713101;11291.322520648788;11312.660620181325;11322.094232461382;11349.943250283695;4347.978260108679;4374.671899607542;4412.977935110304;4520.615747661485;4542.318652202196;9244.399114057565;9267;9286;9310.115539023782;9321.860172097424;5169.844904652867;5179.041877252645;5179.378474583074;5203.635745497779;5209.114450543417;4610.561996610317;4741.478437371887;4754.191787396151;4770.189067858472;4779.354787103766;3699.7040236780995;3742.925141497155;3771.1891943232336;3808.638179372955;3825.5983121771815;1132.65454036518;1181.167277069664;1181.4033912873945;1183.8756930522343;1190.4702407428783;1390.6175801654424;1393.5122707052653;1399.846016938136;1405.6275087101926;1425.230375597166;7871.17352677972;8034.879476807852;8038;8051.557164356017;8060.516369017878;1185.9051275897907;1204.1691233049169;1207.4988879614862;1221.2855479544567;1234.216272666863;6205.627662340274;6243.344448832898;6329.461995730415;6336.271328797247;6350.777722779773;9604.567794449267;9827.508624568743;9833.459159746282;9859.802803943881;10182.541785619665;9792.55933482995;9980.301378903407;9980.550875210633;10007.249456290661;10077.344972576759;7719.536827790351;7798.493097948615;7813.921860781433;7852.803679907934;7854.8429031419055;7480.70077196906;7657.425693072931;7712.344450721752;7726.806829829299;7781;8873.511956842436;8893.510856902933;8977.461352318882;9076.727698169065;9083;9271.907280927104;9391.154796068387;9458.668946587111;9479.763005924908;9544;7098.964505177441;7250.238724934017;7308.30571095745;7317.195108538163;7420.851582968418;7588.051493563305;7660;7660.846783064196;7667.463277570517;7683.462157648911;7345.235011655949;7509.399248060033;7619.466637335333;7638.923610764044;7691.077070751546;7339.59632220233;7478;7491.138519070377;7681.078270607562;7696.384289256734;7552;7706.730264440717;7734.458587899018;7743.5353878767455;7748.8450230996195;6809.319068093151;6827.112475378368;6852.143482064742;7034.226235114235;7113.928860711327;7161.820954476179;7206.6396680164735;7208.7116515340895;7214.458915581247;7232.349088582053 09:44:09 INFO - PROCESS | 1334 | |4;prototype.html;374.40656559353425;383.27752187127294;384.3446922996292;386.40686546151653;388.86389763582747;6346.460550853178;6370.4585110265625;6420.390062944025;6472.5792823466445;6615.735370585171;6412.775552855651;6467.256265529466;6498.44763195129;6505.9590465525525;6514.641694706789;4932.753362331869;4949.505049495057;4951.306817045607;4957.975210123945;4962.60299176065;4962.106820772277;4972.701637901738;4975.378077740283;4981.252812078181;4981.476944920785;4716.952830471703;4793.233082706767;4839.177339852234;4839.903201935959;4858.927116093244;4819.734914579697;4824.300476430898;4856.198727210024;4864.708117512961;4887.608991280725;4280.036991676879;4291.91416171678;4295.914081718348;4298.11888562847;4303.182395344906;6048.69756512177;6071.058985857199;6144.692765361759;6155.045967874987;6175.907361389583;5612.326520817487;5725.599208055438;5750.913736293959;5751.3961034091235;5759.712014399263;6808.795736127924;6813.659317034128;6818.386345228953;6840.555363901381;6846.041554182419;4707.270373092176;4751.809927602892;4772.904541909177;4780.043991201739;4780.211265141247;6995.650217489105;7094.219635840053;7112.928870711278;7152.856942861114;7158.319959603881;4884.389451318585;4894.094592500399;4902.940764878759;4905.484924082992;4913.434954980223;4969.726665033386;4969.801207951641;4972.477889821516;4977.552020318117;4980.178270585386;5711.9718450679275;5712.514436272963;5715.428457154335;5742.28221472316;5750.88498230033;6665.266820649725;6777.830554236085;6803.115594972622;6889.965550172217;6904.792856214322;1738.1743671756067;1740.1038465190436;1741.3208848549075;1756.4291605228352;1761.5067781021335;1164.7437563736135;1185.0756410000213;1192.6183621241294;1204.3195594489262;1215.0522592377959;6514.283428822826;6578.473722102221;6585.736570537125;6604.075429439882;6605;7015.614141222281;7061.223265440797;7067.540609860343;7082.433405327562;7099.467539934525;6508.837279068061;6554;6671.299513551105;6687.531872768956;6688.799336019927;3818.942715859209;3830.9808450958126;3849.3840985442193;3849.3840985442193;3867.7485963412287;7359.521631093961;7387.519811212362;7405.555666660018;7414.518056326321;7421.183669796318;7208.675609597581;7282;7305.305995930378;7325.597092159983;7379.594122323324;7385.667644955883;7388.519746216479;7395.7041718330665;7403.111626604734;7411.518251313647;6922.965385173042;7119.715211391486;7120.430365570845;7124.3944264738075;7150.141982962078;7111.466640001917;7125;7126.643667816485;7133.750318738819;7142.892856607259;7402.518836275625;7428.591427471541;7435.293647103733;7440.404767618686;7443.4789564729945;4820.68665536739;4862.659613826998;4873.074115917964;4907.754612269301;4937.456879743298;7096.787096387116;7156.570605763671;7179.820504487429;7180.31786980236;7180.497365184596;6925.792226233221;6955.23492415844;6976.7558135465015;6978.895316570357;7001.859962800613;6855.760048398282;6953.965230173817;6961.860762784817;6984.196817366068;6998;6822.215445223863;6831.077804496528;6846.315368463114;6860.588364698134;6863;6931.0643063187845;6971.51199416036;6984.4761642878;7004.964975175091;7030.121234845645;6594.571352862049;6705.798826035227;6728.394444500019;6763.5941843489545;6849.1096157499205 09:44:09 INFO - PROCESS | 1334 | |5;yui.html;848.4018766769427;917.6375331743961;919.4483310013989;920.7606022434165;934.4346670264495;12487.063470239735;12544.37278136094;12574.245545267291;12598.496060157606;13995.020348575605;13851.238181899991;13894.51369202078;13914.165150091001;13918.721625567483;13945.651358716037;875.8598624220126;876.7282142535835;892.054422312351;896.6547879066574;902.8735976963197;890.5680744838749;891.0999890111002;894.1460904835899;895.8297923394567;898.2230370729304;921.6958403726754;925.9212966897821;929.0894922975488;930.4789317981952;933.869258303838;919.6643225222813;921.1801496667904;922.8246633139682;925.6204955968054;926.2960150285797;683.4054372695737;685.9108315918949;686.3994005245411;688.3598253624127;689.9206591242021;15186.164760938143;15217.467388641455;15286.617834554114;15338.769918451233;15362;13662.18026918388;13676.726465470734;13751.312434378242;13862.306884655827;13964.092333998258;11487.885121148765;11514.078873690085;11589.594364197297;11737.119716021332;12174.391280435942;3902.9804850975847;3971.4241434992055;3987.860424885115;4008.478897743304;4101.507819061731;52079.218811717474;52344.73827630876;52664;53066.73466632642;53079;10539.314944528582;10884;11036.227464077598;11143.164262680331;11241.437928103562;19234.134463949154;19311.903440482987;19345.12946917392;19367.256946874848;19454.02729863501;8153.1846815317995;8195.46729462583;8210.507369557727;8279.793005174799;8407.663693452194;4465.687401881902;4603.631709463235;4613.5847773700525;4664.696794708333;4747.718116108631;3111.0977816432983;3155.4793459078996;3185.0604071798875;3247.3505298939835;3248.3016151527063;596.8299034775068;612.7855250662233;613.4754784659052;618.888600051995;623.6102435977514;611.4848511790051;670.3363669966795;698.0576222100124;702.1644243350397;712.8396110875011;9271.814563708687;9765.121139097515;9820.705378838646;9850.310478266596;9877.357971731959;626.9592476489014;635.3329004545209;674.7874419557824;678.7522554267657;684.1824020295799;4320.740755554677;4364.664536105085;4413.955860441354;4450.621697155713;4466.932996005063;62729;64368;64380;64437;64447.35552644507;56681.433185667614;57108.42891571114;57293;57666.42333576611;57812;49935.75032124889;50607.74696126496;50705;51093;51822.48177518252;8608.354373421893;8681.958165019985;8726.3891527595;8990.280777537911;9107.180353767928;37675.73945563275;38385;39072.41391379075;40360;40802;45798;46171.3074303879;47804.7609761949;48163.759181203866;49525;11869.813018698407;12022.63932082039;12353;12415.875841241834;12809.359532023174;13701.520446784314;14042.1574705518;14220.431182752987;14391.208483533506;14413.639659008608;12748.426320815772;13049.804252936403;13184.73630527365;13578.79631805504;13603.727925441633;12657.87342126567;12963;13039.282839443922;13111.016673749316;13382.665433364244;12624.55814046504;12998.090133690928;13000.544980925622;13179.60461186166;13283.601491955256;10596.47017649099;10789.921007899462;10790.406527641055;10802.567897284021;11036.944815275872;11199.776004480027;11392;11480.138989575982;11547.364894930524;11648.242864213798 09:44:09 INFO - PROCESS | 1334 | __end_tp_report 09:44:09 INFO - PROCESS | 1334 | __start_cc_report 09:44:09 INFO - PROCESS | 1334 | _x_x_mozilla_cycle_collect,300 09:44:09 INFO - PROCESS | 1334 | __end_cc_report 09:44:09 INFO - PROCESS | 1334 | __startTimestamp1457113449285__endTimestamp 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | ------- Summary: start ------- 09:44:09 INFO - PROCESS | 1334 | Number of tests: 6 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | [#0] dojo.html Cycles:165 Average:5443.02 Median:5637.24 stddev:583.09 (10.3%) stddev-sans-first:560.57 09:44:09 INFO - PROCESS | 1334 | Values: 3319.2 3370.1 3391.8 3401.9 3410.1 5429.2 5435.8 5438.3 5457.8 5461.8 5441.4 5449.2 5466.7 5487.6 5498.1 4929.1 4992.5 5046.5 5080.4 5123.0 4804.8 4947.9 4991.3 4994.6 5017.1 4943.8 5011.5 5017.2 5022.3 5035.6 4938.6 4981.8 4995.5 5007.4 5020.0 4863.6 4927.2 4939.2 4964.6 4968.8 5228.9 5281.7 5295.2 5297.9 5331.1 5858.7 5870.6 5880.1 5880.1 5881.5 5604.4 5803.3 5808.7 5823.1 5944.8 5534.3 5557.7 5559.0 5567.9 5580.5 6039.8 6043.2 6046.2 6048.7 6065.9 5691.9 5773.8 5785.0 5811.6 5819.2 5775.8 5783.1 5785.5 5801.4 5839.3 5789.1 5804.8 5806.8 5808.7 5810.5 5638.5 5678.3 5800.2 5867.6 5894.1 4503.5 4503.6 4511.6 4525.6 4543.7 3969.0 4096.2 4101.0 4111.8 4124.1 5460.1 5485.6 5533.8 5599.9 5625.9 5858.2 5887.6 5897.1 5914.9 5916.3 5414.5 5501.3 5577.2 5588.7 5593.3 5037.6 5039.3 5065.6 5074.4 5101.8 5951.6 5954.5 5957.1 5963.1 5988.7 5716.0 5787.9 5804.3 5806.7 5861.6 5978.9 5981.7 5994.2 6005.3 6031.3 5730.9 5831.5 5831.7 5846.2 5858.0 5777.1 5824.8 5913.0 5954.4 6053.2 5814.3 5842.4 5846.5 5851.7 5856.2 5722.9 5783.2 5798.4 5814.3 5840.4 5541.4 5550.9 5637.2 5639.6 5650.7 5680.3 5711.8 5742.7 5743.4 5754.1 5576.3 5620.2 5621.4 5630.9 5639.1 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | [#1] ext.html Cycles:180 Average:53192.58 Median:41339.88 stddev:94827.14 (229.4%) stddev-sans-first:95010.79 09:44:09 INFO - PROCESS | 1334 | Values: 554.1 565.8 588.6 605.8 622.3 40528.4 41430.4 41535.2 41568.8 41575.6 38901.4 40229.2 40332.6 40363.8 40394.4 8700.4 8817.8 8888.1 8901.2 8937.9 8598.7 8641.8 8667.3 8676.0 8785.1 8726.4 8744.3 8856.5 9038.4 9061.0 8885.8 8894.9 8922.8 8998.2 9001.0 8703.8 8788.2 8850.7 8878.5 8884.6 41249.4 42061.4 42075.2 42082.2 42113.8 3475.1 3507.0 3650.8 3874.5 4334.0 32252.8 32487.8 33020.5 33077.7 33117.2 4249.3 4290.8 4310.2 4352.8 4360.3 286016.0 286565.0 287918.0 289854.0 290790.0 64098.7 64271.4 64310.0 64475.4 64553.0 65150.3 65711.7 65720.3 66009.0 66117.7 16219.9 16557.4 16563.3 16603.2 16650.3 12886.1 13017.9 13057.2 13075.7 13429.8 21001.0 21200.9 21333.5 21368.7 21405.6 8161.2 8352.1 8404.4 8466.2 8513.1 958.0 999.7 1021.4 1069.0 1121.8 30744.5 30748.4 31308.2 31512.2 31518.1 1113.3 1115.1 1126.8 1222.7 1222.8 14843.3 16880.2 17272.5 17569.6 18256.5 277236.0 462357.0 471256.0 472557.0 494193.0 54313.0 55568.0 55687.0 55703.4 55715.4 1501.1 1507.8 1521.6 1521.9 1523.9 32453.4 32467.2 32664.3 32951.3 33635.7 48752.8 49405.5 49541.0 49589.3 49676.0 328329.0 330734.0 331928.0 333040.0 334264.0 35109.8 35189.6 35563.5 36007.3 36074.8 46151.5 46582.8 46671.8 47325.5 47675.3 41591.2 42137.8 42544.8 43578.5 47682.3 39108.8 40063.4 40204.0 40393.2 40470.6 40365.8 42662.0 42901.6 43275.6 43821.6 32958.8 34559.7 35292.6 35325.8 35613.0 28156.2 28397.6 28404.9 28573.3 28595.7 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | [#2] jquery.html Cycles:180 Average:27505.50 Median:11619.20 stddev:85239.57 (733.6%) stddev-sans-first:85454.36 09:44:09 INFO - PROCESS | 1334 | Values: 386.6 388.1 399.6 401.0 403.3 15166.5 15585.1 17173.0 17791.4 17855.6 11746.9 12518.4 15699.0 17386.0 17441.2 5134.4 5397.9 5666.8 5668.8 5690.7 3858.1 3968.7 5509.3 5976.9 6160.4 6056.3 6175.8 6202.3 6266.7 6321.5 6157.9 6160.7 6165.5 6220.2 6236.9 5370.6 5606.4 5624.8 5624.9 5627.4 12458.1 12990.5 13016.6 13018.5 21175.8 2287.6 2377.9 2386.2 2413.0 2413.4 10030.7 10286.9 12527.8 12726.4 13105.3 1995.2 2016.6 2018.8 2042.2 2062.6 58018.7 58196.4 58873.4 59779.7 59926.7 10863.7 10874.6 10949.9 10985.3 11052.9 14520.1 14553.7 14577.2 14633.8 14654.6 8155.3 8303.9 8411.4 8415.3 8450.5 8076.1 8120.3 8139.5 8161.0 8179.2 4621.7 4687.7 4690.6 4702.5 4714.7 1938.4 2030.6 2034.4 2041.5 2051.6 957.0 1044.3 1088.8 1095.6 1104.8 17441.8 17561.6 17642.0 17826.1 18255.3 1015.1 1025.3 1035.2 1040.6 1049.1 9950.0 10139.0 10162.2 10185.3 10328.4 497187.0 508196.0 526676.0 535207.0 539530.0 71495.0 75308.6 75508.0 75546.0 76196.2 1153.9 1175.5 1179.0 1180.9 1195.2 15634.6 15686.6 15738.6 15906.9 16101.4 32503.5 35627.0 36544.5 37986.2 38436.4 43324.8 43893.3 45161.5 45359.3 45453.8 3108.5 3158.5 6825.6 7138.8 7902.6 11252.9 11302.5 11322.8 11502.8 11586.2 10194.5 10292.4 10635.1 10801.7 10808.0 10219.6 10447.2 10484.6 10557.7 10747.2 10048.6 10586.4 10842.0 10870.3 10944.5 7910.2 8032.8 8067.4 8078.1 8104.0 9886.1 10030.0 10581.8 10859.9 10889.3 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | [#3] mootools.html Cycles:180 Average:5854.28 Median:6332.87 stddev:2961.13 (46.8%) stddev-sans-first:2951.40 09:44:09 INFO - PROCESS | 1334 | Values: 1506.8 1527.6 1731.6 1813.2 1852.1 7405.1 7528.2 8126.8 8385.3 8414.6 8035.1 8096.4 8176.9 8216.6 8273.0 2391.6 2412.0 2428.7 2436.5 2437.6 2394.5 2397.2 2430.8 2433.4 2436.1 2329.5 2334.2 2353.6 2421.8 2447.8 2420.4 2430.8 2444.3 2453.5 2454.1 2376.6 2382.6 2392.5 2401.2 2411.3 8240.0 8300.2 8325.8 8348.7 8351.5 5026.1 5074.7 5106.8 5114.3 5186.8 3184.8 3224.6 3233.7 3241.6 3277.7 1052.4 1984.1 2020.6 2139.2 2147.0 11155.3 11291.3 11312.7 11322.1 11349.9 4348.0 4374.7 4413.0 4520.6 4542.3 9244.4 9267.0 9286.0 9310.1 9321.9 5169.8 5179.0 5179.4 5203.6 5209.1 4610.6 4741.5 4754.2 4770.2 4779.4 3699.7 3742.9 3771.2 3808.6 3825.6 1132.7 1181.2 1181.4 1183.9 1190.5 1390.6 1393.5 1399.8 1405.6 1425.2 7871.2 8034.9 8038.0 8051.6 8060.5 1185.9 1204.2 1207.5 1221.3 1234.2 6205.6 6243.3 6329.5 6336.3 6350.8 9604.6 9827.5 9833.5 9859.8 10182.5 9792.6 9980.3 9980.6 10007.2 10077.3 7719.5 7798.5 7813.9 7852.8 7854.8 7480.7 7657.4 7712.3 7726.8 7781.0 8873.5 8893.5 8977.5 9076.7 9083.0 9271.9 9391.2 9458.7 9479.8 9544.0 7099.0 7250.2 7308.3 7317.2 7420.9 7588.1 7660.0 7660.8 7667.5 7683.5 7345.2 7509.4 7619.5 7638.9 7691.1 7339.6 7478.0 7491.1 7681.1 7696.4 7552.0 7706.7 7734.5 7743.5 7748.8 6809.3 6827.1 6852.1 7034.2 7113.9 7161.8 7206.6 7208.7 7214.5 7232.3 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | [#4] prototype.html Cycles:180 Average:5761.83 Median:6534.32 stddev:1743.06 (26.7%) stddev-sans-first:1700.40 09:44:09 INFO - PROCESS | 1334 | Values: 374.4 383.3 384.3 386.4 388.9 6346.5 6370.5 6420.4 6472.6 6615.7 6412.8 6467.3 6498.4 6506.0 6514.6 4932.8 4949.5 4951.3 4958.0 4962.6 4962.1 4972.7 4975.4 4981.3 4981.5 4717.0 4793.2 4839.2 4839.9 4858.9 4819.7 4824.3 4856.2 4864.7 4887.6 4280.0 4291.9 4295.9 4298.1 4303.2 6048.7 6071.1 6144.7 6155.0 6175.9 5612.3 5725.6 5750.9 5751.4 5759.7 6808.8 6813.7 6818.4 6840.6 6846.0 4707.3 4751.8 4772.9 4780.0 4780.2 6995.7 7094.2 7112.9 7152.9 7158.3 4884.4 4894.1 4902.9 4905.5 4913.4 4969.7 4969.8 4972.5 4977.6 4980.2 5712.0 5712.5 5715.4 5742.3 5750.9 6665.3 6777.8 6803.1 6890.0 6904.8 1738.2 1740.1 1741.3 1756.4 1761.5 1164.7 1185.1 1192.6 1204.3 1215.1 6514.3 6578.5 6585.7 6604.1 6605.0 7015.6 7061.2 7067.5 7082.4 7099.5 6508.8 6554.0 6671.3 6687.5 6688.8 3818.9 3831.0 3849.4 3849.4 3867.7 7359.5 7387.5 7405.6 7414.5 7421.2 7208.7 7282.0 7305.3 7325.6 7379.6 7385.7 7388.5 7395.7 7403.1 7411.5 6923.0 7119.7 7120.4 7124.4 7150.1 7111.5 7125.0 7126.6 7133.8 7142.9 7402.5 7428.6 7435.3 7440.4 7443.5 4820.7 4862.7 4873.1 4907.8 4937.5 7096.8 7156.6 7179.8 7180.3 7180.5 6925.8 6955.2 6976.8 6978.9 7001.9 6855.8 6954.0 6961.9 6984.2 6998.0 6822.2 6831.1 6846.3 6860.6 6863.0 6931.1 6971.5 6984.5 7005.0 7030.1 6594.6 6705.8 6728.4 6763.6 6849.1 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - PROCESS | 1334 | [#5] yui.html Cycles:180 Average:15211.01 Median:25132.47 stddev:17575.12 (69.9%) stddev-sans-first:17591.33 09:44:09 INFO - PROCESS | 1334 | Values: 848.4 917.6 919.4 920.8 934.4 12487.1 12544.4 12574.2 12598.5 13995.0 13851.2 13894.5 13914.2 13918.7 13945.7 875.9 876.7 892.1 896.7 902.9 890.6 891.1 894.1 895.8 898.2 921.7 925.9 929.1 930.5 933.9 919.7 921.2 922.8 925.6 926.3 683.4 685.9 686.4 688.4 689.9 15186.2 15217.5 15286.6 15338.8 15362.0 13662.2 13676.7 13751.3 13862.3 13964.1 11487.9 11514.1 11589.6 11737.1 12174.4 3903.0 3971.4 3987.9 4008.5 4101.5 52079.2 52344.7 52664.0 53066.7 53079.0 10539.3 10884.0 11036.2 11143.2 11241.4 19234.1 19311.9 19345.1 19367.3 19454.0 8153.2 8195.5 8210.5 8279.8 8407.7 4465.7 4603.6 4613.6 4664.7 4747.7 3111.1 3155.5 3185.1 3247.4 3248.3 596.8 612.8 613.5 618.9 623.6 611.5 670.3 698.1 702.2 712.8 9271.8 9765.1 9820.7 9850.3 9877.4 627.0 635.3 674.8 678.8 684.2 4320.7 4364.7 4414.0 4450.6 4466.9 62729.0 64368.0 64380.0 64437.0 64447.4 56681.4 57108.4 57293.0 57666.4 57812.0 49935.8 50607.7 50705.0 51093.0 51822.5 8608.4 8682.0 8726.4 8990.3 9107.2 37675.7 38385.0 39072.4 40360.0 40802.0 45798.0 46171.3 47804.8 48163.8 49525.0 11869.8 12022.6 12353.0 12415.9 12809.4 13701.5 14042.2 14220.4 14391.2 14413.6 12748.4 13049.8 13184.7 13578.8 13603.7 12657.9 12963.0 13039.3 13111.0 13382.7 12624.6 12998.1 13000.5 13179.6 13283.6 10596.5 10789.9 10790.4 10802.6 11036.9 11199.8 11392.0 11480.1 11547.4 11648.2 09:44:09 INFO - PROCESS | 1334 | -------- Summary: end -------- 09:44:09 INFO - PROCESS | 1334 | 09:44:09 INFO - TEST-INFO | 1334: exit 0 09:44:09 INFO - TEST-OK | dromaeo_css | took 1108302ms 09:44:09 INFO - TEST-START | kraken 09:44:09 INFO - operating with platform_type : linux_ 09:44:09 INFO - Initialising browser for kraken test... 09:44:09 INFO - TEST-INFO | started process 1581 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgylgou/profile http://localhost:47674/getInfo.html) 09:44:13 INFO - PROCESS | 1581 | 09:44:13 INFO - PROCESS | 1581 | (process:1659): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:44:13 INFO - PROCESS | 1581 | __metrics Screen width/height:1600/1200 09:44:13 INFO - PROCESS | 1581 | colorDepth:24 09:44:13 INFO - PROCESS | 1581 | Browser inner width/height: 1024/697 09:44:13 INFO - PROCESS | 1581 | __metrics 09:44:14 INFO - TEST-INFO | 1581: exit 0 09:44:14 INFO - Browser initialized. 09:44:14 INFO - Running cycle 1/1 for kraken test... 09:44:14 INFO - TEST-INFO | started process 1708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgylgou/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:16 INFO - PROCESS | 1708 | 09:44:16 INFO - PROCESS | 1708 | (process:1772): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:44:26 INFO - PROCESS | 1708 | RSS: Main: 141602816 09:44:26 INFO - PROCESS | 1708 | 09:44:29 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47674/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:29 INFO - PROCESS | 1708 | RSS: Main: 146534400 09:44:29 INFO - PROCESS | 1708 | 09:44:32 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47674/tests/kraken/driver.html?testName=audio-dft) 09:44:33 INFO - PROCESS | 1708 | RSS: Main: 145489920 09:44:33 INFO - PROCESS | 1708 | 09:44:35 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47674/tests/kraken/driver.html?testName=audio-fft) 09:44:36 INFO - PROCESS | 1708 | RSS: Main: 147337216 09:44:36 INFO - PROCESS | 1708 | 09:44:38 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47674/tests/kraken/driver.html?testName=audio-oscillator) 09:44:39 INFO - PROCESS | 1708 | RSS: Main: 147156992 09:44:39 INFO - PROCESS | 1708 | 09:44:41 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:41 INFO - PROCESS | 1708 | RSS: Main: 146927616 09:44:41 INFO - PROCESS | 1708 | 09:44:44 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47674/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:45 INFO - PROCESS | 1708 | RSS: Main: 146182144 09:44:45 INFO - PROCESS | 1708 | 09:44:48 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47674/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:49 INFO - PROCESS | 1708 | RSS: Main: 146952192 09:44:49 INFO - PROCESS | 1708 | 09:44:52 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47674/tests/kraken/driver.html?testName=json-parse-financial) 09:44:52 INFO - PROCESS | 1708 | RSS: Main: 146595840 09:44:52 INFO - PROCESS | 1708 | 09:44:54 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:54 INFO - PROCESS | 1708 | RSS: Main: 146743296 09:44:54 INFO - PROCESS | 1708 | 09:44:56 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:57 INFO - PROCESS | 1708 | RSS: Main: 146321408 09:44:57 INFO - PROCESS | 1708 | 09:44:59 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:59 INFO - PROCESS | 1708 | RSS: Main: 146878464 09:44:59 INFO - PROCESS | 1708 | 09:45:02 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:02 INFO - PROCESS | 1708 | RSS: Main: 145940480 09:45:02 INFO - PROCESS | 1708 | 09:45:05 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:05 INFO - PROCESS | 1708 | RSS: Main: 146649088 09:45:05 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | Cycle 1(1): loaded http://localhost:47674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47674/tests/kraken/driver.html?testName=ai-astar) 09:45:07 INFO - PROCESS | 1708 | RSS: Main: 147853312 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | __start_tp_report 09:45:07 INFO - PROCESS | 1708 | _x_x_mozilla_page_load 09:45:07 INFO - PROCESS | 1708 | _x_x_mozilla_page_load_details 09:45:07 INFO - PROCESS | 1708 | |i|pagename|runs| 09:45:07 INFO - PROCESS | 1708 | |0;ai-astar;111;105;111;111;111;120;110;109;112;112 09:45:07 INFO - PROCESS | 1708 | |1;audio-beat-detection;155;126;159;160;126;155;146;130;175;125 09:45:07 INFO - PROCESS | 1708 | |2;audio-dft;162;162;162;163;161;161;161;163;164;162 09:45:07 INFO - PROCESS | 1708 | |3;audio-fft;73;73;72;154;76;73;73;75;152;74 09:45:07 INFO - PROCESS | 1708 | |4;audio-oscillator;97;96;134;95;95;96;137;99;96;141 09:45:07 INFO - PROCESS | 1708 | |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;111;111 09:45:07 INFO - PROCESS | 1708 | |6;imaging-darkroom;148;147;147;146;146;148;147;148;147;149 09:45:07 INFO - PROCESS | 1708 | |7;imaging-desaturate;96;97;97;97;97;97;97;96;96;96 09:45:07 INFO - PROCESS | 1708 | |8;json-parse-financial;57;61;58;57;62;57;56;65;57;55 09:45:07 INFO - PROCESS | 1708 | |9;json-stringify-tinderbox;64;64;64;65;64;65;65;65;65;65 09:45:07 INFO - PROCESS | 1708 | |10;stanford-crypto-aes;79;88;87;82;86;79;81;83;80;79 09:45:07 INFO - PROCESS | 1708 | |11;stanford-crypto-ccm;113;122;112;119;119;113;116;112;111;120 09:45:07 INFO - PROCESS | 1708 | |12;stanford-crypto-pbkdf2;139;139;144;140;139;146;143;134;138;124 09:45:07 INFO - PROCESS | 1708 | |13;stanford-crypto-sha256-iterative;67;65;68;65;68;70;63;64;68;66 09:45:07 INFO - PROCESS | 1708 | __end_tp_report 09:45:07 INFO - PROCESS | 1708 | __start_cc_report 09:45:07 INFO - PROCESS | 1708 | _x_x_mozilla_cycle_collect,731 09:45:07 INFO - PROCESS | 1708 | __end_cc_report 09:45:07 INFO - PROCESS | 1708 | __startTimestamp1457113507839__endTimestamp 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | ------- Summary: start ------- 09:45:07 INFO - PROCESS | 1708 | Number of tests: 14 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.71 (3.3%) stddev-sans-first:3.93 09:45:07 INFO - PROCESS | 1708 | Values: 111.0 105.0 111.0 111.0 111.0 120.0 110.0 109.0 112.0 112.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:155.00 stddev:17.84 (11.5%) stddev-sans-first:18.60 09:45:07 INFO - PROCESS | 1708 | Values: 155.0 126.0 159.0 160.0 126.0 155.0 146.0 130.0 175.0 125.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 09:45:07 INFO - PROCESS | 1708 | Values: 162.0 162.0 162.0 163.0 161.0 161.0 161.0 163.0 164.0 162.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#3] audio-fft Cycles:10 Average:89.50 Median:73.00 stddev:33.49 (45.9%) stddev-sans-first:34.99 09:45:07 INFO - PROCESS | 1708 | Values: 73.0 73.0 72.0 154.0 76.0 73.0 73.0 75.0 152.0 74.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:96.00 stddev:19.93 (20.8%) stddev-sans-first:20.69 09:45:07 INFO - PROCESS | 1708 | Values: 97.0 96.0 134.0 95.0 95.0 96.0 137.0 99.0 96.0 141.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:45:07 INFO - PROCESS | 1708 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 09:45:07 INFO - PROCESS | 1708 | Values: 148.0 147.0 147.0 146.0 146.0 148.0 147.0 148.0 147.0 149.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:45:07 INFO - PROCESS | 1708 | Values: 96.0 97.0 97.0 97.0 97.0 97.0 97.0 96.0 96.0 96.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:57.50 stddev:3.14 (5.5%) stddev-sans-first:3.28 09:45:07 INFO - PROCESS | 1708 | Values: 57.0 61.0 58.0 57.0 62.0 57.0 56.0 65.0 57.0 55.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 09:45:07 INFO - PROCESS | 1708 | Values: 64.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:3.47 (4.2%) stddev-sans-first:3.46 09:45:07 INFO - PROCESS | 1708 | Values: 79.0 88.0 87.0 82.0 86.0 79.0 81.0 83.0 80.0 79.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:117.50 stddev:4.00 (3.4%) stddev-sans-first:4.12 09:45:07 INFO - PROCESS | 1708 | Values: 113.0 122.0 112.0 119.0 119.0 113.0 116.0 112.0 111.0 120.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:139.50 stddev:6.15 (4.4%) stddev-sans-first:6.52 09:45:07 INFO - PROCESS | 1708 | Values: 139.0 139.0 144.0 140.0 139.0 146.0 143.0 134.0 138.0 124.0 09:45:07 INFO - PROCESS | 1708 | 09:45:07 INFO - PROCESS | 1708 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.50 stddev:2.17 (3.2%) stddev-sans-first:2.29 09:45:07 INFO - PROCESS | 1708 | Values: 67.0 65.0 68.0 65.0 68.0 70.0 63.0 64.0 68.0 66.0 09:45:07 INFO - PROCESS | 1708 | -------- Summary: end -------- 09:45:07 INFO - PROCESS | 1708 | 09:45:08 INFO - TEST-INFO | 1708: exit 0 09:45:08 INFO - TEST-OK | kraken | took 58822ms 09:45:08 INFO - TEST-START | v8_7 09:45:08 INFO - operating with platform_type : linux_ 09:45:08 INFO - Initialising browser for v8_7 test... 09:45:08 INFO - TEST-INFO | started process 2001 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqAYMRG/profile http://localhost:47674/getInfo.html) 09:45:12 INFO - PROCESS | 2001 | 09:45:12 INFO - PROCESS | 2001 | (process:2081): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:45:12 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 09:45:12 INFO - PROCESS | 2001 | colorDepth:24 09:45:12 INFO - PROCESS | 2001 | Browser inner width/height: 1024/697 09:45:12 INFO - PROCESS | 2001 | __metrics 09:45:13 INFO - TEST-INFO | 2001: exit 0 09:45:13 INFO - Browser initialized. 09:45:13 INFO - Running cycle 1/1 for v8_7 test... 09:45:13 INFO - TEST-INFO | started process 2130 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqAYMRG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:15 INFO - PROCESS | 2130 | 09:45:15 INFO - PROCESS | 2130 | (process:2194): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:45:25 INFO - PROCESS | 2130 | RSS: Main: 141176832 09:45:25 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | Cycle 1(1): loaded http://localhost:47674/tests/v8_7/run.html (next: http://localhost:47674/tests/v8_7/run.html) 09:45:48 INFO - PROCESS | 2130 | RSS: Main: 145145856 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | __start_tp_report 09:45:48 INFO - PROCESS | 2130 | _x_x_mozilla_page_load 09:45:48 INFO - PROCESS | 2130 | _x_x_mozilla_page_load_details 09:45:48 INFO - PROCESS | 2130 | |i|pagename|runs| 09:45:48 INFO - PROCESS | 2130 | |0;Richards;168.12373907195695 09:45:48 INFO - PROCESS | 2130 | |1;DeltaBlue;174.70300489168415 09:45:48 INFO - PROCESS | 2130 | |2;Encrypt;279.4076557697681 09:45:48 INFO - PROCESS | 2130 | |3;Decrypt;5223.958333333333 09:45:48 INFO - PROCESS | 2130 | |4;RayTrace;914.0767824497258 09:45:48 INFO - PROCESS | 2130 | |5;Earley;562.429696287964 09:45:48 INFO - PROCESS | 2130 | |6;Boyer;11258.426966292134 09:45:48 INFO - PROCESS | 2130 | |7;RegExp;39346.153846153844 09:45:48 INFO - PROCESS | 2130 | |8;Splay;519.7505197505197 09:45:48 INFO - PROCESS | 2130 | |9;NavierStokes;4822.115384615385 09:45:48 INFO - PROCESS | 2130 | __end_tp_report 09:45:48 INFO - PROCESS | 2130 | __startTimestamp1457113548323__endTimestamp 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | ------- Summary: start ------- 09:45:48 INFO - PROCESS | 2130 | Number of tests: 10 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#0] Richards Cycles:1 Average:168.12 Median:168.12 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 168.1 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#1] DeltaBlue Cycles:1 Average:174.70 Median:174.70 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 174.7 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 279.4 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 5224.0 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#4] RayTrace Cycles:1 Average:914.08 Median:914.08 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 914.1 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#5] Earley Cycles:1 Average:562.43 Median:562.43 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 562.4 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#6] Boyer Cycles:1 Average:11258.43 Median:11258.43 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 11258.4 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#7] RegExp Cycles:1 Average:39346.15 Median:39346.15 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 39346.2 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#8] Splay Cycles:1 Average:519.75 Median:519.75 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 519.8 09:45:48 INFO - PROCESS | 2130 | 09:45:48 INFO - PROCESS | 2130 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 09:45:48 INFO - PROCESS | 2130 | Values: 4822.1 09:45:48 INFO - PROCESS | 2130 | -------- Summary: end -------- 09:45:48 INFO - PROCESS | 2130 | 09:45:49 INFO - TEST-INFO | 2130: exit 0 09:45:49 INFO - TEST-OK | v8_7 | took 40402ms 09:45:49 INFO - SUITE-END | took 1207s 09:45:49 INFO - Completed test suite (00:20:07) 09:45:49 INFO - Working with test: dromaeo_css 09:45:49 INFO - Generating results file: dromaeo_css 09:45:49 INFO - Working with test: kraken 09:45:49 INFO - Generating results file: kraken 09:45:49 INFO - javascript benchmark 09:45:49 INFO - Working with test: v8_7 09:45:49 INFO - Generating results file: v8_7 09:45:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:45:49 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:45:49 INFO - process_Request line: dromaeo_css 7401.11 graph.html#tests=[[72,52,43]] 09:45:49 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:45:49 INFO - process_Request line: kraken 1497.30 graph.html#tests=[[232,52,43]] 09:45:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:45:49 INFO - process_Request line: v8_7 21936.83 graph.html#tests=[[230,52,43]] 09:45:49 INFO - RETURN: dromaeo_css: 7401.11 09:45:49 INFO - RETURN: kraken: 1497.30 09:45:49 INFO - RETURN: v8_7: 21936.83 09:45:49 INFO - javascript benchmark 09:45:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.170207448138, 3370.0563842124197, 3391.7964922104693, 3401.897943061709, 3410.1474631342157, 5429.185622156679, 5435.809746658868, 5438.293021907151, 5457.754401051948, 5461.781528738856, 5441.428649991753, 5449.155380915954, 5466.726663666821, 5487.5609951203905, 5498.147787093007, 4929.137400954836, 4992.47579004203, 5046.495350464943, 5080.364954380702, 5123.0, 4804.807807687688, 4947.901041979158, 4991.276264941581, 4994.625403094782, 5017.147084995559, 4943.752812359386, 5011.498850114996, 5017.172166592508, 5022.296878437021, 5035.647504674675, 4938.580220681247, 4981.750912454381, 4995.450500444948, 5007.37407824022, 5019.974900125494, 4863.610911127102, 4927.1870141426625, 4939.209726443788, 4964.578010869044, 4968.826091086831, 5228.8692782680355, 5281.656692314988, 5295.179247216687, 5297.920531192035, 5331.093714068617, 5858.707064646751, 5870.618409803392, 5880.088586269135, 5880.147378630075, 5881.470667639933, 5604.3835178130375, 5803.274590676166, 5808.651480911117, 5823.068309070529, 5944.821655350346, 5534.280543529356, 5557.694326812024, 5559.0, 5567.8608034799045, 5580.525655319303, 6039.8490037748525, 6043.244594425697, 6046.153538504613, 6048.6673232971725, 6065.878682426327, 5691.8861622768145, 5773.8267851963665, 5785.0454674978155, 5811.593188476766, 5819.185314055951, 5775.768969241183, 5783.103618939072, 5785.508231800344, 5801.361850196475, 5839.328477225088, 5789.073748200352, 5804.796832110856, 5806.82579522615, 5808.651480911159, 5810.4770570648, 5638.492535671728, 5678.3186017678145, 5800.245968024215, 5867.589268751147, 5894.056950887837, 4503.54964503547, 4503.594676479132, 4511.616512596401, 4525.570070843265, 4543.704659197141, 3969.047428617169, 4096.180763847243, 4100.979495102505, 4111.814968326433, 4124.05146816234, 5460.099083651233, 5485.588580856452, 5533.750981205855, 5599.8600034998635, 5625.859353516113, 5858.238429004287, 5887.558433117448, 5897.115432685132, 5914.940850591525, 5916.319623243382, 5414.485623865727, 5501.312335958005, 5577.247071645276, 5588.720563971785, 5593.272874526367, 5037.622178336639, 5039.294498770175, 5065.6200784941275, 5074.416442109205, 5101.770420331094, 5951.583389162717, 5954.46409823118, 5957.076653118774, 5963.135345374896, 5988.730507127103, 5715.971420142872, 5787.884242315215, 5804.2744656917885, 5806.738696758741, 5861.560382971379, 5978.850528736816, 5981.730822112929, 5994.190784244071, 6005.339412664691, 6031.276246850406, 5730.856728581819, 5831.475167234969, 5831.679257640871, 5846.152307915413, 5858.0, 5777.075667893285, 5824.82525524218, 5913.0, 5954.404559544011, 6053.182820319201, 5814.331351894586, 5842.357340692435, 5846.503047240862, 5851.678157701197, 5856.209411729362, 5722.885542289047, 5783.248177736868, 5798.420157984167, 5814.331351894417, 5840.357560668408, 5541.445855414427, 5550.944490555043, 5637.238972738628, 5639.577031722719, 5650.745716442852, 5680.346760122638, 5711.771529138788, 5742.655440673406, 5743.396943320891, 5754.136879468113, 5576.33084029919, 5620.156976453564, 5621.409751976147, 5630.85922851932, 5639.125935480007], "unit": "score", "name": "dojo.html", "value": 5406.9041367093305}, {"lowerIsBetter": false, "replicates": [554.0758507527902, 565.7963133272021, 588.6056342250691, 605.8243109498243, 622.3185611755132, 40528.39207411888, 41430.37854432182, 41535.16929661409, 41568.79215603925, 41575.58424415755, 38901.41647875277, 40229.19541609166, 40332.59667403325, 40363.79818100913, 40394.394084088686, 8700.43447175933, 8817.823643527126, 8888.111188881125, 8901.243394311492, 8937.865932011026, 8598.656053757843, 8641.827163456726, 8667.349948753837, 8676.0, 8785.077566855483, 8726.389152759277, 8744.300455963508, 8856.468611883276, 9038.367314288002, 9060.954695226515, 8885.777855553599, 8894.86657700135, 8922.776930576754, 8998.19016288534, 9000.964889037714, 8703.782405439852, 8788.20906118446, 8850.73447796567, 8878.467291962503, 8884.600192991331, 41249.38125928114, 42061.369079463526, 42075.1584968302, 42082.158356832995, 42113.789431052646, 3475.131217195701, 3506.982465087658, 3650.8357123929486, 3874.5156855393075, 4334.0, 32252.838735806406, 32487.83756081228, 33020.50469242963, 33077.6692233077, 33117.17207069843, 4249.32010878258, 4290.785460726951, 4310.159518893817, 4352.825886964518, 4360.324149756792, 286016.0, 286565.0, 287918.0, 289853.9999999979, 290790.0, 64098.679506603105, 64271.357286427476, 64310.0, 64475.35524644787, 64553.0, 65150.34849651538, 65711.67144164344, 65720.34279657238, 66009.00986485207, 66117.6694116536, 16219.918900405422, 16557.42049028278, 16563.337466501445, 16603.169841507875, 16650.3339866404, 12886.09797314179, 13017.869821301665, 13057.151285166434, 13075.673108172372, 13429.798553021712, 21001.0, 21200.893995530234, 21333.46666333354, 21368.717876927432, 21405.571888562143, 8161.224683655043, 8352.081271060179, 8404.36967227448, 8466.195711407407, 8513.063563008063, 957.9760505987406, 999.7100840756099, 1021.4126877045728, 1069.0325255643654, 1121.770037142384, 30744.53883191754, 30748.38503229923, 31308.217294567363, 31512.212194694857, 31518.054458366285, 1113.2596823112701, 1115.1023426141871, 1126.8253420719802, 1222.730999180179, 1222.8288039674453, 14843.257837108102, 16880.240389182516, 17272.481825545256, 17569.56076098108, 18256.543586410182, 277236.0, 462357.0, 471256.0, 472557.0, 494193.0, 54313.0, 55568.0, 55687.0, 55703.44296557063, 55715.44284557102, 1501.1218437214352, 1507.8314306412399, 1521.634807646157, 1521.9010764300506, 1523.8933274670667, 32453.350932980735, 32467.188320291236, 32664.34671306608, 32951.340973179926, 33635.66364336325, 48752.75623621859, 49405.50594494009, 49541.0, 49589.25616115833, 49676.0, 328329.0, 330734.0, 331928.0, 333040.0, 334264.0, 35109.82445087758, 35189.64810351864, 35563.466548001285, 36007.27985440329, 36074.819625901706, 46151.53848461472, 46582.76708616435, 46671.76664116794, 47325.52674473211, 47675.28487072766, 41591.1681766369, 42137.789311053246, 42544.78727606342, 43578.51532657836, 47682.28476572924, 39108.80445597868, 40063.39904901487, 40204.0, 40393.1921361577, 40470.59529404668, 40365.79817101013, 42661.95384204078, 42901.570984289756, 43275.567244327154, 43821.561784383026, 32958.835205823816, 34559.65440345564, 35292.64707352893, 35325.82337088401, 35613.0, 28156.155315340573, 28397.574036389058, 28404.85797570999, 28573.28566785847, 28595.714042859305], "unit": "score", "name": "ext.html", "value": 20112.30761654924}, {"lowerIsBetter": false, "replicates": [386.5689755922146, 388.0976729104832, 399.6083837838918, 400.98797036088894, 403.2519676001017, 15166.469173578927, 15585.064896106242, 17173.0, 17791.377301794422, 17855.55361115971, 11746.882531174686, 12518.374081295944, 15699.0, 17386.0, 17441.21514531846, 5134.4095429025765, 5397.919031214535, 5666.801661941833, 5668.829935101933, 5690.715464226792, 3858.131920317934, 3968.72218944674, 5509.311336082989, 5976.850578735544, 6160.383961603849, 6056.303525094604, 6175.845603859894, 6202.286737025254, 6266.749330026793, 6321.494280457576, 6157.907631385533, 6160.722767475474, 6165.537584681145, 6220.191375121205, 6236.87526249477, 5370.624056316059, 5606.411326810667, 5624.803131890364, 5624.91562626561, 5627.409122042168, 12458.12793104483, 12990.480380784757, 13016.60950171487, 13018.544350947672, 21175.788242117535, 2287.553926984239, 2377.9405514862265, 2386.200622791367, 2412.9517409651885, 2413.3966508372905, 10030.749231269203, 10286.897131028669, 12527.812082818766, 12726.363681815872, 13105.279209643466, 1995.1520603743352, 2016.596680663873, 2018.8082132197417, 2042.1627132875599, 2062.618415593105, 58018.70990645062, 58196.41803581952, 58873.41126588722, 59779.70110149465, 59926.70036649833, 10863.728406789893, 10874.565017399374, 10949.890501095046, 10985.285956412808, 11052.889471105185, 14520.056196347203, 14553.708925821637, 14577.198254095914, 14633.780493292608, 14654.63363415923, 8155.34757219421, 8303.916960830435, 8411.411201215979, 8415.326773858076, 8450.492970421672, 8076.071251806, 8120.309773669304, 8139.4709343892455, 8161.0, 8179.182081791892, 4621.722696638212, 4687.7343117358805, 4690.64820138491, 4702.459217190067, 4714.693544919569, 1938.3990962801577, 2030.6344857925715, 2034.4100210938957, 2041.5202427429542, 2051.6101940631233, 956.9904300956902, 1044.3264094658903, 1088.8094583447864, 1095.5727266366123, 1104.7790441911488, 17441.82558174402, 17561.648767024588, 17642.0, 17826.10869456522, 18255.26978920855, 1015.1168483419473, 1025.3437799808128, 1035.2287545778443, 1040.552562398161, 1049.0925349572565, 9949.950250248847, 10139.0, 10162.18702503798, 10185.287029907835, 10328.431936243578, 497187.0, 508196.0, 526676.0, 535207.0, 539530.0, 71495.0, 75308.62345688237, 75508.0, 75546.0, 76196.23803762002, 1153.9095554700896, 1175.5121624525725, 1178.988210117905, 1180.8582970043649, 1195.1753290229713, 15634.609134771721, 15686.607834803764, 15738.606534836263, 15906.920465398061, 16101.436449724672, 32503.512447313784, 35627.0, 36544.45183322306, 37986.24027519379, 38436.42345364878, 43324.783376082916, 43893.341599876665, 45161.548384515736, 45359.319610206534, 45453.772731137455, 3108.5026395777472, 3158.5262210668584, 6825.624590647363, 7138.750718624324, 7902.644381002984, 11252.943735281271, 11302.491387887729, 11322.830157547478, 11502.769944600894, 11586.188966772244, 10194.490275486345, 10292.419873156374, 10635.096016838655, 10801.729956751144, 10808.0, 10219.642312519027, 10447.216458765775, 10484.580616775243, 10557.683269501927, 10747.193960452842, 10048.598056077675, 10586.364818110938, 10842.0, 10870.347779133277, 10944.452777361259, 7910.169432209766, 8032.799180020546, 8067.435279530377, 8078.071021832329, 8103.959480202561, 9886.110250077527, 10030.0, 10581.788364232827, 10859.945700271448, 10889.346639201673], "unit": "score", "name": "jquery.html", "value": 8598.29383383108}, {"lowerIsBetter": false, "replicates": [1506.8041154649893, 1527.6028232659512, 1731.5930756272273, 1813.1659436659136, 1852.1017306606293, 7405.111386633612, 7528.209537998499, 8126.756197314083, 8385.329173666107, 8414.621342039607, 8035.116137224915, 8096.43324967251, 8176.91823081769, 8216.630251638675, 8272.958635206816, 2391.629297458897, 2412.0472413396787, 2428.6842710447704, 2436.512697460515, 2437.597796363598, 2394.5330660521204, 2397.1969390254285, 2430.8419952703016, 2433.3916520869693, 2436.0986435019067, 2329.5108027314286, 2334.241371554243, 2353.576356255873, 2421.842580232288, 2447.7674620910984, 2420.407000284924, 2430.7569243075727, 2444.327809852296, 2453.521563295158, 2454.1165180534995, 2376.572217000939, 2382.5949588569983, 2392.509535545209, 2401.183597576832, 2411.288669842401, 8240.0, 8300.2114799094, 8325.791855203608, 8348.666053357858, 8351.498910065415, 5026.095302845486, 5074.695518268915, 5106.770195341219, 5114.309568208281, 5186.766595503173, 3184.792988455743, 3224.629167645727, 3233.725133363667, 3241.578594782663, 3277.73778097754, 1052.3896140238644, 1984.0575726529928, 2020.6160829442358, 2139.229877244191, 2147.0231044874545, 11155.27490713101, 11291.322520648788, 11312.660620181325, 11322.094232461382, 11349.943250283695, 4347.978260108679, 4374.671899607542, 4412.977935110304, 4520.615747661485, 4542.318652202196, 9244.399114057565, 9267.0, 9286.0, 9310.115539023782, 9321.860172097424, 5169.844904652867, 5179.041877252645, 5179.378474583074, 5203.635745497779, 5209.114450543417, 4610.561996610317, 4741.478437371887, 4754.191787396151, 4770.189067858472, 4779.354787103766, 3699.7040236780995, 3742.925141497155, 3771.1891943232336, 3808.638179372955, 3825.5983121771815, 1132.65454036518, 1181.167277069664, 1181.4033912873945, 1183.8756930522343, 1190.4702407428783, 1390.6175801654424, 1393.5122707052653, 1399.846016938136, 1405.6275087101926, 1425.230375597166, 7871.17352677972, 8034.879476807852, 8038.0, 8051.557164356017, 8060.516369017878, 1185.9051275897907, 1204.1691233049169, 1207.4988879614862, 1221.2855479544567, 1234.216272666863, 6205.627662340274, 6243.344448832898, 6329.461995730415, 6336.271328797247, 6350.777722779773, 9604.567794449267, 9827.508624568743, 9833.459159746282, 9859.802803943881, 10182.541785619665, 9792.55933482995, 9980.301378903407, 9980.550875210633, 10007.249456290661, 10077.344972576759, 7719.536827790351, 7798.493097948615, 7813.921860781433, 7852.803679907934, 7854.8429031419055, 7480.70077196906, 7657.425693072931, 7712.344450721752, 7726.806829829299, 7781.0, 8873.511956842436, 8893.510856902933, 8977.461352318882, 9076.727698169065, 9083.0, 9271.907280927104, 9391.154796068387, 9458.668946587111, 9479.763005924908, 9544.0, 7098.964505177441, 7250.238724934017, 7308.30571095745, 7317.195108538163, 7420.851582968418, 7588.051493563305, 7660.0, 7660.846783064196, 7667.463277570517, 7683.462157648911, 7345.235011655949, 7509.399248060033, 7619.466637335333, 7638.923610764044, 7691.077070751546, 7339.59632220233, 7478.0, 7491.138519070377, 7681.078270607562, 7696.384289256734, 7552.0, 7706.730264440717, 7734.458587899018, 7743.5353878767455, 7748.8450230996195, 6809.319068093151, 6827.112475378368, 6852.143482064742, 7034.226235114235, 7113.928860711327, 7161.820954476179, 7206.6396680164735, 7208.7116515340895, 7214.458915581247, 7232.349088582053], "unit": "score", "name": "mootools.html", "value": 4878.988250127897}, {"lowerIsBetter": false, "replicates": [374.40656559353425, 383.27752187127294, 384.3446922996292, 386.40686546151653, 388.86389763582747, 6346.460550853178, 6370.4585110265625, 6420.390062944025, 6472.5792823466445, 6615.735370585171, 6412.775552855651, 6467.256265529466, 6498.44763195129, 6505.9590465525525, 6514.641694706789, 4932.753362331869, 4949.505049495057, 4951.306817045607, 4957.975210123945, 4962.60299176065, 4962.106820772277, 4972.701637901738, 4975.378077740283, 4981.252812078181, 4981.476944920785, 4716.952830471703, 4793.233082706767, 4839.177339852234, 4839.903201935959, 4858.927116093244, 4819.734914579697, 4824.300476430898, 4856.198727210024, 4864.708117512961, 4887.608991280725, 4280.036991676879, 4291.91416171678, 4295.914081718348, 4298.11888562847, 4303.182395344906, 6048.69756512177, 6071.058985857199, 6144.692765361759, 6155.045967874987, 6175.907361389583, 5612.326520817487, 5725.599208055438, 5750.913736293959, 5751.3961034091235, 5759.712014399263, 6808.795736127924, 6813.659317034128, 6818.386345228953, 6840.555363901381, 6846.041554182419, 4707.270373092176, 4751.809927602892, 4772.904541909177, 4780.043991201739, 4780.211265141247, 6995.650217489105, 7094.219635840053, 7112.928870711278, 7152.856942861114, 7158.319959603881, 4884.389451318585, 4894.094592500399, 4902.940764878759, 4905.484924082992, 4913.434954980223, 4969.726665033386, 4969.801207951641, 4972.477889821516, 4977.552020318117, 4980.178270585386, 5711.9718450679275, 5712.514436272963, 5715.428457154335, 5742.28221472316, 5750.88498230033, 6665.266820649725, 6777.830554236085, 6803.115594972622, 6889.965550172217, 6904.792856214322, 1738.1743671756067, 1740.1038465190436, 1741.3208848549075, 1756.4291605228352, 1761.5067781021335, 1164.7437563736135, 1185.0756410000213, 1192.6183621241294, 1204.3195594489262, 1215.0522592377959, 6514.283428822826, 6578.473722102221, 6585.736570537125, 6604.075429439882, 6605.0, 7015.614141222281, 7061.223265440797, 7067.540609860343, 7082.433405327562, 7099.467539934525, 6508.837279068061, 6554.0, 6671.299513551105, 6687.531872768956, 6688.799336019927, 3818.942715859209, 3830.9808450958126, 3849.3840985442193, 3849.3840985442193, 3867.7485963412287, 7359.521631093961, 7387.519811212362, 7405.555666660018, 7414.518056326321, 7421.183669796318, 7208.675609597581, 7282.0, 7305.305995930378, 7325.597092159983, 7379.594122323324, 7385.667644955883, 7388.519746216479, 7395.7041718330665, 7403.111626604734, 7411.518251313647, 6922.965385173042, 7119.715211391486, 7120.430365570845, 7124.3944264738075, 7150.141982962078, 7111.466640001917, 7125.0, 7126.643667816485, 7133.750318738819, 7142.892856607259, 7402.518836275625, 7428.591427471541, 7435.293647103733, 7440.404767618686, 7443.4789564729945, 4820.68665536739, 4862.659613826998, 4873.074115917964, 4907.754612269301, 4937.456879743298, 7096.787096387116, 7156.570605763671, 7179.820504487429, 7180.31786980236, 7180.497365184596, 6925.792226233221, 6955.23492415844, 6976.7558135465015, 6978.895316570357, 7001.859962800613, 6855.760048398282, 6953.965230173817, 6961.860762784817, 6984.196817366068, 6998.0, 6822.215445223863, 6831.077804496528, 6846.315368463114, 6860.588364698134, 6863.0, 6931.0643063187845, 6971.51199416036, 6984.4761642878, 7004.964975175091, 7030.121234845645, 6594.571352862049, 6705.798826035227, 6728.394444500019, 6763.5941843489545, 6849.1096157499205], "unit": "score", "name": "prototype.html", "value": 5203.359555215985}, {"lowerIsBetter": false, "replicates": [848.4018766769427, 917.6375331743961, 919.4483310013989, 920.7606022434165, 934.4346670264495, 12487.063470239735, 12544.37278136094, 12574.245545267291, 12598.496060157606, 13995.020348575605, 13851.238181899991, 13894.51369202078, 13914.165150091001, 13918.721625567483, 13945.651358716037, 875.8598624220126, 876.7282142535835, 892.054422312351, 896.6547879066574, 902.8735976963197, 890.5680744838749, 891.0999890111002, 894.1460904835899, 895.8297923394567, 898.2230370729304, 921.6958403726754, 925.9212966897821, 929.0894922975488, 930.4789317981952, 933.869258303838, 919.6643225222813, 921.1801496667904, 922.8246633139682, 925.6204955968054, 926.2960150285797, 683.4054372695737, 685.9108315918949, 686.3994005245411, 688.3598253624127, 689.9206591242021, 15186.164760938143, 15217.467388641455, 15286.617834554114, 15338.769918451233, 15362.0, 13662.18026918388, 13676.726465470734, 13751.312434378242, 13862.306884655827, 13964.092333998258, 11487.885121148765, 11514.078873690085, 11589.594364197297, 11737.119716021332, 12174.391280435942, 3902.9804850975847, 3971.4241434992055, 3987.860424885115, 4008.478897743304, 4101.507819061731, 52079.218811717474, 52344.73827630876, 52664.0, 53066.73466632642, 53079.0, 10539.314944528582, 10884.0, 11036.227464077598, 11143.164262680331, 11241.437928103562, 19234.134463949154, 19311.903440482987, 19345.12946917392, 19367.256946874848, 19454.02729863501, 8153.1846815317995, 8195.46729462583, 8210.507369557727, 8279.793005174799, 8407.663693452194, 4465.687401881902, 4603.631709463235, 4613.5847773700525, 4664.696794708333, 4747.718116108631, 3111.0977816432983, 3155.4793459078996, 3185.0604071798875, 3247.3505298939835, 3248.3016151527063, 596.8299034775068, 612.7855250662233, 613.4754784659052, 618.888600051995, 623.6102435977514, 611.4848511790051, 670.3363669966795, 698.0576222100124, 702.1644243350397, 712.8396110875011, 9271.814563708687, 9765.121139097515, 9820.705378838646, 9850.310478266596, 9877.357971731959, 626.9592476489014, 635.3329004545209, 674.7874419557824, 678.7522554267657, 684.1824020295799, 4320.740755554677, 4364.664536105085, 4413.955860441354, 4450.621697155713, 4466.932996005063, 62729.0, 64368.0, 64380.0, 64437.0, 64447.35552644507, 56681.433185667614, 57108.42891571114, 57293.0, 57666.42333576611, 57812.0, 49935.75032124889, 50607.74696126496, 50705.0, 51093.0, 51822.48177518252, 8608.354373421893, 8681.958165019985, 8726.3891527595, 8990.280777537911, 9107.180353767928, 37675.73945563275, 38385.0, 39072.41391379075, 40360.0, 40802.0, 45798.0, 46171.3074303879, 47804.7609761949, 48163.759181203866, 49525.0, 11869.813018698407, 12022.63932082039, 12353.0, 12415.875841241834, 12809.359532023174, 13701.520446784314, 14042.1574705518, 14220.431182752987, 14391.208483533506, 14413.639659008608, 12748.426320815772, 13049.804252936403, 13184.73630527365, 13578.79631805504, 13603.727925441633, 12657.87342126567, 12963.0, 13039.282839443922, 13111.016673749316, 13382.665433364244, 12624.55814046504, 12998.090133690928, 13000.544980925622, 13179.60461186166, 13283.601491955256, 10596.47017649099, 10789.921007899462, 10790.406527641055, 10802.567897284021, 11036.944815275872, 11199.776004480027, 11392.0, 11480.138989575982, 11547.364894930524, 11648.242864213798], "unit": "score", "name": "yui.html", "value": 6923.253820774095}], "name": "dromaeo_css", "value": 7401.113152545328}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 111.0, 111.0, 120.0, 110.0, 109.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 159.0, 160.0, 126.0, 155.0, 146.0, 130.0, 175.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 154.0, 76.0, 73.0, 73.0, 75.0, 152.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 134.0, 95.0, 95.0, 96.0, 137.0, 99.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 148.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [57.0, 61.0, 58.0, 57.0, 62.0, 57.0, 56.0, 65.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [79.0, 88.0, 87.0, 82.0, 86.0, 79.0, 81.0, 83.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [113.0, 122.0, 112.0, 119.0, 119.0, 113.0, 116.0, 112.0, 111.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [139.0, 139.0, 144.0, 140.0, 139.0, 146.0, 143.0, 134.0, 138.0, 124.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 68.0, 65.0, 68.0, 70.0, 63.0, 64.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1497.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.12373907195695], "unit": "score", "name": "Richards", "value": 209.97629600000008}, {"lowerIsBetter": false, "replicates": [174.70300489168415], "unit": "score", "name": "DeltaBlue", "value": 378.4594320000001}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [914.0767824497258], "unit": "score", "name": "RayTrace", "value": 809.5479659999999}, {"lowerIsBetter": false, "replicates": [562.429696287964], "unit": "score", "name": "Earley", "value": 1184.9712139999995}, {"lowerIsBetter": false, "replicates": [11258.426966292134], "unit": "score", "name": "Boyer", "value": 59.196813373253526}, {"lowerIsBetter": false, "replicates": [39346.153846153844], "unit": "score", "name": "RegExp", "value": 23.1530889540567}, {"lowerIsBetter": false, "replicates": [519.7505197505197], "unit": "score", "name": "Splay", "value": 156.78868399999996}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21936.831926450544}]} 09:45:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21936.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1497.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7401.11"}}} 09:45:49 INFO - Return code: 0 09:45:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:45:49 INFO - # TBPL SUCCESS # 09:45:49 INFO - Running post-action listener: _resource_record_post_action 09:45:49 INFO - Running post-run listener: _resource_record_post_run 09:45:50 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 8192; Write bytes: 507383808; Read time: 4; Write time: 564936 09:45:50 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 252055552; Read time: 0; Write time: 389688 09:45:50 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 8192; Write bytes: 254390272; Read time: 4; Write time: 175068 09:45:50 INFO - Running post-run listener: _upload_blobber_files 09:45:50 INFO - Blob upload gear active. 09:45:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:45:50 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 09:45:50 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'] 09:45:50 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 09:45:51 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:45:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:52 INFO - (blobuploader) - INFO - Done attempting. 09:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:52 INFO - (blobuploader) - INFO - Done attempting. 09:45:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:52 INFO - Return code: 0 09:45:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:45:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f71f0ca04dbd6df693146ecef887b6606959b43c5da0f9bed2b962426f7ae4030c749d8318f4116a968cec92c7b1ecd9fe55485d7d4c5ca7cca66db4196f7eca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e84d1d92d3a3dd860f8343422c96951f3055494f46a2352853ab62b69a1b1e674bc884a2fb98171e8b97c44dee3c83d2b3632211642fe3ca587653b8f1ef5b0"} 09:45:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:45:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:45:52 INFO - Contents: 09:45:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f71f0ca04dbd6df693146ecef887b6606959b43c5da0f9bed2b962426f7ae4030c749d8318f4116a968cec92c7b1ecd9fe55485d7d4c5ca7cca66db4196f7eca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e84d1d92d3a3dd860f8343422c96951f3055494f46a2352853ab62b69a1b1e674bc884a2fb98171e8b97c44dee3c83d2b3632211642fe3ca587653b8f1ef5b0"} 09:45:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:52 INFO - Copying logs to upload dir... 09:45:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:45:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.471613 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-04 09:45:52.649892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 09:45:52.653122) ========= 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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 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/f71f0ca04dbd6df693146ecef887b6606959b43c5da0f9bed2b962426f7ae4030c749d8318f4116a968cec92c7b1ecd9fe55485d7d4c5ca7cca66db4196f7eca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e84d1d92d3a3dd860f8343422c96951f3055494f46a2352853ab62b69a1b1e674bc884a2fb98171e8b97c44dee3c83d2b3632211642fe3ca587653b8f1ef5b0"} build_url:https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/U_ZYS5ByRFC4GL9eqn_Ofw/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/f71f0ca04dbd6df693146ecef887b6606959b43c5da0f9bed2b962426f7ae4030c749d8318f4116a968cec92c7b1ecd9fe55485d7d4c5ca7cca66db4196f7eca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e84d1d92d3a3dd860f8343422c96951f3055494f46a2352853ab62b69a1b1e674bc884a2fb98171e8b97c44dee3c83d2b3632211642fe3ca587653b8f1ef5b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 09:45:52.679701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:45:52.680355) ========= 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=1b9da9da7504fe468691862d000001b9-1457112289.593593-597509314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 09:45:52.763509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 09:45:52.763828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 09:45:52.764155) ========= ========= Total master_lag: 0.27 =========