builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1456247166.5 results: success (0) buildid: 20160223063907 builduid: 8d31656cd6f5483b8e2a0a4e2e1ca1af revision: c78d4c97956b6cd5544f95bff8a2e944a8b70aee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.498736) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.499257) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.499553) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004934 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.515499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.515780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.536763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.537031) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022233 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.584892) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.585187) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.585543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.585810) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-23 09:06:06-- 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% 60.7M=0s 2016-02-23 09:06:06 (60.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177642 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.774914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.775185) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.183269 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.969323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:06.969626) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c78d4c97956b6cd5544f95bff8a2e944a8b70aee --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 c78d4c97956b6cd5544f95bff8a2e944a8b70aee --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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-23 09:06:07,039 truncating revision to first 12 chars 2016-02-23 09:06:07,040 Setting DEBUG logging. 2016-02-23 09:06:07,040 attempt 1/10 2016-02-23 09:06:07,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c78d4c97956b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 09:06:07,324 unpacking tar archive at: mozilla-aurora-c78d4c97956b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596299 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:07.577903) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:07.578247) ========= echo c78d4c97956b6cd5544f95bff8a2e944a8b70aee in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c78d4c97956b6cd5544f95bff8a2e944a8b70aee'] 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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c78d4c97956b6cd5544f95bff8a2e944a8b70aee program finished with exit code 0 elapsedTime=0.004485 script_repo_revision: 'c78d4c97956b6cd5544f95bff8a2e944a8b70aee' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:07.628289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:07.628560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:06:07.645660) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-23 09:06:07.645916) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:06:07 INFO - MultiFileLogger online at 20160223 09:06:07 in /builds/slave/test-pgo 09:06:07 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:06:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:06:07 INFO - {'append_to_log': False, 09:06:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:06:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:06:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:06:07 INFO - 'branch': 'Mozilla-Aurora', 09:06:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:06:07 INFO - 'config_files': ('talos/linux_config.py',), 09:06:07 INFO - 'default_actions': ('clobber', 09:06:07 INFO - 'read-buildbot-config', 09:06:07 INFO - 'download-and-extract', 09:06:07 INFO - 'populate-webroot', 09:06:07 INFO - 'create-virtualenv', 09:06:07 INFO - 'install', 09:06:07 INFO - 'run-tests'), 09:06:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:06:07 INFO - 'download_minidump_stackwalk': True, 09:06:07 INFO - 'download_symbols': 'ondemand', 09:06:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:06:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:06:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:06:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:06:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:06:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:06:07 INFO - 'installer_path': 'installer.exe', 09:06:07 INFO - 'log_level': 'info', 09:06:07 INFO - 'log_name': 'talos', 09:06:07 INFO - 'log_to_console': True, 09:06:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:06:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:06:07 INFO - 'opt_config_files': (), 09:06:07 INFO - 'pip_index': False, 09:06:07 INFO - 'sps_profile': False, 09:06:07 INFO - 'sps_profile_interval': 0, 09:06:07 INFO - 'suite': 'dromaeojs-e10s', 09:06:07 INFO - 'system_bits': '32', 09:06:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:06:07 INFO - 'title': 'talos-linux64-ix-068', 09:06:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:06:07 INFO - 'use_talos_json': True, 09:06:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:06:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:06:07 INFO - 'work_dir': 'build'} 09:06:07 INFO - ##### 09:06:07 INFO - ##### Running clobber step. 09:06:07 INFO - ##### 09:06:07 INFO - Running pre-action listener: _resource_record_pre_action 09:06:07 INFO - Running main action method: clobber 09:06:07 INFO - rmtree: /builds/slave/test-pgo/build 09:06:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:06:09 INFO - Running post-action listener: _resource_record_post_action 09:06:09 INFO - ##### 09:06:09 INFO - ##### Running read-buildbot-config step. 09:06:09 INFO - ##### 09:06:09 INFO - Running pre-action listener: _resource_record_pre_action 09:06:09 INFO - Running main action method: read_buildbot_config 09:06:09 INFO - Using buildbot properties: 09:06:09 INFO - { 09:06:09 INFO - "project": "", 09:06:09 INFO - "product": "firefox", 09:06:09 INFO - "script_repo_revision": "production", 09:06:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:06:09 INFO - "repository": "", 09:06:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:06:09 INFO - "buildid": "20160223063907", 09:06:09 INFO - "pgo_build": "True", 09:06:09 INFO - "basedir": "/builds/slave/test-pgo", 09:06:09 INFO - "buildnumber": 82, 09:06:09 INFO - "slavename": "talos-linux64-ix-068", 09:06:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:06:09 INFO - "platform": "ubuntu64_hw", 09:06:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:06:09 INFO - "branch": "mozilla-aurora", 09:06:09 INFO - "repo_path": "releases/mozilla-aurora", 09:06:09 INFO - "revision": "c78d4c97956b6cd5544f95bff8a2e944a8b70aee", 09:06:09 INFO - "stage_platform": "linux64-pgo", 09:06:09 INFO - "builduid": "8d31656cd6f5483b8e2a0a4e2e1ca1af", 09:06:09 INFO - "slavebuilddir": "test" 09:06:09 INFO - } 09:06:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 09:06:09 INFO - Running post-action listener: _resource_record_post_action 09:06:09 INFO - ##### 09:06:09 INFO - ##### Running download-and-extract step. 09:06:09 INFO - ##### 09:06:09 INFO - Running pre-action listener: _resource_record_pre_action 09:06:09 INFO - Running main action method: download_and_extract 09:06:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:06:09 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:06:09 INFO - https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:06:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/test_packages.json 09:06:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/test_packages.json 09:06:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:06:12 INFO - Downloaded 1448 bytes. 09:06:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:06:12 INFO - Using the following test package requirements: 09:06:12 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:06:12 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:06:12 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:06:12 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'jsshell-linux-x86_64.zip'], 09:06:12 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:06:12 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:06:12 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:06:12 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:06:12 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:06:12 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:06:12 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:06:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:06:12 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:06: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:06:12 INFO - https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:16 INFO - Downloaded 23079174 bytes. 09:06:16 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:06:16 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:06:17 INFO - Return code: 0 09:06:17 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:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:17 INFO - https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:20 INFO - Downloaded 23079174 bytes. 09:06:20 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:06:20 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:06:21 INFO - Return code: 0 09:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:21 INFO - https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:22 INFO - Downloaded 10706572 bytes. 09:06:22 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:06:22 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:06:22 INFO - Return code: 0 09:06: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:06:22 INFO - https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:06:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:06:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:06:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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:06:24 INFO - Downloaded 59962629 bytes. 09:06:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:06:24 INFO - mkdir: /builds/slave/test-pgo/properties 09:06:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:06:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:06:24 INFO - Contents: 09:06:24 INFO - build_url:https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:06:25 INFO - Running post-action listener: _resource_record_post_action 09:06:25 INFO - Running post-action listener: set_extra_try_arguments 09:06:25 INFO - ##### 09:06:25 INFO - ##### Running populate-webroot step. 09:06:25 INFO - ##### 09:06:25 INFO - Running pre-action listener: _resource_record_pre_action 09:06:25 INFO - Running main action method: populate_webroot 09:06:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:25 INFO - '--tppagecycles', 09:06:25 INFO - '7'], 09:06:25 INFO - 'tests': ['tsvgm']}}, 09:06:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:06:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:06:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:06:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'tests': ['damp', 'tps']}, 09:06:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['damp', 'tps']}, 09:06:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:06:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:25 INFO - 'other': {'tests': ['a11yr', 09:06:25 INFO - 'ts_paint', 09:06:25 INFO - 'tpaint', 09:06:25 INFO - 'sessionrestore', 09:06:25 INFO - 'sessionrestore_no_auto_restore']}, 09:06:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['a11yr', 09:06:25 INFO - 'ts_paint', 09:06:25 INFO - 'tpaint', 09:06:25 INFO - 'sessionrestore', 09:06:25 INFO - 'sessionrestore_no_auto_restore']}, 09:06:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['a11yr', 09:06:25 INFO - 'ts_paint', 09:06:25 INFO - 'tpaint', 09:06:25 INFO - 'sessionrestore', 09:06:25 INFO - 'sessionrestore_no_auto_restore']}, 09:06:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['a11yr', 09:06:25 INFO - 'ts_paint', 09:06:25 INFO - 'tpaint', 09:06:25 INFO - 'sessionrestore', 09:06:25 INFO - 'sessionrestore_no_auto_restore']}, 09:06:25 INFO - 'other_l64': {'tests': ['a11yr', 09:06:25 INFO - 'ts_paint', 09:06:25 INFO - 'tpaint', 09:06:25 INFO - 'sessionrestore', 09:06:25 INFO - 'sessionrestore_no_auto_restore']}, 09:06:25 INFO - 'other_nol64': {'tests': ['a11yr', 09:06:25 INFO - 'ts_paint', 09:06:25 INFO - 'tpaint', 09:06:25 INFO - 'sessionrestore', 09:06:25 INFO - 'sessionrestore_no_auto_restore']}, 09:06:25 INFO - 'svgr': {'tests': ['tsvgx', 09:06:25 INFO - 'tsvgr_opacity', 09:06:25 INFO - 'tart', 09:06:25 INFO - 'tscrollx', 09:06:25 INFO - 'cart']}, 09:06:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['tsvgx', 09:06:25 INFO - 'tsvgr_opacity', 09:06:25 INFO - 'tart', 09:06:25 INFO - 'tscrollx', 09:06:25 INFO - 'cart']}, 09:06:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'tests': ['tp5o']}, 09:06:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'talos_options': ['--e10s'], 09:06:25 INFO - 'tests': ['tp5o']}, 09:06:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'talos_options': ['--xperf_path', 09:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:25 INFO - 'tests': ['tp5n']}, 09:06:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:25 INFO - 'talos_options': ['--e10s', 09:06:25 INFO - '--xperf_path', 09:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:25 INFO - 'tests': ['tp5n']}}, 09:06:25 INFO - 'talos.zip': {'path': '', 09:06:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:25 INFO - Running post-action listener: _resource_record_post_action 09:06:25 INFO - ##### 09:06:25 INFO - ##### Running create-virtualenv step. 09:06:25 INFO - ##### 09:06:25 INFO - Running pre-action listener: _resource_record_pre_action 09:06:25 INFO - Running main action method: create_virtualenv 09:06:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:06:25 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:06:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:06:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:25 INFO - Using real prefix '/usr' 09:06:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:06:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:28 INFO - Installing pip.................done. 09:06:28 INFO - Return code: 0 09:06:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:06:28 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:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:28 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:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:28 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:28 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:06:28 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:06:28 INFO - Using env: {'DISPLAY': ':0', 09:06:28 INFO - 'HOME': '/home/cltbld', 09:06:28 INFO - 'LANG': 'en_US.UTF-8', 09:06:28 INFO - 'LANGUAGE': 'en_US:en', 09:06:28 INFO - 'LOGNAME': 'cltbld', 09:06:28 INFO - 'MAIL': '/var/mail/cltbld', 09:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:28 INFO - 'MOZ_NO_REMOTE': '1', 09:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:28 INFO - 'NO_EM_RESTART': '1', 09:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:28 INFO - 'SHELL': '/bin/bash', 09:06:28 INFO - 'SHLVL': '1', 09:06:28 INFO - 'TERM': 'linux', 09:06:28 INFO - 'TMOUT': '86400', 09:06:28 INFO - 'USER': 'cltbld', 09:06:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:28 INFO - '_': '/tools/buildbot/bin/python'} 09:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:28 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:06:28 INFO - Cleaning up... 09:06:28 INFO - Return code: 0 09:06:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:06:28 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:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:28 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:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:28 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:28 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:06:28 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:06:28 INFO - Using env: {'DISPLAY': ':0', 09:06:28 INFO - 'HOME': '/home/cltbld', 09:06:28 INFO - 'LANG': 'en_US.UTF-8', 09:06:28 INFO - 'LANGUAGE': 'en_US:en', 09:06:28 INFO - 'LOGNAME': 'cltbld', 09:06:28 INFO - 'MAIL': '/var/mail/cltbld', 09:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:28 INFO - 'MOZ_NO_REMOTE': '1', 09:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:28 INFO - 'NO_EM_RESTART': '1', 09:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:28 INFO - 'SHELL': '/bin/bash', 09:06:28 INFO - 'SHLVL': '1', 09:06:28 INFO - 'TERM': 'linux', 09:06:28 INFO - 'TMOUT': '86400', 09:06:28 INFO - 'USER': 'cltbld', 09:06:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:28 INFO - '_': '/tools/buildbot/bin/python'} 09:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:28 INFO - Downloading/unpacking psutil>=0.7.1 09:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:30 INFO - Installing collected packages: psutil 09:06:30 INFO - Running setup.py install for psutil 09:06:30 INFO - building 'psutil._psutil_linux' extension 09:06:30 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:06:30 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:06:30 INFO - building 'psutil._psutil_posix' extension 09:06:30 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:06:30 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:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:30 INFO - Successfully installed psutil 09:06:30 INFO - Cleaning up... 09:06:30 INFO - Return code: 0 09:06:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:30 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:30 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:06:30 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:06:30 INFO - Using env: {'DISPLAY': ':0', 09:06:30 INFO - 'HOME': '/home/cltbld', 09:06:30 INFO - 'LANG': 'en_US.UTF-8', 09:06:30 INFO - 'LANGUAGE': 'en_US:en', 09:06:30 INFO - 'LOGNAME': 'cltbld', 09:06:30 INFO - 'MAIL': '/var/mail/cltbld', 09:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:30 INFO - 'MOZ_NO_REMOTE': '1', 09:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:30 INFO - 'NO_EM_RESTART': '1', 09:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:30 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:30 INFO - 'SHELL': '/bin/bash', 09:06:30 INFO - 'SHLVL': '1', 09:06:30 INFO - 'TERM': 'linux', 09:06:30 INFO - 'TMOUT': '86400', 09:06:30 INFO - 'USER': 'cltbld', 09:06:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:30 INFO - '_': '/tools/buildbot/bin/python'} 09:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:06:31 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:06:31 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:06:31 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:06:31 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:06:31 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:06:31 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:06:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:06:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:33 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:06:33 INFO - Installing collected packages: mozsystemmonitor 09:06:33 INFO - Running setup.py install for mozsystemmonitor 09:06:33 INFO - Successfully installed mozsystemmonitor 09:06:33 INFO - Cleaning up... 09:06:33 INFO - Return code: 0 09:06:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:33 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:33 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:06:33 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:06:33 INFO - Using env: {'DISPLAY': ':0', 09:06:33 INFO - 'HOME': '/home/cltbld', 09:06:33 INFO - 'LANG': 'en_US.UTF-8', 09:06:33 INFO - 'LANGUAGE': 'en_US:en', 09:06:33 INFO - 'LOGNAME': 'cltbld', 09:06:33 INFO - 'MAIL': '/var/mail/cltbld', 09:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:33 INFO - 'MOZ_NO_REMOTE': '1', 09:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:33 INFO - 'NO_EM_RESTART': '1', 09:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:33 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:33 INFO - 'SHELL': '/bin/bash', 09:06:33 INFO - 'SHLVL': '1', 09:06:33 INFO - 'TERM': 'linux', 09:06:33 INFO - 'TMOUT': '86400', 09:06:33 INFO - 'USER': 'cltbld', 09:06:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:33 INFO - '_': '/tools/buildbot/bin/python'} 09:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:06:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:35 INFO - Downloading docopt-0.6.1.tar.gz 09:06:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:35 INFO - Running setup.py install for blobuploader 09:06:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:06:36 INFO - Running setup.py install for requests 09:06:36 INFO - Running setup.py install for docopt 09:06:36 INFO - Successfully installed blobuploader requests docopt 09:06:36 INFO - Cleaning up... 09:06:36 INFO - Return code: 0 09:06:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:06:36 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:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:36 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:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:36 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:36 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:06:36 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:06:36 INFO - Using env: {'DISPLAY': ':0', 09:06:36 INFO - 'HOME': '/home/cltbld', 09:06:36 INFO - 'LANG': 'en_US.UTF-8', 09:06:36 INFO - 'LANGUAGE': 'en_US:en', 09:06:36 INFO - 'LOGNAME': 'cltbld', 09:06:36 INFO - 'MAIL': '/var/mail/cltbld', 09:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:36 INFO - 'MOZ_NO_REMOTE': '1', 09:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:36 INFO - 'NO_EM_RESTART': '1', 09:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:36 INFO - 'SHELL': '/bin/bash', 09:06:36 INFO - 'SHLVL': '1', 09:06:36 INFO - 'TERM': 'linux', 09:06:36 INFO - 'TMOUT': '86400', 09:06:36 INFO - 'USER': 'cltbld', 09:06:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:36 INFO - '_': '/tools/buildbot/bin/python'} 09:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:06:36 INFO - Running setup.py (path:/tmp/pip-hlIMEr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:06:36 INFO - Running setup.py (path:/tmp/pip-eXVZCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:06:36 INFO - Running setup.py (path:/tmp/pip-QiQeiA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:06:36 INFO - Running setup.py (path:/tmp/pip-Bn8OWG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:06:37 INFO - Running setup.py (path:/tmp/pip-PcTqPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:06:37 INFO - Running setup.py (path:/tmp/pip-oQyPMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:06:37 INFO - Running setup.py (path:/tmp/pip-eGiGR5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:06:37 INFO - Running setup.py (path:/tmp/pip-hzvXKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:06:37 INFO - Running setup.py (path:/tmp/pip-ZRC7_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:06:37 INFO - Running setup.py (path:/tmp/pip-tQPg9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:06:37 INFO - Running setup.py (path:/tmp/pip-6pFrrX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:06:37 INFO - Running setup.py (path:/tmp/pip-mNLBgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:06:37 INFO - Running setup.py (path:/tmp/pip-Gc61Xa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:06:37 INFO - Running setup.py (path:/tmp/pip-LNsMBj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:06:37 INFO - Running setup.py (path:/tmp/pip-cGaEpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:06:37 INFO - Running setup.py (path:/tmp/pip-cpo1aP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:06:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:06:37 INFO - Running setup.py (path:/tmp/pip-BKvjPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:06:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:37 INFO - Running setup.py install for manifestparser 09:06:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Running setup.py install for mozcrash 09:06:38 INFO - Running setup.py install for mozdebug 09:06:38 INFO - Running setup.py install for mozdevice 09:06:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Running setup.py install for mozfile 09:06:38 INFO - Running setup.py install for mozhttpd 09:06:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Running setup.py install for mozinfo 09:06:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Running setup.py install for mozInstall 09:06:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:06:38 INFO - Running setup.py install for mozleak 09:06:38 INFO - Running setup.py install for mozlog 09:06:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:06:39 INFO - Running setup.py install for moznetwork 09:06:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:06:39 INFO - Running setup.py install for mozprocess 09:06:39 INFO - Running setup.py install for mozprofile 09:06:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:06:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:06:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:06:39 INFO - Running setup.py install for mozrunner 09:06:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:06:39 INFO - Running setup.py install for mozscreenshot 09:06:39 INFO - Running setup.py install for moztest 09:06:39 INFO - Running setup.py install for mozversion 09:06:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:06:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:39 INFO - Cleaning up... 09:06:39 INFO - Return code: 0 09:06:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:39 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:39 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:06:39 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:06:39 INFO - Using env: {'DISPLAY': ':0', 09:06:39 INFO - 'HOME': '/home/cltbld', 09:06:39 INFO - 'LANG': 'en_US.UTF-8', 09:06:39 INFO - 'LANGUAGE': 'en_US:en', 09:06:39 INFO - 'LOGNAME': 'cltbld', 09:06:39 INFO - 'MAIL': '/var/mail/cltbld', 09:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:39 INFO - 'MOZ_NO_REMOTE': '1', 09:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:39 INFO - 'NO_EM_RESTART': '1', 09:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:39 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:39 INFO - 'SHELL': '/bin/bash', 09:06:39 INFO - 'SHLVL': '1', 09:06:39 INFO - 'TERM': 'linux', 09:06:39 INFO - 'TMOUT': '86400', 09:06:39 INFO - 'USER': 'cltbld', 09:06:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:39 INFO - '_': '/tools/buildbot/bin/python'} 09:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:06:40 INFO - Running setup.py (path:/tmp/pip-DrovEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:06:40 INFO - Running setup.py (path:/tmp/pip-oEGQc4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:06:40 INFO - Running setup.py (path:/tmp/pip-GaZq_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:06:40 INFO - Running setup.py (path:/tmp/pip-XYRdRp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:06:40 INFO - Running setup.py (path:/tmp/pip-swC4n3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:06:40 INFO - Running setup.py (path:/tmp/pip-0njCA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:06:40 INFO - Running setup.py (path:/tmp/pip-ezIAo8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:06:40 INFO - Running setup.py (path:/tmp/pip-_bsSFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:06:40 INFO - Running setup.py (path:/tmp/pip-TthteE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:06:40 INFO - Running setup.py (path:/tmp/pip-QFL3ZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:06:40 INFO - Running setup.py (path:/tmp/pip-UdjW9s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:06:40 INFO - Running setup.py (path:/tmp/pip-WBx_wX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:06:40 INFO - Running setup.py (path:/tmp/pip-it1Pgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:06:40 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:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:06:40 INFO - Running setup.py (path:/tmp/pip-v2WLAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:06:41 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:06:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:06:41 INFO - Running setup.py (path:/tmp/pip-HVlxDw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:06:41 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:06:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:06:41 INFO - Running setup.py (path:/tmp/pip-iC3twk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:06:41 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:06:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:06:41 INFO - Running setup.py (path:/tmp/pip-DOWBTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:06:41 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:06:41 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:06:41 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:06:41 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:06:41 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:06:41 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:06:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:43 INFO - Downloading blessings-1.6.tar.gz 09:06:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:43 INFO - Installing collected packages: blessings 09:06:43 INFO - Running setup.py install for blessings 09:06:43 INFO - Successfully installed blessings 09:06:43 INFO - Cleaning up... 09:06:43 INFO - Return code: 0 09:06:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:06:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:06:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:06:43 INFO - Reading from file tmpfile_stdout 09:06:43 INFO - Current package versions: 09:06:43 INFO - argparse == 1.2.1 09:06:43 INFO - blessings == 1.6 09:06:43 INFO - blobuploader == 1.2.4 09:06:43 INFO - docopt == 0.6.1 09:06:43 INFO - manifestparser == 1.1 09:06:43 INFO - mozInstall == 1.12 09:06:43 INFO - mozcrash == 0.16 09:06:43 INFO - mozdebug == 0.1 09:06:43 INFO - mozdevice == 0.48 09:06:43 INFO - mozfile == 1.2 09:06:43 INFO - mozhttpd == 0.7 09:06:43 INFO - mozinfo == 0.9 09:06:43 INFO - mozleak == 0.1 09:06:43 INFO - mozlog == 3.1 09:06:43 INFO - moznetwork == 0.27 09:06:43 INFO - mozprocess == 0.22 09:06:43 INFO - mozprofile == 0.28 09:06:43 INFO - mozrunner == 6.11 09:06:43 INFO - mozscreenshot == 0.1 09:06:43 INFO - mozsystemmonitor == 0.0 09:06:43 INFO - moztest == 0.7 09:06:43 INFO - mozversion == 1.4 09:06:43 INFO - psutil == 3.1.1 09:06:43 INFO - requests == 1.2.3 09:06:43 INFO - wsgiref == 0.1.2 09:06:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:43 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:43 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:06:43 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:06:43 INFO - Using env: {'DISPLAY': ':0', 09:06:43 INFO - 'HOME': '/home/cltbld', 09:06:43 INFO - 'LANG': 'en_US.UTF-8', 09:06:43 INFO - 'LANGUAGE': 'en_US:en', 09:06:43 INFO - 'LOGNAME': 'cltbld', 09:06:43 INFO - 'MAIL': '/var/mail/cltbld', 09:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:43 INFO - 'MOZ_NO_REMOTE': '1', 09:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:43 INFO - 'NO_EM_RESTART': '1', 09:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:43 INFO - 'SHELL': '/bin/bash', 09:06:43 INFO - 'SHLVL': '1', 09:06:43 INFO - 'TERM': 'linux', 09:06:43 INFO - 'TMOUT': '86400', 09:06:43 INFO - 'USER': 'cltbld', 09:06:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:43 INFO - '_': '/tools/buildbot/bin/python'} 09:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 INFO - Cleaning up... 09:06:43 INFO - Return code: 0 09:06:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:06:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:06:43 INFO - Using env: {'DISPLAY': ':0', 09:06:43 INFO - 'HOME': '/home/cltbld', 09:06:43 INFO - 'LANG': 'en_US.UTF-8', 09:06:43 INFO - 'LANGUAGE': 'en_US:en', 09:06:43 INFO - 'LOGNAME': 'cltbld', 09:06:43 INFO - 'MAIL': '/var/mail/cltbld', 09:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:43 INFO - 'MOZ_NO_REMOTE': '1', 09:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:43 INFO - 'NO_EM_RESTART': '1', 09:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:43 INFO - 'SHELL': '/bin/bash', 09:06:43 INFO - 'SHLVL': '1', 09:06:43 INFO - 'TERM': 'linux', 09:06:43 INFO - 'TMOUT': '86400', 09:06:43 INFO - 'USER': 'cltbld', 09:06:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:43 INFO - '_': '/tools/buildbot/bin/python'} 09:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:43 INFO - Downloading/unpacking jsonschema 09:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:45 INFO - Downloading/unpacking functools32 (from jsonschema) 09:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:46 INFO - warning: no files found matching '*.txt' 09:06:46 INFO - no previously-included directories found matching 'build' 09:06:46 INFO - no previously-included directories found matching 'dist' 09:06:46 INFO - no previously-included directories found matching '.git*' 09:06:46 INFO - Installing collected packages: jsonschema, functools32 09:06:46 INFO - Running setup.py install for functools32 09:06:46 INFO - warning: no files found matching '*.txt' 09:06:46 INFO - no previously-included directories found matching 'build' 09:06:46 INFO - no previously-included directories found matching 'dist' 09:06:46 INFO - no previously-included directories found matching '.git*' 09:06:46 INFO - Successfully installed jsonschema functools32 09:06:46 INFO - Cleaning up... 09:06:46 INFO - Return code: 0 09:06:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:06:46 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:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:46 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:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:46 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 0x7f99fc1a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1456230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', '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:06:46 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:06:46 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:06:46 INFO - Using env: {'DISPLAY': ':0', 09:06:46 INFO - 'HOME': '/home/cltbld', 09:06:46 INFO - 'LANG': 'en_US.UTF-8', 09:06:46 INFO - 'LANGUAGE': 'en_US:en', 09:06:46 INFO - 'LOGNAME': 'cltbld', 09:06:46 INFO - 'MAIL': '/var/mail/cltbld', 09:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:46 INFO - 'MOZ_NO_REMOTE': '1', 09:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:46 INFO - 'NO_EM_RESTART': '1', 09:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:06:46 INFO - 'PWD': '/builds/slave/test-pgo', 09:06:46 INFO - 'SHELL': '/bin/bash', 09:06:46 INFO - 'SHLVL': '1', 09:06:46 INFO - 'TERM': 'linux', 09:06:46 INFO - 'TMOUT': '86400', 09:06:46 INFO - 'USER': 'cltbld', 09:06:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:46 INFO - '_': '/tools/buildbot/bin/python'} 09:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:46 INFO - Downloading/unpacking flake8 09:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:06:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:06:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:06:48 INFO - no previously-included directories found matching 'docs/_build' 09:06:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:06:49 INFO - Running setup.py install for pep8 09:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:06:49 INFO - no previously-included directories found matching 'docs/_build' 09:06:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:06:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:06:49 INFO - Cleaning up... 09:06:49 INFO - Return code: 0 09:06:49 INFO - Running post-action listener: _resource_record_post_action 09:06:49 INFO - Running post-action listener: _start_resource_monitoring 09:06:49 INFO - Starting resource monitoring. 09:06:49 INFO - ##### 09:06:49 INFO - ##### Running install step. 09:06:49 INFO - ##### 09:06:49 INFO - Running pre-action listener: _resource_record_pre_action 09:06:49 INFO - Running main action method: install 09:06:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:06:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:06:49 INFO - Reading from file tmpfile_stdout 09:06:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:06:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:06:49 INFO - Reading from file tmpfile_stdout 09:06:49 INFO - Output received: 09:06:49 INFO - Usage: mozinstall [options] installer 09:06:49 INFO - Options: 09:06:49 INFO - -h, --help show this help message and exit 09:06:49 INFO - -d DEST, --destination=DEST 09:06:49 INFO - Directory to install application into. [default: 09:06:49 INFO - "/builds/slave/test-pgo"] 09:06:49 INFO - --app=APP Application being installed. [default: firefox] 09:06:49 INFO - mkdir: /builds/slave/test-pgo/build/application 09:06:49 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:06:49 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:07:04 INFO - Reading from file tmpfile_stdout 09:07:04 INFO - Output received: 09:07:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:07:04 INFO - Running post-action listener: _resource_record_post_action 09:07:04 INFO - ##### 09:07:04 INFO - ##### Running run-tests step. 09:07:04 INFO - ##### 09:07:04 INFO - Running pre-action listener: _resource_record_pre_action 09:07:04 INFO - Running main action method: run_tests 09:07:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:07:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:07:04 INFO - Python 2.7.3 09:07:04 INFO - Return code: 0 09:07:04 INFO - grabbing minidump binary from tooltool 09:07: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:07:04 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 0x14e87f0>, '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 0x14542d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:07:04 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:07:04 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:07:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:04 INFO - Return code: 0 09:07:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:07:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:07:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:07:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:07:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:07:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:07:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:07:05 INFO - Return code: 0 09:07:05 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/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:07:05 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/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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:07:05 INFO - Using env: {'DISPLAY': ':0', 09:07:05 INFO - 'HOME': '/home/cltbld', 09:07:05 INFO - 'LANG': 'en_US.UTF-8', 09:07:05 INFO - 'LANGUAGE': 'en_US:en', 09:07:05 INFO - 'LOGNAME': 'cltbld', 09:07:05 INFO - 'MAIL': '/var/mail/cltbld', 09:07:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:07:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:05 INFO - 'MOZ_NO_REMOTE': '1', 09:07:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:05 INFO - 'NO_EM_RESTART': '1', 09:07:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:07:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:07:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:07:05 INFO - 'SHELL': '/bin/bash', 09:07:05 INFO - 'SHLVL': '1', 09:07:05 INFO - 'TERM': 'linux', 09:07:05 INFO - 'TMOUT': '86400', 09:07:05 INFO - 'USER': 'cltbld', 09:07:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301', 09:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:05 INFO - '_': '/tools/buildbot/bin/python'} 09:07:05 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/PvBY8Z-pQzSj_VPER6ZhwQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:07:05 INFO - mozversion application_buildid: 20160223063907 09:07:05 INFO - mozversion application_changeset: c78d4c97956b6cd5544f95bff8a2e944a8b70aee 09:07:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:07:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:05 INFO - mozversion application_name: Firefox 09:07:05 INFO - mozversion application_remotingname: firefox-dev 09:07:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:05 INFO - mozversion application_vendor: Mozilla 09:07:05 INFO - mozversion application_version: 46.0a2 09:07:05 INFO - mozversion platform_buildid: 20160223063907 09:07:05 INFO - mozversion platform_changeset: c78d4c97956b6cd5544f95bff8a2e944a8b70aee 09:07:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:05 INFO - mozversion platform_version: 46.0a2 09:07:05 INFO - using testdate: 1456247225 09:07:05 INFO - actual date: 1456247225 09:07:05 INFO - starting webserver on 'localhost:44943' 09:07:05 INFO - SUITE-START | Running 3 tests 09:07:05 INFO - TEST-START | dromaeo_css 09:07:05 INFO - operating with platform_type : linux_ 09:07:05 INFO - Initialising browser for dromaeo_css test... 09:07:05 INFO - TEST-INFO | started process 12226 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprNXB53/profile http://localhost:44943/getInfo.html) 09:07:09 INFO - PROCESS | 12226 | 09:07:09 INFO - PROCESS | 12226 | (process:12304): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:07:10 INFO - PROCESS | 12226 | __metrics Screen width/height:1600/1200 09:07:10 INFO - PROCESS | 12226 | colorDepth:24 09:07:10 INFO - PROCESS | 12226 | Browser inner width/height: 1024/697 09:07:10 INFO - PROCESS | 12226 | __metrics 09:07:11 INFO - TEST-INFO | 12226: exit 0 09:07:11 INFO - Browser initialized. 09:07:11 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:11 INFO - TEST-INFO | started process 12353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprNXB53/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:12 INFO - PROCESS | 12353 | 09:07:12 INFO - PROCESS | 12353 | (process:12415): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:07:23 INFO - PROCESS | 12353 | RSS: Main: 141266944 09:07:23 INFO - PROCESS | 12353 | 09:08:13 INFO - PROCESS | 12353 | 1456247293144 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:10:20 INFO - PROCESS | 12353 | Cycle 1(1): loaded http://localhost:44943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44943/tests/dromaeo/cssquery-ext.html) 09:10:21 INFO - PROCESS | 12353 | RSS: Main: 145920000 09:10:21 INFO - PROCESS | 12353 | 09:13:23 INFO - PROCESS | 12353 | Cycle 1(1): loaded http://localhost:44943/tests/dromaeo/cssquery-ext.html (next: http://localhost:44943/tests/dromaeo/cssquery-jquery.html) 09:13:24 INFO - PROCESS | 12353 | RSS: Main: 144990208 09:13:24 INFO - PROCESS | 12353 | 09:16:26 INFO - PROCESS | 12353 | Cycle 1(1): loaded http://localhost:44943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44943/tests/dromaeo/cssquery-mootools.html) 09:16:26 INFO - PROCESS | 12353 | RSS: Main: 144171008 09:16:26 INFO - PROCESS | 12353 | 09:19:28 INFO - PROCESS | 12353 | Cycle 1(1): loaded http://localhost:44943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44943/tests/dromaeo/cssquery-prototype.html) 09:19:28 INFO - PROCESS | 12353 | RSS: Main: 144273408 09:19:28 INFO - PROCESS | 12353 | 09:22:31 INFO - PROCESS | 12353 | Cycle 1(1): loaded http://localhost:44943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44943/tests/dromaeo/cssquery-yui.html) 09:22:31 INFO - PROCESS | 12353 | RSS: Main: 145334272 09:22:31 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | Cycle 1(1): loaded http://localhost:44943/tests/dromaeo/cssquery-yui.html (next: http://localhost:44943/tests/dromaeo/cssquery-dojo.html) 09:25:34 INFO - PROCESS | 12353 | RSS: Main: 146853888 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | __start_tp_report 09:25:34 INFO - PROCESS | 12353 | _x_x_mozilla_page_load 09:25:34 INFO - PROCESS | 12353 | _x_x_mozilla_page_load_details 09:25:34 INFO - PROCESS | 12353 | |i|pagename|runs| 09:25:34 INFO - PROCESS | 12353 | |0;dojo.html;3292.04530686101;3353.4969754536833;3363.7477189210817;3382.509536117264;3398.7111095556875;5431.239626452295;5443.727813609314;5452.563794896409;5455.399906010336;5478.753456094475;5412.485813847688;5451.509364157225;5508.862278443031;5515.7242137893145;5524.861878453041;4900.558949694527;4966.801327946878;5019.723915184663;5048.7223202723835;5068.594512438996;4788.257820037882;4909.288153217782;4999.075171093341;5012.022655582163;5054.21659642756;4980.12847751642;4984.850454486371;4996.675216110959;5039.77321020555;5065.240213967897;4959.950400496021;4986.850394488171;5008.549230569266;5011.248312753098;5021.046001259785;4840.733759643218;4883.536064073907;4901.460839307673;4904.779284932187;4953.182724850395;5255.080360936859;5270.156774915995;5272.209168624737;5273.235380869753;5277.736113194325;5815.767369305223;5820.097884827858;5823.039198532237;5842.036064049426;5876.941230587682;5724.255846739898;5816.680082595455;5861.150133230701;5915.349311575723;5935.020721580934;5385.407605163429;5433.212184233264;5441.700706461183;5469.56243500519;5469.890602187934;5828.562857785683;5928.762849486058;5949.702514874239;5964.373740757158;5986.07215881539;5626.971865140648;5676.091825307931;5714.542836573064;5720.1991721159075;5782.421757824268;5837.708114594253;5842.269716285465;5852.180694702745;5852.590318677651;5881.2942446906645;5588.329400471969;5637.098064309691;5770.336411312753;5777.971110144423;5787.102999035156;5730.828075157752;5837.153612726216;5846.239988801513;5869;5873.882522349529;4460.397846290709;4461.665375096816;4489.124620698998;4519.480259770168;4521.276595744665;3993.800309984489;4037.555868854424;4043.6360727534075;4071.491063617048;4119.649829764444;5550.084236101079;5558.583106267046;5586.050371436865;5620.4098569649595;5630.493255607015;5874.9118763218585;5883.882322353615;5887.087501437284;5900;5908.645481271052;5412.945870541323;5471.8084867029465;5533.750981205855;5581.10702287632;5619.466150715675;4944.728039957837;4972.8756781080765;4978.352814134139;4978.551930326288;5008.6744361616375;5907.4683278505145;5934;5957.523398128226;5965.254343207099;5981.431763982415;5773.480386765295;5824.388439213822;5839.824805255849;5846.152307915413;5848.385919478564;6001.129836173643;6033.276006879202;6062.696865156813;6078.6048906820915;6093.207882975362;5822.214001109796;5828;5828.912566311424;5831.766729330949;5849.1226316052935;5755.165501002415;5781.595288329945;5814.680192589448;5842.415758424124;5929.6145750526075;5708.429157084258;5713.05734553794;5720.914186287126;5722.542196624343;5748.223989761496;5667.40492248308;5681.715914204356;5723.255976723;5743.655380677173;5761.625494342854;5447.564194864322;5608.523275521627;5633.887322253614;5647.745851436777;5705.686187259741;5605.047141985954;5751.1373294006235;5758.510526605285;5775.451332123442;5792.884142317214;5486.972565137149;5606.411326810626;5627.268455100811;5635.690037048002;5635.8591035224445 09:25:34 INFO - PROCESS | 12353 | |1;ext.html;521.184346497731;551.6248950713518;564.6555601083339;584.3513699793228;595.0479233226838;29995.55006674899;30778.692213077862;38520;38585.614143858555;38914.8054259729;41657.37513937293;42059.78970105153;42172.78913605435;42473;42683.359749603784;8799.91200087999;9012.504312262823;9017.774555636095;9058.456492610432;9061.093890610951;8725.7818554536;8847.292216622687;8849.911500885006;8856.690015849446;8876.511791851446;9063.95468022659;9157.725268241964;9179.127982841654;9192.35653504255;9195.172434480895;8867.423617464845;9044.999999999967;9079.909200907972;9093.18161365477;9100.81798364029;8946.150115738994;9085.772855678595;9103.590338434786;9151.588178531916;9162.037986011439;42251.15497690029;42771.57228427707;42883.35674964847;42909.35635965463;42954;3618.330608837347;3677.3013127505956;3739.9439008414897;4033.657139143176;4237.851675191384;31831.681683183102;31913.52129718056;31954.520682189785;32091.35817283641;33035;4260.957390426087;4309.375140604626;4388.605025547716;4411.470623525165;4441.222786012468;213611;213847;213975;214129;214372;64028.67985660042;64416;64536.354636453034;64683.02975455372;64713.67643161754;67113.32886671169;67551.32448675549;67630.32369676339;67682.3231767676;67868.32131678719;17341.826581734273;17911.193996270198;17958;17991.640167196583;17992.280308787762;13467.663308417172;13498.93250533741;13607.727845443036;13692.726145477034;13702.93148534251;21508.247211347527;21619.13523459044;21814.56370872574;21843.907804609706;21847.235346762787;8058.959705201437;8383.413161078666;8426.915730842737;8455.873161902577;8483.236508714246;1031.4945676618404;1153.4751687981948;1155.5493357590547;1156.9710757230969;1161.3786624156037;31249.53125703116;31445.056648300586;31847.681523184936;34449.65550344464;36123.09692257715;1140.5380820767602;1158.8725240223569;1172.5142697481224;1233.340163012784;1278.4438769135456;16451.42420015318;16465.753013704805;16476.752848707278;16482;16898.324067037425;429101;470136;495691;764598;770581;59911.40088599058;60730.39269607247;60732;60915.39084609186;60966.69516652388;1439.6113049476583;1457.0893191755154;1466.1130016340387;1469.5370958148362;1486.31629450454;32236.516452252767;32787.21159397197;32863.67136328606;33021;33743.83128084344;50166.74916625393;50601.49398506115;50658.74670626623;50686.49313506818;50759.746201268754;339016;341486;342200;344066;344323;33901;34087.31825363528;34273;34685.826570866986;34768.47847282344;45610.315845261684;45948;45962.540374595825;46769.766151169024;47423.288650670955;39257;39700.404493933194;40021;40627.796861016686;40947.590524094376;39394.40908386319;39871.60128398679;40239.99400015023;40297;40388.394174086825;45062.77468612636;45593;45763.54236457593;45926.54073459223;46321;38534.22931541409;39599.80200098981;39668.40497392484;39853.40219896646;42740;31832.840835795672;34600.48099278563;34834;36142.63857361393;36875.07812304714 09:25:34 INFO - PROCESS | 12353 | |2;jquery.html;392.25471603952485;394.3237347948269;397.14811728841653;398.243337658449;401.9397090436436;15414.306356213969;15684.686306273868;17091.316347346106;17570;17611.471655850346;11910.40447977602;12214.633560993185;15747.370105195807;17834.10829458525;17948.73076903844;4733.621310295185;5404.135338345865;5612.803551875685;5615.9157612635845;5629.240052592909;5299.761510732026;5430.56555475563;5528.530074943635;5536.086545719972;5542.307211598551;5373.301470808789;5401.054815407288;5479.232907392969;5489.835304940858;5522.392536820947;5549.361823390322;5722.170285308607;5729.140628905656;5763.942360576382;5880.235569375954;5656.179853921159;5665.49010589049;5669.6314739541795;5696.715164241771;5717.171010203539;13601;14398.71202575953;14424.927875360661;14438.27808609576;16506;2299.5975704251855;2301.976980230193;2307.734610519778;2349.2482405630203;2400.663907053014;10049.447280399576;10156.39061656303;10427.843582346271;10486.685399438029;10536.525856336484;1865.9253629854788;1918.5970946101336;1937.7577802774654;1947.1140631012854;2012.084501551805;57919.710401448145;59647.403525965055;60578;61015;61426.77146457046;10217.948910255402;10479.161667066768;10642.946785266024;10660.733481663021;10665.84001239982;12886.871131288755;13237.338133093306;13261.602151935458;13264.204147751167;13266.403011864297;7601.429892757955;7605.885911711218;7645.5794931279315;7690;7751.496152750054;7070.823229419306;7180.712771489187;7196.172440169343;7390.371818395497;7408.296211859864;4481.977590112028;4484.506704262529;7882.960585197037;8081.272685458337;8270.8345833083;3107.254258977829;3196.856141473639;3357.6810203030673;3377.763556551067;3491.5984661764223;471.2789432168787;483.21718815519085;488.5505335091724;947.7298969793576;1124.9943750281195;10581.788364232672;11309.491072901574;11584.42077896102;11604.709882253012;11702.180847340775;514.4187068612443;521.4785214785214;545.2339463054415;556.5547561950505;1006.7634105985088;9188.816223675623;9422.199113075329;9553.379030363143;9571.90428095724;9686.176674982564;606576;607292;626050;633345;641532;79151;79330;79613.60193199113;79821.60089199634;82082;1202.6452196602024;1204.740980689156;1206.6741979665442;1218.9146759726912;1239.2997956154743;14915.254237288309;15157.393704251706;15380.077195368314;15492.922535387701;15508.147051912254;32519.674803251666;32825.50761738623;32983.34033319368;33495.16262093467;33861.830690846386;46794.53205468038;47747.761261193475;47864.521354786004;49545.50454495409;50487.74756126196;7474.177840437439;7548.094228692592;7550.263439409076;7616.3906887447765;7670.117936437158;9490.620375184915;11405;11445.427728613702;11676.649700508999;11942.402879856147;3132.63974642919;3143.35561209956;5330.573554115739;5629.493345598916;8621.44813933498;9464.763380915258;9841.753956151153;9951.303408761607;9964.302498825013;10180.287379883337;10053.19574434058;10086.697399078039;10198.949005254926;10419.374837509773;10549.789004220027;7697.307242348215;7914.327282180849;7930;7946.404019698662;7977.5612341321785;9113.270938324786;9780.217582593234;10289.2797504174;10365.326253793479;10594.523246453773 09:25:34 INFO - PROCESS | 12353 | |3;mootools.html;1572.5125211184534;1607.815101263355;1836.5959488912442;1917.913693883775;1933.9226430942763;8359.28946039586;8429.873551896719;8571.057183709787;8611.827763444728;8620.224179823814;8214.958925205381;8324.125966773492;8332.375071869603;8367.456115352514;8372.665093396257;2379.143508336993;2410.1323523531514;2410.204632471289;2416.1060407649193;2436.1229957215387;2404.63930410439;2447.90208391665;2488.751124887515;2500.374906273432;2516.043903316737;2370.2178281167257;2429.914952976646;2448;2461.323136137559;2476.7894728948063;2480.2435257246534;2499.600063989753;2510.9874450627813;2516.9806228477496;2526.1537384976145;2440.890159942789;2471.8393304435335;2493.738157493455;2498.462830491453;2505.8747062646976;8353.791155221108;8388.706395276136;8410.116937721512;8432.325413966868;8454.365922555771;5002.499750024968;5085.110105731482;5086.542211200973;5134.178531434953;5139.383274007106;3228.5480032795426;3233.692799184074;3241.951370729441;3378.3581119587448;3389.3051924355696;1057.5241141486285;1065.7229120428667;1072.8551645527832;1081.5241293830688;1096.446294621211;11265;11490.482928268248;11513.88486115145;11535.077193824558;11558.884411155865;4452.398926144929;4498.8425405110665;4532.841350552715;4550.453945526558;4552.931706024412;9494.525273736286;9499.810003799885;9544.52277386128;9557.092076252746;9570.61717531291;5118.053160165381;5120.564751996048;5134.845954621367;5137.33214682089;5178.404483484447;4769.642276829251;4792.856214313576;4816.373871396766;4818.325434439182;4825.686330388584;3591.2637909228547;3655.2141289622327;3695.4456831474954;3697.22358304759;3699.6855267302044;1060.8302671572512;1088.4285749981323;1124.2579897267765;1126.357975953715;1132.3602164776876;961.0869673809908;1034.9896501034893;1108.0636861851722;1188.9464974076188;1401.6916278418732;7736.110347310018;7790.182030886788;7895.092064412551;7905;7909.24862138096;1210.8304837322783;1214.6295379909036;1218.4577862851124;1221.248931906871;1231.335079057317;6048.425399587032;6107.511399088151;6121.908171377433;6146.385361463817;6152.046432802923;9084.364094513321;9368.90631093694;9420.576074076545;9446.338756286994;9473.242140628734;9748.658796942073;10009.399436033862;10055.195584353234;10104.141148002354;10160.54277557497;7358.889616655754;7365.558066516026;7371.447141464411;7373.115226172894;7398.223186565441;7782.221777822172;7918.802029949297;7996.20037996219;8004;8116.553589552631;8981.7754556134;9205.217556507772;9206;9227.584758685742;9371.969083400683;9307.441553506811;9384.249260059043;9391.953040234755;9403.670871519464;9566.66516671913;7558;7683.961580192064;7702.268284512962;7730.613469326624;7775.561521118611;7958.522488650699;8263.545504997042;8271.834563308821;8295.129011453952;8297.626606802829;7143.607101609461;7293.562386256842;7299;7310.780676579711;7636.80907977305;7040.788776336718;7135.785926422215;7160.498765086394;7165.677544510405;7304.19653838088;7284.708611655475;7321.816954576178;7334.376577990717;7356.117265928123;7362.852742945218;6433.228012638326;6550.017497375432;6551.868962620816;6588.7035083422315;6602.042703807825;6672.933270667231;6716.932830671631;6762.323767623198;6817.7272909083085;6874.553154044971 09:25:34 INFO - PROCESS | 12353 | |4;prototype.html;377.68840706417205;386.19285692901866;387.50205985308867;387.9844806207752;392.4113829256114;6233.7818176363835;6381.0747441621;6419.903701444477;6437.163168788051;6467.611943283407;6195.6902154892305;6311.905321420182;6324.177856878599;6347.555671103025;6375.394337537938;4925.901481970376;4947.82682606107;4947.876303092434;4955.653104282702;4957.082939656157;4954;4973.353464049668;4978.5270399312;4982.651214414975;4983.775730092137;4720.433547974248;4841.15279826029;4847.781849816767;4864.683795553296;4871.318015477836;4875.609951203895;4878.951210487903;4879.951200487985;4880.463149053601;4888.266759985995;4304.268274393361;4307.5261721210645;4312.568743125662;4313;4317.7193482423545;5956.851078723023;6051.576389652726;6064.090386442025;6076.240469941257;6089.634621922699;5670.177824215507;5703.4011428799795;5726.226959360475;5732.426757324276;5732.570057245682;6750.62871542065;6764.323567643196;6766.864662706718;6774.356436138559;6789.388954994025;4765.332853400527;4771.28430735389;4773.355596994396;4774.28385742138;4781.641376896747;6938.722451101949;7011.088558487364;7044.788656340318;7082.822929426806;7089.0784198053925;4857.514248575185;4867.245576935581;4868.586170175504;4871.29366241893;4877;4900.338454308694;4979.278004689299;4983.501649834988;4987.276844857475;4991.925121123186;5557.194206839986;5653.660780353192;5661.830145095653;5663.801766938137;5687.175359572839;6780.796576102724;6803.591784492946;6817.829554261183;6818.249992500821;6833.965830170917;1712.3749831311482;1741.7300318450662;1744.6074633207427;1747.632997070604;1759.6304775996928;1173.4484792147678;1178.0104712041925;1193.0515240383916;1194.832723418722;1211.1400905357118;6475.061116138134;6480.902786458207;6495.4803615710625;6508.674566271668;6510.381513756186;6905.413039891565;6913.2049814272;6916.585004899722;6929.688164032631;6940.618265995317;6371.39471750183;6472.935270647234;6478.611283322922;6489.545731798823;6489.707963141575;3749.3063783200196;3750.3249415104997;3767.6609105180664;3776.9244615107546;3785.337565925952;7017.929820701727;7063.89404158938;7069.222385537587;7076.363127318566;7077.6461176941975;6871.862562748817;7022.262662420474;7039.436845052383;7054.6825392857445;7067.964660176666;7031.226565077837;7067.293270672892;7072.434205263567;7077.646117694095;7081.752138675225;6879.965600171967;6923.446124309942;6929.896051559332;6936.20233673134;6947.3747362737595;6627.801165965029;6766.4248538874745;6769.458443324424;6789.830254243683;6848.965755171392;7028.8945665814035;7040.823979400351;7054.6472676367;7066.611336376549;7071.752488662872;4865.854024379274;4874.561289483963;4885.8045678172475;4891.339669144762;4895.7062576245535;6755.763548275787;6857.245702972768;6861;6878.27778083294;6878.793636190922;6686.7993960181275;6708.195016597844;6709.127813384229;6717.193936727624;6723.361280678328;6694.364035416627;6710.396064354231;6716.597004179765;6741.089952856301;6746.898796517958;6387;6563.310852360433;6574.0796288520605;6581.539292249497;6596.208454985241;6687.76592819249;6720.46236301085;6722.890723030645;6751.729930802713;6765;6541.8691626166255;6573.014047892854;6580.901286480803;6594.802155935329;6609.966950165219 09:25:34 INFO - PROCESS | 12353 | |5;yui.html;836.698788436163;877.5656050255122;914.5792935249784;916.1891725822645;932.6222879733706;14780.408783648654;14928.328225229863;14980.925095374521;14995.175265360402;15016.624584385396;13776.24230667313;13887.513937012181;13922.443102275896;13945;13977.860221397783;883.8674198870189;893.6693423433322;912.1061359867334;914.7530166854946;917.0600134861753;906.112010229975;907.0929070929071;910.399136569864;910.4992254260163;912.7535565397372;932.9486878221695;934.2619330728717;940.1820416237848;941.5621735892809;944.263474489899;914.5107367558358;921.7050543826011;924.3021518753366;928.972130836076;931.6832277025776;682.969266383009;684.4079870911676;685.7017197519095;692.8614277144591;694.0526181761859;15368.385264589402;15399.769003464957;15410.537683869501;15441.382344706199;15458.1498017609;14056.789148162785;14084.507042253574;14090.154590724589;14149;14184.361703723358;11690.415479226005;11740.236884602473;11757.176997610171;11762.411879405996;12307.4461649226;3980.7014473914574;3987.5613682494904;4034.0519977805193;4057.7768222747736;4067;53043.73478132623;53538;53795.73102134503;53807.46192538064;53836.46163538354;10938.234323597271;10970.670879873616;11069.225154239126;11205.719857003478;11311.490982905789;19139.13873875679;19192.328268510537;19249.32627358036;19268.518287042934;19332.130054147598;8224.342052635775;8516.70191543293;8530.914690853137;8674.04585495595;8689.913100869036;4484.080763443551;4517;4525.954740452553;4582.564656357641;4603.9079218415445;3230.353929214167;3251.5447837302795;3267.281198136406;3274.246923207628;3281.622613399442;592.8754961458056;598.3238939997775;605.2918085839578;610.2493932463095;611.6910959965189;612.8835521250948;622.3372108704216;622.6202016769766;630.8454428665007;688.435482904024;9329.533523323942;9624.807503850025;9667.46828924416;9720.125188733047;9780.853287200698;602.012699173356;605.3280858247342;608.8021393047277;620.9660914577179;621.580433207583;4332.155229730172;4359.869203923888;4393.824247030147;4508.954910450919;4795.712257264575;57970;58080;58437;58500.414995849496;58660.41339586549;52843.47156528386;53514.464855351725;53716;54576;55002.724986374815;49183.016339673006;49304.99999999928;49627.50372496229;50121.74939125354;50255.24617130746;9715.935346348168;9884.85172722424;9885.435994885962;9993.850092248767;10092.798144037224;35706.821465892506;35973.82013089918;36393.63606363902;36734.44898326474;36825.26349472942;41415.171696565296;45678.771606143084;47051;47293;48328.27507587459;12016.579419720269;12091.939540302243;12113.69715757113;12378.690532736753;12402.689932751753;13147.14543554666;13348.799768003293;13782.241976691379;13784.241866697026;14063.156210627396;12685.175463594836;13001.15492492985;13065;13358.465661373824;13436.731265374834;12993.610191694264;13081.803772943224;13166.40751166219;13506.797398039234;13626;12392.75214495687;12752.936235319135;12827.807582886451;12891.355432228538;13116.868831311565;10563.366198028143;10721.303115297793;10786.298890572089;10836.945815270874;11113.444327783416;10705.785884282426;10768;10805.187599694984;10893.509792059218;10992.120630349713 09:25:34 INFO - PROCESS | 12353 | __end_tp_report 09:25:34 INFO - PROCESS | 12353 | __start_cc_report 09:25:34 INFO - PROCESS | 12353 | _x_x_mozilla_cycle_collect,306 09:25:34 INFO - PROCESS | 12353 | __end_cc_report 09:25:34 INFO - PROCESS | 12353 | __startTimestamp1456248334375__endTimestamp 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | ------- Summary: start ------- 09:25:34 INFO - PROCESS | 12353 | Number of tests: 6 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | [#0] dojo.html Cycles:165 Average:5423.46 Median:5630.49 stddev:584.99 (10.4%) stddev-sans-first:562.38 09:25:34 INFO - PROCESS | 12353 | Values: 3292.0 3353.5 3363.7 3382.5 3398.7 5431.2 5443.7 5452.6 5455.4 5478.8 5412.5 5451.5 5508.9 5515.7 5524.9 4900.6 4966.8 5019.7 5048.7 5068.6 4788.3 4909.3 4999.1 5012.0 5054.2 4980.1 4984.9 4996.7 5039.8 5065.2 4960.0 4986.9 5008.5 5011.2 5021.0 4840.7 4883.5 4901.5 4904.8 4953.2 5255.1 5270.2 5272.2 5273.2 5277.7 5815.8 5820.1 5823.0 5842.0 5876.9 5724.3 5816.7 5861.2 5915.3 5935.0 5385.4 5433.2 5441.7 5469.6 5469.9 5828.6 5928.8 5949.7 5964.4 5986.1 5627.0 5676.1 5714.5 5720.2 5782.4 5837.7 5842.3 5852.2 5852.6 5881.3 5588.3 5637.1 5770.3 5778.0 5787.1 5730.8 5837.2 5846.2 5869.0 5873.9 4460.4 4461.7 4489.1 4519.5 4521.3 3993.8 4037.6 4043.6 4071.5 4119.6 5550.1 5558.6 5586.1 5620.4 5630.5 5874.9 5883.9 5887.1 5900.0 5908.6 5412.9 5471.8 5533.8 5581.1 5619.5 4944.7 4972.9 4978.4 4978.6 5008.7 5907.5 5934.0 5957.5 5965.3 5981.4 5773.5 5824.4 5839.8 5846.2 5848.4 6001.1 6033.3 6062.7 6078.6 6093.2 5822.2 5828.0 5828.9 5831.8 5849.1 5755.2 5781.6 5814.7 5842.4 5929.6 5708.4 5713.1 5720.9 5722.5 5748.2 5667.4 5681.7 5723.3 5743.7 5761.6 5447.6 5608.5 5633.9 5647.7 5705.7 5605.0 5751.1 5758.5 5775.5 5792.9 5487.0 5606.4 5627.3 5635.7 5635.9 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | [#1] ext.html Cycles:180 Average:56144.54 Median:40508.10 stddev:112308.81 (277.3%) stddev-sans-first:112546.22 09:25:34 INFO - PROCESS | 12353 | Values: 521.2 551.6 564.7 584.4 595.0 29995.6 30778.7 38520.0 38585.6 38914.8 41657.4 42059.8 42172.8 42473.0 42683.4 8799.9 9012.5 9017.8 9058.5 9061.1 8725.8 8847.3 8849.9 8856.7 8876.5 9064.0 9157.7 9179.1 9192.4 9195.2 8867.4 9045.0 9079.9 9093.2 9100.8 8946.2 9085.8 9103.6 9151.6 9162.0 42251.2 42771.6 42883.4 42909.4 42954.0 3618.3 3677.3 3739.9 4033.7 4237.9 31831.7 31913.5 31954.5 32091.4 33035.0 4261.0 4309.4 4388.6 4411.5 4441.2 213611.0 213847.0 213975.0 214129.0 214372.0 64028.7 64416.0 64536.4 64683.0 64713.7 67113.3 67551.3 67630.3 67682.3 67868.3 17341.8 17911.2 17958.0 17991.6 17992.3 13467.7 13498.9 13607.7 13692.7 13702.9 21508.2 21619.1 21814.6 21843.9 21847.2 8059.0 8383.4 8426.9 8455.9 8483.2 1031.5 1153.5 1155.5 1157.0 1161.4 31249.5 31445.1 31847.7 34449.7 36123.1 1140.5 1158.9 1172.5 1233.3 1278.4 16451.4 16465.8 16476.8 16482.0 16898.3 429101.0 470136.0 495691.0 764598.0 770581.0 59911.4 60730.4 60732.0 60915.4 60966.7 1439.6 1457.1 1466.1 1469.5 1486.3 32236.5 32787.2 32863.7 33021.0 33743.8 50166.7 50601.5 50658.7 50686.5 50759.7 339016.0 341486.0 342200.0 344066.0 344323.0 33901.0 34087.3 34273.0 34685.8 34768.5 45610.3 45948.0 45962.5 46769.8 47423.3 39257.0 39700.4 40021.0 40627.8 40947.6 39394.4 39871.6 40240.0 40297.0 40388.4 45062.8 45593.0 45763.5 45926.5 46321.0 38534.2 39599.8 39668.4 39853.4 42740.0 31832.8 34600.5 34834.0 36142.6 36875.1 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | [#2] jquery.html Cycles:180 Average:30087.64 Median:2602.45 stddev:101887.59 (3915.1%) stddev-sans-first:102149.01 09:25:34 INFO - PROCESS | 12353 | Values: 392.3 394.3 397.1 398.2 401.9 15414.3 15684.7 17091.3 17570.0 17611.5 11910.4 12214.6 15747.4 17834.1 17948.7 4733.6 5404.1 5612.8 5615.9 5629.2 5299.8 5430.6 5528.5 5536.1 5542.3 5373.3 5401.1 5479.2 5489.8 5522.4 5549.4 5722.2 5729.1 5763.9 5880.2 5656.2 5665.5 5669.6 5696.7 5717.2 13601.0 14398.7 14424.9 14438.3 16506.0 2299.6 2302.0 2307.7 2349.2 2400.7 10049.4 10156.4 10427.8 10486.7 10536.5 1865.9 1918.6 1937.8 1947.1 2012.1 57919.7 59647.4 60578.0 61015.0 61426.8 10217.9 10479.2 10642.9 10660.7 10665.8 12886.9 13237.3 13261.6 13264.2 13266.4 7601.4 7605.9 7645.6 7690.0 7751.5 7070.8 7180.7 7196.2 7390.4 7408.3 4482.0 4484.5 7883.0 8081.3 8270.8 3107.3 3196.9 3357.7 3377.8 3491.6 471.3 483.2 488.6 947.7 1125.0 10581.8 11309.5 11584.4 11604.7 11702.2 514.4 521.5 545.2 556.6 1006.8 9188.8 9422.2 9553.4 9571.9 9686.2 606576.0 607292.0 626050.0 633345.0 641532.0 79151.0 79330.0 79613.6 79821.6 82082.0 1202.6 1204.7 1206.7 1218.9 1239.3 14915.3 15157.4 15380.1 15492.9 15508.1 32519.7 32825.5 32983.3 33495.2 33861.8 46794.5 47747.8 47864.5 49545.5 50487.7 7474.2 7548.1 7550.3 7616.4 7670.1 9490.6 11405.0 11445.4 11676.6 11942.4 3132.6 3143.4 5330.6 5629.5 8621.4 9464.8 9841.8 9951.3 9964.3 10180.3 10053.2 10086.7 10198.9 10419.4 10549.8 7697.3 7914.3 7930.0 7946.4 7977.6 9113.3 9780.2 10289.3 10365.3 10594.5 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | [#3] mootools.html Cycles:180 Average:5825.61 Median:6134.15 stddev:3009.46 (49.1%) stddev-sans-first:3000.92 09:25:34 INFO - PROCESS | 12353 | Values: 1572.5 1607.8 1836.6 1917.9 1933.9 8359.3 8429.9 8571.1 8611.8 8620.2 8215.0 8324.1 8332.4 8367.5 8372.7 2379.1 2410.1 2410.2 2416.1 2436.1 2404.6 2447.9 2488.8 2500.4 2516.0 2370.2 2429.9 2448.0 2461.3 2476.8 2480.2 2499.6 2511.0 2517.0 2526.2 2440.9 2471.8 2493.7 2498.5 2505.9 8353.8 8388.7 8410.1 8432.3 8454.4 5002.5 5085.1 5086.5 5134.2 5139.4 3228.5 3233.7 3242.0 3378.4 3389.3 1057.5 1065.7 1072.9 1081.5 1096.4 11265.0 11490.5 11513.9 11535.1 11558.9 4452.4 4498.8 4532.8 4550.5 4552.9 9494.5 9499.8 9544.5 9557.1 9570.6 5118.1 5120.6 5134.8 5137.3 5178.4 4769.6 4792.9 4816.4 4818.3 4825.7 3591.3 3655.2 3695.4 3697.2 3699.7 1060.8 1088.4 1124.3 1126.4 1132.4 961.1 1035.0 1108.1 1188.9 1401.7 7736.1 7790.2 7895.1 7905.0 7909.2 1210.8 1214.6 1218.5 1221.2 1231.3 6048.4 6107.5 6121.9 6146.4 6152.0 9084.4 9368.9 9420.6 9446.3 9473.2 9748.7 10009.4 10055.2 10104.1 10160.5 7358.9 7365.6 7371.4 7373.1 7398.2 7782.2 7918.8 7996.2 8004.0 8116.6 8981.8 9205.2 9206.0 9227.6 9372.0 9307.4 9384.2 9392.0 9403.7 9566.7 7558.0 7684.0 7702.3 7730.6 7775.6 7958.5 8263.5 8271.8 8295.1 8297.6 7143.6 7293.6 7299.0 7310.8 7636.8 7040.8 7135.8 7160.5 7165.7 7304.2 7284.7 7321.8 7334.4 7356.1 7362.9 6433.2 6550.0 6551.9 6588.7 6602.0 6672.9 6716.9 6762.3 6817.7 6874.6 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | [#4] prototype.html Cycles:180 Average:5642.04 Median:6452.39 stddev:1660.85 (25.7%) stddev-sans-first:1617.83 09:25:34 INFO - PROCESS | 12353 | Values: 377.7 386.2 387.5 388.0 392.4 6233.8 6381.1 6419.9 6437.2 6467.6 6195.7 6311.9 6324.2 6347.6 6375.4 4925.9 4947.8 4947.9 4955.7 4957.1 4954.0 4973.4 4978.5 4982.7 4983.8 4720.4 4841.2 4847.8 4864.7 4871.3 4875.6 4879.0 4880.0 4880.5 4888.3 4304.3 4307.5 4312.6 4313.0 4317.7 5956.9 6051.6 6064.1 6076.2 6089.6 5670.2 5703.4 5726.2 5732.4 5732.6 6750.6 6764.3 6766.9 6774.4 6789.4 4765.3 4771.3 4773.4 4774.3 4781.6 6938.7 7011.1 7044.8 7082.8 7089.1 4857.5 4867.2 4868.6 4871.3 4877.0 4900.3 4979.3 4983.5 4987.3 4991.9 5557.2 5653.7 5661.8 5663.8 5687.2 6780.8 6803.6 6817.8 6818.2 6834.0 1712.4 1741.7 1744.6 1747.6 1759.6 1173.4 1178.0 1193.1 1194.8 1211.1 6475.1 6480.9 6495.5 6508.7 6510.4 6905.4 6913.2 6916.6 6929.7 6940.6 6371.4 6472.9 6478.6 6489.5 6489.7 3749.3 3750.3 3767.7 3776.9 3785.3 7017.9 7063.9 7069.2 7076.4 7077.6 6871.9 7022.3 7039.4 7054.7 7068.0 7031.2 7067.3 7072.4 7077.6 7081.8 6880.0 6923.4 6929.9 6936.2 6947.4 6627.8 6766.4 6769.5 6789.8 6849.0 7028.9 7040.8 7054.6 7066.6 7071.8 4865.9 4874.6 4885.8 4891.3 4895.7 6755.8 6857.2 6861.0 6878.3 6878.8 6686.8 6708.2 6709.1 6717.2 6723.4 6694.4 6710.4 6716.6 6741.1 6746.9 6387.0 6563.3 6574.1 6581.5 6596.2 6687.8 6720.5 6722.9 6751.7 6765.0 6541.9 6573.0 6580.9 6594.8 6610.0 09:25:34 INFO - PROCESS | 12353 | 09:25:34 INFO - PROCESS | 12353 | [#5] yui.html Cycles:180 Average:14903.57 Median:4496.52 stddev:16714.19 (371.7%) stddev-sans-first:16727.70 09:25:34 INFO - PROCESS | 12353 | Values: 836.7 877.6 914.6 916.2 932.6 14780.4 14928.3 14980.9 14995.2 15016.6 13776.2 13887.5 13922.4 13945.0 13977.9 883.9 893.7 912.1 914.8 917.1 906.1 907.1 910.4 910.5 912.8 932.9 934.3 940.2 941.6 944.3 914.5 921.7 924.3 929.0 931.7 683.0 684.4 685.7 692.9 694.1 15368.4 15399.8 15410.5 15441.4 15458.1 14056.8 14084.5 14090.2 14149.0 14184.4 11690.4 11740.2 11757.2 11762.4 12307.4 3980.7 3987.6 4034.1 4057.8 4067.0 53043.7 53538.0 53795.7 53807.5 53836.5 10938.2 10970.7 11069.2 11205.7 11311.5 19139.1 19192.3 19249.3 19268.5 19332.1 8224.3 8516.7 8530.9 8674.0 8689.9 4484.1 4517.0 4526.0 4582.6 4603.9 3230.4 3251.5 3267.3 3274.2 3281.6 592.9 598.3 605.3 610.2 611.7 612.9 622.3 622.6 630.8 688.4 9329.5 9624.8 9667.5 9720.1 9780.9 602.0 605.3 608.8 621.0 621.6 4332.2 4359.9 4393.8 4509.0 4795.7 57970.0 58080.0 58437.0 58500.4 58660.4 52843.5 53514.5 53716.0 54576.0 55002.7 49183.0 49305.0 49627.5 50121.7 50255.2 9715.9 9884.9 9885.4 9993.9 10092.8 35706.8 35973.8 36393.6 36734.4 36825.3 41415.2 45678.8 47051.0 47293.0 48328.3 12016.6 12091.9 12113.7 12378.7 12402.7 13147.1 13348.8 13782.2 13784.2 14063.2 12685.2 13001.2 13065.0 13358.5 13436.7 12993.6 13081.8 13166.4 13506.8 13626.0 12392.8 12752.9 12827.8 12891.4 13116.9 10563.4 10721.3 10786.3 10836.9 11113.4 10705.8 10768.0 10805.2 10893.5 10992.1 09:25:34 INFO - PROCESS | 12353 | -------- Summary: end -------- 09:25:34 INFO - PROCESS | 12353 | 09:25:35 INFO - TEST-INFO | 12353: exit 0 09:25:35 INFO - TEST-OK | dromaeo_css | took 1109101ms 09:25:35 INFO - TEST-START | kraken 09:25:35 INFO - operating with platform_type : linux_ 09:25:35 INFO - Initialising browser for kraken test... 09:25:35 INFO - TEST-INFO | started process 12602 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS4adZ3/profile http://localhost:44943/getInfo.html) 09:25:38 INFO - PROCESS | 12602 | 09:25:38 INFO - PROCESS | 12602 | (process:12683): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:25:39 INFO - PROCESS | 12602 | __metrics Screen width/height:1600/1200 09:25:39 INFO - PROCESS | 12602 | colorDepth:24 09:25:39 INFO - PROCESS | 12602 | Browser inner width/height: 1024/697 09:25:39 INFO - PROCESS | 12602 | __metrics 09:25:40 INFO - TEST-INFO | 12602: exit 0 09:25:40 INFO - Browser initialized. 09:25:40 INFO - Running cycle 1/1 for kraken test... 09:25:40 INFO - TEST-INFO | started process 12732 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS4adZ3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:41 INFO - PROCESS | 12732 | 09:25:41 INFO - PROCESS | 12732 | (process:12794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:25:52 INFO - PROCESS | 12732 | RSS: Main: 141135872 09:25:52 INFO - PROCESS | 12732 | 09:25:54 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44943/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:55 INFO - PROCESS | 12732 | RSS: Main: 145678336 09:25:55 INFO - PROCESS | 12732 | 09:25:58 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44943/tests/kraken/driver.html?testName=audio-dft) 09:25:58 INFO - PROCESS | 12732 | RSS: Main: 145895424 09:25:58 INFO - PROCESS | 12732 | 09:26:01 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44943/tests/kraken/driver.html?testName=audio-fft) 09:26:02 INFO - PROCESS | 12732 | RSS: Main: 145616896 09:26:02 INFO - PROCESS | 12732 | 09:26:04 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44943/tests/kraken/driver.html?testName=audio-oscillator) 09:26:04 INFO - PROCESS | 12732 | RSS: Main: 144969728 09:26:04 INFO - PROCESS | 12732 | 09:26:07 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:07 INFO - PROCESS | 12732 | RSS: Main: 145715200 09:26:07 INFO - PROCESS | 12732 | 09:26:10 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44943/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:11 INFO - PROCESS | 12732 | RSS: Main: 146964480 09:26:11 INFO - PROCESS | 12732 | 09:26:14 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44943/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:15 INFO - PROCESS | 12732 | RSS: Main: 146178048 09:26:15 INFO - PROCESS | 12732 | 09:26:17 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44943/tests/kraken/driver.html?testName=json-parse-financial) 09:26:18 INFO - PROCESS | 12732 | RSS: Main: 146382848 09:26:18 INFO - PROCESS | 12732 | 09:26:20 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:20 INFO - PROCESS | 12732 | RSS: Main: 146485248 09:26:20 INFO - PROCESS | 12732 | 09:26:22 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:23 INFO - PROCESS | 12732 | RSS: Main: 146239488 09:26:23 INFO - PROCESS | 12732 | 09:26:25 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:25 INFO - PROCESS | 12732 | RSS: Main: 146345984 09:26:25 INFO - PROCESS | 12732 | 09:26:28 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:28 INFO - PROCESS | 12732 | RSS: Main: 146137088 09:26:28 INFO - PROCESS | 12732 | 09:26:31 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:31 INFO - PROCESS | 12732 | RSS: Main: 146288640 09:26:31 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:44943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44943/tests/kraken/driver.html?testName=ai-astar) 09:26:33 INFO - PROCESS | 12732 | RSS: Main: 147271680 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | __start_tp_report 09:26:33 INFO - PROCESS | 12732 | _x_x_mozilla_page_load 09:26:33 INFO - PROCESS | 12732 | _x_x_mozilla_page_load_details 09:26:33 INFO - PROCESS | 12732 | |i|pagename|runs| 09:26:33 INFO - PROCESS | 12732 | |0;ai-astar;112;107;111;111;111;122;111;111;113;112 09:26:33 INFO - PROCESS | 12732 | |1;audio-beat-detection;149;126;153;165;128;153;155;128;161;127 09:26:33 INFO - PROCESS | 12732 | |2;audio-dft;165;163;163;164;164;162;163;163;165;161 09:26:33 INFO - PROCESS | 12732 | |3;audio-fft;76;75;72;153;77;75;76;76;157;74 09:26:33 INFO - PROCESS | 12732 | |4;audio-oscillator;95;95;141;94;95;96;134;94;95;134 09:26:33 INFO - PROCESS | 12732 | |5;imaging-gaussian-blur;110;109;110;109;110;110;109;109;110;110 09:26:33 INFO - PROCESS | 12732 | |6;imaging-darkroom;147;147;147;146;147;146;148;146;148;147 09:26:33 INFO - PROCESS | 12732 | |7;imaging-desaturate;97;98;96;96;96;97;97;97;97;97 09:26:33 INFO - PROCESS | 12732 | |8;json-parse-financial;53;56;56;55;60;55;55;62;52;56 09:26:33 INFO - PROCESS | 12732 | |9;json-stringify-tinderbox;65;65;64;64;64;65;65;65;65;70 09:26:33 INFO - PROCESS | 12732 | |10;stanford-crypto-aes;89;80;81;90;83;81;82;83;82;81 09:26:33 INFO - PROCESS | 12732 | |11;stanford-crypto-ccm;111;119;110;119;122;115;111;113;125;124 09:26:33 INFO - PROCESS | 12732 | |12;stanford-crypto-pbkdf2;125;143;137;138;138;139;138;139;139;135 09:26:33 INFO - PROCESS | 12732 | |13;stanford-crypto-sha256-iterative;65;68;66;67;72;65;66;65;64;69 09:26:33 INFO - PROCESS | 12732 | __end_tp_report 09:26:33 INFO - PROCESS | 12732 | __start_cc_report 09:26:33 INFO - PROCESS | 12732 | _x_x_mozilla_cycle_collect,748 09:26:33 INFO - PROCESS | 12732 | __end_cc_report 09:26:33 INFO - PROCESS | 12732 | __startTimestamp1456248393551__endTimestamp 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | ------- Summary: start ------- 09:26:33 INFO - PROCESS | 12732 | Number of tests: 14 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.81 (3.4%) stddev-sans-first:4.04 09:26:33 INFO - PROCESS | 12732 | Values: 112.0 107.0 111.0 111.0 111.0 122.0 111.0 111.0 113.0 112.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:153.00 stddev:15.49 (10.1%) stddev-sans-first:16.35 09:26:33 INFO - PROCESS | 12732 | Values: 149.0 126.0 153.0 165.0 128.0 153.0 155.0 128.0 161.0 127.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.25 (0.8%) stddev-sans-first:1.17 09:26:33 INFO - PROCESS | 12732 | Values: 165.0 163.0 163.0 164.0 164.0 162.0 163.0 163.0 165.0 161.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#3] audio-fft Cycles:10 Average:91.10 Median:75.50 stddev:33.72 (44.7%) stddev-sans-first:35.32 09:26:33 INFO - PROCESS | 12732 | Values: 76.0 75.0 72.0 153.0 77.0 75.0 76.0 76.0 157.0 74.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:95.00 stddev:20.13 (21.2%) stddev-sans-first:20.86 09:26:33 INFO - PROCESS | 12732 | Values: 95.0 95.0 141.0 94.0 95.0 96.0 134.0 94.0 95.0 134.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:26:33 INFO - PROCESS | 12732 | Values: 110.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:26:33 INFO - PROCESS | 12732 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 148.0 146.0 148.0 147.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:26:33 INFO - PROCESS | 12732 | Values: 97.0 98.0 96.0 96.0 96.0 97.0 97.0 97.0 97.0 97.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.98 (5.3%) stddev-sans-first:2.96 09:26:33 INFO - PROCESS | 12732 | Values: 53.0 56.0 56.0 55.0 60.0 55.0 55.0 62.0 52.0 56.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.75 (2.7%) stddev-sans-first:1.86 09:26:33 INFO - PROCESS | 12732 | Values: 65.0 65.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 70.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.50 stddev:3.46 (4.2%) stddev-sans-first:2.96 09:26:33 INFO - PROCESS | 12732 | Values: 89.0 80.0 81.0 90.0 83.0 81.0 82.0 83.0 82.0 81.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:119.00 stddev:5.65 (4.7%) stddev-sans-first:5.57 09:26:33 INFO - PROCESS | 12732 | Values: 111.0 119.0 110.0 119.0 122.0 115.0 111.0 113.0 125.0 124.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:138.50 stddev:4.70 (3.4%) stddev-sans-first:2.13 09:26:33 INFO - PROCESS | 12732 | Values: 125.0 143.0 137.0 138.0 138.0 139.0 138.0 139.0 139.0 135.0 09:26:33 INFO - PROCESS | 12732 | 09:26:33 INFO - PROCESS | 12732 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:2.41 (3.6%) stddev-sans-first:2.47 09:26:33 INFO - PROCESS | 12732 | Values: 65.0 68.0 66.0 67.0 72.0 65.0 66.0 65.0 64.0 69.0 09:26:33 INFO - PROCESS | 12732 | -------- Summary: end -------- 09:26:33 INFO - PROCESS | 12732 | 09:26:34 INFO - TEST-INFO | 12732: exit 0 09:26:34 INFO - TEST-OK | kraken | took 59480ms 09:26:34 INFO - TEST-START | v8_7 09:26:34 INFO - operating with platform_type : linux_ 09:26:34 INFO - Initialising browser for v8_7 test... 09:26:34 INFO - TEST-INFO | started process 13022 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAvIqDr/profile http://localhost:44943/getInfo.html) 09:26:38 INFO - PROCESS | 13022 | 09:26:38 INFO - PROCESS | 13022 | (process:13101): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:26:39 INFO - PROCESS | 13022 | __metrics Screen width/height:1600/1200 09:26:39 INFO - PROCESS | 13022 | colorDepth:24 09:26:39 INFO - PROCESS | 13022 | Browser inner width/height: 1024/697 09:26:39 INFO - PROCESS | 13022 | __metrics 09:26:40 INFO - TEST-INFO | 13022: exit 0 09:26:40 INFO - Browser initialized. 09:26:40 INFO - Running cycle 1/1 for v8_7 test... 09:26:40 INFO - TEST-INFO | started process 13150 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAvIqDr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:41 INFO - PROCESS | 13150 | 09:26:41 INFO - PROCESS | 13150 | (process:13216): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:26:52 INFO - PROCESS | 13150 | RSS: Main: 141606912 09:26:52 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:44943/tests/v8_7/run.html (next: http://localhost:44943/tests/v8_7/run.html) 09:27:14 INFO - PROCESS | 13150 | RSS: Main: 145346560 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | __start_tp_report 09:27:14 INFO - PROCESS | 13150 | _x_x_mozilla_page_load 09:27:14 INFO - PROCESS | 13150 | _x_x_mozilla_page_load_details 09:27:14 INFO - PROCESS | 13150 | |i|pagename|runs| 09:27:14 INFO - PROCESS | 13150 | |0;Richards;167.897918065816 09:27:14 INFO - PROCESS | 13150 | |1;DeltaBlue;170.35775127768312 09:27:14 INFO - PROCESS | 13150 | |2;Encrypt;278.39643652561244 09:27:14 INFO - PROCESS | 13150 | |3;Decrypt;5246.073298429319 09:27:14 INFO - PROCESS | 13150 | |4;RayTrace;923.3610341643582 09:27:14 INFO - PROCESS | 13150 | |5;Earley;605.6935190793458 09:27:14 INFO - PROCESS | 13150 | |6;Boyer;10934.782608695652 09:27:14 INFO - PROCESS | 13150 | |7;RegExp;39173.07692307692 09:27:14 INFO - PROCESS | 13150 | |8;Splay;499.50544015825915 09:27:14 INFO - PROCESS | 13150 | |9;NavierStokes;4822.115384615385 09:27:14 INFO - PROCESS | 13150 | __end_tp_report 09:27:14 INFO - PROCESS | 13150 | __startTimestamp1456248434748__endTimestamp 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | ------- Summary: start ------- 09:27:14 INFO - PROCESS | 13150 | Number of tests: 10 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 167.9 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#1] DeltaBlue Cycles:1 Average:170.36 Median:170.36 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 170.4 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 278.4 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 5246.1 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#4] RayTrace Cycles:1 Average:923.36 Median:923.36 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 923.4 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#5] Earley Cycles:1 Average:605.69 Median:605.69 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 605.7 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#6] Boyer Cycles:1 Average:10934.78 Median:10934.78 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 10934.8 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#7] RegExp Cycles:1 Average:39173.08 Median:39173.08 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 39173.1 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#8] Splay Cycles:1 Average:499.51 Median:499.51 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 499.5 09:27:14 INFO - PROCESS | 13150 | 09:27:14 INFO - PROCESS | 13150 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 09:27:14 INFO - PROCESS | 13150 | Values: 4822.1 09:27:14 INFO - PROCESS | 13150 | -------- Summary: end -------- 09:27:14 INFO - PROCESS | 13150 | 09:27:15 INFO - TEST-INFO | 13150: exit 0 09:27:15 INFO - TEST-OK | v8_7 | took 41162ms 09:27:15 INFO - SUITE-END | took 1209s 09:27:15 INFO - Completed test suite (00:20:09) 09:27:15 INFO - Working with test: dromaeo_css 09:27:15 INFO - Generating results file: dromaeo_css 09:27:15 INFO - Working with test: kraken 09:27:15 INFO - Generating results file: kraken 09:27:15 INFO - javascript benchmark 09:27:15 INFO - Working with test: v8_7 09:27:15 INFO - Generating results file: v8_7 09:27:15 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:27:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:27:15 INFO - process_Request line: dromaeo_css 7317.40 graph.html#tests=[[72,52,43]] 09:27:15 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:27:15 INFO - process_Request line: kraken 1496.70 graph.html#tests=[[232,52,43]] 09:27:15 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:27:15 INFO - process_Request line: v8_7 21968.15 graph.html#tests=[[230,52,43]] 09:27:15 INFO - RETURN: dromaeo_css: 7317.40 09:27:15 INFO - RETURN: kraken: 1496.70 09:27:15 INFO - RETURN: v8_7: 21968.15 09:27:15 INFO - javascript benchmark 09:27:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3292.04530686101, 3353.4969754536833, 3363.7477189210817, 3382.509536117264, 3398.7111095556875, 5431.239626452295, 5443.727813609314, 5452.563794896409, 5455.399906010336, 5478.753456094475, 5412.485813847688, 5451.509364157225, 5508.862278443031, 5515.7242137893145, 5524.861878453041, 4900.558949694527, 4966.801327946878, 5019.723915184663, 5048.7223202723835, 5068.594512438996, 4788.257820037882, 4909.288153217782, 4999.075171093341, 5012.022655582163, 5054.21659642756, 4980.12847751642, 4984.850454486371, 4996.675216110959, 5039.77321020555, 5065.240213967897, 4959.950400496021, 4986.850394488171, 5008.549230569266, 5011.248312753098, 5021.046001259785, 4840.733759643218, 4883.536064073907, 4901.460839307673, 4904.779284932187, 4953.182724850395, 5255.080360936859, 5270.156774915995, 5272.209168624737, 5273.235380869753, 5277.736113194325, 5815.767369305223, 5820.097884827858, 5823.039198532237, 5842.036064049426, 5876.941230587682, 5724.255846739898, 5816.680082595455, 5861.150133230701, 5915.349311575723, 5935.020721580934, 5385.407605163429, 5433.212184233264, 5441.700706461183, 5469.56243500519, 5469.890602187934, 5828.562857785683, 5928.762849486058, 5949.702514874239, 5964.373740757158, 5986.07215881539, 5626.971865140648, 5676.091825307931, 5714.542836573064, 5720.1991721159075, 5782.421757824268, 5837.708114594253, 5842.269716285465, 5852.180694702745, 5852.590318677651, 5881.2942446906645, 5588.329400471969, 5637.098064309691, 5770.336411312753, 5777.971110144423, 5787.102999035156, 5730.828075157752, 5837.153612726216, 5846.239988801513, 5869.0, 5873.882522349529, 4460.397846290709, 4461.665375096816, 4489.124620698998, 4519.480259770168, 4521.276595744665, 3993.800309984489, 4037.555868854424, 4043.6360727534075, 4071.491063617048, 4119.649829764444, 5550.084236101079, 5558.583106267046, 5586.050371436865, 5620.4098569649595, 5630.493255607015, 5874.9118763218585, 5883.882322353615, 5887.087501437284, 5900.0, 5908.645481271052, 5412.945870541323, 5471.8084867029465, 5533.750981205855, 5581.10702287632, 5619.466150715675, 4944.728039957837, 4972.8756781080765, 4978.352814134139, 4978.551930326288, 5008.6744361616375, 5907.4683278505145, 5934.0, 5957.523398128226, 5965.254343207099, 5981.431763982415, 5773.480386765295, 5824.388439213822, 5839.824805255849, 5846.152307915413, 5848.385919478564, 6001.129836173643, 6033.276006879202, 6062.696865156813, 6078.6048906820915, 6093.207882975362, 5822.214001109796, 5828.0, 5828.912566311424, 5831.766729330949, 5849.1226316052935, 5755.165501002415, 5781.595288329945, 5814.680192589448, 5842.415758424124, 5929.6145750526075, 5708.429157084258, 5713.05734553794, 5720.914186287126, 5722.542196624343, 5748.223989761496, 5667.40492248308, 5681.715914204356, 5723.255976723, 5743.655380677173, 5761.625494342854, 5447.564194864322, 5608.523275521627, 5633.887322253614, 5647.745851436777, 5705.686187259741, 5605.047141985954, 5751.1373294006235, 5758.510526605285, 5775.451332123442, 5792.884142317214, 5486.972565137149, 5606.411326810626, 5627.268455100811, 5635.690037048002, 5635.8591035224445], "unit": "score", "name": "dojo.html", "value": 5386.953572309037}, {"lowerIsBetter": false, "replicates": [521.184346497731, 551.6248950713518, 564.6555601083339, 584.3513699793228, 595.0479233226838, 29995.55006674899, 30778.692213077862, 38520.0, 38585.614143858555, 38914.8054259729, 41657.37513937293, 42059.78970105153, 42172.78913605435, 42473.0, 42683.359749603784, 8799.91200087999, 9012.504312262823, 9017.774555636095, 9058.456492610432, 9061.093890610951, 8725.7818554536, 8847.292216622687, 8849.911500885006, 8856.690015849446, 8876.511791851446, 9063.95468022659, 9157.725268241964, 9179.127982841654, 9192.35653504255, 9195.172434480895, 8867.423617464845, 9044.999999999967, 9079.909200907972, 9093.18161365477, 9100.81798364029, 8946.150115738994, 9085.772855678595, 9103.590338434786, 9151.588178531916, 9162.037986011439, 42251.15497690029, 42771.57228427707, 42883.35674964847, 42909.35635965463, 42954.0, 3618.330608837347, 3677.3013127505956, 3739.9439008414897, 4033.657139143176, 4237.851675191384, 31831.681683183102, 31913.52129718056, 31954.520682189785, 32091.35817283641, 33035.0, 4260.957390426087, 4309.375140604626, 4388.605025547716, 4411.470623525165, 4441.222786012468, 213611.0, 213847.0, 213975.0, 214129.0, 214372.0, 64028.67985660042, 64416.0, 64536.354636453034, 64683.02975455372, 64713.67643161754, 67113.32886671169, 67551.32448675549, 67630.32369676339, 67682.3231767676, 67868.32131678719, 17341.826581734273, 17911.193996270198, 17958.0, 17991.640167196583, 17992.280308787762, 13467.663308417172, 13498.93250533741, 13607.727845443036, 13692.726145477034, 13702.93148534251, 21508.247211347527, 21619.13523459044, 21814.56370872574, 21843.907804609706, 21847.235346762787, 8058.959705201437, 8383.413161078666, 8426.915730842737, 8455.873161902577, 8483.236508714246, 1031.4945676618404, 1153.4751687981948, 1155.5493357590547, 1156.9710757230969, 1161.3786624156037, 31249.53125703116, 31445.056648300586, 31847.681523184936, 34449.65550344464, 36123.09692257715, 1140.5380820767602, 1158.8725240223569, 1172.5142697481224, 1233.340163012784, 1278.4438769135456, 16451.42420015318, 16465.753013704805, 16476.752848707278, 16482.0, 16898.324067037425, 429101.0, 470136.0, 495691.0, 764598.0, 770581.0, 59911.40088599058, 60730.39269607247, 60732.0, 60915.39084609186, 60966.69516652388, 1439.6113049476583, 1457.0893191755154, 1466.1130016340387, 1469.5370958148362, 1486.31629450454, 32236.516452252767, 32787.21159397197, 32863.67136328606, 33021.0, 33743.83128084344, 50166.74916625393, 50601.49398506115, 50658.74670626623, 50686.49313506818, 50759.746201268754, 339016.0, 341486.0, 342200.0, 344066.0, 344323.0, 33901.0, 34087.31825363528, 34273.0, 34685.826570866986, 34768.47847282344, 45610.315845261684, 45948.0, 45962.540374595825, 46769.766151169024, 47423.288650670955, 39257.0, 39700.404493933194, 40021.0, 40627.796861016686, 40947.590524094376, 39394.40908386319, 39871.60128398679, 40239.99400015023, 40297.0, 40388.394174086825, 45062.77468612636, 45593.0, 45763.54236457593, 45926.54073459223, 46321.0, 38534.22931541409, 39599.80200098981, 39668.40497392484, 39853.40219896646, 42740.0, 31832.840835795672, 34600.48099278563, 34834.0, 36142.63857361393, 36875.07812304714], "unit": "score", "name": "ext.html", "value": 20516.35852148178}, {"lowerIsBetter": false, "replicates": [392.25471603952485, 394.3237347948269, 397.14811728841653, 398.243337658449, 401.9397090436436, 15414.306356213969, 15684.686306273868, 17091.316347346106, 17570.0, 17611.471655850346, 11910.40447977602, 12214.633560993185, 15747.370105195807, 17834.10829458525, 17948.73076903844, 4733.621310295185, 5404.135338345865, 5612.803551875685, 5615.9157612635845, 5629.240052592909, 5299.761510732026, 5430.56555475563, 5528.530074943635, 5536.086545719972, 5542.307211598551, 5373.301470808789, 5401.054815407288, 5479.232907392969, 5489.835304940858, 5522.392536820947, 5549.361823390322, 5722.170285308607, 5729.140628905656, 5763.942360576382, 5880.235569375954, 5656.179853921159, 5665.49010589049, 5669.6314739541795, 5696.715164241771, 5717.171010203539, 13601.0, 14398.71202575953, 14424.927875360661, 14438.27808609576, 16506.0, 2299.5975704251855, 2301.976980230193, 2307.734610519778, 2349.2482405630203, 2400.663907053014, 10049.447280399576, 10156.39061656303, 10427.843582346271, 10486.685399438029, 10536.525856336484, 1865.9253629854788, 1918.5970946101336, 1937.7577802774654, 1947.1140631012854, 2012.084501551805, 57919.710401448145, 59647.403525965055, 60578.0, 61015.0, 61426.77146457046, 10217.948910255402, 10479.161667066768, 10642.946785266024, 10660.733481663021, 10665.84001239982, 12886.871131288755, 13237.338133093306, 13261.602151935458, 13264.204147751167, 13266.403011864297, 7601.429892757955, 7605.885911711218, 7645.5794931279315, 7690.0, 7751.496152750054, 7070.823229419306, 7180.712771489187, 7196.172440169343, 7390.371818395497, 7408.296211859864, 4481.977590112028, 4484.506704262529, 7882.960585197037, 8081.272685458337, 8270.8345833083, 3107.254258977829, 3196.856141473639, 3357.6810203030673, 3377.763556551067, 3491.5984661764223, 471.2789432168787, 483.21718815519085, 488.5505335091724, 947.7298969793576, 1124.9943750281195, 10581.788364232672, 11309.491072901574, 11584.42077896102, 11604.709882253012, 11702.180847340775, 514.4187068612443, 521.4785214785214, 545.2339463054415, 556.5547561950505, 1006.7634105985088, 9188.816223675623, 9422.199113075329, 9553.379030363143, 9571.90428095724, 9686.176674982564, 606576.0, 607292.0, 626050.0, 633345.0, 641532.0, 79151.0, 79330.0, 79613.60193199113, 79821.60089199634, 82082.0, 1202.6452196602024, 1204.740980689156, 1206.6741979665442, 1218.9146759726912, 1239.2997956154743, 14915.254237288309, 15157.393704251706, 15380.077195368314, 15492.922535387701, 15508.147051912254, 32519.674803251666, 32825.50761738623, 32983.34033319368, 33495.16262093467, 33861.830690846386, 46794.53205468038, 47747.761261193475, 47864.521354786004, 49545.50454495409, 50487.74756126196, 7474.177840437439, 7548.094228692592, 7550.263439409076, 7616.3906887447765, 7670.117936437158, 9490.620375184915, 11405.0, 11445.427728613702, 11676.649700508999, 11942.402879856147, 3132.63974642919, 3143.35561209956, 5330.573554115739, 5629.493345598916, 8621.44813933498, 9464.763380915258, 9841.753956151153, 9951.303408761607, 9964.302498825013, 10180.287379883337, 10053.19574434058, 10086.697399078039, 10198.949005254926, 10419.374837509773, 10549.789004220027, 7697.307242348215, 7914.327282180849, 7930.0, 7946.404019698662, 7977.5612341321785, 9113.270938324786, 9780.217582593234, 10289.2797504174, 10365.326253793479, 10594.523246453773], "unit": "score", "name": "jquery.html", "value": 8233.877006112936}, {"lowerIsBetter": false, "replicates": [1572.5125211184534, 1607.815101263355, 1836.5959488912442, 1917.913693883775, 1933.9226430942763, 8359.28946039586, 8429.873551896719, 8571.057183709787, 8611.827763444728, 8620.224179823814, 8214.958925205381, 8324.125966773492, 8332.375071869603, 8367.456115352514, 8372.665093396257, 2379.143508336993, 2410.1323523531514, 2410.204632471289, 2416.1060407649193, 2436.1229957215387, 2404.63930410439, 2447.90208391665, 2488.751124887515, 2500.374906273432, 2516.043903316737, 2370.2178281167257, 2429.914952976646, 2448.0, 2461.323136137559, 2476.7894728948063, 2480.2435257246534, 2499.600063989753, 2510.9874450627813, 2516.9806228477496, 2526.1537384976145, 2440.890159942789, 2471.8393304435335, 2493.738157493455, 2498.462830491453, 2505.8747062646976, 8353.791155221108, 8388.706395276136, 8410.116937721512, 8432.325413966868, 8454.365922555771, 5002.499750024968, 5085.110105731482, 5086.542211200973, 5134.178531434953, 5139.383274007106, 3228.5480032795426, 3233.692799184074, 3241.951370729441, 3378.3581119587448, 3389.3051924355696, 1057.5241141486285, 1065.7229120428667, 1072.8551645527832, 1081.5241293830688, 1096.446294621211, 11265.0, 11490.482928268248, 11513.88486115145, 11535.077193824558, 11558.884411155865, 4452.398926144929, 4498.8425405110665, 4532.841350552715, 4550.453945526558, 4552.931706024412, 9494.525273736286, 9499.810003799885, 9544.52277386128, 9557.092076252746, 9570.61717531291, 5118.053160165381, 5120.564751996048, 5134.845954621367, 5137.33214682089, 5178.404483484447, 4769.642276829251, 4792.856214313576, 4816.373871396766, 4818.325434439182, 4825.686330388584, 3591.2637909228547, 3655.2141289622327, 3695.4456831474954, 3697.22358304759, 3699.6855267302044, 1060.8302671572512, 1088.4285749981323, 1124.2579897267765, 1126.357975953715, 1132.3602164776876, 961.0869673809908, 1034.9896501034893, 1108.0636861851722, 1188.9464974076188, 1401.6916278418732, 7736.110347310018, 7790.182030886788, 7895.092064412551, 7905.0, 7909.24862138096, 1210.8304837322783, 1214.6295379909036, 1218.4577862851124, 1221.248931906871, 1231.335079057317, 6048.425399587032, 6107.511399088151, 6121.908171377433, 6146.385361463817, 6152.046432802923, 9084.364094513321, 9368.90631093694, 9420.576074076545, 9446.338756286994, 9473.242140628734, 9748.658796942073, 10009.399436033862, 10055.195584353234, 10104.141148002354, 10160.54277557497, 7358.889616655754, 7365.558066516026, 7371.447141464411, 7373.115226172894, 7398.223186565441, 7782.221777822172, 7918.802029949297, 7996.20037996219, 8004.0, 8116.553589552631, 8981.7754556134, 9205.217556507772, 9206.0, 9227.584758685742, 9371.969083400683, 9307.441553506811, 9384.249260059043, 9391.953040234755, 9403.670871519464, 9566.66516671913, 7558.0, 7683.961580192064, 7702.268284512962, 7730.613469326624, 7775.561521118611, 7958.522488650699, 8263.545504997042, 8271.834563308821, 8295.129011453952, 8297.626606802829, 7143.607101609461, 7293.562386256842, 7299.0, 7310.780676579711, 7636.80907977305, 7040.788776336718, 7135.785926422215, 7160.498765086394, 7165.677544510405, 7304.19653838088, 7284.708611655475, 7321.816954576178, 7334.376577990717, 7356.117265928123, 7362.852742945218, 6433.228012638326, 6550.017497375432, 6551.868962620816, 6588.7035083422315, 6602.042703807825, 6672.933270667231, 6716.932830671631, 6762.323767623198, 6817.7272909083085, 6874.553154044971], "unit": "score", "name": "mootools.html", "value": 4782.045357622232}, {"lowerIsBetter": false, "replicates": [377.68840706417205, 386.19285692901866, 387.50205985308867, 387.9844806207752, 392.4113829256114, 6233.7818176363835, 6381.0747441621, 6419.903701444477, 6437.163168788051, 6467.611943283407, 6195.6902154892305, 6311.905321420182, 6324.177856878599, 6347.555671103025, 6375.394337537938, 4925.901481970376, 4947.82682606107, 4947.876303092434, 4955.653104282702, 4957.082939656157, 4954.0, 4973.353464049668, 4978.5270399312, 4982.651214414975, 4983.775730092137, 4720.433547974248, 4841.15279826029, 4847.781849816767, 4864.683795553296, 4871.318015477836, 4875.609951203895, 4878.951210487903, 4879.951200487985, 4880.463149053601, 4888.266759985995, 4304.268274393361, 4307.5261721210645, 4312.568743125662, 4313.0, 4317.7193482423545, 5956.851078723023, 6051.576389652726, 6064.090386442025, 6076.240469941257, 6089.634621922699, 5670.177824215507, 5703.4011428799795, 5726.226959360475, 5732.426757324276, 5732.570057245682, 6750.62871542065, 6764.323567643196, 6766.864662706718, 6774.356436138559, 6789.388954994025, 4765.332853400527, 4771.28430735389, 4773.355596994396, 4774.28385742138, 4781.641376896747, 6938.722451101949, 7011.088558487364, 7044.788656340318, 7082.822929426806, 7089.0784198053925, 4857.514248575185, 4867.245576935581, 4868.586170175504, 4871.29366241893, 4877.0, 4900.338454308694, 4979.278004689299, 4983.501649834988, 4987.276844857475, 4991.925121123186, 5557.194206839986, 5653.660780353192, 5661.830145095653, 5663.801766938137, 5687.175359572839, 6780.796576102724, 6803.591784492946, 6817.829554261183, 6818.249992500821, 6833.965830170917, 1712.3749831311482, 1741.7300318450662, 1744.6074633207427, 1747.632997070604, 1759.6304775996928, 1173.4484792147678, 1178.0104712041925, 1193.0515240383916, 1194.832723418722, 1211.1400905357118, 6475.061116138134, 6480.902786458207, 6495.4803615710625, 6508.674566271668, 6510.381513756186, 6905.413039891565, 6913.2049814272, 6916.585004899722, 6929.688164032631, 6940.618265995317, 6371.39471750183, 6472.935270647234, 6478.611283322922, 6489.545731798823, 6489.707963141575, 3749.3063783200196, 3750.3249415104997, 3767.6609105180664, 3776.9244615107546, 3785.337565925952, 7017.929820701727, 7063.89404158938, 7069.222385537587, 7076.363127318566, 7077.6461176941975, 6871.862562748817, 7022.262662420474, 7039.436845052383, 7054.6825392857445, 7067.964660176666, 7031.226565077837, 7067.293270672892, 7072.434205263567, 7077.646117694095, 7081.752138675225, 6879.965600171967, 6923.446124309942, 6929.896051559332, 6936.20233673134, 6947.3747362737595, 6627.801165965029, 6766.4248538874745, 6769.458443324424, 6789.830254243683, 6848.965755171392, 7028.8945665814035, 7040.823979400351, 7054.6472676367, 7066.611336376549, 7071.752488662872, 4865.854024379274, 4874.561289483963, 4885.8045678172475, 4891.339669144762, 4895.7062576245535, 6755.763548275787, 6857.245702972768, 6861.0, 6878.27778083294, 6878.793636190922, 6686.7993960181275, 6708.195016597844, 6709.127813384229, 6717.193936727624, 6723.361280678328, 6694.364035416627, 6710.396064354231, 6716.597004179765, 6741.089952856301, 6746.898796517958, 6387.0, 6563.310852360433, 6574.0796288520605, 6581.539292249497, 6596.208454985241, 6687.76592819249, 6720.46236301085, 6722.890723030645, 6751.729930802713, 6765.0, 6541.8691626166255, 6573.014047892854, 6580.901286480803, 6594.802155935329, 6609.966950165219], "unit": "score", "name": "prototype.html", "value": 5113.1435748767135}, {"lowerIsBetter": false, "replicates": [836.698788436163, 877.5656050255122, 914.5792935249784, 916.1891725822645, 932.6222879733706, 14780.408783648654, 14928.328225229863, 14980.925095374521, 14995.175265360402, 15016.624584385396, 13776.24230667313, 13887.513937012181, 13922.443102275896, 13945.0, 13977.860221397783, 883.8674198870189, 893.6693423433322, 912.1061359867334, 914.7530166854946, 917.0600134861753, 906.112010229975, 907.0929070929071, 910.399136569864, 910.4992254260163, 912.7535565397372, 932.9486878221695, 934.2619330728717, 940.1820416237848, 941.5621735892809, 944.263474489899, 914.5107367558358, 921.7050543826011, 924.3021518753366, 928.972130836076, 931.6832277025776, 682.969266383009, 684.4079870911676, 685.7017197519095, 692.8614277144591, 694.0526181761859, 15368.385264589402, 15399.769003464957, 15410.537683869501, 15441.382344706199, 15458.1498017609, 14056.789148162785, 14084.507042253574, 14090.154590724589, 14149.0, 14184.361703723358, 11690.415479226005, 11740.236884602473, 11757.176997610171, 11762.411879405996, 12307.4461649226, 3980.7014473914574, 3987.5613682494904, 4034.0519977805193, 4057.7768222747736, 4067.0, 53043.73478132623, 53538.0, 53795.73102134503, 53807.46192538064, 53836.46163538354, 10938.234323597271, 10970.670879873616, 11069.225154239126, 11205.719857003478, 11311.490982905789, 19139.13873875679, 19192.328268510537, 19249.32627358036, 19268.518287042934, 19332.130054147598, 8224.342052635775, 8516.70191543293, 8530.914690853137, 8674.04585495595, 8689.913100869036, 4484.080763443551, 4517.0, 4525.954740452553, 4582.564656357641, 4603.9079218415445, 3230.353929214167, 3251.5447837302795, 3267.281198136406, 3274.246923207628, 3281.622613399442, 592.8754961458056, 598.3238939997775, 605.2918085839578, 610.2493932463095, 611.6910959965189, 612.8835521250948, 622.3372108704216, 622.6202016769766, 630.8454428665007, 688.435482904024, 9329.533523323942, 9624.807503850025, 9667.46828924416, 9720.125188733047, 9780.853287200698, 602.012699173356, 605.3280858247342, 608.8021393047277, 620.9660914577179, 621.580433207583, 4332.155229730172, 4359.869203923888, 4393.824247030147, 4508.954910450919, 4795.712257264575, 57970.0, 58080.0, 58437.0, 58500.414995849496, 58660.41339586549, 52843.47156528386, 53514.464855351725, 53716.0, 54576.0, 55002.724986374815, 49183.016339673006, 49304.99999999928, 49627.50372496229, 50121.74939125354, 50255.24617130746, 9715.935346348168, 9884.85172722424, 9885.435994885962, 9993.850092248767, 10092.798144037224, 35706.821465892506, 35973.82013089918, 36393.63606363902, 36734.44898326474, 36825.26349472942, 41415.171696565296, 45678.771606143084, 47051.0, 47293.0, 48328.27507587459, 12016.579419720269, 12091.939540302243, 12113.69715757113, 12378.690532736753, 12402.689932751753, 13147.14543554666, 13348.799768003293, 13782.241976691379, 13784.241866697026, 14063.156210627396, 12685.175463594836, 13001.15492492985, 13065.0, 13358.465661373824, 13436.731265374834, 12993.610191694264, 13081.803772943224, 13166.40751166219, 13506.797398039234, 13626.0, 12392.75214495687, 12752.936235319135, 12827.807582886451, 12891.355432228538, 13116.868831311565, 10563.366198028143, 10721.303115297793, 10786.298890572089, 10836.945815270874, 11113.444327783416, 10705.785884282426, 10768.0, 10805.187599694984, 10893.509792059218, 10992.120630349713], "unit": "score", "name": "yui.html", "value": 6898.5061821833815}], "name": "dromaeo_css", "value": 7317.402739398895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 111.0, 111.0, 111.0, 122.0, 111.0, 111.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 153.0, 165.0, 128.0, 153.0, 155.0, 128.0, 161.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 163.0, 164.0, 164.0, 162.0, 163.0, 163.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 72.0, 153.0, 77.0, 75.0, 76.0, 76.0, 157.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 94.0, 95.0, 96.0, 134.0, 94.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 148.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 56.0, 55.0, 60.0, 55.0, 55.0, 62.0, 52.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [89.0, 80.0, 81.0, 90.0, 83.0, 81.0, 82.0, 83.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [111.0, 119.0, 110.0, 119.0, 122.0, 115.0, 111.0, 113.0, 125.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [125.0, 143.0, 137.0, 138.0, 138.0, 139.0, 138.0, 139.0, 139.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 66.0, 67.0, 72.0, 65.0, 66.0, 65.0, 64.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1496.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [170.35775127768312], "unit": "score", "name": "DeltaBlue", "value": 388.1126600000002}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [923.3610341643582], "unit": "score", "name": "RayTrace", "value": 801.4080869999998}, {"lowerIsBetter": false, "replicates": [605.6935190793458], "unit": "score", "name": "Earley", "value": 1100.3304130000001}, {"lowerIsBetter": false, "replicates": [10934.782608695652], "unit": "score", "name": "Boyer", "value": 60.94890258449304}, {"lowerIsBetter": false, "replicates": [39173.07692307692], "unit": "score", "name": "RegExp", "value": 23.255385370643086}, {"lowerIsBetter": false, "replicates": [499.50544015825915], "unit": "score", "name": "Splay", "value": 163.1433683168317}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21968.150883233357}]} 09:27:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21968.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1496.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7317.40"}}} 09:27:15 INFO - Return code: 0 09:27:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:27:16 INFO - # TBPL SUCCESS # 09:27:16 INFO - Running post-action listener: _resource_record_post_action 09:27:16 INFO - Running post-run listener: _resource_record_post_run 09:27:17 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 282624; Write bytes: 512704512; Read time: 84; Write time: 520444 09:27:17 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242192384; Read time: 0; Write time: 369384 09:27:17 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 282624; Write bytes: 270512128; Read time: 84; Write time: 151060 09:27:17 INFO - Running post-run listener: _upload_blobber_files 09:27:17 INFO - Blob upload gear active. 09:27:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:27:17 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:27:17 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:27:17 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:27:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:27:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:18 INFO - (blobuploader) - INFO - Done attempting. 09:27:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:27:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:27:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:19 INFO - (blobuploader) - INFO - Done attempting. 09:27:19 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:19 INFO - Return code: 0 09:27:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:27:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/152c19409faff18eab7c2247063550474d31df041f33f83b05e22bcd479520456dfc9ca3be7c51f70809a233e22d89ec7ff1a41f1a75279ed824f6e036e2feea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c27321cf8158668583e6238eef86efe1a422865b78c3e4b4eb4a2eeadbe57e59423481059c55196b32472632f6097062b571c409c2d67ac020bf2daecb5bea"} 09:27:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:27:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:27:19 INFO - Contents: 09:27:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/152c19409faff18eab7c2247063550474d31df041f33f83b05e22bcd479520456dfc9ca3be7c51f70809a233e22d89ec7ff1a41f1a75279ed824f6e036e2feea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c27321cf8158668583e6238eef86efe1a422865b78c3e4b4eb4a2eeadbe57e59423481059c55196b32472632f6097062b571c409c2d67ac020bf2daecb5bea"} 09:27:19 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:19 INFO - Copying logs to upload dir... 09:27:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:27:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.558912 ========= master_lag: -0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-02-23 09:27:19.178080) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 09:27:19.181727) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 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/152c19409faff18eab7c2247063550474d31df041f33f83b05e22bcd479520456dfc9ca3be7c51f70809a233e22d89ec7ff1a41f1a75279ed824f6e036e2feea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c27321cf8158668583e6238eef86efe1a422865b78c3e4b4eb4a2eeadbe57e59423481059c55196b32472632f6097062b571c409c2d67ac020bf2daecb5bea"} build_url:https://queue.taskcluster.net/v1/task/PvBY8Z-pQzSj_VPER6ZhwQ/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/PvBY8Z-pQzSj_VPER6ZhwQ/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/152c19409faff18eab7c2247063550474d31df041f33f83b05e22bcd479520456dfc9ca3be7c51f70809a233e22d89ec7ff1a41f1a75279ed824f6e036e2feea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c27321cf8158668583e6238eef86efe1a422865b78c3e4b4eb4a2eeadbe57e59423481059c55196b32472632f6097062b571c409c2d67ac020bf2daecb5bea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 09:27:19.206418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:27:19.206773) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456247103.754885-549323301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:27:19.290169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:27:19.290508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:27:19.290834) ========= ========= Total master_lag: 0.18 =========