builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1453742212.96 results: success (0) buildid: 20160125060633 builduid: 4fb7ba2d584b4449b4355f3ca346d3b9 revision: b9a803752a2cb143582e6665ed3fb679eebf60b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:52.965567) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:52.970512) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:52.970933) ========= 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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006249 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:52.997619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:52.997974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.011497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.011804) ========= 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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004697 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.061371) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.061736) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.062882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.063199) ========= 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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 09:16:53-- 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% 38.6M=0s 2016-01-25 09:16:53 (38.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.174239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.174968) ========= 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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.229911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.230647) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9a803752a2cb143582e6665ed3fb679eebf60b3 --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 b9a803752a2cb143582e6665ed3fb679eebf60b3 --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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 09:16:53,755 truncating revision to first 12 chars 2016-01-25 09:16:53,755 Setting DEBUG logging. 2016-01-25 09:16:53,755 attempt 1/10 2016-01-25 09:16:53,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b9a803752a2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 09:16:54,022 unpacking tar archive at: mozilla-aurora-b9a803752a2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.772190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.772788) ========= echo b9a803752a2cb143582e6665ed3fb679eebf60b3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b9a803752a2cb143582e6665ed3fb679eebf60b3'] 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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b9a803752a2cb143582e6665ed3fb679eebf60b3 program finished with exit code 0 elapsedTime=0.004688 script_repo_revision: 'b9a803752a2cb143582e6665ed3fb679eebf60b3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.827194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.827800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 09:16:53.839539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-25 09:16:53.840062) ========= /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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:16:54 INFO - MultiFileLogger online at 20160125 09:16:54 in /builds/slave/test-pgo 09:16:54 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:16:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:16:54 INFO - {'append_to_log': False, 09:16:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:16:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:16:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:16:54 INFO - 'branch': 'Mozilla-Aurora', 09:16:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:54 INFO - 'config_files': ('talos/linux_config.py',), 09:16:54 INFO - 'default_actions': ('clobber', 09:16:54 INFO - 'read-buildbot-config', 09:16:54 INFO - 'download-and-extract', 09:16:54 INFO - 'populate-webroot', 09:16:54 INFO - 'create-virtualenv', 09:16:54 INFO - 'install', 09:16:54 INFO - 'run-tests'), 09:16:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:54 INFO - 'download_minidump_stackwalk': True, 09:16:54 INFO - 'download_symbols': 'ondemand', 09:16:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:54 INFO - 'installer_path': 'installer.exe', 09:16:54 INFO - 'log_level': 'info', 09:16:54 INFO - 'log_name': 'talos', 09:16:54 INFO - 'log_to_console': True, 09:16:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:16:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:16:54 INFO - 'opt_config_files': (), 09:16:54 INFO - 'pip_index': False, 09:16:54 INFO - 'sps_profile': False, 09:16:54 INFO - 'sps_profile_interval': 0, 09:16:54 INFO - 'suite': 'dromaeojs-e10s', 09:16:54 INFO - 'system_bits': '32', 09:16:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:54 INFO - 'title': 'talos-linux64-ix-054', 09:16:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:54 INFO - 'use_talos_json': True, 09:16:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:16:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:54 INFO - 'work_dir': 'build'} 09:16:54 INFO - ##### 09:16:54 INFO - ##### Running clobber step. 09:16:54 INFO - ##### 09:16:54 INFO - Running pre-action listener: _resource_record_pre_action 09:16:54 INFO - Running main action method: clobber 09:16:54 INFO - rmtree: /builds/slave/test-pgo/build 09:16:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:16:55 INFO - Running post-action listener: _resource_record_post_action 09:16:55 INFO - ##### 09:16:55 INFO - ##### Running read-buildbot-config step. 09:16:55 INFO - ##### 09:16:55 INFO - Running pre-action listener: _resource_record_pre_action 09:16:55 INFO - Running main action method: read_buildbot_config 09:16:55 INFO - Using buildbot properties: 09:16:55 INFO - { 09:16:55 INFO - "project": "", 09:16:55 INFO - "product": "firefox", 09:16:55 INFO - "script_repo_revision": "production", 09:16:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:16:55 INFO - "repository": "", 09:16:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:16:55 INFO - "buildid": "20160125060633", 09:16:55 INFO - "stage_platform": "linux64-pgo", 09:16:55 INFO - "basedir": "/builds/slave/test-pgo", 09:16:55 INFO - "nightly_build": "True", 09:16:55 INFO - "buildnumber": 110, 09:16:55 INFO - "slavename": "talos-linux64-ix-054", 09:16:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:16:55 INFO - "platform": "ubuntu64_hw", 09:16:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:16:55 INFO - "branch": "mozilla-aurora", 09:16:55 INFO - "repo_path": "releases/mozilla-aurora", 09:16:55 INFO - "revision": "b9a803752a2cb143582e6665ed3fb679eebf60b3", 09:16:55 INFO - "pgo_build": "True", 09:16:55 INFO - "builduid": "4fb7ba2d584b4449b4355f3ca346d3b9", 09:16:55 INFO - "slavebuilddir": "test" 09:16:55 INFO - } 09:16:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 09:16:55 INFO - Running post-action listener: _resource_record_post_action 09:16:55 INFO - ##### 09:16:55 INFO - ##### Running download-and-extract step. 09:16:55 INFO - ##### 09:16:55 INFO - Running pre-action listener: _resource_record_pre_action 09:16:55 INFO - Running main action method: download_and_extract 09:16:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:55 INFO - https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/test_packages.json 09:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/test_packages.json 09:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:16:56 INFO - Downloaded 1448 bytes. 09:16:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:16:56 INFO - Using the following test package requirements: 09:16:56 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:56 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:16:56 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:16:56 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'jsshell-linux-x86_64.zip'], 09:16:56 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:16:56 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:56 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:16:56 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:16:56 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:16:56 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:56 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:56 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:16:56 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:16:56 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:16:56 INFO - https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:16:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:16:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:16:57 INFO - Downloaded 22398179 bytes. 09:16:57 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:16:57 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:16:58 INFO - Return code: 0 09:16:58 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:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:58 INFO - https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:16:59 INFO - Downloaded 22398179 bytes. 09:16:59 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:16:59 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:17:00 INFO - Return code: 0 09:17:00 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:17:00 INFO - https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:17:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:17:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:17:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:17:01 INFO - Downloaded 10706572 bytes. 09:17:01 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:17:01 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:17:01 INFO - Return code: 0 09:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:01 INFO - https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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:17:03 INFO - Downloaded 59564385 bytes. 09:17:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:03 INFO - mkdir: /builds/slave/test-pgo/properties 09:17:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:17:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:17:03 INFO - Contents: 09:17:03 INFO - build_url:https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:03 INFO - Running post-action listener: _resource_record_post_action 09:17:03 INFO - Running post-action listener: set_extra_try_arguments 09:17:03 INFO - ##### 09:17:03 INFO - ##### Running populate-webroot step. 09:17:03 INFO - ##### 09:17:03 INFO - Running pre-action listener: _resource_record_pre_action 09:17:03 INFO - Running main action method: populate_webroot 09:17:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:03 INFO - '--tppagecycles', 09:17:03 INFO - '7'], 09:17:03 INFO - 'tests': ['tsvgm']}}, 09:17:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:17:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:17:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:17:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'tests': ['damp', 'tps']}, 09:17:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['damp', 'tps']}, 09:17:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:17:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:03 INFO - 'other': {'tests': ['a11yr', 09:17:03 INFO - 'ts_paint', 09:17:03 INFO - 'tpaint', 09:17:03 INFO - 'sessionrestore', 09:17:03 INFO - 'sessionrestore_no_auto_restore']}, 09:17:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['a11yr', 09:17:03 INFO - 'ts_paint', 09:17:03 INFO - 'tpaint', 09:17:03 INFO - 'sessionrestore', 09:17:03 INFO - 'sessionrestore_no_auto_restore']}, 09:17:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['a11yr', 09:17:03 INFO - 'ts_paint', 09:17:03 INFO - 'tpaint', 09:17:03 INFO - 'sessionrestore', 09:17:03 INFO - 'sessionrestore_no_auto_restore']}, 09:17:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['a11yr', 09:17:03 INFO - 'ts_paint', 09:17:03 INFO - 'tpaint', 09:17:03 INFO - 'sessionrestore', 09:17:03 INFO - 'sessionrestore_no_auto_restore']}, 09:17:03 INFO - 'other_l64': {'tests': ['a11yr', 09:17:03 INFO - 'ts_paint', 09:17:03 INFO - 'tpaint', 09:17:03 INFO - 'sessionrestore', 09:17:03 INFO - 'sessionrestore_no_auto_restore']}, 09:17:03 INFO - 'other_nol64': {'tests': ['a11yr', 09:17:03 INFO - 'ts_paint', 09:17:03 INFO - 'tpaint', 09:17:03 INFO - 'sessionrestore', 09:17:03 INFO - 'sessionrestore_no_auto_restore']}, 09:17:03 INFO - 'svgr': {'tests': ['tsvgx', 09:17:03 INFO - 'tsvgr_opacity', 09:17:03 INFO - 'tart', 09:17:03 INFO - 'tscrollx', 09:17:03 INFO - 'cart']}, 09:17:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['tsvgx', 09:17:03 INFO - 'tsvgr_opacity', 09:17:03 INFO - 'tart', 09:17:03 INFO - 'tscrollx', 09:17:03 INFO - 'cart']}, 09:17:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'tests': ['tp5o']}, 09:17:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'talos_options': ['--e10s'], 09:17:03 INFO - 'tests': ['tp5o']}, 09:17:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'talos_options': ['--xperf_path', 09:17:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:03 INFO - 'tests': ['tp5n']}, 09:17:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:03 INFO - 'talos_options': ['--e10s', 09:17:03 INFO - '--xperf_path', 09:17:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:03 INFO - 'tests': ['tp5n']}}, 09:17:03 INFO - 'talos.zip': {'path': '', 09:17:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:03 INFO - Running post-action listener: _resource_record_post_action 09:17:03 INFO - ##### 09:17:03 INFO - ##### Running create-virtualenv step. 09:17:03 INFO - ##### 09:17:03 INFO - Running pre-action listener: _resource_record_pre_action 09:17:03 INFO - Running main action method: create_virtualenv 09:17:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:17:03 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:17:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:17:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:03 INFO - Using real prefix '/usr' 09:17:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:17:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:06 INFO - Installing pip.................done. 09:17:06 INFO - Return code: 0 09:17:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:17:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:17:06 INFO - Using env: {'DISPLAY': ':0', 09:17:06 INFO - 'HOME': '/home/cltbld', 09:17:06 INFO - 'LANG': 'en_US.UTF-8', 09:17:06 INFO - 'LANGUAGE': 'en_US:en', 09:17:06 INFO - 'LOGNAME': 'cltbld', 09:17:06 INFO - 'MAIL': '/var/mail/cltbld', 09:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:06 INFO - 'MOZ_NO_REMOTE': '1', 09:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:06 INFO - 'NO_EM_RESTART': '1', 09:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:06 INFO - 'SHELL': '/bin/bash', 09:17:06 INFO - 'SHLVL': '1', 09:17:06 INFO - 'TERM': 'linux', 09:17:06 INFO - 'TMOUT': '86400', 09:17:06 INFO - 'USER': 'cltbld', 09:17:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:06 INFO - '_': '/tools/buildbot/bin/python'} 09:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:06 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:17:06 INFO - Cleaning up... 09:17:06 INFO - Return code: 0 09:17:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:17:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:17:06 INFO - Using env: {'DISPLAY': ':0', 09:17:06 INFO - 'HOME': '/home/cltbld', 09:17:06 INFO - 'LANG': 'en_US.UTF-8', 09:17:06 INFO - 'LANGUAGE': 'en_US:en', 09:17:06 INFO - 'LOGNAME': 'cltbld', 09:17:06 INFO - 'MAIL': '/var/mail/cltbld', 09:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:06 INFO - 'MOZ_NO_REMOTE': '1', 09:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:06 INFO - 'NO_EM_RESTART': '1', 09:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:06 INFO - 'SHELL': '/bin/bash', 09:17:06 INFO - 'SHLVL': '1', 09:17:06 INFO - 'TERM': 'linux', 09:17:06 INFO - 'TMOUT': '86400', 09:17:06 INFO - 'USER': 'cltbld', 09:17:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:06 INFO - '_': '/tools/buildbot/bin/python'} 09:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:06 INFO - Downloading/unpacking psutil>=0.7.1 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:08 INFO - Installing collected packages: psutil 09:17:08 INFO - Running setup.py install for psutil 09:17:08 INFO - building 'psutil._psutil_linux' extension 09:17:08 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:17:08 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:17:08 INFO - building 'psutil._psutil_posix' extension 09:17:08 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:17:08 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:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:08 INFO - Successfully installed psutil 09:17:08 INFO - Cleaning up... 09:17:08 INFO - Return code: 0 09:17:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:17:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:17:08 INFO - Using env: {'DISPLAY': ':0', 09:17:08 INFO - 'HOME': '/home/cltbld', 09:17:08 INFO - 'LANG': 'en_US.UTF-8', 09:17:08 INFO - 'LANGUAGE': 'en_US:en', 09:17:08 INFO - 'LOGNAME': 'cltbld', 09:17:08 INFO - 'MAIL': '/var/mail/cltbld', 09:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:08 INFO - 'MOZ_NO_REMOTE': '1', 09:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:08 INFO - 'NO_EM_RESTART': '1', 09:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:08 INFO - 'SHELL': '/bin/bash', 09:17:08 INFO - 'SHLVL': '1', 09:17:08 INFO - 'TERM': 'linux', 09:17:08 INFO - 'TMOUT': '86400', 09:17:08 INFO - 'USER': 'cltbld', 09:17:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:08 INFO - '_': '/tools/buildbot/bin/python'} 09:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:17:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:10 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:17:10 INFO - Installing collected packages: mozsystemmonitor 09:17:10 INFO - Running setup.py install for mozsystemmonitor 09:17:11 INFO - Successfully installed mozsystemmonitor 09:17:11 INFO - Cleaning up... 09:17:11 INFO - Return code: 0 09:17:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:17:11 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:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:11 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:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:11 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 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:11 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:17:11 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:17:11 INFO - Using env: {'DISPLAY': ':0', 09:17:11 INFO - 'HOME': '/home/cltbld', 09:17:11 INFO - 'LANG': 'en_US.UTF-8', 09:17:11 INFO - 'LANGUAGE': 'en_US:en', 09:17:11 INFO - 'LOGNAME': 'cltbld', 09:17:11 INFO - 'MAIL': '/var/mail/cltbld', 09:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:11 INFO - 'MOZ_NO_REMOTE': '1', 09:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:11 INFO - 'NO_EM_RESTART': '1', 09:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:11 INFO - 'SHELL': '/bin/bash', 09:17:11 INFO - 'SHLVL': '1', 09:17:11 INFO - 'TERM': 'linux', 09:17:11 INFO - 'TMOUT': '86400', 09:17:11 INFO - 'USER': 'cltbld', 09:17:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:11 INFO - '_': '/tools/buildbot/bin/python'} 09:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17:13 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:17:13 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:17:13 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:17:13 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:17:13 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:17:13 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:17:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:17:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:13 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:17:13 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:17:13 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:17:13 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:17:13 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:17:13 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:17:13 INFO - Downloading docopt-0.6.1.tar.gz 09:17:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:13 INFO - Running setup.py install for blobuploader 09:17:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:17:13 INFO - Running setup.py install for requests 09:17:14 INFO - Running setup.py install for docopt 09:17:14 INFO - Successfully installed blobuploader requests docopt 09:17:14 INFO - Cleaning up... 09:17:14 INFO - Return code: 0 09:17:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17:14 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:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:14 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:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:14 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 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:14 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:17:14 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:17:14 INFO - Using env: {'DISPLAY': ':0', 09:17:14 INFO - 'HOME': '/home/cltbld', 09:17:14 INFO - 'LANG': 'en_US.UTF-8', 09:17:14 INFO - 'LANGUAGE': 'en_US:en', 09:17:14 INFO - 'LOGNAME': 'cltbld', 09:17:14 INFO - 'MAIL': '/var/mail/cltbld', 09:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:14 INFO - 'MOZ_NO_REMOTE': '1', 09:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:14 INFO - 'NO_EM_RESTART': '1', 09:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:14 INFO - 'SHELL': '/bin/bash', 09:17:14 INFO - 'SHLVL': '1', 09:17:14 INFO - 'TERM': 'linux', 09:17:14 INFO - 'TMOUT': '86400', 09:17:14 INFO - 'USER': 'cltbld', 09:17:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:14 INFO - '_': '/tools/buildbot/bin/python'} 09:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:14 INFO - Running setup.py (path:/tmp/pip-IVTINT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:14 INFO - Running setup.py (path:/tmp/pip-unS2fK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:14 INFO - Running setup.py (path:/tmp/pip-Q6Efah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:14 INFO - Running setup.py (path:/tmp/pip-hYe6y7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:14 INFO - Running setup.py (path:/tmp/pip-IcR8XK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:14 INFO - Running setup.py (path:/tmp/pip-ufV6A_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:15 INFO - Running setup.py (path:/tmp/pip-gNn_JT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:15 INFO - Running setup.py (path:/tmp/pip-CZss3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:15 INFO - Running setup.py (path:/tmp/pip-JrzoFG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:15 INFO - Running setup.py (path:/tmp/pip-xPJWBt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:15 INFO - Running setup.py (path:/tmp/pip-vq8haU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:15 INFO - Running setup.py (path:/tmp/pip-5ikhDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:15 INFO - Running setup.py (path:/tmp/pip-TGPIBe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:15 INFO - Running setup.py (path:/tmp/pip-wPxEMZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:15 INFO - Running setup.py (path:/tmp/pip-8vh7eY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:15 INFO - Running setup.py (path:/tmp/pip-_OrZc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:15 INFO - Running setup.py (path:/tmp/pip-B_neYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:15 INFO - Running setup.py install for manifestparser 09:17:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:17:15 INFO - Running setup.py install for mozcrash 09:17:16 INFO - Running setup.py install for mozdebug 09:17:16 INFO - Running setup.py install for mozdevice 09:17:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozfile 09:17:16 INFO - Running setup.py install for mozhttpd 09:17:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozinfo 09:17:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozInstall 09:17:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozleak 09:17:16 INFO - Running setup.py install for mozlog 09:17:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for moznetwork 09:17:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozprocess 09:17:17 INFO - Running setup.py install for mozprofile 09:17:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Running setup.py install for mozrunner 09:17:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Running setup.py install for mozscreenshot 09:17:17 INFO - Running setup.py install for moztest 09:17:17 INFO - Running setup.py install for mozversion 09:17:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:17 INFO - Cleaning up... 09:17:17 INFO - Return code: 0 09:17:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17: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:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:17 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 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:17 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:17:17 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:17:17 INFO - Using env: {'DISPLAY': ':0', 09:17:17 INFO - 'HOME': '/home/cltbld', 09:17:17 INFO - 'LANG': 'en_US.UTF-8', 09:17:17 INFO - 'LANGUAGE': 'en_US:en', 09:17:17 INFO - 'LOGNAME': 'cltbld', 09:17:17 INFO - 'MAIL': '/var/mail/cltbld', 09:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:17 INFO - 'MOZ_NO_REMOTE': '1', 09:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:17 INFO - 'NO_EM_RESTART': '1', 09:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:17 INFO - 'SHELL': '/bin/bash', 09:17:17 INFO - 'SHLVL': '1', 09:17:17 INFO - 'TERM': 'linux', 09:17:17 INFO - 'TMOUT': '86400', 09:17:17 INFO - 'USER': 'cltbld', 09:17:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:17 INFO - '_': '/tools/buildbot/bin/python'} 09:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:17 INFO - Running setup.py (path:/tmp/pip-d4kRKi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:17 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:17:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:17 INFO - Running setup.py (path:/tmp/pip-mn_2Iz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:18 INFO - Running setup.py (path:/tmp/pip-zdmiVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:18 INFO - Running setup.py (path:/tmp/pip-0HOVZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:18 INFO - Running setup.py (path:/tmp/pip-rYsk_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:18 INFO - Running setup.py (path:/tmp/pip-ar3gP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:18 INFO - Running setup.py (path:/tmp/pip-ZIMKRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:18 INFO - Running setup.py (path:/tmp/pip-971Vuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:18 INFO - Running setup.py (path:/tmp/pip-GSVjhw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:18 INFO - Running setup.py (path:/tmp/pip-w2u5Pi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:18 INFO - Running setup.py (path:/tmp/pip-CSz2VX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:18 INFO - Running setup.py (path:/tmp/pip-21Udnz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:18 INFO - Running setup.py (path:/tmp/pip-drvelL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:18 INFO - Running setup.py (path:/tmp/pip-GIlrph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:18 INFO - Running setup.py (path:/tmp/pip-u5S36K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:18 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:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:18 INFO - Running setup.py (path:/tmp/pip-1hEgUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:19 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:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:19 INFO - Running setup.py (path:/tmp/pip-iYzdeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:19 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:17:19 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:17:19 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:17:19 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:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:17:19 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:17:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:20 INFO - Downloading blessings-1.6.tar.gz 09:17:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:20 INFO - Installing collected packages: blessings 09:17:20 INFO - Running setup.py install for blessings 09:17:21 INFO - Successfully installed blessings 09:17:21 INFO - Cleaning up... 09:17:21 INFO - Return code: 0 09:17:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:17:21 INFO - Reading from file tmpfile_stdout 09:17:21 INFO - Current package versions: 09:17:21 INFO - argparse == 1.2.1 09:17:21 INFO - blessings == 1.6 09:17:21 INFO - blobuploader == 1.2.4 09:17:21 INFO - docopt == 0.6.1 09:17:21 INFO - manifestparser == 1.1 09:17:21 INFO - mozInstall == 1.12 09:17:21 INFO - mozcrash == 0.16 09:17:21 INFO - mozdebug == 0.1 09:17:21 INFO - mozdevice == 0.48 09:17:21 INFO - mozfile == 1.2 09:17:21 INFO - mozhttpd == 0.7 09:17:21 INFO - mozinfo == 0.9 09:17:21 INFO - mozleak == 0.1 09:17:21 INFO - mozlog == 3.1 09:17:21 INFO - moznetwork == 0.27 09:17:21 INFO - mozprocess == 0.22 09:17:21 INFO - mozprofile == 0.28 09:17:21 INFO - mozrunner == 6.11 09:17:21 INFO - mozscreenshot == 0.1 09:17:21 INFO - mozsystemmonitor == 0.0 09:17:21 INFO - moztest == 0.7 09:17:21 INFO - mozversion == 1.4 09:17:21 INFO - psutil == 3.1.1 09:17:21 INFO - requests == 1.2.3 09:17:21 INFO - wsgiref == 0.1.2 09:17:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17: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:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:21 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 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:21 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:17:21 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:17:21 INFO - Using env: {'DISPLAY': ':0', 09:17:21 INFO - 'HOME': '/home/cltbld', 09:17:21 INFO - 'LANG': 'en_US.UTF-8', 09:17:21 INFO - 'LANGUAGE': 'en_US:en', 09:17:21 INFO - 'LOGNAME': 'cltbld', 09:17:21 INFO - 'MAIL': '/var/mail/cltbld', 09:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:21 INFO - 'MOZ_NO_REMOTE': '1', 09:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:21 INFO - 'NO_EM_RESTART': '1', 09:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:21 INFO - 'SHELL': '/bin/bash', 09:17:21 INFO - 'SHLVL': '1', 09:17:21 INFO - 'TERM': 'linux', 09:17:21 INFO - 'TMOUT': '86400', 09:17:21 INFO - 'USER': 'cltbld', 09:17:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:21 INFO - '_': '/tools/buildbot/bin/python'} 09:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:21 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:17:21 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:17:21 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:17:21 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:17:21 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:17:21 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:17:21 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:17:21 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:17:21 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:17:21 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:17:21 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:17:21 INFO - Cleaning up... 09:17:21 INFO - Return code: 0 09:17:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:17: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:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:17:21 INFO - Using env: {'DISPLAY': ':0', 09:17:21 INFO - 'HOME': '/home/cltbld', 09:17:21 INFO - 'LANG': 'en_US.UTF-8', 09:17:21 INFO - 'LANGUAGE': 'en_US:en', 09:17:21 INFO - 'LOGNAME': 'cltbld', 09:17:21 INFO - 'MAIL': '/var/mail/cltbld', 09:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:21 INFO - 'MOZ_NO_REMOTE': '1', 09:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:21 INFO - 'NO_EM_RESTART': '1', 09:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:21 INFO - 'SHELL': '/bin/bash', 09:17:21 INFO - 'SHLVL': '1', 09:17:21 INFO - 'TERM': 'linux', 09:17:21 INFO - 'TMOUT': '86400', 09:17:21 INFO - 'USER': 'cltbld', 09:17:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:21 INFO - '_': '/tools/buildbot/bin/python'} 09:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:21 INFO - Downloading/unpacking jsonschema 09:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:23 INFO - Downloading/unpacking functools32 (from jsonschema) 09:17:23 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:17:23 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:17:23 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:17:23 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:17:23 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:17:23 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:17:23 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:23 INFO - warning: no files found matching '*.txt' 09:17:23 INFO - no previously-included directories found matching 'build' 09:17:23 INFO - no previously-included directories found matching 'dist' 09:17:23 INFO - no previously-included directories found matching '.git*' 09:17:23 INFO - Installing collected packages: jsonschema, functools32 09:17:23 INFO - Running setup.py install for functools32 09:17:23 INFO - warning: no files found matching '*.txt' 09:17:23 INFO - no previously-included directories found matching 'build' 09:17:23 INFO - no previously-included directories found matching 'dist' 09:17:23 INFO - no previously-included directories found matching '.git*' 09:17:23 INFO - Successfully installed jsonschema functools32 09:17:23 INFO - Cleaning up... 09:17:23 INFO - Return code: 0 09:17:23 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:17:23 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:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:23 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:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:23 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 0x7f048cd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, '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': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', '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:17:23 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:17:23 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:17:23 INFO - Using env: {'DISPLAY': ':0', 09:17:23 INFO - 'HOME': '/home/cltbld', 09:17:23 INFO - 'LANG': 'en_US.UTF-8', 09:17:23 INFO - 'LANGUAGE': 'en_US:en', 09:17:23 INFO - 'LOGNAME': 'cltbld', 09:17:23 INFO - 'MAIL': '/var/mail/cltbld', 09:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:23 INFO - 'MOZ_NO_REMOTE': '1', 09:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:23 INFO - 'NO_EM_RESTART': '1', 09:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:23 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:23 INFO - 'SHELL': '/bin/bash', 09:17:23 INFO - 'SHLVL': '1', 09:17:23 INFO - 'TERM': 'linux', 09:17:23 INFO - 'TMOUT': '86400', 09:17:23 INFO - 'USER': 'cltbld', 09:17:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:23 INFO - '_': '/tools/buildbot/bin/python'} 09:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:24 INFO - Downloading/unpacking flake8 09:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:17:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:17:26 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:17:26 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:17:26 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:17:26 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:17:26 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:17:26 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:17:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:17:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:17:26 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:17:26 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:17:26 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:17:26 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:17:26 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:17:26 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:17:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:17:26 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:17:26 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:17:26 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:17:26 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:17:26 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:17:26 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:17:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:26 INFO - no previously-included directories found matching 'docs/_build' 09:17:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:17:26 INFO - Running setup.py install for pep8 09:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:26 INFO - no previously-included directories found matching 'docs/_build' 09:17:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:17:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:17:26 INFO - Cleaning up... 09:17:26 INFO - Return code: 0 09:17:26 INFO - Running post-action listener: _resource_record_post_action 09:17:26 INFO - Running post-action listener: _start_resource_monitoring 09:17:26 INFO - Starting resource monitoring. 09:17:26 INFO - ##### 09:17:26 INFO - ##### Running install step. 09:17:26 INFO - ##### 09:17:26 INFO - Running pre-action listener: _resource_record_pre_action 09:17:26 INFO - Running main action method: install 09:17:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:17:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:17:27 INFO - Reading from file tmpfile_stdout 09:17:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:17:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:17:27 INFO - Reading from file tmpfile_stdout 09:17:27 INFO - Output received: 09:17:27 INFO - Usage: mozinstall [options] installer 09:17:27 INFO - Options: 09:17:27 INFO - -h, --help show this help message and exit 09:17:27 INFO - -d DEST, --destination=DEST 09:17:27 INFO - Directory to install application into. [default: 09:17:27 INFO - "/builds/slave/test-pgo"] 09:17:27 INFO - --app=APP Application being installed. [default: firefox] 09:17:27 INFO - mkdir: /builds/slave/test-pgo/build/application 09:17:27 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:17:27 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:17:42 INFO - Reading from file tmpfile_stdout 09:17:42 INFO - Output received: 09:17:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:17:42 INFO - Running post-action listener: _resource_record_post_action 09:17:42 INFO - ##### 09:17:42 INFO - ##### Running run-tests step. 09:17:42 INFO - ##### 09:17:42 INFO - Running pre-action listener: _resource_record_pre_action 09:17:42 INFO - Running main action method: run_tests 09:17:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:17:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:17:42 INFO - Python 2.7.3 09:17:42 INFO - Return code: 0 09:17:42 INFO - grabbing minidump binary from tooltool 09:17:42 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:17:42 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 0x10cb7f0>, '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 0x10372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:17:42 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:17:42 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:17:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:42 INFO - Return code: 0 09:17:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:17:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:17:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:17:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:17:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:17:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:17:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:17:43 INFO - Return code: 0 09:17:43 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/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:17:43 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/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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:17:43 INFO - Using env: {'DISPLAY': ':0', 09:17:43 INFO - 'HOME': '/home/cltbld', 09:17:43 INFO - 'LANG': 'en_US.UTF-8', 09:17:43 INFO - 'LANGUAGE': 'en_US:en', 09:17:43 INFO - 'LOGNAME': 'cltbld', 09:17:43 INFO - 'MAIL': '/var/mail/cltbld', 09:17:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:17:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:43 INFO - 'MOZ_NO_REMOTE': '1', 09:17:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:43 INFO - 'NO_EM_RESTART': '1', 09:17:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:17:43 INFO - 'SHELL': '/bin/bash', 09:17:43 INFO - 'SHLVL': '1', 09:17:43 INFO - 'TERM': 'linux', 09:17:43 INFO - 'TMOUT': '86400', 09:17:43 INFO - 'USER': 'cltbld', 09:17:43 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731', 09:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:43 INFO - '_': '/tools/buildbot/bin/python'} 09:17:43 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/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:17:43 INFO - mozversion application_buildid: 20160125060633 09:17:43 INFO - mozversion application_changeset: b9a803752a2cb143582e6665ed3fb679eebf60b3 09:17:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:17:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:43 INFO - mozversion application_name: Firefox 09:17:43 INFO - mozversion application_remotingname: firefox-dev 09:17:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:43 INFO - mozversion application_vendor: Mozilla 09:17:43 INFO - mozversion application_version: 46.0a2 09:17:43 INFO - mozversion platform_buildid: 20160125060633 09:17:43 INFO - mozversion platform_changeset: b9a803752a2cb143582e6665ed3fb679eebf60b3 09:17:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:43 INFO - mozversion platform_version: 46.0a2 09:17:43 INFO - using testdate: 1453742263 09:17:43 INFO - actual date: 1453742263 09:17:43 INFO - starting webserver on 'localhost:38160' 09:17:43 INFO - SUITE-START | Running 3 tests 09:17:43 INFO - TEST-START | dromaeo_css 09:17:43 INFO - operating with platform_type : linux_ 09:17:43 INFO - Initialising browser for dromaeo_css test... 09:17:43 INFO - TEST-INFO | started process 1808 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbAi_bJ/profile http://localhost:38160/getInfo.html) 09:17:47 INFO - PROCESS | 1808 | 09:17:47 INFO - PROCESS | 1808 | (process:1886): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:17:48 INFO - PROCESS | 1808 | __metrics Screen width/height:1600/1200 09:17:48 INFO - PROCESS | 1808 | colorDepth:24 09:17:48 INFO - PROCESS | 1808 | Browser inner width/height: 1024/697 09:17:48 INFO - PROCESS | 1808 | __metrics 09:17:49 INFO - TEST-INFO | 1808: exit 0 09:17:49 INFO - Browser initialized. 09:17:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:49 INFO - TEST-INFO | started process 1935 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbAi_bJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:50 INFO - PROCESS | 1935 | 09:17:50 INFO - PROCESS | 1935 | (process:2000): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:01 INFO - PROCESS | 1935 | RSS: Main: 140070912 09:18:01 INFO - PROCESS | 1935 | 09:18:50 INFO - PROCESS | 1935 | 1453742330643 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:20:58 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:38160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38160/tests/dromaeo/cssquery-ext.html) 09:21:00 INFO - PROCESS | 1935 | RSS: Main: 145096704 09:21:00 INFO - PROCESS | 1935 | 09:24:01 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:38160/tests/dromaeo/cssquery-ext.html (next: http://localhost:38160/tests/dromaeo/cssquery-jquery.html) 09:24:02 INFO - PROCESS | 1935 | RSS: Main: 143777792 09:24:02 INFO - PROCESS | 1935 | 09:27:04 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:38160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38160/tests/dromaeo/cssquery-mootools.html) 09:27:04 INFO - PROCESS | 1935 | RSS: Main: 142000128 09:27:04 INFO - PROCESS | 1935 | 09:30:06 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:38160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38160/tests/dromaeo/cssquery-prototype.html) 09:30:06 INFO - PROCESS | 1935 | RSS: Main: 142471168 09:30:06 INFO - PROCESS | 1935 | 09:33:09 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:38160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38160/tests/dromaeo/cssquery-yui.html) 09:33:09 INFO - PROCESS | 1935 | RSS: Main: 143474688 09:33:09 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:38160/tests/dromaeo/cssquery-yui.html (next: http://localhost:38160/tests/dromaeo/cssquery-dojo.html) 09:36:12 INFO - PROCESS | 1935 | RSS: Main: 145821696 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | __start_tp_report 09:36:12 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 09:36:12 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 09:36:12 INFO - PROCESS | 1935 | |i|pagename|runs| 09:36:12 INFO - PROCESS | 1935 | |0;dojo.html;3361.6974472297497;3416.8291585420725;3428;3463.6536346365365;3464.393731097059;5601.019821531236;5608.074667679833;5612.719364031803;5623.831285061445;5632.07070833312;5540.944590554093;5626.2967129108865;5627.521660658838;5633.070543360341;5664.943350566493;5044.369453818273;5054.014467178883;5150.896982060356;5154.07226699194;5167.974160129194;4975.7263350515705;5027.748612569375;5085.821996230133;5090.847274581768;5105.948940510603;5079.720615366154;5113.846584602468;5115.258287548303;5116.795328186887;5164.561012313958;5085.491450854904;5102.2346648003095;5104.438511763721;5115.948840511584;5146.742662866879;4904.6321525885705;4912.164931961575;5036.924446133311;5051;5103.872403189913;5022.623303252234;5295.443978382292;5357.892842143136;5388.541973932221;5416.972915135439;5948.7620495180145;5962;5988.401159884021;6007.639541627473;6016.969915150396;5790.7394167262155;5921.111833225008;5936.257967754031;6032.577719559633;6037.245344331958;5606.383297837235;5615.466530679538;5648.096304591287;5658.207850900877;5659.320881494205;6145.354737752472;6159.692015399212;6160.9383906161265;6168.784092556739;6180.690965451709;5740.454656807597;5816.447437493432;5871.588988770745;5926.436988486087;5985.581009329392;5991.430814072656;6000.129981152796;6001.279846418458;6002.39976002405;6010.729517171738;5909.084091965752;5922.3485416604135;5929.584929054925;5974.581779275496;5976.372480889531;5787.363390027093;5890.9410905891245;5921.703914804242;5949.672767997715;6084.30030546484;4519.7740112994215;4532.0256144929;4534.909301813946;4545.045540436479;4566.178087944136;3971.324874771296;4061.0862555925273;4095.672346212296;4129.97935010329;4136.73111247774;5547.750351234205;5634.549236061105;5641;5643.322801263875;5656.745446454919;5943.762249509971;6034.125051867454;6038.396160383926;6040.124181993674;6060.454559089703;5666;5700.144978253295;5729.1119876419225;5757.366689664133;5769.221155144086;4991.800327986913;5121.667091639031;5166.896662066738;5172.7155006475;5214.2960700304975;6117.851559182993;6146.846328841725;6155.199824022849;6166.445019948226;6184.412480814315;5965.731542080704;6009.849753756191;6010.9699451502465;6022.976094063932;6060.848478787977;5989.730462129128;6067.453929146398;6120.44915957566;6133.26400831903;6138.294096178996;5916.053431450947;5920.023196172583;5932.080527518242;5935.554833387427;5963.373845746134;6009.158717779427;6016.338202797601;6025.728842202024;6041.335453100068;6051.878962420815;5713.885722285448;5780.971095144498;5823.5923485355615;5868.061110222344;5929.436703513159;5819.82540523785;5855.882882342244;5911.083782013795;5915.792947246826;5924.703764811656;5814.476697097112;5820.0396934507025;5822.563307752021;5824.446677565625;5825.184474173704;5667.603267771216;5771.365149833431;5836.708164591669;5937.228160339128;5955.434233747787;5741.995150848501;5745.195672605755;5747.48272655463;5764.0201165802755;5790.420957904176 09:36:12 INFO - PROCESS | 1935 | |1;ext.html;553.7120697237436;559.6809818403509;577.347597215147;587.7472686744698;592.2034863109117;38038.429423558635;39305.410418843705;39341.8032909835;39382;39521.60478395215;41580.58419415805;41992.37011444823;42051.15897682044;42117.78941105298;42236.36645450321;8858.955705221464;8862.29101671868;9052.094790520961;9061.818763624724;9075.36472446929;8580.871286930702;8789.208971192591;8793.692220772275;8980.955095224515;9008.459492430442;9017.909820901805;9075.863862042075;9089;9089.909100908972;9095.63617455301;8832.514211718353;8929.241014513807;8980.101989801033;9003.95498022509;9006.324525660537;8771.736847894574;8822.514761688104;8841.778955526099;8878.73363799087;8879.778005549848;40978.79510602428;41254.58745412568;41595.584044159776;41715.58284417148;41778.373324400156;3511.5610548681416;3520.5247291615815;3904.2581909437117;3913.9804300978312;3916.5495967963766;30327.24181895448;31679.52480712768;31843.52234716458;31950.360992780013;32056.6794332056;3914.309958961282;3976.224636195943;3991.2217117662067;3998.900027499336;4051.291024070805;298768;298901;299296;300601.4969925158;301048;54119;55582.72208638931;59899.40100599025;60683.08975365373;61969.69015154895;55824.16263756047;55870.161947570006;55995;56036.719816400655;56356.15465768017;17551.385701500385;17743.201555929754;17761.7335739964;17796.644067118585;17800.732989005177;13521.797173042216;13821.101628394123;13830.93084534591;13834.65413364674;13894.930525347309;20001.699974500396;20190.798092019184;20390;20435.693464598044;20482.283120090724;7976.322012628992;8107.756767296991;8135.511869287861;8178.877316840133;8204.548749818698;1056.5826498533036;1070.272214893864;1148.8391625172483;1220.737541428597;1244.8941839943707;30613.540796888065;30730.231744206125;30860.691393086232;32813.17967050843;33343.3331333372;1132.6658635702322;1204.9156559040782;1210.1589395370308;1228.177121328712;1253.0414233111676;14836.110986328926;14916.179610121331;15070.924645376703;15495.767563486557;15570.9221453892;354685;374583;375090;376450;376673;48037.519624804;48750.512494874594;48826;49079;49153.75423122933;1485.7548504496854;1500.9774853377207;1504.5711972088122;1510.652549913526;1510.8187017557964;27160.456790864468;28447.28881777972;29216.7078329214;29398.265043374086;30390.696093038787;50543.483695489194;52384.476155239485;52456;52485.21272180844;52530;236241;237750;237925;238383;239208;33068.83465582753;33079.50380744242;33113.33773324568;33177.17057073592;33575.664243357256;44966;45020.77489612531;45384.54615453803;45699.31451028171;45915;34055.82972085124;34339.65660343364;34783;35318.64681353256;35646.82176589101;36510;38529.422058669705;38953.41569876511;39008.21983560256;39355.409668855566;38774.80612596919;38992.82795554423;39106.41340379953;39202;39308.213835722556;33159.83420082884;33190.17024574308;33528.832355838065;33678.32643347168;33722.83138584292;26939.865300673373;27030;27043.86478067597;27341.453170936868;27547.173584792487 09:36:12 INFO - PROCESS | 1935 | |2;jquery.html;390.80998359993816;394.134873951676;395.0873482255989;397.05302852696326;398.65118021730984;14597.41610335588;16808.91595542022;17069.82930170698;17329.393471228508;17351.045692486907;16879.746803797952;17191.82808171921;17305.480835574952;18134.909325453355;18183.363582274622;5633;5828.18405423239;5831.708414579254;5834.329052159013;5850.385709500505;5519.420460851613;5617.859553511174;5679.176519404684;5728.083506638938;5739.827805165852;4215.199112168678;5703.258576385064;5755.280589926259;5764.538836893039;5839.532837373;6076.240469941257;6265.248170219557;6269.843253918643;6272.686365681698;6286.9056964145575;5405.918911216296;5417.214503896913;5425.9728701356635;5456.781728730846;5460.372057213432;18387.63224735511;18920.71618925717;19032.809671903244;19296.1316740747;20005.8999705002;2173.3045425463856;2212.3362991102604;2280.0993607524933;2323.639835825433;2820.9421466949893;9934.751631209205;13226.735465290736;13339.799903001463;13578.796318055238;13601.387937542835;1899.240303878446;1902.8953407562578;1918.932837350686;1926.1909997800958;1939.1080103152567;52229.21656175161;52964.47035529634;57393.42606573922;59387.70306148485;61366.69316653433;10361.274710770174;10405.739856503496;10422.583096676048;10454.372737635766;10617.681469555926;13719.314034298246;13875.653108672162;13900.652483687989;13955.930220348833;14016.789748153786;8195.549244791475;8275.875861862078;8361.874571881426;8393.286570641563;8407.11725268838;8194.385421093442;8210.630521626541;8215.424920255524;8238.299744521662;8300.584970751439;4527.954720452819;4536.591706746409;4542.295944128666;4574.5425457453985;4645.558671926162;1904.5333893196255;1915.79884112169;1948.7174359717762;1961.3723608445162;1962.7154062660834;443.1469421363926;445.16531503431065;457.08810922210404;470.407286818611;474.88602735343267;10807.135429165648;11390.487428065757;11514.88485115138;16709.749353759704;17302.567435814206;1064.2231171245035;1064.2550214849637;1088.172988528708;1149.741308205647;1160.4661855546374;9541;9947.751306217258;10024.498775061218;10045.397276163307;10191.184705223564;573798;578031.4393712102;625289;679667;679775;77352;77655.61172194102;79181.60409197917;79303.60348198337;80945.19054809495;507.3252574076469;524.2398522142907;526.6287267476497;528.0363336910154;529.5102030621659;9993.950030249802;10358.119559837498;10414.531346089292;10468.738281543023;10756.462176890967;34587.4811877817;35387.11532211612;35681.64318356783;36112.27775444529;36310;43275.78362108169;43296.350554742334;43628.34557481704;45589.316160258284;46180.30729539127;7396.186419493959;7713.344365728976;7740.22597740244;7754;7755.302022817974;9991.800163996824;11410.543578256777;11718.941405292919;11778.882211177779;11882.881171188177;7814.5199530808895;9537.952310238405;9673.9032609673;10623.946880265548;10790.406527640742;10107.64623238183;10288.588456461957;10313.9484302578;10687.145028397865;10788.622398216025;10695.89304106949;10706.089982351587;10863.239573229797;10898.836517452086;11111.611093612008;7888.723894663659;7967.681292748225;8019.278264956182;8044.798880028046;8052.516848989079;10590.364578125336;10765.138788897026;10877.510512027136;10895.945520272347;11041.171912106463 09:36:12 INFO - PROCESS | 1935 | |3;mootools.html;1551.115863957544;1585.2866210205411;1785.6250187460632;1856.610111876506;1884.4158310923615;8411.369147313946;8427;8547.230749232567;8587.398882078242;8627.956860215698;8363.4563753356;8450.154984501547;8497.702580409687;8523.829523409528;8534.1039190885;2440.1581454398247;2447.3514518652482;2460.434100156965;2464.4208610976407;2471.085698291635;2472.8887200076038;2519.496100779842;2521.8612976286295;2548.719640839506;2550.2476769353084;2401.231605886117;2439.512097580482;2489.5020995800824;2493.9127130550432;2522.6216067589826;2481.6401621764835;2499.962500562475;2506.749325067497;2513.384220865881;2516.899324027046;2535.6450096986437;2558;2558.9744102559107;2563.1541591274836;2583.883725232369;8448.662053517852;8452.704155354595;8472.78818029548;8531.402801803877;8551;5190.896182076337;5269.604779641542;5346.91979620306;5374.032674118657;5398.73006349681;3300.405926933151;3370.5281260623533;3387.6104248011547;3405.0636075079306;3426.3832510148163;982.8181786369545;994.9154321882577;1048.7325731938383;1074.7044562745307;1080.6055789636805;11977.101717371232;12046.759064818742;12111.515539378413;12111.636650900487;12168.026557875348;4419.845305414359;4541.704789188692;4557.225271703752;4564.3153526970555;4624.861254162381;9751;9787.706368808947;9790.06994335537;9797;9810.117089461983;5137.8201762938115;5159.329287192641;5161.612879034087;5177.637565370464;5197.58419326453;4677.087967846305;4742.33607294979;4747.7626118693925;4753.619710423227;4779.211430114062;3824.521934758155;3826.1582451860545;3836.5037635322246;3859.0931131184147;3872.496575445174;1177.3524561491317;1196.5811965811897;1201.7596480703894;1208.583038851595;1209.0388141427586;1074.1621535202555;1098.23123813331;1166.416791604198;1391.269583468687;1462.926853657313;7451.888221676679;7507.662155203029;7516;7688.884666729891;7711.03612048494;616.1527899138684;625.7497001199556;626.3517259636254;627.9058141278754;772.8909015562685;6004.0693692477735;6008.24896887889;6084.148219249309;6117.816465506042;6149.41580549847;10415.479226038819;10567.471626418803;10587.258891877495;10623.362598243975;10754.731131721614;10181.083702466665;10604.310719803188;10619.09737672291;10658.946705266579;10746.623868164577;8179.877301840596;8213.507189568645;8276.710315138942;8283.337333013465;8291.212334828182;7605.771826845204;7630.084389873251;7694.153643099143;7710.884336734841;7735.303822655988;9242.260619150318;9308.906910930804;9550.283728720513;9636.22910167199;9677.419354838732;9537.284703647392;9598.376105553396;9705.854412183964;9814.65648702292;9855.655052073143;7299.233580473974;7303.087114110736;7358.117025956705;7366.226546212785;7368.557886526825;8261.297789687704;8297.419180657296;8325.83348333042;8420.95789521073;8447.324214062983;6683.097781799394;8001.599920004093;8010.679572817022;8056.637451314822;8103.392245581487;7106.7157313706875;7459.813504662427;7575.659095340833;7585.355244804254;7611.238876112345;7452.962735186289;7476.925230747623;7488.588127653032;7521.172671006294;7575.734849280248;6821.317868213139;6892.586444813327;6894.758683446055;6903.1371078615175;6950.721971121098;6916.827079323057;6963.268856770169;6976.616286104313;6978.755743548952;6982.231954485104 09:36:12 INFO - PROCESS | 1935 | |4;prototype.html;349.58050339592495;354.43467669067843;357.57091490211747;359.16494151098703;369.1067616368389;6242.469390101835;6325.493960483162;6338.968305158479;6347.016212487066;6352.491800655948;6140.048292514656;6226.968865155668;6302.369763023696;6313.652749098797;6314.589551679138;4861.927071093936;4864.635152363569;4864.683795553296;4875.073735990169;4878.926816097762;4861.076395484864;4907.75461226939;4909.582685471739;4910.165271903785;4913.091078150535;4771.618270538349;4869.220924652056;4869.318295438624;4876.731779752112;4878.097551952882;4837.250226214942;4839.128956787795;4847;4850.951490485085;4860.270959356089;4263;4263.765492897889;4266.168097221043;4277.486701595828;4280.1653677532895;5924.7333869975955;5976.282846058457;6041.395860413967;6045.969770151121;6055.424734650202;5716.371199168088;5724.141378793172;5738.081906894919;5751.856203594902;5754.338251101093;6727.024581435713;6728.596284222962;6746.730130794763;6759.087523184406;6772.864542709168;4750.904981900343;4761.166795810719;4778.976105119487;4796.952030479721;4797.328374027639;6912.930870691329;7066.258042905472;7068.5758854468895;7076.646167691595;7088.539244949114;4924.704517728947;4926.039422312686;4926.236433352836;4927.531884470969;4929.75351232437;4990.90018199634;4993.201087825931;4993.375828021497;4998.775055122528;4999.200127979506;5411.918821217685;5695.743691533891;5706.087026075891;5709.8287051388525;5725.799597014167;6715.1941766988275;6735.730570777114;6742.595444273359;6777.762778302736;6842.589444633338;1675.2963755222836;1699.609089909303;1722.810490846006;1724.8361405666442;1730.6711724772254;1135.28477059452;1147.3345459633392;1159.7854396936593;1165.8018136916744;1171.420147027227;6452.612843229327;6464.806055818239;6481.157449531625;6516.934830651728;6557.901631475532;6874.106366172466;6900.861982760417;6900.861982760417;6917.827054323581;6924.792256232321;6460.806175814733;6472.190976127984;6518.152640156749;6518.413342799171;6527.314631963575;3803.2013277212095;3823.8661646842784;3827.4067519534515;3835.6547910687614;3835.9041023974064;7258.891116633149;7314.049173607504;7316.561006339637;7332.230115837867;7336.633168341668;7044.718211271595;7291.161516425573;7302.087239095114;7303.525270857377;7336.7798966031105;7187.748428804966;7241.818954526074;7265.12818461788;7270;7307.488475806643;6988.126484189476;6989.615571143636;7067.929320706727;7073.787786366417;7075.327843854826;6807.659617019228;6956.165260168812;7008.194057683431;7037.894431583428;7046.964765176142;7300.269973002657;7319.780406587811;7329.413646908128;7333.523320984119;7334.706611735471;4739.857804265877;4741.596964258077;4746.288056791509;4762.9523704762505;4764.2615394613895;6917.13535808024;6919.719851827428;7059.117610298713;7075.257098004636;7124.85750284981;6897.620630865351;6899.551529150589;6933.341332573397;6934.965325173342;6939.340762627542;6847.931520684929;6866.931330686629;6897.137857767779;6898.689558969959;6905.240423553506;6633.436157926631;6698.5980841149685;6723.361280678328;6771.119754431892;6806.387425131762;6913.343232392915;6928.757493487704;6935.029095926473;6936.930630693831;6942.340477654615;6744.156980377453;6746.69639866217;6758.8648227036165;6765.052892595139;6767.729290828312 09:36:12 INFO - PROCESS | 1935 | |5;yui.html;840.2227939156279;849.8810166576684;865.5499140446966;880.9163129502697;922.4972390047424;14035.649108772273;14048;14051.156930584171;14063.718725625495;14078.22569758663;13706.177629342246;13775.380107895144;13796.586102416919;13840.584782456543;14645.414183432677;862.9697960571397;881.2333270055061;881.7266647339345;882.3029806452927;883.0463099852144;879.2965627498008;885.5395194498857;886.6542048601051;887.4187407248263;892.8839250897374;924.3945215883573;933.5752232734123;934.2619330728717;934.4580143516744;936.1247233836385;930.0327659234388;933.1135421349711;933.1788026536605;934.686879895236;934.9205317548017;681.9522633415663;687.7145984416461;688.187938232885;689.5380095336137;691.9619420931847;13666.590002299947;13770.518031868936;13777.517786877512;13847.376868040963;13861;11991.10066744989;12048.759024819454;12162;12164.14850960433;12189;11132.666020019413;11225.66323010311;11684.532618695242;11714.589989350417;11778.646640600795;3793.2223894101644;3800.90497737556;3849.788261645608;3857.3442514772273;3882.611738826123;48470;51058.489415105745;52077.218841717025;52149.47850521484;52381.47618523766;10410.843837342445;10700.946495267473;10703.571857125784;10783.514741836636;10821.613398756177;18527.07364631763;18620.72068918967;18658.813411865707;18666.440006799818;18756.343527976456;7785.1436342002335;7878.448508604342;7913.841723165619;7947.562884041317;8179.877301840477;4561.2473941799235;4566;4632.467266264355;4649.5815376616265;4710.36410084641;3388.3562123196516;3432.742544309137;3436.415809312423;3442.1910850950007;3442.345954268681;626.2422468812697;638.8530637953204;640.6028262477294;647.1942431672504;653.0954627840475;557.1225320120826;601.3835818286204;624.7376102037156;648.3419329380682;695.6904177640902;9058.637654493747;9194.49430281341;9423.575939082757;9494.572744226527;9949.104580587782;563.2424389196524;644.5262731892055;686.3925425998028;751.3163021650272;766.4366690482491;4007.779572123561;4085.4688890444054;4151.46985550573;4280.079782846703;4379.1241751649795;59872;60542.39457605367;60576;60904.695476522335;64585;53638.54797060875;54141.72929135408;54142.729286353315;54586.727066364416;54708.72645636746;46773.29840052402;48765.512344876806;51389.7430512845;51420.22869656958;51705.7414712924;8286.212809783061;8607.440516366416;8624.266937310398;8636.438631488933;8639.568021598769;35012;36860;37061.629383706895;37930.62069379381;38519;42750;42836.35745463758;45979.3103103447;46754;46784.7660761694;11897.940510297392;12072.3360215189;12185.268883866996;12242.326672032767;12336.074794390277;13185.60443186706;13613.52352667652;13896.51362202318;14051.437942482595;14348.06737562055;11844.232035599434;12338.94526253955;12795.93602032021;12867;13087.672808179872;11492.253003554742;12120.575779848015;12276.324802135969;12304.75390492203;12504.249745015328;12348;12531.87468125307;12786.104972651825;12909.096363254857;13111;10037.252272388674;10727.892721072689;10793.701115035294;10870.130389568974;10951.288166269167;10552.788944221225;10819.783604328028;11104.833427498756;11116.777664446827;11271.380074095676 09:36:12 INFO - PROCESS | 1935 | __end_tp_report 09:36:12 INFO - PROCESS | 1935 | __start_cc_report 09:36:12 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,294 09:36:12 INFO - PROCESS | 1935 | __end_cc_report 09:36:12 INFO - PROCESS | 1935 | __startTimestamp1453743372257__endTimestamp 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | ------- Summary: start ------- 09:36:12 INFO - PROCESS | 1935 | Number of tests: 6 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | [#0] dojo.html Cycles:165 Average:5554.34 Median:5771.37 stddev:614.20 (10.6%) stddev-sans-first:591.50 09:36:12 INFO - PROCESS | 1935 | Values: 3361.7 3416.8 3428.0 3463.7 3464.4 5601.0 5608.1 5612.7 5623.8 5632.1 5540.9 5626.3 5627.5 5633.1 5664.9 5044.4 5054.0 5150.9 5154.1 5168.0 4975.7 5027.7 5085.8 5090.8 5105.9 5079.7 5113.8 5115.3 5116.8 5164.6 5085.5 5102.2 5104.4 5115.9 5146.7 4904.6 4912.2 5036.9 5051.0 5103.9 5022.6 5295.4 5357.9 5388.5 5417.0 5948.8 5962.0 5988.4 6007.6 6017.0 5790.7 5921.1 5936.3 6032.6 6037.2 5606.4 5615.5 5648.1 5658.2 5659.3 6145.4 6159.7 6160.9 6168.8 6180.7 5740.5 5816.4 5871.6 5926.4 5985.6 5991.4 6000.1 6001.3 6002.4 6010.7 5909.1 5922.3 5929.6 5974.6 5976.4 5787.4 5890.9 5921.7 5949.7 6084.3 4519.8 4532.0 4534.9 4545.0 4566.2 3971.3 4061.1 4095.7 4130.0 4136.7 5547.8 5634.5 5641.0 5643.3 5656.7 5943.8 6034.1 6038.4 6040.1 6060.5 5666.0 5700.1 5729.1 5757.4 5769.2 4991.8 5121.7 5166.9 5172.7 5214.3 6117.9 6146.8 6155.2 6166.4 6184.4 5965.7 6009.8 6011.0 6023.0 6060.8 5989.7 6067.5 6120.4 6133.3 6138.3 5916.1 5920.0 5932.1 5935.6 5963.4 6009.2 6016.3 6025.7 6041.3 6051.9 5713.9 5781.0 5823.6 5868.1 5929.4 5819.8 5855.9 5911.1 5915.8 5924.7 5814.5 5820.0 5822.6 5824.4 5825.2 5667.6 5771.4 5836.7 5937.2 5955.4 5742.0 5745.2 5747.5 5764.0 5790.4 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | [#1] ext.html Cycles:180 Average:47854.20 Median:38864.11 stddev:80582.95 (207.3%) stddev-sans-first:80730.75 09:36:12 INFO - PROCESS | 1935 | Values: 553.7 559.7 577.3 587.7 592.2 38038.4 39305.4 39341.8 39382.0 39521.6 41580.6 41992.4 42051.2 42117.8 42236.4 8859.0 8862.3 9052.1 9061.8 9075.4 8580.9 8789.2 8793.7 8981.0 9008.5 9017.9 9075.9 9089.0 9089.9 9095.6 8832.5 8929.2 8980.1 9004.0 9006.3 8771.7 8822.5 8841.8 8878.7 8879.8 40978.8 41254.6 41595.6 41715.6 41778.4 3511.6 3520.5 3904.3 3914.0 3916.5 30327.2 31679.5 31843.5 31950.4 32056.7 3914.3 3976.2 3991.2 3998.9 4051.3 298768.0 298901.0 299296.0 300601.5 301048.0 54119.0 55582.7 59899.4 60683.1 61969.7 55824.2 55870.2 55995.0 56036.7 56356.2 17551.4 17743.2 17761.7 17796.6 17800.7 13521.8 13821.1 13830.9 13834.7 13894.9 20001.7 20190.8 20390.0 20435.7 20482.3 7976.3 8107.8 8135.5 8178.9 8204.5 1056.6 1070.3 1148.8 1220.7 1244.9 30613.5 30730.2 30860.7 32813.2 33343.3 1132.7 1204.9 1210.2 1228.2 1253.0 14836.1 14916.2 15070.9 15495.8 15570.9 354685.0 374583.0 375090.0 376450.0 376673.0 48037.5 48750.5 48826.0 49079.0 49153.8 1485.8 1501.0 1504.6 1510.7 1510.8 27160.5 28447.3 29216.7 29398.3 30390.7 50543.5 52384.5 52456.0 52485.2 52530.0 236241.0 237750.0 237925.0 238383.0 239208.0 33068.8 33079.5 33113.3 33177.2 33575.7 44966.0 45020.8 45384.5 45699.3 45915.0 34055.8 34339.7 34783.0 35318.6 35646.8 36510.0 38529.4 38953.4 39008.2 39355.4 38774.8 38992.8 39106.4 39202.0 39308.2 33159.8 33190.2 33528.8 33678.3 33722.8 26939.9 27030.0 27043.9 27341.5 27547.2 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | [#2] jquery.html Cycles:180 Average:30399.69 Median:397.85 stddev:102747.86 (25825.6%) stddev-sans-first:103011.38 09:36:12 INFO - PROCESS | 1935 | Values: 390.8 394.1 395.1 397.1 398.7 14597.4 16808.9 17069.8 17329.4 17351.0 16879.7 17191.8 17305.5 18134.9 18183.4 5633.0 5828.2 5831.7 5834.3 5850.4 5519.4 5617.9 5679.2 5728.1 5739.8 4215.2 5703.3 5755.3 5764.5 5839.5 6076.2 6265.2 6269.8 6272.7 6286.9 5405.9 5417.2 5426.0 5456.8 5460.4 18387.6 18920.7 19032.8 19296.1 20005.9 2173.3 2212.3 2280.1 2323.6 2820.9 9934.8 13226.7 13339.8 13578.8 13601.4 1899.2 1902.9 1918.9 1926.2 1939.1 52229.2 52964.5 57393.4 59387.7 61366.7 10361.3 10405.7 10422.6 10454.4 10617.7 13719.3 13875.7 13900.7 13955.9 14016.8 8195.5 8275.9 8361.9 8393.3 8407.1 8194.4 8210.6 8215.4 8238.3 8300.6 4528.0 4536.6 4542.3 4574.5 4645.6 1904.5 1915.8 1948.7 1961.4 1962.7 443.1 445.2 457.1 470.4 474.9 10807.1 11390.5 11514.9 16709.7 17302.6 1064.2 1064.3 1088.2 1149.7 1160.5 9541.0 9947.8 10024.5 10045.4 10191.2 573798.0 578031.4 625289.0 679667.0 679775.0 77352.0 77655.6 79181.6 79303.6 80945.2 507.3 524.2 526.6 528.0 529.5 9994.0 10358.1 10414.5 10468.7 10756.5 34587.5 35387.1 35681.6 36112.3 36310.0 43275.8 43296.4 43628.3 45589.3 46180.3 7396.2 7713.3 7740.2 7754.0 7755.3 9991.8 11410.5 11718.9 11778.9 11882.9 7814.5 9538.0 9673.9 10623.9 10790.4 10107.6 10288.6 10313.9 10687.1 10788.6 10695.9 10706.1 10863.2 10898.8 11111.6 7888.7 7967.7 8019.3 8044.8 8052.5 10590.4 10765.1 10877.5 10895.9 11041.2 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | [#3] mootools.html Cycles:180 Average:5969.74 Median:6100.98 stddev:3170.74 (52.0%) stddev-sans-first:3162.24 09:36:12 INFO - PROCESS | 1935 | Values: 1551.1 1585.3 1785.6 1856.6 1884.4 8411.4 8427.0 8547.2 8587.4 8628.0 8363.5 8450.2 8497.7 8523.8 8534.1 2440.2 2447.4 2460.4 2464.4 2471.1 2472.9 2519.5 2521.9 2548.7 2550.2 2401.2 2439.5 2489.5 2493.9 2522.6 2481.6 2500.0 2506.7 2513.4 2516.9 2535.6 2558.0 2559.0 2563.2 2583.9 8448.7 8452.7 8472.8 8531.4 8551.0 5190.9 5269.6 5346.9 5374.0 5398.7 3300.4 3370.5 3387.6 3405.1 3426.4 982.8 994.9 1048.7 1074.7 1080.6 11977.1 12046.8 12111.5 12111.6 12168.0 4419.8 4541.7 4557.2 4564.3 4624.9 9751.0 9787.7 9790.1 9797.0 9810.1 5137.8 5159.3 5161.6 5177.6 5197.6 4677.1 4742.3 4747.8 4753.6 4779.2 3824.5 3826.2 3836.5 3859.1 3872.5 1177.4 1196.6 1201.8 1208.6 1209.0 1074.2 1098.2 1166.4 1391.3 1462.9 7451.9 7507.7 7516.0 7688.9 7711.0 616.2 625.7 626.4 627.9 772.9 6004.1 6008.2 6084.1 6117.8 6149.4 10415.5 10567.5 10587.3 10623.4 10754.7 10181.1 10604.3 10619.1 10658.9 10746.6 8179.9 8213.5 8276.7 8283.3 8291.2 7605.8 7630.1 7694.2 7710.9 7735.3 9242.3 9308.9 9550.3 9636.2 9677.4 9537.3 9598.4 9705.9 9814.7 9855.7 7299.2 7303.1 7358.1 7366.2 7368.6 8261.3 8297.4 8325.8 8421.0 8447.3 6683.1 8001.6 8010.7 8056.6 8103.4 7106.7 7459.8 7575.7 7585.4 7611.2 7453.0 7476.9 7488.6 7521.2 7575.7 6821.3 6892.6 6894.8 6903.1 6950.7 6916.8 6963.3 6976.6 6978.8 6982.2 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | [#4] prototype.html Cycles:180 Average:5696.08 Median:6456.71 stddev:1718.24 (26.6%) stddev-sans-first:1675.55 09:36:12 INFO - PROCESS | 1935 | Values: 349.6 354.4 357.6 359.2 369.1 6242.5 6325.5 6339.0 6347.0 6352.5 6140.0 6227.0 6302.4 6313.7 6314.6 4861.9 4864.6 4864.7 4875.1 4878.9 4861.1 4907.8 4909.6 4910.2 4913.1 4771.6 4869.2 4869.3 4876.7 4878.1 4837.3 4839.1 4847.0 4851.0 4860.3 4263.0 4263.8 4266.2 4277.5 4280.2 5924.7 5976.3 6041.4 6046.0 6055.4 5716.4 5724.1 5738.1 5751.9 5754.3 6727.0 6728.6 6746.7 6759.1 6772.9 4750.9 4761.2 4779.0 4797.0 4797.3 6912.9 7066.3 7068.6 7076.6 7088.5 4924.7 4926.0 4926.2 4927.5 4929.8 4990.9 4993.2 4993.4 4998.8 4999.2 5411.9 5695.7 5706.1 5709.8 5725.8 6715.2 6735.7 6742.6 6777.8 6842.6 1675.3 1699.6 1722.8 1724.8 1730.7 1135.3 1147.3 1159.8 1165.8 1171.4 6452.6 6464.8 6481.2 6516.9 6557.9 6874.1 6900.9 6900.9 6917.8 6924.8 6460.8 6472.2 6518.2 6518.4 6527.3 3803.2 3823.9 3827.4 3835.7 3835.9 7258.9 7314.0 7316.6 7332.2 7336.6 7044.7 7291.2 7302.1 7303.5 7336.8 7187.7 7241.8 7265.1 7270.0 7307.5 6988.1 6989.6 7067.9 7073.8 7075.3 6807.7 6956.2 7008.2 7037.9 7047.0 7300.3 7319.8 7329.4 7333.5 7334.7 4739.9 4741.6 4746.3 4763.0 4764.3 6917.1 6919.7 7059.1 7075.3 7124.9 6897.6 6899.6 6933.3 6935.0 6939.3 6847.9 6866.9 6897.1 6898.7 6905.2 6633.4 6698.6 6723.4 6771.1 6806.4 6913.3 6928.8 6935.0 6936.9 6942.3 6744.2 6746.7 6758.9 6765.1 6767.7 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - PROCESS | 1935 | [#5] yui.html Cycles:180 Average:14661.89 Median:23607.74 stddev:16848.52 (71.4%) stddev-sans-first:16863.82 09:36:12 INFO - PROCESS | 1935 | Values: 840.2 849.9 865.5 880.9 922.5 14035.6 14048.0 14051.2 14063.7 14078.2 13706.2 13775.4 13796.6 13840.6 14645.4 863.0 881.2 881.7 882.3 883.0 879.3 885.5 886.7 887.4 892.9 924.4 933.6 934.3 934.5 936.1 930.0 933.1 933.2 934.7 934.9 682.0 687.7 688.2 689.5 692.0 13666.6 13770.5 13777.5 13847.4 13861.0 11991.1 12048.8 12162.0 12164.1 12189.0 11132.7 11225.7 11684.5 11714.6 11778.6 3793.2 3800.9 3849.8 3857.3 3882.6 48470.0 51058.5 52077.2 52149.5 52381.5 10410.8 10700.9 10703.6 10783.5 10821.6 18527.1 18620.7 18658.8 18666.4 18756.3 7785.1 7878.4 7913.8 7947.6 8179.9 4561.2 4566.0 4632.5 4649.6 4710.4 3388.4 3432.7 3436.4 3442.2 3442.3 626.2 638.9 640.6 647.2 653.1 557.1 601.4 624.7 648.3 695.7 9058.6 9194.5 9423.6 9494.6 9949.1 563.2 644.5 686.4 751.3 766.4 4007.8 4085.5 4151.5 4280.1 4379.1 59872.0 60542.4 60576.0 60904.7 64585.0 53638.5 54141.7 54142.7 54586.7 54708.7 46773.3 48765.5 51389.7 51420.2 51705.7 8286.2 8607.4 8624.3 8636.4 8639.6 35012.0 36860.0 37061.6 37930.6 38519.0 42750.0 42836.4 45979.3 46754.0 46784.8 11897.9 12072.3 12185.3 12242.3 12336.1 13185.6 13613.5 13896.5 14051.4 14348.1 11844.2 12338.9 12795.9 12867.0 13087.7 11492.3 12120.6 12276.3 12304.8 12504.2 12348.0 12531.9 12786.1 12909.1 13111.0 10037.3 10727.9 10793.7 10870.1 10951.3 10552.8 10819.8 11104.8 11116.8 11271.4 09:36:12 INFO - PROCESS | 1935 | -------- Summary: end -------- 09:36:12 INFO - PROCESS | 1935 | 09:36:12 INFO - TEST-INFO | 1935: exit 0 09:36:12 INFO - TEST-OK | dromaeo_css | took 1109329ms 09:36:12 INFO - TEST-START | kraken 09:36:12 INFO - operating with platform_type : linux_ 09:36:12 INFO - Initialising browser for kraken test... 09:36:12 INFO - TEST-INFO | started process 2185 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZv0Vzt/profile http://localhost:38160/getInfo.html) 09:36:16 INFO - PROCESS | 2185 | 09:36:16 INFO - PROCESS | 2185 | (process:2263): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:17 INFO - PROCESS | 2185 | __metrics Screen width/height:1600/1200 09:36:17 INFO - PROCESS | 2185 | colorDepth:24 09:36:17 INFO - PROCESS | 2185 | Browser inner width/height: 1024/697 09:36:17 INFO - PROCESS | 2185 | __metrics 09:36:18 INFO - TEST-INFO | 2185: exit 0 09:36:18 INFO - Browser initialized. 09:36:18 INFO - Running cycle 1/1 for kraken test... 09:36:18 INFO - TEST-INFO | started process 2312 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZv0Vzt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:19 INFO - PROCESS | 2312 | 09:36:19 INFO - PROCESS | 2312 | (process:2449): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:30 INFO - PROCESS | 2312 | RSS: Main: 139538432 09:36:30 INFO - PROCESS | 2312 | 09:36:32 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38160/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:33 INFO - PROCESS | 2312 | RSS: Main: 143712256 09:36:33 INFO - PROCESS | 2312 | 09:36:35 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38160/tests/kraken/driver.html?testName=audio-dft) 09:36:36 INFO - PROCESS | 2312 | RSS: Main: 143147008 09:36:36 INFO - PROCESS | 2312 | 09:36:39 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38160/tests/kraken/driver.html?testName=audio-fft) 09:36:39 INFO - PROCESS | 2312 | RSS: Main: 144134144 09:36:39 INFO - PROCESS | 2312 | 09:36:41 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38160/tests/kraken/driver.html?testName=audio-oscillator) 09:36:42 INFO - PROCESS | 2312 | RSS: Main: 145506304 09:36:42 INFO - PROCESS | 2312 | 09:36:44 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:45 INFO - PROCESS | 2312 | RSS: Main: 144666624 09:36:45 INFO - PROCESS | 2312 | 09:36:48 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38160/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:48 INFO - PROCESS | 2312 | RSS: Main: 145330176 09:36:48 INFO - PROCESS | 2312 | 09:36:52 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38160/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:52 INFO - PROCESS | 2312 | RSS: Main: 144973824 09:36:52 INFO - PROCESS | 2312 | 09:36:55 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38160/tests/kraken/driver.html?testName=json-parse-financial) 09:36:56 INFO - PROCESS | 2312 | RSS: Main: 145395712 09:36:56 INFO - PROCESS | 2312 | 09:36:57 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:58 INFO - PROCESS | 2312 | RSS: Main: 145031168 09:36:58 INFO - PROCESS | 2312 | 09:36:59 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:00 INFO - PROCESS | 2312 | RSS: Main: 144007168 09:37:00 INFO - PROCESS | 2312 | 09:37:02 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:03 INFO - PROCESS | 2312 | RSS: Main: 144826368 09:37:03 INFO - PROCESS | 2312 | 09:37:05 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:06 INFO - PROCESS | 2312 | RSS: Main: 143912960 09:37:06 INFO - PROCESS | 2312 | 09:37:08 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:09 INFO - PROCESS | 2312 | RSS: Main: 144130048 09:37:09 INFO - PROCESS | 2312 | 09:37:10 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:38160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38160/tests/kraken/driver.html?testName=ai-astar) 09:37:11 INFO - PROCESS | 2312 | RSS: Main: 147210240 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | __start_tp_report 09:37:11 INFO - PROCESS | 2312 | _x_x_mozilla_page_load 09:37:11 INFO - PROCESS | 2312 | _x_x_mozilla_page_load_details 09:37:11 INFO - PROCESS | 2312 | |i|pagename|runs| 09:37:11 INFO - PROCESS | 2312 | |0;ai-astar;112;106;111;110;110;120;110;112;110;110 09:37:11 INFO - PROCESS | 2312 | |1;audio-beat-detection;145;127;151;161;126;150;145;128;159;126 09:37:11 INFO - PROCESS | 2312 | |2;audio-dft;167;165;163;162;163;163;161;162;163;160 09:37:11 INFO - PROCESS | 2312 | |3;audio-fft;73;73;76;162;72;75;73;74;148;74 09:37:11 INFO - PROCESS | 2312 | |4;audio-oscillator;96;96;145;96;95;97;138;97;96;143 09:37:11 INFO - PROCESS | 2312 | |5;imaging-gaussian-blur;110;111;110;110;109;109;109;110;110;113 09:37:11 INFO - PROCESS | 2312 | |6;imaging-darkroom;149;146;146;147;148;147;151;147;147;146 09:37:11 INFO - PROCESS | 2312 | |7;imaging-desaturate;98;97;96;96;96;96;97;96;97;96 09:37:11 INFO - PROCESS | 2312 | |8;json-parse-financial;54;55;59;54;57;61;55;59;56;52 09:37:11 INFO - PROCESS | 2312 | |9;json-stringify-tinderbox;64;64;64;65;65;65;65;65;64;64 09:37:11 INFO - PROCESS | 2312 | |10;stanford-crypto-aes;82;80;82;81;83;81;84;83;82;79 09:37:11 INFO - PROCESS | 2312 | |11;stanford-crypto-ccm;113;121;111;121;111;120;120;117;114;114 09:37:11 INFO - PROCESS | 2312 | |12;stanford-crypto-pbkdf2;130;148;129;138;141;140;149;140;137;138 09:37:11 INFO - PROCESS | 2312 | |13;stanford-crypto-sha256-iterative;69;65;66;65;66;67;66;66;66;66 09:37:11 INFO - PROCESS | 2312 | __end_tp_report 09:37:11 INFO - PROCESS | 2312 | __start_cc_report 09:37:11 INFO - PROCESS | 2312 | _x_x_mozilla_cycle_collect,722 09:37:11 INFO - PROCESS | 2312 | __end_cc_report 09:37:11 INFO - PROCESS | 2312 | __startTimestamp1453743431159__endTimestamp 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | ------- Summary: start ------- 09:37:11 INFO - PROCESS | 2312 | Number of tests: 14 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:3.54 (3.2%) stddev-sans-first:3.74 09:37:11 INFO - PROCESS | 2312 | Values: 112.0 106.0 111.0 110.0 110.0 120.0 110.0 112.0 110.0 110.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.50 stddev:13.93 (9.4%) stddev-sans-first:14.72 09:37:11 INFO - PROCESS | 2312 | Values: 145.0 127.0 151.0 161.0 126.0 150.0 145.0 128.0 159.0 126.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.97 (1.2%) stddev-sans-first:1.42 09:37:11 INFO - PROCESS | 2312 | Values: 167.0 165.0 163.0 162.0 163.0 163.0 161.0 162.0 163.0 160.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#3] audio-fft Cycles:10 Average:90.00 Median:73.50 stddev:34.44 (46.9%) stddev-sans-first:35.97 09:37:11 INFO - PROCESS | 2312 | Values: 73.0 73.0 76.0 162.0 72.0 75.0 73.0 74.0 148.0 74.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:22.22 (23.1%) stddev-sans-first:23.00 09:37:11 INFO - PROCESS | 2312 | Values: 96.0 96.0 145.0 96.0 95.0 97.0 138.0 97.0 96.0 143.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.20 (1.1%) stddev-sans-first:1.27 09:37:11 INFO - PROCESS | 2312 | Values: 110.0 111.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 113.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.58 (1.1%) stddev-sans-first:1.56 09:37:11 INFO - PROCESS | 2312 | Values: 149.0 146.0 146.0 147.0 148.0 147.0 151.0 147.0 147.0 146.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 09:37:11 INFO - PROCESS | 2312 | Values: 98.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:2.78 (4.9%) stddev-sans-first:2.83 09:37:11 INFO - PROCESS | 2312 | Values: 54.0 55.0 59.0 54.0 57.0 61.0 55.0 59.0 56.0 52.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:37:11 INFO - PROCESS | 2312 | Values: 64.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 64.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.49 (1.8%) stddev-sans-first:1.58 09:37:11 INFO - PROCESS | 2312 | Values: 82.0 80.0 82.0 81.0 83.0 81.0 84.0 83.0 82.0 79.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:118.50 stddev:4.08 (3.4%) stddev-sans-first:4.16 09:37:11 INFO - PROCESS | 2312 | Values: 113.0 121.0 111.0 121.0 111.0 120.0 120.0 117.0 114.0 114.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:140.00 stddev:6.45 (4.6%) stddev-sans-first:5.96 09:37:11 INFO - PROCESS | 2312 | Values: 130.0 148.0 129.0 138.0 141.0 140.0 149.0 140.0 137.0 138.0 09:37:11 INFO - PROCESS | 2312 | 09:37:11 INFO - PROCESS | 2312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:0.60 09:37:11 INFO - PROCESS | 2312 | Values: 69.0 65.0 66.0 65.0 66.0 67.0 66.0 66.0 66.0 66.0 09:37:11 INFO - PROCESS | 2312 | -------- Summary: end -------- 09:37:11 INFO - PROCESS | 2312 | 09:37:12 INFO - TEST-INFO | 2312: exit 0 09:37:12 INFO - TEST-OK | kraken | took 59272ms 09:37:12 INFO - TEST-START | v8_7 09:37:12 INFO - operating with platform_type : linux_ 09:37:12 INFO - Initialising browser for v8_7 test... 09:37:12 INFO - TEST-INFO | started process 2723 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHkHxey/profile http://localhost:38160/getInfo.html) 09:37:15 INFO - PROCESS | 2723 | 09:37:15 INFO - PROCESS | 2723 | (process:2867): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:37:16 INFO - PROCESS | 2723 | __metrics Screen width/height:1600/1200 09:37:16 INFO - PROCESS | 2723 | colorDepth:24 09:37:16 INFO - PROCESS | 2723 | Browser inner width/height: 1024/697 09:37:16 INFO - PROCESS | 2723 | __metrics 09:37:17 INFO - TEST-INFO | 2723: exit 0 09:37:17 INFO - Browser initialized. 09:37:17 INFO - Running cycle 1/1 for v8_7 test... 09:37:17 INFO - TEST-INFO | started process 2930 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHkHxey/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:18 INFO - PROCESS | 2930 | 09:37:18 INFO - PROCESS | 2930 | (process:2997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:37:29 INFO - PROCESS | 2930 | RSS: Main: 140247040 09:37:29 INFO - PROCESS | 2930 | 09:37:51 INFO - PROCESS | 2930 | Cycle 1(1): loaded http://localhost:38160/tests/v8_7/run.html (next: http://localhost:38160/tests/v8_7/run.html) 09:37:52 INFO - PROCESS | 2930 | RSS: Main: 143474688 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | __start_tp_report 09:37:52 INFO - PROCESS | 2930 | _x_x_mozilla_page_load 09:37:52 INFO - PROCESS | 2930 | _x_x_mozilla_page_load_details 09:37:52 INFO - PROCESS | 2930 | |i|pagename|runs| 09:37:52 INFO - PROCESS | 2930 | |0;Richards;166.25103906899417 09:37:52 INFO - PROCESS | 2930 | |1;DeltaBlue;170.38677798602828 09:37:52 INFO - PROCESS | 2930 | |2;Encrypt;280.19052956010086 09:37:52 INFO - PROCESS | 2930 | |3;Decrypt;5213.541666666667 09:37:52 INFO - PROCESS | 2930 | |4;RayTrace;946.969696969697 09:37:52 INFO - PROCESS | 2930 | |5;Earley;565.2911249293386 09:37:52 INFO - PROCESS | 2930 | |6;Boyer;11155.555555555555 09:37:52 INFO - PROCESS | 2930 | |7;RegExp;39764.705882352944 09:37:52 INFO - PROCESS | 2930 | |8;Splay;502.25563909774434 09:37:52 INFO - PROCESS | 2930 | |9;NavierStokes;4826.923076923077 09:37:52 INFO - PROCESS | 2930 | __end_tp_report 09:37:52 INFO - PROCESS | 2930 | __startTimestamp1453743472052__endTimestamp 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | ------- Summary: start ------- 09:37:52 INFO - PROCESS | 2930 | Number of tests: 10 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 166.3 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#1] DeltaBlue Cycles:1 Average:170.39 Median:170.39 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 170.4 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 280.2 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 5213.5 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#4] RayTrace Cycles:1 Average:946.97 Median:946.97 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 947.0 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#5] Earley Cycles:1 Average:565.29 Median:565.29 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 565.3 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#6] Boyer Cycles:1 Average:11155.56 Median:11155.56 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 11155.6 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#7] RegExp Cycles:1 Average:39764.71 Median:39764.71 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 39764.7 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#8] Splay Cycles:1 Average:502.26 Median:502.26 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 502.3 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - PROCESS | 2930 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:37:52 INFO - PROCESS | 2930 | Values: 4826.9 09:37:52 INFO - PROCESS | 2930 | -------- Summary: end -------- 09:37:52 INFO - PROCESS | 2930 | 09:37:52 INFO - TEST-INFO | 2930: exit 0 09:37:52 INFO - TEST-OK | v8_7 | took 40718ms 09:37:52 INFO - SUITE-END | took 1209s 09:37:53 INFO - Completed test suite (00:20:09) 09:37:53 INFO - Working with test: dromaeo_css 09:37:53 INFO - Generating results file: dromaeo_css 09:37:53 INFO - Working with test: kraken 09:37:53 INFO - Generating results file: kraken 09:37:53 INFO - javascript benchmark 09:37:53 INFO - Working with test: v8_7 09:37:53 INFO - Generating results file: v8_7 09:37:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:37:53 INFO - process_Request line: dromaeo_css 7260.96 graph.html#tests=[[72,52,43]] 09:37:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:53 INFO - process_Request line: kraken 1493.50 graph.html#tests=[[232,52,43]] 09:37:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:53 INFO - process_Request line: v8_7 21995.98 graph.html#tests=[[230,52,43]] 09:37:53 INFO - RETURN: dromaeo_css: 7260.96 09:37:53 INFO - RETURN: kraken: 1493.50 09:37:53 INFO - RETURN: v8_7: 21995.98 09:37:53 INFO - javascript benchmark 09:37:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3361.6974472297497, 3416.8291585420725, 3428.0, 3463.6536346365365, 3464.393731097059, 5601.019821531236, 5608.074667679833, 5612.719364031803, 5623.831285061445, 5632.07070833312, 5540.944590554093, 5626.2967129108865, 5627.521660658838, 5633.070543360341, 5664.943350566493, 5044.369453818273, 5054.014467178883, 5150.896982060356, 5154.07226699194, 5167.974160129194, 4975.7263350515705, 5027.748612569375, 5085.821996230133, 5090.847274581768, 5105.948940510603, 5079.720615366154, 5113.846584602468, 5115.258287548303, 5116.795328186887, 5164.561012313958, 5085.491450854904, 5102.2346648003095, 5104.438511763721, 5115.948840511584, 5146.742662866879, 4904.6321525885705, 4912.164931961575, 5036.924446133311, 5051.0, 5103.872403189913, 5022.623303252234, 5295.443978382292, 5357.892842143136, 5388.541973932221, 5416.972915135439, 5948.7620495180145, 5962.0, 5988.401159884021, 6007.639541627473, 6016.969915150396, 5790.7394167262155, 5921.111833225008, 5936.257967754031, 6032.577719559633, 6037.245344331958, 5606.383297837235, 5615.466530679538, 5648.096304591287, 5658.207850900877, 5659.320881494205, 6145.354737752472, 6159.692015399212, 6160.9383906161265, 6168.784092556739, 6180.690965451709, 5740.454656807597, 5816.447437493432, 5871.588988770745, 5926.436988486087, 5985.581009329392, 5991.430814072656, 6000.129981152796, 6001.279846418458, 6002.39976002405, 6010.729517171738, 5909.084091965752, 5922.3485416604135, 5929.584929054925, 5974.581779275496, 5976.372480889531, 5787.363390027093, 5890.9410905891245, 5921.703914804242, 5949.672767997715, 6084.30030546484, 4519.7740112994215, 4532.0256144929, 4534.909301813946, 4545.045540436479, 4566.178087944136, 3971.324874771296, 4061.0862555925273, 4095.672346212296, 4129.97935010329, 4136.73111247774, 5547.750351234205, 5634.549236061105, 5641.0, 5643.322801263875, 5656.745446454919, 5943.762249509971, 6034.125051867454, 6038.396160383926, 6040.124181993674, 6060.454559089703, 5666.0, 5700.144978253295, 5729.1119876419225, 5757.366689664133, 5769.221155144086, 4991.800327986913, 5121.667091639031, 5166.896662066738, 5172.7155006475, 5214.2960700304975, 6117.851559182993, 6146.846328841725, 6155.199824022849, 6166.445019948226, 6184.412480814315, 5965.731542080704, 6009.849753756191, 6010.9699451502465, 6022.976094063932, 6060.848478787977, 5989.730462129128, 6067.453929146398, 6120.44915957566, 6133.26400831903, 6138.294096178996, 5916.053431450947, 5920.023196172583, 5932.080527518242, 5935.554833387427, 5963.373845746134, 6009.158717779427, 6016.338202797601, 6025.728842202024, 6041.335453100068, 6051.878962420815, 5713.885722285448, 5780.971095144498, 5823.5923485355615, 5868.061110222344, 5929.436703513159, 5819.82540523785, 5855.882882342244, 5911.083782013795, 5915.792947246826, 5924.703764811656, 5814.476697097112, 5820.0396934507025, 5822.563307752021, 5824.446677565625, 5825.184474173704, 5667.603267771216, 5771.365149833431, 5836.708164591669, 5937.228160339128, 5955.434233747787, 5741.995150848501, 5745.195672605755, 5747.48272655463, 5764.0201165802755, 5790.420957904176], "unit": "score", "name": "dojo.html", "value": 5515.046357578045}, {"lowerIsBetter": false, "replicates": [553.7120697237436, 559.6809818403509, 577.347597215147, 587.7472686744698, 592.2034863109117, 38038.429423558635, 39305.410418843705, 39341.8032909835, 39382.0, 39521.60478395215, 41580.58419415805, 41992.37011444823, 42051.15897682044, 42117.78941105298, 42236.36645450321, 8858.955705221464, 8862.29101671868, 9052.094790520961, 9061.818763624724, 9075.36472446929, 8580.871286930702, 8789.208971192591, 8793.692220772275, 8980.955095224515, 9008.459492430442, 9017.909820901805, 9075.863862042075, 9089.0, 9089.909100908972, 9095.63617455301, 8832.514211718353, 8929.241014513807, 8980.101989801033, 9003.95498022509, 9006.324525660537, 8771.736847894574, 8822.514761688104, 8841.778955526099, 8878.73363799087, 8879.778005549848, 40978.79510602428, 41254.58745412568, 41595.584044159776, 41715.58284417148, 41778.373324400156, 3511.5610548681416, 3520.5247291615815, 3904.2581909437117, 3913.9804300978312, 3916.5495967963766, 30327.24181895448, 31679.52480712768, 31843.52234716458, 31950.360992780013, 32056.6794332056, 3914.309958961282, 3976.224636195943, 3991.2217117662067, 3998.900027499336, 4051.291024070805, 298768.0, 298901.0, 299296.0, 300601.4969925158, 301048.0, 54119.0, 55582.72208638931, 59899.40100599025, 60683.08975365373, 61969.69015154895, 55824.16263756047, 55870.161947570006, 55995.0, 56036.719816400655, 56356.15465768017, 17551.385701500385, 17743.201555929754, 17761.7335739964, 17796.644067118585, 17800.732989005177, 13521.797173042216, 13821.101628394123, 13830.93084534591, 13834.65413364674, 13894.930525347309, 20001.699974500396, 20190.798092019184, 20390.0, 20435.693464598044, 20482.283120090724, 7976.322012628992, 8107.756767296991, 8135.511869287861, 8178.877316840133, 8204.548749818698, 1056.5826498533036, 1070.272214893864, 1148.8391625172483, 1220.737541428597, 1244.8941839943707, 30613.540796888065, 30730.231744206125, 30860.691393086232, 32813.17967050843, 33343.3331333372, 1132.6658635702322, 1204.9156559040782, 1210.1589395370308, 1228.177121328712, 1253.0414233111676, 14836.110986328926, 14916.179610121331, 15070.924645376703, 15495.767563486557, 15570.9221453892, 354685.0, 374583.0, 375090.0, 376450.0, 376673.0, 48037.519624804, 48750.512494874594, 48826.0, 49079.0, 49153.75423122933, 1485.7548504496854, 1500.9774853377207, 1504.5711972088122, 1510.652549913526, 1510.8187017557964, 27160.456790864468, 28447.28881777972, 29216.7078329214, 29398.265043374086, 30390.696093038787, 50543.483695489194, 52384.476155239485, 52456.0, 52485.21272180844, 52530.0, 236241.0, 237750.0, 237925.0, 238383.0, 239208.0, 33068.83465582753, 33079.50380744242, 33113.33773324568, 33177.17057073592, 33575.664243357256, 44966.0, 45020.77489612531, 45384.54615453803, 45699.31451028171, 45915.0, 34055.82972085124, 34339.65660343364, 34783.0, 35318.64681353256, 35646.82176589101, 36510.0, 38529.422058669705, 38953.41569876511, 39008.21983560256, 39355.409668855566, 38774.80612596919, 38992.82795554423, 39106.41340379953, 39202.0, 39308.213835722556, 33159.83420082884, 33190.17024574308, 33528.832355838065, 33678.32643347168, 33722.83138584292, 26939.865300673373, 27030.0, 27043.86478067597, 27341.453170936868, 27547.173584792487], "unit": "score", "name": "ext.html", "value": 19311.092512616826}, {"lowerIsBetter": false, "replicates": [390.80998359993816, 394.134873951676, 395.0873482255989, 397.05302852696326, 398.65118021730984, 14597.41610335588, 16808.91595542022, 17069.82930170698, 17329.393471228508, 17351.045692486907, 16879.746803797952, 17191.82808171921, 17305.480835574952, 18134.909325453355, 18183.363582274622, 5633.0, 5828.18405423239, 5831.708414579254, 5834.329052159013, 5850.385709500505, 5519.420460851613, 5617.859553511174, 5679.176519404684, 5728.083506638938, 5739.827805165852, 4215.199112168678, 5703.258576385064, 5755.280589926259, 5764.538836893039, 5839.532837373, 6076.240469941257, 6265.248170219557, 6269.843253918643, 6272.686365681698, 6286.9056964145575, 5405.918911216296, 5417.214503896913, 5425.9728701356635, 5456.781728730846, 5460.372057213432, 18387.63224735511, 18920.71618925717, 19032.809671903244, 19296.1316740747, 20005.8999705002, 2173.3045425463856, 2212.3362991102604, 2280.0993607524933, 2323.639835825433, 2820.9421466949893, 9934.751631209205, 13226.735465290736, 13339.799903001463, 13578.796318055238, 13601.387937542835, 1899.240303878446, 1902.8953407562578, 1918.932837350686, 1926.1909997800958, 1939.1080103152567, 52229.21656175161, 52964.47035529634, 57393.42606573922, 59387.70306148485, 61366.69316653433, 10361.274710770174, 10405.739856503496, 10422.583096676048, 10454.372737635766, 10617.681469555926, 13719.314034298246, 13875.653108672162, 13900.652483687989, 13955.930220348833, 14016.789748153786, 8195.549244791475, 8275.875861862078, 8361.874571881426, 8393.286570641563, 8407.11725268838, 8194.385421093442, 8210.630521626541, 8215.424920255524, 8238.299744521662, 8300.584970751439, 4527.954720452819, 4536.591706746409, 4542.295944128666, 4574.5425457453985, 4645.558671926162, 1904.5333893196255, 1915.79884112169, 1948.7174359717762, 1961.3723608445162, 1962.7154062660834, 443.1469421363926, 445.16531503431065, 457.08810922210404, 470.407286818611, 474.88602735343267, 10807.135429165648, 11390.487428065757, 11514.88485115138, 16709.749353759704, 17302.567435814206, 1064.2231171245035, 1064.2550214849637, 1088.172988528708, 1149.741308205647, 1160.4661855546374, 9541.0, 9947.751306217258, 10024.498775061218, 10045.397276163307, 10191.184705223564, 573798.0, 578031.4393712102, 625289.0, 679667.0, 679775.0, 77352.0, 77655.61172194102, 79181.60409197917, 79303.60348198337, 80945.19054809495, 507.3252574076469, 524.2398522142907, 526.6287267476497, 528.0363336910154, 529.5102030621659, 9993.950030249802, 10358.119559837498, 10414.531346089292, 10468.738281543023, 10756.462176890967, 34587.4811877817, 35387.11532211612, 35681.64318356783, 36112.27775444529, 36310.0, 43275.78362108169, 43296.350554742334, 43628.34557481704, 45589.316160258284, 46180.30729539127, 7396.186419493959, 7713.344365728976, 7740.22597740244, 7754.0, 7755.302022817974, 9991.800163996824, 11410.543578256777, 11718.941405292919, 11778.882211177779, 11882.881171188177, 7814.5199530808895, 9537.952310238405, 9673.9032609673, 10623.946880265548, 10790.406527640742, 10107.64623238183, 10288.588456461957, 10313.9484302578, 10687.145028397865, 10788.622398216025, 10695.89304106949, 10706.089982351587, 10863.239573229797, 10898.836517452086, 11111.611093612008, 7888.723894663659, 7967.681292748225, 8019.278264956182, 8044.798880028046, 8052.516848989079, 10590.364578125336, 10765.138788897026, 10877.510512027136, 10895.945520272347, 11041.171912106463], "unit": "score", "name": "jquery.html", "value": 8238.028172449827}, {"lowerIsBetter": false, "replicates": [1551.115863957544, 1585.2866210205411, 1785.6250187460632, 1856.610111876506, 1884.4158310923615, 8411.369147313946, 8427.0, 8547.230749232567, 8587.398882078242, 8627.956860215698, 8363.4563753356, 8450.154984501547, 8497.702580409687, 8523.829523409528, 8534.1039190885, 2440.1581454398247, 2447.3514518652482, 2460.434100156965, 2464.4208610976407, 2471.085698291635, 2472.8887200076038, 2519.496100779842, 2521.8612976286295, 2548.719640839506, 2550.2476769353084, 2401.231605886117, 2439.512097580482, 2489.5020995800824, 2493.9127130550432, 2522.6216067589826, 2481.6401621764835, 2499.962500562475, 2506.749325067497, 2513.384220865881, 2516.899324027046, 2535.6450096986437, 2558.0, 2558.9744102559107, 2563.1541591274836, 2583.883725232369, 8448.662053517852, 8452.704155354595, 8472.78818029548, 8531.402801803877, 8551.0, 5190.896182076337, 5269.604779641542, 5346.91979620306, 5374.032674118657, 5398.73006349681, 3300.405926933151, 3370.5281260623533, 3387.6104248011547, 3405.0636075079306, 3426.3832510148163, 982.8181786369545, 994.9154321882577, 1048.7325731938383, 1074.7044562745307, 1080.6055789636805, 11977.101717371232, 12046.759064818742, 12111.515539378413, 12111.636650900487, 12168.026557875348, 4419.845305414359, 4541.704789188692, 4557.225271703752, 4564.3153526970555, 4624.861254162381, 9751.0, 9787.706368808947, 9790.06994335537, 9797.0, 9810.117089461983, 5137.8201762938115, 5159.329287192641, 5161.612879034087, 5177.637565370464, 5197.58419326453, 4677.087967846305, 4742.33607294979, 4747.7626118693925, 4753.619710423227, 4779.211430114062, 3824.521934758155, 3826.1582451860545, 3836.5037635322246, 3859.0931131184147, 3872.496575445174, 1177.3524561491317, 1196.5811965811897, 1201.7596480703894, 1208.583038851595, 1209.0388141427586, 1074.1621535202555, 1098.23123813331, 1166.416791604198, 1391.269583468687, 1462.926853657313, 7451.888221676679, 7507.662155203029, 7516.0, 7688.884666729891, 7711.03612048494, 616.1527899138684, 625.7497001199556, 626.3517259636254, 627.9058141278754, 772.8909015562685, 6004.0693692477735, 6008.24896887889, 6084.148219249309, 6117.816465506042, 6149.41580549847, 10415.479226038819, 10567.471626418803, 10587.258891877495, 10623.362598243975, 10754.731131721614, 10181.083702466665, 10604.310719803188, 10619.09737672291, 10658.946705266579, 10746.623868164577, 8179.877301840596, 8213.507189568645, 8276.710315138942, 8283.337333013465, 8291.212334828182, 7605.771826845204, 7630.084389873251, 7694.153643099143, 7710.884336734841, 7735.303822655988, 9242.260619150318, 9308.906910930804, 9550.283728720513, 9636.22910167199, 9677.419354838732, 9537.284703647392, 9598.376105553396, 9705.854412183964, 9814.65648702292, 9855.655052073143, 7299.233580473974, 7303.087114110736, 7358.117025956705, 7366.226546212785, 7368.557886526825, 8261.297789687704, 8297.419180657296, 8325.83348333042, 8420.95789521073, 8447.324214062983, 6683.097781799394, 8001.599920004093, 8010.679572817022, 8056.637451314822, 8103.392245581487, 7106.7157313706875, 7459.813504662427, 7575.659095340833, 7585.355244804254, 7611.238876112345, 7452.962735186289, 7476.925230747623, 7488.588127653032, 7521.172671006294, 7575.734849280248, 6821.317868213139, 6892.586444813327, 6894.758683446055, 6903.1371078615175, 6950.721971121098, 6916.827079323057, 6963.268856770169, 6976.616286104313, 6978.755743548952, 6982.231954485104], "unit": "score", "name": "mootools.html", "value": 4812.068448740133}, {"lowerIsBetter": false, "replicates": [349.58050339592495, 354.43467669067843, 357.57091490211747, 359.16494151098703, 369.1067616368389, 6242.469390101835, 6325.493960483162, 6338.968305158479, 6347.016212487066, 6352.491800655948, 6140.048292514656, 6226.968865155668, 6302.369763023696, 6313.652749098797, 6314.589551679138, 4861.927071093936, 4864.635152363569, 4864.683795553296, 4875.073735990169, 4878.926816097762, 4861.076395484864, 4907.75461226939, 4909.582685471739, 4910.165271903785, 4913.091078150535, 4771.618270538349, 4869.220924652056, 4869.318295438624, 4876.731779752112, 4878.097551952882, 4837.250226214942, 4839.128956787795, 4847.0, 4850.951490485085, 4860.270959356089, 4263.0, 4263.765492897889, 4266.168097221043, 4277.486701595828, 4280.1653677532895, 5924.7333869975955, 5976.282846058457, 6041.395860413967, 6045.969770151121, 6055.424734650202, 5716.371199168088, 5724.141378793172, 5738.081906894919, 5751.856203594902, 5754.338251101093, 6727.024581435713, 6728.596284222962, 6746.730130794763, 6759.087523184406, 6772.864542709168, 4750.904981900343, 4761.166795810719, 4778.976105119487, 4796.952030479721, 4797.328374027639, 6912.930870691329, 7066.258042905472, 7068.5758854468895, 7076.646167691595, 7088.539244949114, 4924.704517728947, 4926.039422312686, 4926.236433352836, 4927.531884470969, 4929.75351232437, 4990.90018199634, 4993.201087825931, 4993.375828021497, 4998.775055122528, 4999.200127979506, 5411.918821217685, 5695.743691533891, 5706.087026075891, 5709.8287051388525, 5725.799597014167, 6715.1941766988275, 6735.730570777114, 6742.595444273359, 6777.762778302736, 6842.589444633338, 1675.2963755222836, 1699.609089909303, 1722.810490846006, 1724.8361405666442, 1730.6711724772254, 1135.28477059452, 1147.3345459633392, 1159.7854396936593, 1165.8018136916744, 1171.420147027227, 6452.612843229327, 6464.806055818239, 6481.157449531625, 6516.934830651728, 6557.901631475532, 6874.106366172466, 6900.861982760417, 6900.861982760417, 6917.827054323581, 6924.792256232321, 6460.806175814733, 6472.190976127984, 6518.152640156749, 6518.413342799171, 6527.314631963575, 3803.2013277212095, 3823.8661646842784, 3827.4067519534515, 3835.6547910687614, 3835.9041023974064, 7258.891116633149, 7314.049173607504, 7316.561006339637, 7332.230115837867, 7336.633168341668, 7044.718211271595, 7291.161516425573, 7302.087239095114, 7303.525270857377, 7336.7798966031105, 7187.748428804966, 7241.818954526074, 7265.12818461788, 7270.0, 7307.488475806643, 6988.126484189476, 6989.615571143636, 7067.929320706727, 7073.787786366417, 7075.327843854826, 6807.659617019228, 6956.165260168812, 7008.194057683431, 7037.894431583428, 7046.964765176142, 7300.269973002657, 7319.780406587811, 7329.413646908128, 7333.523320984119, 7334.706611735471, 4739.857804265877, 4741.596964258077, 4746.288056791509, 4762.9523704762505, 4764.2615394613895, 6917.13535808024, 6919.719851827428, 7059.117610298713, 7075.257098004636, 7124.85750284981, 6897.620630865351, 6899.551529150589, 6933.341332573397, 6934.965325173342, 6939.340762627542, 6847.931520684929, 6866.931330686629, 6897.137857767779, 6898.689558969959, 6905.240423553506, 6633.436157926631, 6698.5980841149685, 6723.361280678328, 6771.119754431892, 6806.387425131762, 6913.343232392915, 6928.757493487704, 6935.029095926473, 6936.930630693831, 6942.340477654615, 6744.156980377453, 6746.69639866217, 6758.8648227036165, 6765.052892595139, 6767.729290828312], "unit": "score", "name": "prototype.html", "value": 5135.900093350774}, {"lowerIsBetter": false, "replicates": [840.2227939156279, 849.8810166576684, 865.5499140446966, 880.9163129502697, 922.4972390047424, 14035.649108772273, 14048.0, 14051.156930584171, 14063.718725625495, 14078.22569758663, 13706.177629342246, 13775.380107895144, 13796.586102416919, 13840.584782456543, 14645.414183432677, 862.9697960571397, 881.2333270055061, 881.7266647339345, 882.3029806452927, 883.0463099852144, 879.2965627498008, 885.5395194498857, 886.6542048601051, 887.4187407248263, 892.8839250897374, 924.3945215883573, 933.5752232734123, 934.2619330728717, 934.4580143516744, 936.1247233836385, 930.0327659234388, 933.1135421349711, 933.1788026536605, 934.686879895236, 934.9205317548017, 681.9522633415663, 687.7145984416461, 688.187938232885, 689.5380095336137, 691.9619420931847, 13666.590002299947, 13770.518031868936, 13777.517786877512, 13847.376868040963, 13861.0, 11991.10066744989, 12048.759024819454, 12162.0, 12164.14850960433, 12189.0, 11132.666020019413, 11225.66323010311, 11684.532618695242, 11714.589989350417, 11778.646640600795, 3793.2223894101644, 3800.90497737556, 3849.788261645608, 3857.3442514772273, 3882.611738826123, 48470.0, 51058.489415105745, 52077.218841717025, 52149.47850521484, 52381.47618523766, 10410.843837342445, 10700.946495267473, 10703.571857125784, 10783.514741836636, 10821.613398756177, 18527.07364631763, 18620.72068918967, 18658.813411865707, 18666.440006799818, 18756.343527976456, 7785.1436342002335, 7878.448508604342, 7913.841723165619, 7947.562884041317, 8179.877301840477, 4561.2473941799235, 4566.0, 4632.467266264355, 4649.5815376616265, 4710.36410084641, 3388.3562123196516, 3432.742544309137, 3436.415809312423, 3442.1910850950007, 3442.345954268681, 626.2422468812697, 638.8530637953204, 640.6028262477294, 647.1942431672504, 653.0954627840475, 557.1225320120826, 601.3835818286204, 624.7376102037156, 648.3419329380682, 695.6904177640902, 9058.637654493747, 9194.49430281341, 9423.575939082757, 9494.572744226527, 9949.104580587782, 563.2424389196524, 644.5262731892055, 686.3925425998028, 751.3163021650272, 766.4366690482491, 4007.779572123561, 4085.4688890444054, 4151.46985550573, 4280.079782846703, 4379.1241751649795, 59872.0, 60542.39457605367, 60576.0, 60904.695476522335, 64585.0, 53638.54797060875, 54141.72929135408, 54142.729286353315, 54586.727066364416, 54708.72645636746, 46773.29840052402, 48765.512344876806, 51389.7430512845, 51420.22869656958, 51705.7414712924, 8286.212809783061, 8607.440516366416, 8624.266937310398, 8636.438631488933, 8639.568021598769, 35012.0, 36860.0, 37061.629383706895, 37930.62069379381, 38519.0, 42750.0, 42836.35745463758, 45979.3103103447, 46754.0, 46784.7660761694, 11897.940510297392, 12072.3360215189, 12185.268883866996, 12242.326672032767, 12336.074794390277, 13185.60443186706, 13613.52352667652, 13896.51362202318, 14051.437942482595, 14348.06737562055, 11844.232035599434, 12338.94526253955, 12795.93602032021, 12867.0, 13087.672808179872, 11492.253003554742, 12120.575779848015, 12276.324802135969, 12304.75390492203, 12504.249745015328, 12348.0, 12531.87468125307, 12786.104972651825, 12909.096363254857, 13111.0, 10037.252272388674, 10727.892721072689, 10793.701115035294, 10870.130389568974, 10951.288166269167, 10552.788944221225, 10819.783604328028, 11104.833427498756, 11116.777664446827, 11271.380074095676], "unit": "score", "name": "yui.html", "value": 6757.73605428473}], "name": "dromaeo_css", "value": 7260.95653791269}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 110.0, 110.0, 120.0, 110.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [145.0, 127.0, 151.0, 161.0, 126.0, 150.0, 145.0, 128.0, 159.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [167.0, 165.0, 163.0, 162.0, 163.0, 163.0, 161.0, 162.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 76.0, 162.0, 72.0, 75.0, 73.0, 74.0, 148.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 145.0, 96.0, 95.0, 97.0, 138.0, 97.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 113.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 146.0, 147.0, 148.0, 147.0, 151.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 59.0, 54.0, 57.0, 61.0, 55.0, 59.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 81.0, 83.0, 81.0, 84.0, 83.0, 82.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [113.0, 121.0, 111.0, 121.0, 111.0, 120.0, 120.0, 117.0, 114.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [130.0, 148.0, 129.0, 138.0, 141.0, 140.0, 149.0, 140.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1493.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [170.38677798602828], "unit": "score", "name": "DeltaBlue", "value": 388.0465419999999}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [946.969696969697], "unit": "score", "name": "RayTrace", "value": 781.4283840000004}, {"lowerIsBetter": false, "replicates": [565.2911249293386], "unit": "score", "name": "Earley", "value": 1178.9730469999995}, {"lowerIsBetter": false, "replicates": [11155.555555555555], "unit": "score", "name": "Boyer", "value": 59.74269920318723}, {"lowerIsBetter": false, "replicates": [39764.705882352944], "unit": "score", "name": "RegExp", "value": 22.909386094674556}, {"lowerIsBetter": false, "replicates": [502.25563909774434], "unit": "score", "name": "Splay", "value": 162.25004491017964}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21995.976930137076}]} 09:37:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21995.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1493.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7260.96"}}} 09:37:53 INFO - Return code: 0 09:37:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:37:53 INFO - # TBPL SUCCESS # 09:37:53 INFO - Running post-action listener: _resource_record_post_action 09:37:53 INFO - Running post-run listener: _resource_record_post_run 09:37:54 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509272064; Read time: 56; Write time: 374272 09:37:54 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 238858240; Read time: 0; Write time: 251528 09:37:54 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269815808; Read time: 56; Write time: 122744 09:37:54 INFO - Running post-run listener: _upload_blobber_files 09:37:54 INFO - Blob upload gear active. 09:37:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:37:54 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:37:54 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:37:54 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:37:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:37:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:55 INFO - (blobuploader) - INFO - Done attempting. 09:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:56 INFO - (blobuploader) - INFO - Done attempting. 09:37:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:56 INFO - Return code: 0 09:37:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:37:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/721491f4add62308dd8e06977df4d92225195955c20365020ee249cd01610052c9969afdb26335df172d2ae839b34a95a3cb9e18b4bf1872085f237e2da0c8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e56701e8e83f1e00ea6a0a0a766f742fb9dfeb08cd9dda17b41607a50f883877ec403d353afe5bb97bc5a5952496cdeecb74abe1ddd32fd62e6225b493121020"} 09:37:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:37:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:37:56 INFO - Contents: 09:37:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/721491f4add62308dd8e06977df4d92225195955c20365020ee249cd01610052c9969afdb26335df172d2ae839b34a95a3cb9e18b4bf1872085f237e2da0c8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e56701e8e83f1e00ea6a0a0a766f742fb9dfeb08cd9dda17b41607a50f883877ec403d353afe5bb97bc5a5952496cdeecb74abe1ddd32fd62e6225b493121020"} 09:37:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:56 INFO - Copying logs to upload dir... 09:37:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:37:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.496689 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-25 09:37:56.367476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:37:56.370962) ========= 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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 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/721491f4add62308dd8e06977df4d92225195955c20365020ee249cd01610052c9969afdb26335df172d2ae839b34a95a3cb9e18b4bf1872085f237e2da0c8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e56701e8e83f1e00ea6a0a0a766f742fb9dfeb08cd9dda17b41607a50f883877ec403d353afe5bb97bc5a5952496cdeecb74abe1ddd32fd62e6225b493121020"} build_url:https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/ev6SC7MrQma6cuYKyHoFVQ/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/721491f4add62308dd8e06977df4d92225195955c20365020ee249cd01610052c9969afdb26335df172d2ae839b34a95a3cb9e18b4bf1872085f237e2da0c8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e56701e8e83f1e00ea6a0a0a766f742fb9dfeb08cd9dda17b41607a50f883877ec403d353afe5bb97bc5a5952496cdeecb74abe1ddd32fd62e6225b493121020"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 09:37:56.400124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:37:56.400891) ========= 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=cbe409c6de289db6ac707de3000001d4-1453742212.740547-1838187731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 09:37:56.481810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:37:56.482181) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 09:37:56.482548) ========= ========= Total master_lag: 0.31 =========