builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1454489652.83 results: success (0) buildid: 20160202192940 builduid: 8723079d68654dfea5b6915ba774e72d revision: 52d03258c7446174ae3f47d1ab9d687acdb4eee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.833211) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.833927) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.834212) ========= 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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.885562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.885847) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.910950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.911424) ========= 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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.974643) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.975142) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.975761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:12.976275) ========= 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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-03 00:54:13-- 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% 225M=0s 2016-02-03 00:54:13 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.169156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.169446) ========= 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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017717 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.229674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.230038) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 52d03258c7446174ae3f47d1ab9d687acdb4eee3 --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 52d03258c7446174ae3f47d1ab9d687acdb4eee3 --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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-03 00:54:13,980 truncating revision to first 12 chars 2016-02-03 00:54:13,980 Setting DEBUG logging. 2016-02-03 00:54:13,980 attempt 1/10 2016-02-03 00:54:13,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/52d03258c744?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-03 00:54:14,244 unpacking tar archive at: mozilla-aurora-52d03258c744/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539737 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.782348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.782672) ========= echo 52d03258c7446174ae3f47d1ab9d687acdb4eee3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'52d03258c7446174ae3f47d1ab9d687acdb4eee3'] 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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 52d03258c7446174ae3f47d1ab9d687acdb4eee3 program finished with exit code 0 elapsedTime=0.004619 script_repo_revision: '52d03258c7446174ae3f47d1ab9d687acdb4eee3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.832377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.832694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 00:54:13.842539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-03 00:54:13.842910) ========= /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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:54:14 INFO - MultiFileLogger online at 20160203 00:54:14 in /builds/slave/test-pgo 00:54:14 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 00:54:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:54:14 INFO - {'append_to_log': False, 00:54:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:54:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:54:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:54:14 INFO - 'branch': 'Mozilla-Aurora', 00:54:14 INFO - 'buildbot_json_path': 'buildprops.json', 00:54:14 INFO - 'config_files': ('talos/linux_config.py',), 00:54:14 INFO - 'default_actions': ('clobber', 00:54:14 INFO - 'read-buildbot-config', 00:54:14 INFO - 'download-and-extract', 00:54:14 INFO - 'populate-webroot', 00:54:14 INFO - 'create-virtualenv', 00:54:14 INFO - 'install', 00:54:14 INFO - 'run-tests'), 00:54:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:54:14 INFO - 'download_minidump_stackwalk': True, 00:54:14 INFO - 'download_symbols': 'ondemand', 00:54:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:54:14 INFO - 'tooltool.py': '/tools/tooltool.py', 00:54:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:54:14 INFO - '/tools/misc-python/virtualenv.py')}, 00:54:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:54:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:54:14 INFO - 'installer_path': 'installer.exe', 00:54:14 INFO - 'log_level': 'info', 00:54:14 INFO - 'log_name': 'talos', 00:54:14 INFO - 'log_to_console': True, 00:54:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:54:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:54:14 INFO - 'opt_config_files': (), 00:54:14 INFO - 'pip_index': False, 00:54:14 INFO - 'sps_profile': False, 00:54:14 INFO - 'sps_profile_interval': 0, 00:54:14 INFO - 'suite': 'dromaeojs-e10s', 00:54:14 INFO - 'system_bits': '32', 00:54:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:54:14 INFO - 'title': 'talos-linux64-ix-055', 00:54:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:54:14 INFO - 'use_talos_json': True, 00:54:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:54:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:54:14 INFO - 'work_dir': 'build'} 00:54:14 INFO - ##### 00:54:14 INFO - ##### Running clobber step. 00:54:14 INFO - ##### 00:54:14 INFO - Running pre-action listener: _resource_record_pre_action 00:54:14 INFO - Running main action method: clobber 00:54:14 INFO - rmtree: /builds/slave/test-pgo/build 00:54:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:54:15 INFO - Running post-action listener: _resource_record_post_action 00:54:15 INFO - ##### 00:54:15 INFO - ##### Running read-buildbot-config step. 00:54:15 INFO - ##### 00:54:15 INFO - Running pre-action listener: _resource_record_pre_action 00:54:15 INFO - Running main action method: read_buildbot_config 00:54:15 INFO - Using buildbot properties: 00:54:15 INFO - { 00:54:15 INFO - "project": "", 00:54:15 INFO - "product": "firefox", 00:54:15 INFO - "script_repo_revision": "production", 00:54:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 00:54:15 INFO - "repository": "", 00:54:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 00:54:15 INFO - "buildid": "20160202192940", 00:54:15 INFO - "pgo_build": "True", 00:54:15 INFO - "basedir": "/builds/slave/test-pgo", 00:54:15 INFO - "buildnumber": 105, 00:54:15 INFO - "slavename": "talos-linux64-ix-055", 00:54:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:54:15 INFO - "platform": "ubuntu64_hw", 00:54:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:54:15 INFO - "branch": "mozilla-aurora", 00:54:15 INFO - "repo_path": "releases/mozilla-aurora", 00:54:15 INFO - "revision": "52d03258c7446174ae3f47d1ab9d687acdb4eee3", 00:54:15 INFO - "stage_platform": "linux64-pgo", 00:54:15 INFO - "builduid": "8723079d68654dfea5b6915ba774e72d", 00:54:15 INFO - "slavebuilddir": "test" 00:54:15 INFO - } 00:54:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 00:54:15 INFO - Running post-action listener: _resource_record_post_action 00:54:15 INFO - ##### 00:54:15 INFO - ##### Running download-and-extract step. 00:54:15 INFO - ##### 00:54:15 INFO - Running pre-action listener: _resource_record_pre_action 00:54:15 INFO - Running main action method: download_and_extract 00:54:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:15 INFO - https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/test_packages.json 00:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/test_packages.json 00:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:54:25 INFO - Downloaded 1448 bytes. 00:54:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:54:25 INFO - Using the following test package requirements: 00:54:25 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 00:54:25 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:54:25 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:54:25 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'jsshell-linux-x86_64.zip'], 00:54:25 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:54:25 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 00:54:25 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:54:25 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:54:25 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:54:25 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 00:54:25 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 00:54:25 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:54:25 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:54:25 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')]} 00:54:25 INFO - https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 00:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 00:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:32 INFO - Downloaded 22399036 bytes. 00:54:32 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'] 00:54:32 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 00:54:33 INFO - Return code: 0 00:54:33 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 00:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:33 INFO - https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 00:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 00:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:36 INFO - Downloaded 22399036 bytes. 00:54:36 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'] 00:54:36 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 00:54:38 INFO - Return code: 0 00:54:38 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')]} 00:54:38 INFO - https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 00:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 00:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:39 INFO - Downloaded 10706572 bytes. 00:54:39 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'] 00:54:39 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 00:54:39 INFO - Return code: 0 00:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:39 INFO - https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 00:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 00:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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 00:54:41 INFO - Downloaded 59582334 bytes. 00:54:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 00:54:41 INFO - mkdir: /builds/slave/test-pgo/properties 00:54:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:54:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:54:41 INFO - Contents: 00:54:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 00:54:41 INFO - Running post-action listener: _resource_record_post_action 00:54:41 INFO - Running post-action listener: set_extra_try_arguments 00:54:41 INFO - ##### 00:54:41 INFO - ##### Running populate-webroot step. 00:54:41 INFO - ##### 00:54:41 INFO - Running pre-action listener: _resource_record_pre_action 00:54:41 INFO - Running main action method: populate_webroot 00:54:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:54:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:54:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:54:41 INFO - '--tppagecycles', 00:54:41 INFO - '7'], 00:54:41 INFO - 'tests': ['tsvgm']}}, 00:54:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:54:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:54:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:54:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:54:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'tests': ['damp', 'tps']}, 00:54:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['damp', 'tps']}, 00:54:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:54:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:54:41 INFO - 'other': {'tests': ['a11yr', 00:54:41 INFO - 'ts_paint', 00:54:41 INFO - 'tpaint', 00:54:41 INFO - 'sessionrestore', 00:54:41 INFO - 'sessionrestore_no_auto_restore']}, 00:54:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['a11yr', 00:54:41 INFO - 'ts_paint', 00:54:41 INFO - 'tpaint', 00:54:41 INFO - 'sessionrestore', 00:54:41 INFO - 'sessionrestore_no_auto_restore']}, 00:54:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['a11yr', 00:54:41 INFO - 'ts_paint', 00:54:41 INFO - 'tpaint', 00:54:41 INFO - 'sessionrestore', 00:54:41 INFO - 'sessionrestore_no_auto_restore']}, 00:54:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['a11yr', 00:54:41 INFO - 'ts_paint', 00:54:41 INFO - 'tpaint', 00:54:41 INFO - 'sessionrestore', 00:54:41 INFO - 'sessionrestore_no_auto_restore']}, 00:54:41 INFO - 'other_l64': {'tests': ['a11yr', 00:54:41 INFO - 'ts_paint', 00:54:41 INFO - 'tpaint', 00:54:41 INFO - 'sessionrestore', 00:54:41 INFO - 'sessionrestore_no_auto_restore']}, 00:54:41 INFO - 'other_nol64': {'tests': ['a11yr', 00:54:41 INFO - 'ts_paint', 00:54:41 INFO - 'tpaint', 00:54:41 INFO - 'sessionrestore', 00:54:41 INFO - 'sessionrestore_no_auto_restore']}, 00:54:41 INFO - 'svgr': {'tests': ['tsvgx', 00:54:41 INFO - 'tsvgr_opacity', 00:54:41 INFO - 'tart', 00:54:41 INFO - 'tscrollx', 00:54:41 INFO - 'cart']}, 00:54:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['tsvgx', 00:54:41 INFO - 'tsvgr_opacity', 00:54:41 INFO - 'tart', 00:54:41 INFO - 'tscrollx', 00:54:41 INFO - 'cart']}, 00:54:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'tests': ['tp5o']}, 00:54:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'talos_options': ['--e10s'], 00:54:41 INFO - 'tests': ['tp5o']}, 00:54:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'talos_options': ['--xperf_path', 00:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:41 INFO - 'tests': ['tp5n']}, 00:54:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:41 INFO - 'talos_options': ['--e10s', 00:54:41 INFO - '--xperf_path', 00:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:41 INFO - 'tests': ['tp5n']}}, 00:54:41 INFO - 'talos.zip': {'path': '', 00:54:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:54:41 INFO - Running post-action listener: _resource_record_post_action 00:54:41 INFO - ##### 00:54:41 INFO - ##### Running create-virtualenv step. 00:54:41 INFO - ##### 00:54:41 INFO - Running pre-action listener: _resource_record_pre_action 00:54:41 INFO - Running main action method: create_virtualenv 00:54:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:54:41 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 00:54:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:54:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:54:41 INFO - Using real prefix '/usr' 00:54:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:54:41 INFO - Installing distribute.............................................................................................................................................................................................done. 00:54:43 INFO - Installing pip.................done. 00:54:43 INFO - Return code: 0 00:54:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:54:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:54:43 INFO - Using env: {'DISPLAY': ':0', 00:54:43 INFO - 'HOME': '/home/cltbld', 00:54:43 INFO - 'LANG': 'en_US.UTF-8', 00:54:43 INFO - 'LANGUAGE': 'en_US:en', 00:54:43 INFO - 'LOGNAME': 'cltbld', 00:54:43 INFO - 'MAIL': '/var/mail/cltbld', 00:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:43 INFO - 'MOZ_NO_REMOTE': '1', 00:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:43 INFO - 'NO_EM_RESTART': '1', 00:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:43 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:43 INFO - 'SHELL': '/bin/bash', 00:54:43 INFO - 'SHLVL': '1', 00:54:43 INFO - 'TERM': 'linux', 00:54:43 INFO - 'TMOUT': '86400', 00:54:43 INFO - 'USER': 'cltbld', 00:54:43 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:43 INFO - '_': '/tools/buildbot/bin/python'} 00:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:43 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 00:54:43 INFO - Cleaning up... 00:54:43 INFO - Return code: 0 00:54:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:44 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 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:44 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 00:54:44 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 00:54:44 INFO - Using env: {'DISPLAY': ':0', 00:54:44 INFO - 'HOME': '/home/cltbld', 00:54:44 INFO - 'LANG': 'en_US.UTF-8', 00:54:44 INFO - 'LANGUAGE': 'en_US:en', 00:54:44 INFO - 'LOGNAME': 'cltbld', 00:54:44 INFO - 'MAIL': '/var/mail/cltbld', 00:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:44 INFO - 'MOZ_NO_REMOTE': '1', 00:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:44 INFO - 'NO_EM_RESTART': '1', 00:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:44 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:44 INFO - 'SHELL': '/bin/bash', 00:54:44 INFO - 'SHLVL': '1', 00:54:44 INFO - 'TERM': 'linux', 00:54:44 INFO - 'TMOUT': '86400', 00:54:44 INFO - 'USER': 'cltbld', 00:54:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:44 INFO - '_': '/tools/buildbot/bin/python'} 00:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:44 INFO - Downloading/unpacking psutil>=0.7.1 00:54:44 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 00:54:44 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 00:54:44 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 00:54:44 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 00:54:44 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 00:54:44 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 00:54:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:46 INFO - Installing collected packages: psutil 00:54:46 INFO - Running setup.py install for psutil 00:54:46 INFO - building 'psutil._psutil_linux' extension 00:54:46 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 00:54:46 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 00:54:46 INFO - building 'psutil._psutil_posix' extension 00:54:46 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 00:54:46 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 00:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:46 INFO - Successfully installed psutil 00:54:46 INFO - Cleaning up... 00:54:46 INFO - Return code: 0 00:54:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 00:54:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:54:46 INFO - Using env: {'DISPLAY': ':0', 00:54:46 INFO - 'HOME': '/home/cltbld', 00:54:46 INFO - 'LANG': 'en_US.UTF-8', 00:54:46 INFO - 'LANGUAGE': 'en_US:en', 00:54:46 INFO - 'LOGNAME': 'cltbld', 00:54:46 INFO - 'MAIL': '/var/mail/cltbld', 00:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:46 INFO - 'MOZ_NO_REMOTE': '1', 00:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:46 INFO - 'NO_EM_RESTART': '1', 00:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:46 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:46 INFO - 'SHELL': '/bin/bash', 00:54:46 INFO - 'SHLVL': '1', 00:54:46 INFO - 'TERM': 'linux', 00:54:46 INFO - 'TMOUT': '86400', 00:54:46 INFO - 'USER': 'cltbld', 00:54:46 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:46 INFO - '_': '/tools/buildbot/bin/python'} 00:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:54:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:54:48 INFO - Installing collected packages: mozsystemmonitor 00:54:48 INFO - Running setup.py install for mozsystemmonitor 00:54:48 INFO - Successfully installed mozsystemmonitor 00:54:48 INFO - Cleaning up... 00:54:48 INFO - Return code: 0 00:54:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:54:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:54:48 INFO - Using env: {'DISPLAY': ':0', 00:54:48 INFO - 'HOME': '/home/cltbld', 00:54:48 INFO - 'LANG': 'en_US.UTF-8', 00:54:48 INFO - 'LANGUAGE': 'en_US:en', 00:54:48 INFO - 'LOGNAME': 'cltbld', 00:54:48 INFO - 'MAIL': '/var/mail/cltbld', 00:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:48 INFO - 'MOZ_NO_REMOTE': '1', 00:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:48 INFO - 'NO_EM_RESTART': '1', 00:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:48 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:48 INFO - 'SHELL': '/bin/bash', 00:54:48 INFO - 'SHLVL': '1', 00:54:48 INFO - 'TERM': 'linux', 00:54:48 INFO - 'TMOUT': '86400', 00:54:48 INFO - 'USER': 'cltbld', 00:54:48 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:48 INFO - '_': '/tools/buildbot/bin/python'} 00:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:49 INFO - Downloading/unpacking blobuploader==1.2.4 00:54:49 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 00:54:49 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 00:54:49 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 00:54:49 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 00:54:49 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 00:54:49 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 00:54:50 INFO - Downloading blobuploader-1.2.4.tar.gz 00:54:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:54:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:54:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 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 00:54:51 INFO - Downloading docopt-0.6.1.tar.gz 00:54:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:54:51 INFO - Installing collected packages: blobuploader, requests, docopt 00:54:51 INFO - Running setup.py install for blobuploader 00:54:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:54:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:54:51 INFO - Running setup.py install for requests 00:54:52 INFO - Running setup.py install for docopt 00:54:52 INFO - Successfully installed blobuploader requests docopt 00:54:52 INFO - Cleaning up... 00:54:52 INFO - Return code: 0 00:54:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:52 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 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:52 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 00:54:52 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 00:54:52 INFO - Using env: {'DISPLAY': ':0', 00:54:52 INFO - 'HOME': '/home/cltbld', 00:54:52 INFO - 'LANG': 'en_US.UTF-8', 00:54:52 INFO - 'LANGUAGE': 'en_US:en', 00:54:52 INFO - 'LOGNAME': 'cltbld', 00:54:52 INFO - 'MAIL': '/var/mail/cltbld', 00:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:52 INFO - 'MOZ_NO_REMOTE': '1', 00:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:52 INFO - 'NO_EM_RESTART': '1', 00:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:52 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:52 INFO - 'SHELL': '/bin/bash', 00:54:52 INFO - 'SHLVL': '1', 00:54:52 INFO - 'TERM': 'linux', 00:54:52 INFO - 'TMOUT': '86400', 00:54:52 INFO - 'USER': 'cltbld', 00:54:52 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:52 INFO - '_': '/tools/buildbot/bin/python'} 00:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:54:52 INFO - Running setup.py (path:/tmp/pip-ssdMMk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:54:52 INFO - Running setup.py (path:/tmp/pip-WuEP9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:54:52 INFO - Running setup.py (path:/tmp/pip-VMFCGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:54:52 INFO - Running setup.py (path:/tmp/pip-s5fOWT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:54:52 INFO - Running setup.py (path:/tmp/pip-Ua3ohj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:54:52 INFO - Running setup.py (path:/tmp/pip-pvF83t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:54:52 INFO - Running setup.py (path:/tmp/pip-4Yf8Tx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:54:53 INFO - Running setup.py (path:/tmp/pip-AAdQUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:54:53 INFO - Running setup.py (path:/tmp/pip-zaAJjj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:54:53 INFO - Running setup.py (path:/tmp/pip-QFOhPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:54:53 INFO - Running setup.py (path:/tmp/pip-gLfdfX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:54:53 INFO - Running setup.py (path:/tmp/pip-i9GiOH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:54:53 INFO - Running setup.py (path:/tmp/pip-w_lcE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:54:53 INFO - Running setup.py (path:/tmp/pip-MWw96u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:54:53 INFO - Running setup.py (path:/tmp/pip-DgEnQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:54:53 INFO - Running setup.py (path:/tmp/pip-_gyXoC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:54:53 INFO - Running setup.py (path:/tmp/pip-XO5yXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:54:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:54:53 INFO - Running setup.py install for manifestparser 00:54:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:54:53 INFO - Running setup.py install for mozcrash 00:54:53 INFO - Running setup.py install for mozdebug 00:54:54 INFO - Running setup.py install for mozdevice 00:54:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Running setup.py install for mozfile 00:54:54 INFO - Running setup.py install for mozhttpd 00:54:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Running setup.py install for mozinfo 00:54:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Running setup.py install for mozInstall 00:54:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Running setup.py install for mozleak 00:54:54 INFO - Running setup.py install for mozlog 00:54:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Running setup.py install for moznetwork 00:54:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:54:54 INFO - Running setup.py install for mozprocess 00:54:54 INFO - Running setup.py install for mozprofile 00:54:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:54:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:54:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:54:55 INFO - Running setup.py install for mozrunner 00:54:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:54:55 INFO - Running setup.py install for mozscreenshot 00:54:55 INFO - Running setup.py install for moztest 00:54:55 INFO - Running setup.py install for mozversion 00:54:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:54:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:54:55 INFO - Cleaning up... 00:54:55 INFO - Return code: 0 00:54:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:54: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')]} 00:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54: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')]} 00:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:55 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 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:55 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 00:54:55 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 00:54:55 INFO - Using env: {'DISPLAY': ':0', 00:54:55 INFO - 'HOME': '/home/cltbld', 00:54:55 INFO - 'LANG': 'en_US.UTF-8', 00:54:55 INFO - 'LANGUAGE': 'en_US:en', 00:54:55 INFO - 'LOGNAME': 'cltbld', 00:54:55 INFO - 'MAIL': '/var/mail/cltbld', 00:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:55 INFO - 'MOZ_NO_REMOTE': '1', 00:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:55 INFO - 'NO_EM_RESTART': '1', 00:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:55 INFO - 'SHELL': '/bin/bash', 00:54:55 INFO - 'SHLVL': '1', 00:54:55 INFO - 'TERM': 'linux', 00:54:55 INFO - 'TMOUT': '86400', 00:54:55 INFO - 'USER': 'cltbld', 00:54:55 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:55 INFO - '_': '/tools/buildbot/bin/python'} 00:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:54:55 INFO - Running setup.py (path:/tmp/pip-Wx5fsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:54:55 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)) 00:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:54:55 INFO - Running setup.py (path:/tmp/pip-lFguvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:54:55 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)) 00:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:54:55 INFO - Running setup.py (path:/tmp/pip-yj9HNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:54:55 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)) 00:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:54:55 INFO - Running setup.py (path:/tmp/pip-dvwOjr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:54:56 INFO - Running setup.py (path:/tmp/pip-67V3wv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:54:56 INFO - Running setup.py (path:/tmp/pip-WQhC4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:54:56 INFO - Running setup.py (path:/tmp/pip-CZQkS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:54:56 INFO - Running setup.py (path:/tmp/pip-fAb22z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:54:56 INFO - Running setup.py (path:/tmp/pip-vhhecO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:54:56 INFO - Running setup.py (path:/tmp/pip-XPXGPX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:54:56 INFO - Running setup.py (path:/tmp/pip-hEHihm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:54:56 INFO - Running setup.py (path:/tmp/pip-zhBhmw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:54:56 INFO - Running setup.py (path:/tmp/pip-1WYxJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:54:56 INFO - Running setup.py (path:/tmp/pip-cQ2NZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:54:56 INFO - Running setup.py (path:/tmp/pip-3qxWnk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:54:56 INFO - Running setup.py (path:/tmp/pip-S4fljI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:54:56 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)) 00:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:54:56 INFO - Running setup.py (path:/tmp/pip-UJLds_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:54:56 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)) 00:54:56 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)) 00:54:56 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)) 00:54:56 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)) 00:54:56 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)) 00:54:56 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)) 00:54:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:54:56 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 00:54:56 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 00:54:56 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 00:54:56 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 00:54:56 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 00:54:56 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 00:54:58 INFO - Downloading blessings-1.6.tar.gz 00:54:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:54:58 INFO - Installing collected packages: blessings 00:54:58 INFO - Running setup.py install for blessings 00:54:58 INFO - Successfully installed blessings 00:54:58 INFO - Cleaning up... 00:54:58 INFO - Return code: 0 00:54:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:54:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:54:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:54:59 INFO - Reading from file tmpfile_stdout 00:54:59 INFO - Current package versions: 00:54:59 INFO - argparse == 1.2.1 00:54:59 INFO - blessings == 1.6 00:54:59 INFO - blobuploader == 1.2.4 00:54:59 INFO - docopt == 0.6.1 00:54:59 INFO - manifestparser == 1.1 00:54:59 INFO - mozInstall == 1.12 00:54:59 INFO - mozcrash == 0.16 00:54:59 INFO - mozdebug == 0.1 00:54:59 INFO - mozdevice == 0.48 00:54:59 INFO - mozfile == 1.2 00:54:59 INFO - mozhttpd == 0.7 00:54:59 INFO - mozinfo == 0.9 00:54:59 INFO - mozleak == 0.1 00:54:59 INFO - mozlog == 3.1 00:54:59 INFO - moznetwork == 0.27 00:54:59 INFO - mozprocess == 0.22 00:54:59 INFO - mozprofile == 0.28 00:54:59 INFO - mozrunner == 6.11 00:54:59 INFO - mozscreenshot == 0.1 00:54:59 INFO - mozsystemmonitor == 0.0 00:54:59 INFO - moztest == 0.7 00:54:59 INFO - mozversion == 1.4 00:54:59 INFO - psutil == 3.1.1 00:54:59 INFO - requests == 1.2.3 00:54:59 INFO - wsgiref == 0.1.2 00:54:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:59 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 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:59 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 00:54:59 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 00:54:59 INFO - Using env: {'DISPLAY': ':0', 00:54:59 INFO - 'HOME': '/home/cltbld', 00:54:59 INFO - 'LANG': 'en_US.UTF-8', 00:54:59 INFO - 'LANGUAGE': 'en_US:en', 00:54:59 INFO - 'LOGNAME': 'cltbld', 00:54:59 INFO - 'MAIL': '/var/mail/cltbld', 00:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:59 INFO - 'MOZ_NO_REMOTE': '1', 00:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:59 INFO - 'NO_EM_RESTART': '1', 00:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:59 INFO - 'SHELL': '/bin/bash', 00:54:59 INFO - 'SHLVL': '1', 00:54:59 INFO - 'TERM': 'linux', 00:54:59 INFO - 'TMOUT': '86400', 00:54:59 INFO - 'USER': 'cltbld', 00:54:59 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:59 INFO - '_': '/tools/buildbot/bin/python'} 00:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 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)) 00:54:59 INFO - Cleaning up... 00:54:59 INFO - Return code: 0 00:54:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:54:59 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 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:54:59 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 00:54:59 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 00:54:59 INFO - Using env: {'DISPLAY': ':0', 00:54:59 INFO - 'HOME': '/home/cltbld', 00:54:59 INFO - 'LANG': 'en_US.UTF-8', 00:54:59 INFO - 'LANGUAGE': 'en_US:en', 00:54:59 INFO - 'LOGNAME': 'cltbld', 00:54:59 INFO - 'MAIL': '/var/mail/cltbld', 00:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:59 INFO - 'MOZ_NO_REMOTE': '1', 00:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:59 INFO - 'NO_EM_RESTART': '1', 00:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 00:54:59 INFO - 'SHELL': '/bin/bash', 00:54:59 INFO - 'SHLVL': '1', 00:54:59 INFO - 'TERM': 'linux', 00:54:59 INFO - 'TMOUT': '86400', 00:54:59 INFO - 'USER': 'cltbld', 00:54:59 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:59 INFO - '_': '/tools/buildbot/bin/python'} 00:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:59 INFO - Downloading/unpacking jsonschema 00:54:59 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 00:54:59 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 00:54:59 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 00:54:59 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 00:54:59 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 00:54:59 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 00:55:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:55:01 INFO - Downloading/unpacking functools32 (from jsonschema) 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:01 INFO - Downloading functools32-3.2.3-2.tar.gz 00:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:55:01 INFO - warning: no files found matching '*.txt' 00:55:01 INFO - no previously-included directories found matching 'build' 00:55:01 INFO - no previously-included directories found matching 'dist' 00:55:01 INFO - no previously-included directories found matching '.git*' 00:55:01 INFO - Installing collected packages: jsonschema, functools32 00:55:01 INFO - Running setup.py install for functools32 00:55:01 INFO - warning: no files found matching '*.txt' 00:55:01 INFO - no previously-included directories found matching 'build' 00:55:01 INFO - no previously-included directories found matching 'dist' 00:55:01 INFO - no previously-included directories found matching '.git*' 00:55:01 INFO - Successfully installed jsonschema functools32 00:55:01 INFO - Cleaning up... 00:55:01 INFO - Return code: 0 00:55:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:55: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')]} 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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')]} 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4fc01daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, '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': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', '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 00:55:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 00:55:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:55:01 INFO - Using env: {'DISPLAY': ':0', 00:55:01 INFO - 'HOME': '/home/cltbld', 00:55:01 INFO - 'LANG': 'en_US.UTF-8', 00:55:01 INFO - 'LANGUAGE': 'en_US:en', 00:55:01 INFO - 'LOGNAME': 'cltbld', 00:55:01 INFO - 'MAIL': '/var/mail/cltbld', 00:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:01 INFO - 'MOZ_NO_REMOTE': '1', 00:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:01 INFO - 'NO_EM_RESTART': '1', 00:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:55:01 INFO - 'PWD': '/builds/slave/test-pgo', 00:55:01 INFO - 'SHELL': '/bin/bash', 00:55:01 INFO - 'SHLVL': '1', 00:55:01 INFO - 'TERM': 'linux', 00:55:01 INFO - 'TMOUT': '86400', 00:55:01 INFO - 'USER': 'cltbld', 00:55:01 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:01 INFO - '_': '/tools/buildbot/bin/python'} 00:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:02 INFO - Downloading/unpacking flake8 00:55:02 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 00:55:02 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 00:55:02 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 00:55:02 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 00:55:02 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 00:55:02 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 00:55:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:55:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:55:03 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 00:55:03 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 00:55:03 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 00:55:03 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 00:55:03 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 00:55:03 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 00:55:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:55:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:55:04 INFO - no previously-included directories found matching 'docs/_build' 00:55:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:55:04 INFO - Running setup.py install for pep8 00:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:55:04 INFO - no previously-included directories found matching 'docs/_build' 00:55:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:55:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:55:04 INFO - Cleaning up... 00:55:04 INFO - Return code: 0 00:55:04 INFO - Running post-action listener: _resource_record_post_action 00:55:04 INFO - Running post-action listener: _start_resource_monitoring 00:55:04 INFO - Starting resource monitoring. 00:55:04 INFO - ##### 00:55:04 INFO - ##### Running install step. 00:55:04 INFO - ##### 00:55:04 INFO - Running pre-action listener: _resource_record_pre_action 00:55:04 INFO - Running main action method: install 00:55:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:55:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:55:04 INFO - Reading from file tmpfile_stdout 00:55:04 INFO - Detecting whether we're running mozinstall >=1.0... 00:55:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:55:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:55:05 INFO - Reading from file tmpfile_stdout 00:55:05 INFO - Output received: 00:55:05 INFO - Usage: mozinstall [options] installer 00:55:05 INFO - Options: 00:55:05 INFO - -h, --help show this help message and exit 00:55:05 INFO - -d DEST, --destination=DEST 00:55:05 INFO - Directory to install application into. [default: 00:55:05 INFO - "/builds/slave/test-pgo"] 00:55:05 INFO - --app=APP Application being installed. [default: firefox] 00:55:05 INFO - mkdir: /builds/slave/test-pgo/build/application 00:55:05 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'] 00:55:05 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 00:55:19 INFO - Reading from file tmpfile_stdout 00:55:19 INFO - Output received: 00:55:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:55:19 INFO - Running post-action listener: _resource_record_post_action 00:55:19 INFO - ##### 00:55:19 INFO - ##### Running run-tests step. 00:55:19 INFO - ##### 00:55:19 INFO - Running pre-action listener: _resource_record_pre_action 00:55:19 INFO - Running main action method: run_tests 00:55:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:55:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:55:20 INFO - Python 2.7.3 00:55:20 INFO - Return code: 0 00:55:20 INFO - grabbing minidump binary from tooltool 00:55:20 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')]} 00:55:20 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 0x22937f0>, '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 0x21ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:55:20 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 00:55:20 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 00:55:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:55:20 INFO - Return code: 0 00:55:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:55:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:55:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:55:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:55:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:55:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:55:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:55:21 INFO - Return code: 0 00:55:21 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/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 00:55:21 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/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 00:55:21 INFO - Using env: {'DISPLAY': ':0', 00:55:21 INFO - 'HOME': '/home/cltbld', 00:55:21 INFO - 'LANG': 'en_US.UTF-8', 00:55:21 INFO - 'LANGUAGE': 'en_US:en', 00:55:21 INFO - 'LOGNAME': 'cltbld', 00:55:21 INFO - 'MAIL': '/var/mail/cltbld', 00:55:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:55:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:21 INFO - 'MOZ_NO_REMOTE': '1', 00:55:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:21 INFO - 'NO_EM_RESTART': '1', 00:55:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:55:21 INFO - 'PWD': '/builds/slave/test-pgo', 00:55:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:55:21 INFO - 'SHELL': '/bin/bash', 00:55:21 INFO - 'SHLVL': '1', 00:55:21 INFO - 'TERM': 'linux', 00:55:21 INFO - 'TMOUT': '86400', 00:55:21 INFO - 'USER': 'cltbld', 00:55:21 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807', 00:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:21 INFO - '_': '/tools/buildbot/bin/python'} 00:55:21 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/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 00:55:21 INFO - mozversion application_buildid: 20160202192940 00:55:21 INFO - mozversion application_changeset: 52d03258c7446174ae3f47d1ab9d687acdb4eee3 00:55:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:55:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:55:21 INFO - mozversion application_name: Firefox 00:55:21 INFO - mozversion application_remotingname: firefox-dev 00:55:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:55:21 INFO - mozversion application_vendor: Mozilla 00:55:21 INFO - mozversion application_version: 46.0a2 00:55:21 INFO - mozversion platform_buildid: 20160202192940 00:55:21 INFO - mozversion platform_changeset: 52d03258c7446174ae3f47d1ab9d687acdb4eee3 00:55:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:55:21 INFO - mozversion platform_version: 46.0a2 00:55:21 INFO - using testdate: 1454489721 00:55:21 INFO - actual date: 1454489721 00:55:21 INFO - starting webserver on 'localhost:44889' 00:55:21 INFO - SUITE-START | Running 3 tests 00:55:21 INFO - TEST-START | dromaeo_css 00:55:21 INFO - operating with platform_type : linux_ 00:55:21 INFO - Initialising browser for dromaeo_css test... 00:55:21 INFO - TEST-INFO | started process 16744 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnmk5V4/profile http://localhost:44889/getInfo.html) 00:55:24 INFO - PROCESS | 16744 | 00:55:24 INFO - PROCESS | 16744 | (process:16826): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:55:25 INFO - PROCESS | 16744 | __metrics Screen width/height:1600/1200 00:55:25 INFO - PROCESS | 16744 | colorDepth:24 00:55:25 INFO - PROCESS | 16744 | Browser inner width/height: 1024/697 00:55:25 INFO - PROCESS | 16744 | __metrics 00:55:26 INFO - TEST-INFO | 16744: exit 0 00:55:26 INFO - Browser initialized. 00:55:26 INFO - Running cycle 1/1 for dromaeo_css test... 00:55:26 INFO - TEST-INFO | started process 16875 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnmk5V4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:55:27 INFO - PROCESS | 16875 | 00:55:27 INFO - PROCESS | 16875 | (process:16937): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:55:38 INFO - PROCESS | 16875 | RSS: Main: 140816384 00:55:38 INFO - PROCESS | 16875 | 00:56:28 INFO - PROCESS | 16875 | 1454489788087 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] 00:58:36 INFO - PROCESS | 16875 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44889/tests/dromaeo/cssquery-ext.html) 00:58:37 INFO - PROCESS | 16875 | RSS: Main: 145965056 00:58:37 INFO - PROCESS | 16875 | 01:01:39 INFO - PROCESS | 16875 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-ext.html (next: http://localhost:44889/tests/dromaeo/cssquery-jquery.html) 01:01:39 INFO - PROCESS | 16875 | RSS: Main: 143429632 01:01:39 INFO - PROCESS | 16875 | 01:04:41 INFO - PROCESS | 16875 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44889/tests/dromaeo/cssquery-mootools.html) 01:04:41 INFO - PROCESS | 16875 | RSS: Main: 143278080 01:04:41 INFO - PROCESS | 16875 | 01:07:43 INFO - PROCESS | 16875 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44889/tests/dromaeo/cssquery-prototype.html) 01:07:44 INFO - PROCESS | 16875 | RSS: Main: 143753216 01:07:44 INFO - PROCESS | 16875 | 01:10:46 INFO - PROCESS | 16875 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44889/tests/dromaeo/cssquery-yui.html) 01:10:47 INFO - PROCESS | 16875 | RSS: Main: 144830464 01:10:47 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-yui.html (next: http://localhost:44889/tests/dromaeo/cssquery-dojo.html) 01:13:49 INFO - PROCESS | 16875 | RSS: Main: 146669568 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | __start_tp_report 01:13:49 INFO - PROCESS | 16875 | _x_x_mozilla_page_load 01:13:49 INFO - PROCESS | 16875 | _x_x_mozilla_page_load_details 01:13:49 INFO - PROCESS | 16875 | |i|pagename|runs| 01:13:49 INFO - PROCESS | 16875 | |0;dojo.html;3380.0873764083694;3406.471996840489;3435.5362026126472;3436.50170725245;3446.8621255149797;5613.887722245553;5627.915581266274;5630.40880707526;5640.351359593648;5673;5595.49640532352;5634.9857025735355;5669.262995810549;5677.949579327827;5679.801206957757;5127.435982041972;5166.276721259008;5197.246399272122;5232.058229518685;5266.81566145185;4922.433920099199;5000.749962501878;5007.524285192901;5019.799208031693;5026.969471258383;5031.672941258825;5080.923786143211;5176.0683077046115;5273.762680679379;5294.814681486148;5146.768395422197;5175.275461435402;5198.2722418861385;5199.792008319662;5201.1678131498775;5059.595232381401;5060.2156665716875;5158.277841102249;5170.534651881311;5198.40218374888;5337.572994160497;5358.624896257264;5405.567554595662;5458.972705136489;5478.178273259004;6084.878302433971;6091.756329746805;6094.634321940698;6107.114468402056;6110.419510146529;5975.671338076404;6112.908306375408;6122.96938515309;6129.111278864584;6164.321924588292;5565.443455654402;5656.377798442168;5719.28508936383;5737.799177028784;5753.252077229933;6075.605085669417;6078.787242446581;6081.878362432815;6107.664078475637;6127.387261273926;5831.591788574844;5838.5037271831525;5881.794137205177;5899.085641725454;5908.704564771744;5879.52963762898;6037.486813620892;6040.426159514839;6044.365341639153;6083.695815209222;5980.342162362137;5986.07215881539;5986.49114825236;5993.520518358521;6002.849928751816;5812.564057695689;5900.321463031721;5995.790147344822;6022.789202377896;6038.728257228435;4552.681312308173;4599.701019433726;4602.263637817933;4609.562091601292;4631.073785242965;4117.464729585135;4130.504339479282;4141.5237247716295;4145.626893579532;4174.7077704561;5563.693996830213;5625.859353516113;5665.688387138664;5722.37053924068;5741.368449470555;6046.788362407383;6056.848578785565;6074.3925607438905;6078.088286757022;6086.421789929949;5712.914306285409;5742;5744.655320680772;5751.367349591542;5756.366799652119;5029.572486338702;5038.143515602356;5077.593792496591;5117.104506711311;5136.306598609214;6107.206063211843;6140.5701600887505;6151.507879369639;6168.321484636686;6170.907436388457;6040.305364883095;6060.878782424327;6069.150318955438;6071;6072.483838873569;6017.789377371771;6157.076438534255;6215.254169499689;6232.25212974446;6271.122042913905;5926.2295901532525;5934.050551911846;5973.49225315853;5988.131720900532;5991.071383935497;5879.911801322898;5938.6436813791315;6022.668753218615;6037.516998640186;6059.33347331802;5721.942780572307;5801.071828507418;5846.093855452412;5912.46787789101;5918.911216331672;5771.740271687868;5824.912626310524;5825;5826.184334193301;5833.270841144857;5664;5691.686957217393;5744.770209191753;5745.597808153556;5752.395998420106;5889.528837692888;5906.143609176731;6008.279006519246;6018.939810601838;6029.9698501508965;5815.185873977562;5846.473817356458;5867.442592953663;5873.647581145145;5900.1149827526215 01:13:49 INFO - PROCESS | 16875 | |1;ext.html;559.1473003669404;586.217399771305;589.2663633775949;593.237689568904;621.841430435239;35931;36171.27657446853;36223.63776362239;36481.45277820828;36499.63500364996;36698.08254793631;37180.256394872085;37321.440178397344;37338.4399234011;37432.81283593578;8318.500889946607;8554.61504232311;8565.571721413935;8579.871301930476;8615.396922215448;8252.174782521759;8532.957335213316;8595.355348348867;8636.481811091324;8669.69656062038;8643.740687779376;8757.299416046733;8763.51800650964;8764.21122099011;8791.472511649321;8521.44610600309;8648.740537783877;8700.651973921036;8708.608112634947;8717.171868672434;8427.662893484254;8533.402661813676;8544.914550854473;8567.400281980264;8580.313574913991;37458.812705936296;37731.245375092345;37738.62261377378;37803.24393512142;37943.241135177144;3426.5716785401823;3555.768875023141;3686.078480379905;3751.681107105899;4073.551909289976;31798.205044873834;32058;32220.677793222236;32449.837750811093;32573.511397329057;3784.735068545203;3791.6966642668795;3878.1661942682176;3920.2943470175355;3974.1058261890844;229565;229951;233201;233337.9999999983;233370;57207;58027.70986145042;64656.35343646503;65622.34377656257;65919;56165.43834561602;56284;57030.7148464255;57076.42923570711;57186.42813571894;15437;15439.30523126462;15455.613609659624;15542.689146217239;15571;13008;13151.539696110782;13169.539066132831;13171.143875648053;13301.334933253493;19944.401667949984;20217.29239476611;20286.08712607936;20306;20395;8183.877241841377;8287.378446616527;8341.95829020851;8389.370797190235;8515.574221289035;1077.256692881909;1093.1309608860975;1111.1499702727258;1114.4594871487323;1171.5021116025825;27033.324166895592;27131.593026104623;27360.45279094407;27641;27982.720172798417;1096.2326371539955;1131.7510147767478;1143.239745569187;1146.5528443906883;1185.3125187391292;14819.66623003935;14933.70132597342;15178.544643660707;15329.386824526893;15554.300056497485;782725;828491;841468;842016;854099;56746.43253567412;57532;57587.42412575905;57880.13179802307;58029.12956305659;1474.4765608209145;1488.9702205956037;1494.0886059503694;1509.2830905320104;1510.6752048309665;30037.399252014402;30303.69696303009;30779.53830692586;31412.05763827089;31673.208169795016;47001.294980576;47056;47354.289685654054;47497.762511187226;47551.52448475471;339279;342438;342949;343671;344568;32206.677933221305;43108.78445607752;43901.78049109734;44116.11767764563;44574.3313850286;40267.1946561073;41320.38019429771;48246;48385.758071210825;48496.5150348492;33844.15389615279;34547.136321591155;35058.47412288767;35580.28839423249;35651;34300.31399372048;34694.65305347015;34702.479462807576;34968;35186.296274074884;36186.09534761652;36480;36547.63452365442;36676.63323366839;42135.578644213165;29259.82960681549;30605.540916886708;30911.84544077355;30938.845305773328;31072.378552428374;25819.225423237334;26223.868880655475;26293.73706262913;26485.11028404273;26749.19752407431 01:13:49 INFO - PROCESS | 16875 | |2;jquery.html;378.8503541101263;398.205579868163;399.22550252510126;402.46070265843764;405.62479706271694;14265.144091354527;14582.343794529244;16197.352105915765;16690.749638755413;16784.999999999985;11011.788703242657;11198.104151667867;11504.884951150487;17242.913785431087;17310.740338894928;4791.832285869995;4918.114739346916;5088.7964481420695;5097.847064588068;5683.403242659523;5112.233165025257;5325.4940780625775;5326.946730532683;5336.226247194155;5537.418571050042;5345.33183352081;5350.170723537858;5532.3637781655225;5889.234399528077;5907.172995780594;5842.2405087338375;6020.6688632125215;6031.638101713889;6047.213862197908;6269.310375858652;5597.328320601513;5600.0759874620635;5602.859928501779;5620.297462817148;5642.858928526779;15304.923475382664;20437.38687839367;21229.68155477669;21341.679874801892;21505;2100.59038487495;2120.2367147826926;2252.324302709197;2263.366257447901;2326.2904814031713;9566.330356875022;9839.754006149831;10483.370997740083;10771.892281077246;14027.158370497802;1900.249401486405;1949.8245157935853;1955.5795503966574;1965.2237366240397;2010.7084472751515;58914.705426472596;59007;60089.6995515024;60701.6964915177;60739;10704.464776761131;10968.396738179477;11104.666859994213;11111.55553777856;11126.332420054661;14654.487092951695;14716.117032977842;14771;14795.186264755543;14818.925905370405;8102.675892964333;8126.715564955198;8137.064237612751;8143.063547691972;8159;7633.885491717629;7666.463347565728;7669.884951725729;7723.961380193063;7739.7678069658;4674.626029917598;4784.736839473862;4833.05755377705;4886.633502487328;4897.114610874768;2045.6829191475344;2094.455441585199;2097.25547430663;2113.091370710609;2125.978740212578;905.42053086025;967.2020583019038;1008.6268080810147;1026.5226669598671;1055.9155267578576;15513.301901414463;15879.12664803447;17313.2209050593;17554.736678949826;17829.910850445664;955.2696719311101;997.8773879385691;1007.652359935821;1079.3092420850662;1086.0605576176708;9765.121139097515;9865.309428340091;10372;10428.843567346496;10524.473776311153;418191;510885;582141;582641;586720;69917.20331186797;70517.2948270521;76635.61682191554;77635.61182194053;78697.60651196707;1153.2792004996877;1182.0366401383017;1186.2645160000682;1192.7256730951756;1193.1945936492832;15663.373465061726;15767.448139315069;15806.68386632284;15814.683706325579;16015.439459619323;31836.681633183372;32371.19072023124;32828.835855820565;33545.329093418484;36035.63964360323;41254;41581.79209104056;42257.366139507314;43122.56877431311;45181.322280165165;7775.455718099679;7836.255555722198;7943.205679432011;7975.880361794694;10020.298579099685;8332.708355207538;8462.873056904029;8519.914800851911;8538.615762290588;8629.09394513567;7672;7808.180141085104;7823.061232652118;8105.520371016853;8293.875591866248;8109.3917956152345;8195.79510512218;8235.629396677044;8335.083140854622;8465.28045116172;8283.792905177177;8293.567713147897;8476.406651534333;8500.957495212484;8583.356248281529;10741.785164296827;10742;10842.945785271024;11007.61473348429;11041.613543525938;10791.56833726642;10807.837882431613;10863.076638485818;10962.780744385227;11003.394813285026 01:13:49 INFO - PROCESS | 16875 | |3;mootools.html;1536.3700882638118;1551.9767203491942;1763.5767415820208;1880.257298367146;1913.5503156758168;8451.87322190167;8520.233179013887;8581.87127193091;8604.784880377985;8767.868481972775;8386.664533418656;8447.704330348439;8447.91552084479;8485.278751306147;8511.744647660564;2473.7402572729875;2505.436276837706;2507.285423654259;2511.158761814794;2514.7485251474795;2445.156421034749;2477.987610061947;2484.6521486991837;2486.614574740909;2495.563276426627;2407.518496300738;2430.635404689293;2448.926532204028;2505.887235074426;2509.987450062747;2443.3280847766828;2453.0678342229926;2492.713337966139;2509.422832748469;2510.79913606911;2416.673749043874;2525.217182673377;2529.418233806235;2536.822422430431;2542.8092893033095;8600.096989816042;8638.049814520398;8660.090690477535;8666.610002549838;8680.782980425476;5327.973360133214;5483.067878460632;5500.339959204881;5510.91733623996;5516.034693928546;3299.059767966118;3312.370649576597;3366.8148251846137;3402.9659703403145;3408.1309266137223;1056.9894301056968;1079.525008996047;1082.4046774274118;1107.479484642217;1107.6621630402724;11598.478068486938;11717.941410292893;11723.4138293085;11737.53049878004;11779.941100294443;4529.456465224194;4568.2690769477385;4609.124266389375;4668.836590719308;4743.596794272526;9542.856857147148;9609.663661771945;9616.182624476858;9623.615055397706;9624.711258662252;5305.469453054664;5306.09796334624;5307.9734601326745;5324.361076670824;5329.573634109262;4878.731669758126;4891.951080489221;4902.607791376681;4946.0355230729665;4958.132326842788;3818.3317919364;3924.1955399143108;3934.272159650474;3941.3693808990424;3942;1138.5445821671399;1219.951201951912;1223.2660403757852;1235.092207227687;1240.088534926828;1119.9832002519968;1125.1280257800106;1140.2474366917795;1234.623439850854;1250.4560516175493;7743.148253692089;7798.883016754753;7816.804579885435;7895.328897043815;8128.59357032146;1202.4408649977627;1204.680759598707;1206.8250103735086;1207.5449083853935;1238.120934136755;6318.62088274705;6328.873422531616;6377.904331435032;6408.61548307103;6417.871642567123;10630.681079567625;10747.247692661595;10790.244682872124;10883.23817332779;10987.340759554452;10584.841227381596;10700.732481688021;10726.624568140078;10731.570737170427;10774.138068954464;8153.1439198884445;8193.09875913649;8216.342692584698;8220.794480137925;8227.341812654973;7829.491083079582;7866.410019248465;7887.84224315499;7922.286994170552;7977.920220797718;9320;9397.483138427453;9453.810923781624;9509.476978766234;9672.08115229052;9169.816603668023;9298.070192980918;9309.953450232706;9608.66369677058;9669.516524173903;7245.601491917995;7255.09311336083;7288.380487658396;7299.5620262784405;7378;7573.886391704019;7650.120236172911;7677.155512893689;7704.6918123274445;7728.072631284057;7183.173934997333;7515.173330933702;7547.698092076255;7609.771706848804;7818.6481608328895;7337.926620733724;7339.229380914927;7392.4825262231125;7469.066366704162;7489.363404110712;7478.551286922802;7485.438592105723;7519.43604229674;7533.811654708456;7571.848563028819;6817.556858804361;6822.931770682229;6846.623435711083;6864.725410983505;6874.587524748531;6787.864242715217;6810.5913645181445;6818.522703410912;6850.725970961105;6855.931440685529 01:13:49 INFO - PROCESS | 16875 | |4;prototype.html;362.15798269024515;366.06653034761354;368.77320447924535;369.4107897902844;375.70131745262506;6314.747410103596;6321.146645202896;6334.208223972004;6336.9227231370605;6552.967235163817;6272.4041216084515;6468.385503377183;6469.353064693529;6469.805905822821;6471.482281417487;4950.6287028472825;4985.700857948535;5000.07498612756;5007.974960125194;5024.5226703463295;4985.6759310644875;5013.097642424362;5014.373203349582;5017.272495488152;5020.322256495363;4757.785899634525;4860.100881336946;4890.877728056809;4907.1412502812045;4936.580390666798;4897.485763994782;4902.142125128106;4908.410990681141;4917.7786999585105;4920.581750551208;4264.722793018444;4278.7860606969525;4302.902759796263;4303.311470164758;4303.483581970152;6008.909866351964;6084.056971169476;6129.846753831145;6131.325554189036;6171.765646870599;5761.9135712964335;5764.250647415851;5764.596478246524;5774.97112514439;5777.826665200051;6766.932330676679;6796.932030679679;6811.659417029129;6821.795346139624;6839.213490448612;4771.427428708577;4790.8323208687525;4792.784324705397;4802.231642937113;4805.567498925078;6992.720291188346;7055.435565154775;7159;7189.496735228536;7195.028671129383;4871.196252618278;4874.317595536628;4874.390701162355;4876.829310974099;4880.023995200903;4929.06347793918;4932.975335123301;4937.086638971802;4940.086084074458;4940.851774446773;5636.60543761941;5686.857828554236;5703.17303990919;5715.742791574389;5733.770649173986;6898.586084834926;6909.689063992132;6918.619475928772;6918.93081069193;6919.238883722786;1726.7496213049037;1763.0303333166707;1767.4344209852723;1768.5843826700716;1772.6277481728723;1163.8777928317575;1180.7166280092888;1187.554666999875;1196.1328037173155;1197.1918954705714;6500.869982600416;6511.674416279167;6564.80305590833;6576.309487503839;6587;7002.614856182959;7004.509684322048;7026.051483049825;7037.824054398681;7049.400800931979;6394.8721025579225;6477.222733272038;6503.382178693017;6532.444742196966;6550.181227346582;3773.811309434517;3799.5820459749407;3826.368649172911;3838.7120965927666;3841.7887016214377;7169.749058782918;7201.711931522786;7202.567845929261;7210.062691850026;7217.639118044077;7128.821779455555;7177.7487787927175;7218.242084581043;7251.746188883364;7260.745873894389;7175.390091842148;7189.245129261352;7201.603911784798;7213.242609526029;7213.567185968858;7003.684834182576;7036.190838053484;7041.964790176016;7047.964760176166;7055.470839686941;6775.559588626724;6936.7572134975035;6946.097007389007;6948.478864085315;6951.756688515878;7126.322999315057;7172.784816455514;7189.196213476853;7197.676104575411;7213.3868621167785;4903.6077113831525;4905.920697446556;4908;4910.238912968495;4926.8768280793265;6896.758583455026;6997.545159564816;7007.264237255219;7015.894761578478;7221.386182174574;6913.723451061901;6927.480438966997;6950.131233595801;6971.5468494547695;7000.964995174992;6957.826054348479;6960.825979350557;6978.267281935527;6979.162500499972;6979.790606281819;6731.990201469819;6743.494237932273;6829.4877884157895;6837.1111755471475;6842.178938527409;6989.615571143432;6996.895046574407;7005.789826305219;7007.7196912122945;7010.193827709879;6636.867262654623;6751.662416879235;6769.627670478171;6803.251642319242;6845.212800528003 01:13:49 INFO - PROCESS | 16875 | |5;yui.html;877.166691642939;891.7057371067548;891.9197272245497;898.6764764684714;926.5876684875232;13386.933065334671;13603.455861765542;13614.183149011042;13634.250116243615;13644.727105457885;11545.307281563111;11547.076233901289;11586;11591.072714182867;11647.883521164786;843.8818565400849;866.3545658484438;869.0440515433037;872.3108744092191;873.7946582553095;860.8837806896083;862.6032025268353;862.8101817600118;862.9611667474978;865.8051938313861;907.3512438606396;907.37844576465;910.2945217456459;911.1344222988155;911.4850109688039;890.866370044492;893.5085702863399;896.4218079338823;897.4435849773117;898.137787723786;652.2043107409;663.058456991069;670.6311528659218;671.2079745899837;671.318611609217;14215.431382744679;14263.857361426357;14312.284385780773;14315.069520481135;14341.928290358586;13681.726365472734;13750.518731844337;13806.93096534521;13808.723825523533;13894.583162505141;11137.331760094421;11376.943115284454;11458.312501249868;11619.360935148563;11784.646460606196;3798.297314996707;3803.1442925341853;3830.6552410283207;3892.163184915257;3976.0258736609717;49137.26294105591;50671.746641266924;51252.231216531785;51368.229476557884;52435.47564524344;10722;10797.406142662228;11042.723931901766;11083.556657733761;11211.159163062803;17444.215010324566;17526.474205773848;17543.210555524776;17547.21037553313;17559.648807024045;7647.08235011791;7738.342240909473;7740;7874.21257874208;8181.754547363588;4096.426500289962;4177.60050383119;4394.516603173648;4518.661100417482;4593.954060459419;3380.645032271625;3427.7771944823508;3430.451127819587;3451.0854623524788;3460.8096554689732;631.4916492223804;638.7476946606065;638.8083574927504;639.0637715746453;646.4279112984948;568.3293713418124;572.3818276261627;613.883362161188;660.8744338575656;670.2058061197497;8846.734597962071;8959.641614335484;9059.139381758854;9263.861042084374;9379.437233765995;695.3984803145344;705.4885208224099;742.224375527575;745.2919726259967;748.1172216784138;4346.630536404441;4460.888477788081;4489.214387482178;4548.317752337176;4556.931646025312;60782.39217607767;61552.69223653853;62047;62375.6881215591;62461;54214.186787198225;54406.18390724142;54570;54621;54963;43212.567874320855;46969;48629.270560941615;50826.237606435934;51285.48714512807;9386;9609.423434593948;9657.951710241405;9689.321747477608;9711.611535538499;36509.45235821518;36682.63317366792;37033.81483092567;37617.4357384634;38492.80753596214;47030.76484617555;47688.52311476841;47812.2828157571;47912;48586.271205932644;12621.747565048465;12657.303848288433;12714.61856144317;12833.230006199658;13028.218306901616;13376.398062087424;13428.328583570978;13582.86417135816;13970.091944023607;14338.068025578305;12557.43491542901;12641.3679316032;12687.555935542212;12777.16948398351;12891.935540322613;12512.687182820502;12643.747125057631;12843.935780321039;12861.356932153169;13239.139455935334;12468.314242716737;12570.685732856751;12900.806487902877;12964.481420743441;13149.21104733719;9816.263780216656;9976.451295178835;10555.577776889146;10623.36259824413;10804.729881753019;10359.792804144026;10653.786924261316;10760.623378181726;10892.455377231265;10898.673039808818 01:13:49 INFO - PROCESS | 16875 | __end_tp_report 01:13:49 INFO - PROCESS | 16875 | __start_cc_report 01:13:49 INFO - PROCESS | 16875 | _x_x_mozilla_cycle_collect,291 01:13:49 INFO - PROCESS | 16875 | __end_cc_report 01:13:49 INFO - PROCESS | 16875 | __startTimestamp1454490829426__endTimestamp 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | ------- Summary: start ------- 01:13:49 INFO - PROCESS | 16875 | Number of tests: 6 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | [#0] dojo.html Cycles:165 Average:5589.38 Median:5801.07 stddev:613.40 (10.6%) stddev-sans-first:590.29 01:13:49 INFO - PROCESS | 16875 | Values: 3380.1 3406.5 3435.5 3436.5 3446.9 5613.9 5627.9 5630.4 5640.4 5673.0 5595.5 5635.0 5669.3 5677.9 5679.8 5127.4 5166.3 5197.2 5232.1 5266.8 4922.4 5000.7 5007.5 5019.8 5027.0 5031.7 5080.9 5176.1 5273.8 5294.8 5146.8 5175.3 5198.3 5199.8 5201.2 5059.6 5060.2 5158.3 5170.5 5198.4 5337.6 5358.6 5405.6 5459.0 5478.2 6084.9 6091.8 6094.6 6107.1 6110.4 5975.7 6112.9 6123.0 6129.1 6164.3 5565.4 5656.4 5719.3 5737.8 5753.3 6075.6 6078.8 6081.9 6107.7 6127.4 5831.6 5838.5 5881.8 5899.1 5908.7 5879.5 6037.5 6040.4 6044.4 6083.7 5980.3 5986.1 5986.5 5993.5 6002.8 5812.6 5900.3 5995.8 6022.8 6038.7 4552.7 4599.7 4602.3 4609.6 4631.1 4117.5 4130.5 4141.5 4145.6 4174.7 5563.7 5625.9 5665.7 5722.4 5741.4 6046.8 6056.8 6074.4 6078.1 6086.4 5712.9 5742.0 5744.7 5751.4 5756.4 5029.6 5038.1 5077.6 5117.1 5136.3 6107.2 6140.6 6151.5 6168.3 6170.9 6040.3 6060.9 6069.2 6071.0 6072.5 6017.8 6157.1 6215.3 6232.3 6271.1 5926.2 5934.1 5973.5 5988.1 5991.1 5879.9 5938.6 6022.7 6037.5 6059.3 5721.9 5801.1 5846.1 5912.5 5918.9 5771.7 5824.9 5825.0 5826.2 5833.3 5664.0 5691.7 5744.8 5745.6 5752.4 5889.5 5906.1 6008.3 6018.9 6030.0 5815.2 5846.5 5867.4 5873.6 5900.1 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | [#1] ext.html Cycles:180 Average:61338.62 Median:36612.13 stddev:145237.55 (396.7%) stddev-sans-first:145573.29 01:13:49 INFO - PROCESS | 16875 | Values: 559.1 586.2 589.3 593.2 621.8 35931.0 36171.3 36223.6 36481.5 36499.6 36698.1 37180.3 37321.4 37338.4 37432.8 8318.5 8554.6 8565.6 8579.9 8615.4 8252.2 8533.0 8595.4 8636.5 8669.7 8643.7 8757.3 8763.5 8764.2 8791.5 8521.4 8648.7 8700.7 8708.6 8717.2 8427.7 8533.4 8544.9 8567.4 8580.3 37458.8 37731.2 37738.6 37803.2 37943.2 3426.6 3555.8 3686.1 3751.7 4073.6 31798.2 32058.0 32220.7 32449.8 32573.5 3784.7 3791.7 3878.2 3920.3 3974.1 229565.0 229951.0 233201.0 233338.0 233370.0 57207.0 58027.7 64656.4 65622.3 65919.0 56165.4 56284.0 57030.7 57076.4 57186.4 15437.0 15439.3 15455.6 15542.7 15571.0 13008.0 13151.5 13169.5 13171.1 13301.3 19944.4 20217.3 20286.1 20306.0 20395.0 8183.9 8287.4 8342.0 8389.4 8515.6 1077.3 1093.1 1111.1 1114.5 1171.5 27033.3 27131.6 27360.5 27641.0 27982.7 1096.2 1131.8 1143.2 1146.6 1185.3 14819.7 14933.7 15178.5 15329.4 15554.3 782725.0 828491.0 841468.0 842016.0 854099.0 56746.4 57532.0 57587.4 57880.1 58029.1 1474.5 1489.0 1494.1 1509.3 1510.7 30037.4 30303.7 30779.5 31412.1 31673.2 47001.3 47056.0 47354.3 47497.8 47551.5 339279.0 342438.0 342949.0 343671.0 344568.0 32206.7 43108.8 43901.8 44116.1 44574.3 40267.2 41320.4 48246.0 48385.8 48496.5 33844.2 34547.1 35058.5 35580.3 35651.0 34300.3 34694.7 34702.5 34968.0 35186.3 36186.1 36480.0 36547.6 36676.6 42135.6 29259.8 30605.5 30911.8 30938.8 31072.4 25819.2 26223.9 26293.7 26485.1 26749.2 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | [#2] jquery.html Cycles:180 Average:27692.49 Median:230224.18 stddev:88287.67 (38.3%) stddev-sans-first:88511.52 01:13:49 INFO - PROCESS | 16875 | Values: 378.9 398.2 399.2 402.5 405.6 14265.1 14582.3 16197.4 16690.7 16785.0 11011.8 11198.1 11504.9 17242.9 17310.7 4791.8 4918.1 5088.8 5097.8 5683.4 5112.2 5325.5 5326.9 5336.2 5537.4 5345.3 5350.2 5532.4 5889.2 5907.2 5842.2 6020.7 6031.6 6047.2 6269.3 5597.3 5600.1 5602.9 5620.3 5642.9 15304.9 20437.4 21229.7 21341.7 21505.0 2100.6 2120.2 2252.3 2263.4 2326.3 9566.3 9839.8 10483.4 10771.9 14027.2 1900.2 1949.8 1955.6 1965.2 2010.7 58914.7 59007.0 60089.7 60701.7 60739.0 10704.5 10968.4 11104.7 11111.6 11126.3 14654.5 14716.1 14771.0 14795.2 14818.9 8102.7 8126.7 8137.1 8143.1 8159.0 7633.9 7666.5 7669.9 7724.0 7739.8 4674.6 4784.7 4833.1 4886.6 4897.1 2045.7 2094.5 2097.3 2113.1 2126.0 905.4 967.2 1008.6 1026.5 1055.9 15513.3 15879.1 17313.2 17554.7 17829.9 955.3 997.9 1007.7 1079.3 1086.1 9765.1 9865.3 10372.0 10428.8 10524.5 418191.0 510885.0 582141.0 582641.0 586720.0 69917.2 70517.3 76635.6 77635.6 78697.6 1153.3 1182.0 1186.3 1192.7 1193.2 15663.4 15767.4 15806.7 15814.7 16015.4 31836.7 32371.2 32828.8 33545.3 36035.6 41254.0 41581.8 42257.4 43122.6 45181.3 7775.5 7836.3 7943.2 7975.9 10020.3 8332.7 8462.9 8519.9 8538.6 8629.1 7672.0 7808.2 7823.1 8105.5 8293.9 8109.4 8195.8 8235.6 8335.1 8465.3 8283.8 8293.6 8476.4 8501.0 8583.4 10741.8 10742.0 10842.9 11007.6 11041.6 10791.6 10807.8 10863.1 10962.8 11003.4 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | [#3] mootools.html Cycles:180 Average:5979.74 Median:5406.32 stddev:3115.36 (57.6%) stddev-sans-first:3106.20 01:13:49 INFO - PROCESS | 16875 | Values: 1536.4 1552.0 1763.6 1880.3 1913.6 8451.9 8520.2 8581.9 8604.8 8767.9 8386.7 8447.7 8447.9 8485.3 8511.7 2473.7 2505.4 2507.3 2511.2 2514.7 2445.2 2478.0 2484.7 2486.6 2495.6 2407.5 2430.6 2448.9 2505.9 2510.0 2443.3 2453.1 2492.7 2509.4 2510.8 2416.7 2525.2 2529.4 2536.8 2542.8 8600.1 8638.0 8660.1 8666.6 8680.8 5328.0 5483.1 5500.3 5510.9 5516.0 3299.1 3312.4 3366.8 3403.0 3408.1 1057.0 1079.5 1082.4 1107.5 1107.7 11598.5 11717.9 11723.4 11737.5 11779.9 4529.5 4568.3 4609.1 4668.8 4743.6 9542.9 9609.7 9616.2 9623.6 9624.7 5305.5 5306.1 5308.0 5324.4 5329.6 4878.7 4892.0 4902.6 4946.0 4958.1 3818.3 3924.2 3934.3 3941.4 3942.0 1138.5 1220.0 1223.3 1235.1 1240.1 1120.0 1125.1 1140.2 1234.6 1250.5 7743.1 7798.9 7816.8 7895.3 8128.6 1202.4 1204.7 1206.8 1207.5 1238.1 6318.6 6328.9 6377.9 6408.6 6417.9 10630.7 10747.2 10790.2 10883.2 10987.3 10584.8 10700.7 10726.6 10731.6 10774.1 8153.1 8193.1 8216.3 8220.8 8227.3 7829.5 7866.4 7887.8 7922.3 7977.9 9320.0 9397.5 9453.8 9509.5 9672.1 9169.8 9298.1 9310.0 9608.7 9669.5 7245.6 7255.1 7288.4 7299.6 7378.0 7573.9 7650.1 7677.2 7704.7 7728.1 7183.2 7515.2 7547.7 7609.8 7818.6 7337.9 7339.2 7392.5 7469.1 7489.4 7478.6 7485.4 7519.4 7533.8 7571.8 6817.6 6822.9 6846.6 6864.7 6874.6 6787.9 6810.6 6818.5 6850.7 6855.9 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | [#4] prototype.html Cycles:180 Average:5728.87 Median:6489.05 stddev:1713.04 (26.4%) stddev-sans-first:1669.81 01:13:49 INFO - PROCESS | 16875 | Values: 362.2 366.1 368.8 369.4 375.7 6314.7 6321.1 6334.2 6336.9 6553.0 6272.4 6468.4 6469.4 6469.8 6471.5 4950.6 4985.7 5000.1 5008.0 5024.5 4985.7 5013.1 5014.4 5017.3 5020.3 4757.8 4860.1 4890.9 4907.1 4936.6 4897.5 4902.1 4908.4 4917.8 4920.6 4264.7 4278.8 4302.9 4303.3 4303.5 6008.9 6084.1 6129.8 6131.3 6171.8 5761.9 5764.3 5764.6 5775.0 5777.8 6766.9 6796.9 6811.7 6821.8 6839.2 4771.4 4790.8 4792.8 4802.2 4805.6 6992.7 7055.4 7159.0 7189.5 7195.0 4871.2 4874.3 4874.4 4876.8 4880.0 4929.1 4933.0 4937.1 4940.1 4940.9 5636.6 5686.9 5703.2 5715.7 5733.8 6898.6 6909.7 6918.6 6918.9 6919.2 1726.7 1763.0 1767.4 1768.6 1772.6 1163.9 1180.7 1187.6 1196.1 1197.2 6500.9 6511.7 6564.8 6576.3 6587.0 7002.6 7004.5 7026.1 7037.8 7049.4 6394.9 6477.2 6503.4 6532.4 6550.2 3773.8 3799.6 3826.4 3838.7 3841.8 7169.7 7201.7 7202.6 7210.1 7217.6 7128.8 7177.7 7218.2 7251.7 7260.7 7175.4 7189.2 7201.6 7213.2 7213.6 7003.7 7036.2 7042.0 7048.0 7055.5 6775.6 6936.8 6946.1 6948.5 6951.8 7126.3 7172.8 7189.2 7197.7 7213.4 4903.6 4905.9 4908.0 4910.2 4926.9 6896.8 6997.5 7007.3 7015.9 7221.4 6913.7 6927.5 6950.1 6971.5 7001.0 6957.8 6960.8 6978.3 6979.2 6979.8 6732.0 6743.5 6829.5 6837.1 6842.2 6989.6 6996.9 7005.8 7007.7 7010.2 6636.9 6751.7 6769.6 6803.3 6845.2 01:13:49 INFO - PROCESS | 16875 | 01:13:49 INFO - PROCESS | 16875 | [#5] yui.html Cycles:180 Average:14708.72 Median:4533.49 stddev:16930.90 (373.5%) stddev-sans-first:16946.53 01:13:49 INFO - PROCESS | 16875 | Values: 877.2 891.7 891.9 898.7 926.6 13386.9 13603.5 13614.2 13634.3 13644.7 11545.3 11547.1 11586.0 11591.1 11647.9 843.9 866.4 869.0 872.3 873.8 860.9 862.6 862.8 863.0 865.8 907.4 907.4 910.3 911.1 911.5 890.9 893.5 896.4 897.4 898.1 652.2 663.1 670.6 671.2 671.3 14215.4 14263.9 14312.3 14315.1 14341.9 13681.7 13750.5 13806.9 13808.7 13894.6 11137.3 11376.9 11458.3 11619.4 11784.6 3798.3 3803.1 3830.7 3892.2 3976.0 49137.3 50671.7 51252.2 51368.2 52435.5 10722.0 10797.4 11042.7 11083.6 11211.2 17444.2 17526.5 17543.2 17547.2 17559.6 7647.1 7738.3 7740.0 7874.2 8181.8 4096.4 4177.6 4394.5 4518.7 4594.0 3380.6 3427.8 3430.5 3451.1 3460.8 631.5 638.7 638.8 639.1 646.4 568.3 572.4 613.9 660.9 670.2 8846.7 8959.6 9059.1 9263.9 9379.4 695.4 705.5 742.2 745.3 748.1 4346.6 4460.9 4489.2 4548.3 4556.9 60782.4 61552.7 62047.0 62375.7 62461.0 54214.2 54406.2 54570.0 54621.0 54963.0 43212.6 46969.0 48629.3 50826.2 51285.5 9386.0 9609.4 9658.0 9689.3 9711.6 36509.5 36682.6 37033.8 37617.4 38492.8 47030.8 47688.5 47812.3 47912.0 48586.3 12621.7 12657.3 12714.6 12833.2 13028.2 13376.4 13428.3 13582.9 13970.1 14338.1 12557.4 12641.4 12687.6 12777.2 12891.9 12512.7 12643.7 12843.9 12861.4 13239.1 12468.3 12570.7 12900.8 12964.5 13149.2 9816.3 9976.5 10555.6 10623.4 10804.7 10359.8 10653.8 10760.6 10892.5 10898.7 01:13:49 INFO - PROCESS | 16875 | -------- Summary: end -------- 01:13:49 INFO - PROCESS | 16875 | 01:13:50 INFO - TEST-INFO | 16875: exit 0 01:13:50 INFO - TEST-OK | dromaeo_css | took 1108785ms 01:13:50 INFO - TEST-START | kraken 01:13:50 INFO - operating with platform_type : linux_ 01:13:50 INFO - Initialising browser for kraken test... 01:13:50 INFO - TEST-INFO | started process 17117 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7FMC53/profile http://localhost:44889/getInfo.html) 01:13:53 INFO - PROCESS | 17117 | 01:13:53 INFO - PROCESS | 17117 | (process:17197): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:13:54 INFO - PROCESS | 17117 | __metrics Screen width/height:1600/1200 01:13:54 INFO - PROCESS | 17117 | colorDepth:24 01:13:54 INFO - PROCESS | 17117 | Browser inner width/height: 1024/697 01:13:54 INFO - PROCESS | 17117 | __metrics 01:13:54 INFO - TEST-INFO | 17117: exit 0 01:13:54 INFO - Browser initialized. 01:13:54 INFO - Running cycle 1/1 for kraken test... 01:13:55 INFO - TEST-INFO | started process 17246 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7FMC53/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:13:56 INFO - PROCESS | 17246 | 01:13:56 INFO - PROCESS | 17246 | (process:17310): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:14:06 INFO - PROCESS | 17246 | RSS: Main: 140447744 01:14:06 INFO - PROCESS | 17246 | 01:14:09 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-beat-detection) 01:14:09 INFO - PROCESS | 17246 | RSS: Main: 144781312 01:14:09 INFO - PROCESS | 17246 | 01:14:12 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-dft) 01:14:13 INFO - PROCESS | 17246 | RSS: Main: 143196160 01:14:13 INFO - PROCESS | 17246 | 01:14:15 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-fft) 01:14:16 INFO - PROCESS | 17246 | RSS: Main: 145092608 01:14:16 INFO - PROCESS | 17246 | 01:14:18 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-oscillator) 01:14:19 INFO - PROCESS | 17246 | RSS: Main: 145821696 01:14:19 INFO - PROCESS | 17246 | 01:14:21 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44889/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:14:21 INFO - PROCESS | 17246 | RSS: Main: 144134144 01:14:21 INFO - PROCESS | 17246 | 01:14:24 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44889/tests/kraken/driver.html?testName=imaging-darkroom) 01:14:25 INFO - PROCESS | 17246 | RSS: Main: 145784832 01:14:25 INFO - PROCESS | 17246 | 01:14:28 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44889/tests/kraken/driver.html?testName=imaging-desaturate) 01:14:29 INFO - PROCESS | 17246 | RSS: Main: 145485824 01:14:29 INFO - PROCESS | 17246 | 01:14:32 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44889/tests/kraken/driver.html?testName=json-parse-financial) 01:14:32 INFO - PROCESS | 17246 | RSS: Main: 145383424 01:14:32 INFO - PROCESS | 17246 | 01:14:34 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44889/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:14:35 INFO - PROCESS | 17246 | RSS: Main: 145838080 01:14:35 INFO - PROCESS | 17246 | 01:14:36 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:14:37 INFO - PROCESS | 17246 | RSS: Main: 145559552 01:14:37 INFO - PROCESS | 17246 | 01:14:39 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:14:40 INFO - PROCESS | 17246 | RSS: Main: 145530880 01:14:40 INFO - PROCESS | 17246 | 01:14:42 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:14:43 INFO - PROCESS | 17246 | RSS: Main: 145051648 01:14:43 INFO - PROCESS | 17246 | 01:14:45 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:14:46 INFO - PROCESS | 17246 | RSS: Main: 146116608 01:14:46 INFO - PROCESS | 17246 | 01:14:47 INFO - PROCESS | 17246 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44889/tests/kraken/driver.html?testName=ai-astar) 01:14:48 INFO - PROCESS | 17246 | RSS: Main: 147042304 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | __start_tp_report 01:14:48 INFO - PROCESS | 17246 | _x_x_mozilla_page_load 01:14:48 INFO - PROCESS | 17246 | _x_x_mozilla_page_load_details 01:14:48 INFO - PROCESS | 17246 | |i|pagename|runs| 01:14:48 INFO - PROCESS | 17246 | |0;ai-astar;111;105;111;109;111;120;109;109;108;109 01:14:48 INFO - PROCESS | 17246 | |1;audio-beat-detection;150;126;150;167;126;149;154;134;158;127 01:14:48 INFO - PROCESS | 17246 | |2;audio-dft;162;161;162;161;162;161;164;161;166;162 01:14:48 INFO - PROCESS | 17246 | |3;audio-fft;76;73;73;152;74;76;76;76;153;73 01:14:48 INFO - PROCESS | 17246 | |4;audio-oscillator;99;95;136;95;96;96;147;95;96;138 01:14:48 INFO - PROCESS | 17246 | |5;imaging-gaussian-blur;110;110;110;110;111;110;110;110;110;110 01:14:48 INFO - PROCESS | 17246 | |6;imaging-darkroom;147;145;146;148;147;148;148;147;146;148 01:14:48 INFO - PROCESS | 17246 | |7;imaging-desaturate;97;96;96;96;96;97;96;101;96;97 01:14:48 INFO - PROCESS | 17246 | |8;json-parse-financial;56;55;60;56;56;58;55;61;54;53 01:14:48 INFO - PROCESS | 17246 | |9;json-stringify-tinderbox;63;64;63;64;64;66;65;63;64;66 01:14:48 INFO - PROCESS | 17246 | |10;stanford-crypto-aes;89;82;84;82;83;82;84;82;90;82 01:14:48 INFO - PROCESS | 17246 | |11;stanford-crypto-ccm;122;115;120;122;115;112;112;117;127;114 01:14:48 INFO - PROCESS | 17246 | |12;stanford-crypto-pbkdf2;149;138;138;139;148;143;149;136;139;135 01:14:48 INFO - PROCESS | 17246 | |13;stanford-crypto-sha256-iterative;68;67;65;67;70;66;66;66;69;65 01:14:48 INFO - PROCESS | 17246 | __end_tp_report 01:14:48 INFO - PROCESS | 17246 | __start_cc_report 01:14:48 INFO - PROCESS | 17246 | _x_x_mozilla_cycle_collect,734 01:14:48 INFO - PROCESS | 17246 | __end_cc_report 01:14:48 INFO - PROCESS | 17246 | __startTimestamp1454490888040__endTimestamp 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | ------- Summary: start ------- 01:14:48 INFO - PROCESS | 17246 | Number of tests: 14 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:3.88 (3.5%) stddev-sans-first:4.11 01:14:48 INFO - PROCESS | 17246 | Values: 111.0 105.0 111.0 109.0 111.0 120.0 109.0 109.0 108.0 109.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:150.00 stddev:14.75 (9.8%) stddev-sans-first:15.49 01:14:48 INFO - PROCESS | 17246 | Values: 150.0 126.0 150.0 167.0 126.0 149.0 154.0 134.0 158.0 127.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.62 (1.0%) stddev-sans-first:1.72 01:14:48 INFO - PROCESS | 17246 | Values: 162.0 161.0 162.0 161.0 162.0 161.0 164.0 161.0 166.0 162.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#3] audio-fft Cycles:10 Average:90.20 Median:75.00 stddev:32.86 (43.8%) stddev-sans-first:34.45 01:14:48 INFO - PROCESS | 17246 | Values: 76.0 73.0 73.0 152.0 74.0 76.0 76.0 76.0 153.0 73.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:95.50 stddev:21.62 (22.6%) stddev-sans-first:22.61 01:14:48 INFO - PROCESS | 17246 | Values: 99.0 95.0 136.0 95.0 96.0 96.0 147.0 95.0 96.0 138.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:14:48 INFO - PROCESS | 17246 | Values: 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 01:14:48 INFO - PROCESS | 17246 | Values: 147.0 145.0 146.0 148.0 147.0 148.0 148.0 147.0 146.0 148.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.64 01:14:48 INFO - PROCESS | 17246 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 101.0 96.0 97.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:2.55 (4.5%) stddev-sans-first:2.70 01:14:48 INFO - PROCESS | 17246 | Values: 56.0 55.0 60.0 56.0 56.0 58.0 55.0 61.0 54.0 53.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.12 01:14:48 INFO - PROCESS | 17246 | Values: 63.0 64.0 63.0 64.0 64.0 66.0 65.0 63.0 64.0 66.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:3.02 (3.6%) stddev-sans-first:2.60 01:14:48 INFO - PROCESS | 17246 | Values: 89.0 82.0 84.0 82.0 83.0 82.0 84.0 82.0 90.0 82.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:118.50 stddev:4.97 (4.2%) stddev-sans-first:5.01 01:14:48 INFO - PROCESS | 17246 | Values: 122.0 115.0 120.0 122.0 115.0 112.0 112.0 117.0 127.0 114.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:141.00 stddev:5.44 (3.9%) stddev-sans-first:5.03 01:14:48 INFO - PROCESS | 17246 | Values: 149.0 138.0 138.0 139.0 148.0 143.0 149.0 136.0 139.0 135.0 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - PROCESS | 17246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.72 01:14:48 INFO - PROCESS | 17246 | Values: 68.0 67.0 65.0 67.0 70.0 66.0 66.0 66.0 69.0 65.0 01:14:48 INFO - PROCESS | 17246 | -------- Summary: end -------- 01:14:48 INFO - PROCESS | 17246 | 01:14:48 INFO - TEST-INFO | 17246: exit 0 01:14:48 INFO - TEST-OK | kraken | took 58797ms 01:14:48 INFO - TEST-START | v8_7 01:14:48 INFO - operating with platform_type : linux_ 01:14:48 INFO - Initialising browser for v8_7 test... 01:14:48 INFO - TEST-INFO | started process 17538 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqx4AWA/profile http://localhost:44889/getInfo.html) 01:14:52 INFO - PROCESS | 17538 | 01:14:52 INFO - PROCESS | 17538 | (process:17617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:14:52 INFO - PROCESS | 17538 | __metrics Screen width/height:1600/1200 01:14:52 INFO - PROCESS | 17538 | colorDepth:24 01:14:52 INFO - PROCESS | 17538 | Browser inner width/height: 1024/697 01:14:52 INFO - PROCESS | 17538 | __metrics 01:14:53 INFO - TEST-INFO | 17538: exit 0 01:14:53 INFO - Browser initialized. 01:14:53 INFO - Running cycle 1/1 for v8_7 test... 01:14:53 INFO - TEST-INFO | started process 17666 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqx4AWA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:55 INFO - PROCESS | 17666 | 01:14:55 INFO - PROCESS | 17666 | (process:17729): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:15:05 INFO - PROCESS | 17666 | RSS: Main: 140840960 01:15:05 INFO - PROCESS | 17666 | 01:15:27 INFO - PROCESS | 17666 | Cycle 1(1): loaded http://localhost:44889/tests/v8_7/run.html (next: http://localhost:44889/tests/v8_7/run.html) 01:15:28 INFO - PROCESS | 17666 | RSS: Main: 144494592 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | __start_tp_report 01:15:28 INFO - PROCESS | 17666 | _x_x_mozilla_page_load 01:15:28 INFO - PROCESS | 17666 | _x_x_mozilla_page_load_details 01:15:28 INFO - PROCESS | 17666 | |i|pagename|runs| 01:15:28 INFO - PROCESS | 17666 | |0;Richards;165.53550736633008 01:15:28 INFO - PROCESS | 17666 | |1;DeltaBlue;178.25311942959001 01:15:28 INFO - PROCESS | 17666 | |2;Encrypt;279.3296089385475 01:15:28 INFO - PROCESS | 17666 | |3;Decrypt;5256.544502617801 01:15:28 INFO - PROCESS | 17666 | |4;RayTrace;905.7971014492754 01:15:28 INFO - PROCESS | 17666 | |5;Earley;563.6978579481398 01:15:28 INFO - PROCESS | 17666 | |6;Boyer;11269.662921348314 01:15:28 INFO - PROCESS | 17666 | |7;RegExp;39538.46153846154 01:15:28 INFO - PROCESS | 17666 | |8;Splay;506.53923541247485 01:15:28 INFO - PROCESS | 17666 | |9;NavierStokes;4854.368932038835 01:15:28 INFO - PROCESS | 17666 | __end_tp_report 01:15:28 INFO - PROCESS | 17666 | __startTimestamp1454490928197__endTimestamp 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | ------- Summary: start ------- 01:15:28 INFO - PROCESS | 17666 | Number of tests: 10 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#0] Richards Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 165.5 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#1] DeltaBlue Cycles:1 Average:178.25 Median:178.25 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 178.3 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 279.3 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 5256.5 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#4] RayTrace Cycles:1 Average:905.80 Median:905.80 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 905.8 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#5] Earley Cycles:1 Average:563.70 Median:563.70 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 563.7 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#6] Boyer Cycles:1 Average:11269.66 Median:11269.66 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 11269.7 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#7] RegExp Cycles:1 Average:39538.46 Median:39538.46 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 39538.5 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#8] Splay Cycles:1 Average:506.54 Median:506.54 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 506.5 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - PROCESS | 17666 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 01:15:28 INFO - PROCESS | 17666 | Values: 4854.4 01:15:28 INFO - PROCESS | 17666 | -------- Summary: end -------- 01:15:28 INFO - PROCESS | 17666 | 01:15:28 INFO - TEST-INFO | 17666: exit 0 01:15:29 INFO - TEST-OK | v8_7 | took 40127ms 01:15:29 INFO - SUITE-END | took 1207s 01:15:29 INFO - Completed test suite (00:20:07) 01:15:29 INFO - Working with test: dromaeo_css 01:15:29 INFO - Generating results file: dromaeo_css 01:15:29 INFO - Working with test: kraken 01:15:29 INFO - Generating results file: kraken 01:15:29 INFO - javascript benchmark 01:15:29 INFO - Working with test: v8_7 01:15:29 INFO - Generating results file: v8_7 01:15:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:15:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 01:15:29 INFO - process_Request line: dromaeo_css 7336.59 graph.html#tests=[[72,52,43]] 01:15:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:15:29 INFO - process_Request line: kraken 1500.40 graph.html#tests=[[232,52,43]] 01:15:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:15:29 INFO - process_Request line: v8_7 21958.18 graph.html#tests=[[230,52,43]] 01:15:29 INFO - RETURN: dromaeo_css: 7336.59 01:15:29 INFO - RETURN: kraken: 1500.40 01:15:29 INFO - RETURN: v8_7: 21958.18 01:15:29 INFO - javascript benchmark 01:15:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3380.0873764083694, 3406.471996840489, 3435.5362026126472, 3436.50170725245, 3446.8621255149797, 5613.887722245553, 5627.915581266274, 5630.40880707526, 5640.351359593648, 5673.0, 5595.49640532352, 5634.9857025735355, 5669.262995810549, 5677.949579327827, 5679.801206957757, 5127.435982041972, 5166.276721259008, 5197.246399272122, 5232.058229518685, 5266.81566145185, 4922.433920099199, 5000.749962501878, 5007.524285192901, 5019.799208031693, 5026.969471258383, 5031.672941258825, 5080.923786143211, 5176.0683077046115, 5273.762680679379, 5294.814681486148, 5146.768395422197, 5175.275461435402, 5198.2722418861385, 5199.792008319662, 5201.1678131498775, 5059.595232381401, 5060.2156665716875, 5158.277841102249, 5170.534651881311, 5198.40218374888, 5337.572994160497, 5358.624896257264, 5405.567554595662, 5458.972705136489, 5478.178273259004, 6084.878302433971, 6091.756329746805, 6094.634321940698, 6107.114468402056, 6110.419510146529, 5975.671338076404, 6112.908306375408, 6122.96938515309, 6129.111278864584, 6164.321924588292, 5565.443455654402, 5656.377798442168, 5719.28508936383, 5737.799177028784, 5753.252077229933, 6075.605085669417, 6078.787242446581, 6081.878362432815, 6107.664078475637, 6127.387261273926, 5831.591788574844, 5838.5037271831525, 5881.794137205177, 5899.085641725454, 5908.704564771744, 5879.52963762898, 6037.486813620892, 6040.426159514839, 6044.365341639153, 6083.695815209222, 5980.342162362137, 5986.07215881539, 5986.49114825236, 5993.520518358521, 6002.849928751816, 5812.564057695689, 5900.321463031721, 5995.790147344822, 6022.789202377896, 6038.728257228435, 4552.681312308173, 4599.701019433726, 4602.263637817933, 4609.562091601292, 4631.073785242965, 4117.464729585135, 4130.504339479282, 4141.5237247716295, 4145.626893579532, 4174.7077704561, 5563.693996830213, 5625.859353516113, 5665.688387138664, 5722.37053924068, 5741.368449470555, 6046.788362407383, 6056.848578785565, 6074.3925607438905, 6078.088286757022, 6086.421789929949, 5712.914306285409, 5742.0, 5744.655320680772, 5751.367349591542, 5756.366799652119, 5029.572486338702, 5038.143515602356, 5077.593792496591, 5117.104506711311, 5136.306598609214, 6107.206063211843, 6140.5701600887505, 6151.507879369639, 6168.321484636686, 6170.907436388457, 6040.305364883095, 6060.878782424327, 6069.150318955438, 6071.0, 6072.483838873569, 6017.789377371771, 6157.076438534255, 6215.254169499689, 6232.25212974446, 6271.122042913905, 5926.2295901532525, 5934.050551911846, 5973.49225315853, 5988.131720900532, 5991.071383935497, 5879.911801322898, 5938.6436813791315, 6022.668753218615, 6037.516998640186, 6059.33347331802, 5721.942780572307, 5801.071828507418, 5846.093855452412, 5912.46787789101, 5918.911216331672, 5771.740271687868, 5824.912626310524, 5825.0, 5826.184334193301, 5833.270841144857, 5664.0, 5691.686957217393, 5744.770209191753, 5745.597808153556, 5752.395998420106, 5889.528837692888, 5906.143609176731, 6008.279006519246, 6018.939810601838, 6029.9698501508965, 5815.185873977562, 5846.473817356458, 5867.442592953663, 5873.647581145145, 5900.1149827526215], "unit": "score", "name": "dojo.html", "value": 5550.213978163825}, {"lowerIsBetter": false, "replicates": [559.1473003669404, 586.217399771305, 589.2663633775949, 593.237689568904, 621.841430435239, 35931.0, 36171.27657446853, 36223.63776362239, 36481.45277820828, 36499.63500364996, 36698.08254793631, 37180.256394872085, 37321.440178397344, 37338.4399234011, 37432.81283593578, 8318.500889946607, 8554.61504232311, 8565.571721413935, 8579.871301930476, 8615.396922215448, 8252.174782521759, 8532.957335213316, 8595.355348348867, 8636.481811091324, 8669.69656062038, 8643.740687779376, 8757.299416046733, 8763.51800650964, 8764.21122099011, 8791.472511649321, 8521.44610600309, 8648.740537783877, 8700.651973921036, 8708.608112634947, 8717.171868672434, 8427.662893484254, 8533.402661813676, 8544.914550854473, 8567.400281980264, 8580.313574913991, 37458.812705936296, 37731.245375092345, 37738.62261377378, 37803.24393512142, 37943.241135177144, 3426.5716785401823, 3555.768875023141, 3686.078480379905, 3751.681107105899, 4073.551909289976, 31798.205044873834, 32058.0, 32220.677793222236, 32449.837750811093, 32573.511397329057, 3784.735068545203, 3791.6966642668795, 3878.1661942682176, 3920.2943470175355, 3974.1058261890844, 229565.0, 229951.0, 233201.0, 233337.9999999983, 233370.0, 57207.0, 58027.70986145042, 64656.35343646503, 65622.34377656257, 65919.0, 56165.43834561602, 56284.0, 57030.7148464255, 57076.42923570711, 57186.42813571894, 15437.0, 15439.30523126462, 15455.613609659624, 15542.689146217239, 15571.0, 13008.0, 13151.539696110782, 13169.539066132831, 13171.143875648053, 13301.334933253493, 19944.401667949984, 20217.29239476611, 20286.08712607936, 20306.0, 20395.0, 8183.877241841377, 8287.378446616527, 8341.95829020851, 8389.370797190235, 8515.574221289035, 1077.256692881909, 1093.1309608860975, 1111.1499702727258, 1114.4594871487323, 1171.5021116025825, 27033.324166895592, 27131.593026104623, 27360.45279094407, 27641.0, 27982.720172798417, 1096.2326371539955, 1131.7510147767478, 1143.239745569187, 1146.5528443906883, 1185.3125187391292, 14819.66623003935, 14933.70132597342, 15178.544643660707, 15329.386824526893, 15554.300056497485, 782725.0, 828491.0, 841468.0, 842016.0, 854099.0, 56746.43253567412, 57532.0, 57587.42412575905, 57880.13179802307, 58029.12956305659, 1474.4765608209145, 1488.9702205956037, 1494.0886059503694, 1509.2830905320104, 1510.6752048309665, 30037.399252014402, 30303.69696303009, 30779.53830692586, 31412.05763827089, 31673.208169795016, 47001.294980576, 47056.0, 47354.289685654054, 47497.762511187226, 47551.52448475471, 339279.0, 342438.0, 342949.0, 343671.0, 344568.0, 32206.677933221305, 43108.78445607752, 43901.78049109734, 44116.11767764563, 44574.3313850286, 40267.1946561073, 41320.38019429771, 48246.0, 48385.758071210825, 48496.5150348492, 33844.15389615279, 34547.136321591155, 35058.47412288767, 35580.28839423249, 35651.0, 34300.31399372048, 34694.65305347015, 34702.479462807576, 34968.0, 35186.296274074884, 36186.09534761652, 36480.0, 36547.63452365442, 36676.63323366839, 42135.578644213165, 29259.82960681549, 30605.540916886708, 30911.84544077355, 30938.845305773328, 31072.378552428374, 25819.225423237334, 26223.868880655475, 26293.73706262913, 26485.11028404273, 26749.19752407431], "unit": "score", "name": "ext.html", "value": 19425.66644403943}, {"lowerIsBetter": false, "replicates": [378.8503541101263, 398.205579868163, 399.22550252510126, 402.46070265843764, 405.62479706271694, 14265.144091354527, 14582.343794529244, 16197.352105915765, 16690.749638755413, 16784.999999999985, 11011.788703242657, 11198.104151667867, 11504.884951150487, 17242.913785431087, 17310.740338894928, 4791.832285869995, 4918.114739346916, 5088.7964481420695, 5097.847064588068, 5683.403242659523, 5112.233165025257, 5325.4940780625775, 5326.946730532683, 5336.226247194155, 5537.418571050042, 5345.33183352081, 5350.170723537858, 5532.3637781655225, 5889.234399528077, 5907.172995780594, 5842.2405087338375, 6020.6688632125215, 6031.638101713889, 6047.213862197908, 6269.310375858652, 5597.328320601513, 5600.0759874620635, 5602.859928501779, 5620.297462817148, 5642.858928526779, 15304.923475382664, 20437.38687839367, 21229.68155477669, 21341.679874801892, 21505.0, 2100.59038487495, 2120.2367147826926, 2252.324302709197, 2263.366257447901, 2326.2904814031713, 9566.330356875022, 9839.754006149831, 10483.370997740083, 10771.892281077246, 14027.158370497802, 1900.249401486405, 1949.8245157935853, 1955.5795503966574, 1965.2237366240397, 2010.7084472751515, 58914.705426472596, 59007.0, 60089.6995515024, 60701.6964915177, 60739.0, 10704.464776761131, 10968.396738179477, 11104.666859994213, 11111.55553777856, 11126.332420054661, 14654.487092951695, 14716.117032977842, 14771.0, 14795.186264755543, 14818.925905370405, 8102.675892964333, 8126.715564955198, 8137.064237612751, 8143.063547691972, 8159.0, 7633.885491717629, 7666.463347565728, 7669.884951725729, 7723.961380193063, 7739.7678069658, 4674.626029917598, 4784.736839473862, 4833.05755377705, 4886.633502487328, 4897.114610874768, 2045.6829191475344, 2094.455441585199, 2097.25547430663, 2113.091370710609, 2125.978740212578, 905.42053086025, 967.2020583019038, 1008.6268080810147, 1026.5226669598671, 1055.9155267578576, 15513.301901414463, 15879.12664803447, 17313.2209050593, 17554.736678949826, 17829.910850445664, 955.2696719311101, 997.8773879385691, 1007.652359935821, 1079.3092420850662, 1086.0605576176708, 9765.121139097515, 9865.309428340091, 10372.0, 10428.843567346496, 10524.473776311153, 418191.0, 510885.0, 582141.0, 582641.0, 586720.0, 69917.20331186797, 70517.2948270521, 76635.61682191554, 77635.61182194053, 78697.60651196707, 1153.2792004996877, 1182.0366401383017, 1186.2645160000682, 1192.7256730951756, 1193.1945936492832, 15663.373465061726, 15767.448139315069, 15806.68386632284, 15814.683706325579, 16015.439459619323, 31836.681633183372, 32371.19072023124, 32828.835855820565, 33545.329093418484, 36035.63964360323, 41254.0, 41581.79209104056, 42257.366139507314, 43122.56877431311, 45181.322280165165, 7775.455718099679, 7836.255555722198, 7943.205679432011, 7975.880361794694, 10020.298579099685, 8332.708355207538, 8462.873056904029, 8519.914800851911, 8538.615762290588, 8629.09394513567, 7672.0, 7808.180141085104, 7823.061232652118, 8105.520371016853, 8293.875591866248, 8109.3917956152345, 8195.79510512218, 8235.629396677044, 8335.083140854622, 8465.28045116172, 8283.792905177177, 8293.567713147897, 8476.406651534333, 8500.957495212484, 8583.356248281529, 10741.785164296827, 10742.0, 10842.945785271024, 11007.61473348429, 11041.613543525938, 10791.56833726642, 10807.837882431613, 10863.076638485818, 10962.780744385227, 11003.394813285026], "unit": "score", "name": "jquery.html", "value": 8437.360065858755}, {"lowerIsBetter": false, "replicates": [1536.3700882638118, 1551.9767203491942, 1763.5767415820208, 1880.257298367146, 1913.5503156758168, 8451.87322190167, 8520.233179013887, 8581.87127193091, 8604.784880377985, 8767.868481972775, 8386.664533418656, 8447.704330348439, 8447.91552084479, 8485.278751306147, 8511.744647660564, 2473.7402572729875, 2505.436276837706, 2507.285423654259, 2511.158761814794, 2514.7485251474795, 2445.156421034749, 2477.987610061947, 2484.6521486991837, 2486.614574740909, 2495.563276426627, 2407.518496300738, 2430.635404689293, 2448.926532204028, 2505.887235074426, 2509.987450062747, 2443.3280847766828, 2453.0678342229926, 2492.713337966139, 2509.422832748469, 2510.79913606911, 2416.673749043874, 2525.217182673377, 2529.418233806235, 2536.822422430431, 2542.8092893033095, 8600.096989816042, 8638.049814520398, 8660.090690477535, 8666.610002549838, 8680.782980425476, 5327.973360133214, 5483.067878460632, 5500.339959204881, 5510.91733623996, 5516.034693928546, 3299.059767966118, 3312.370649576597, 3366.8148251846137, 3402.9659703403145, 3408.1309266137223, 1056.9894301056968, 1079.525008996047, 1082.4046774274118, 1107.479484642217, 1107.6621630402724, 11598.478068486938, 11717.941410292893, 11723.4138293085, 11737.53049878004, 11779.941100294443, 4529.456465224194, 4568.2690769477385, 4609.124266389375, 4668.836590719308, 4743.596794272526, 9542.856857147148, 9609.663661771945, 9616.182624476858, 9623.615055397706, 9624.711258662252, 5305.469453054664, 5306.09796334624, 5307.9734601326745, 5324.361076670824, 5329.573634109262, 4878.731669758126, 4891.951080489221, 4902.607791376681, 4946.0355230729665, 4958.132326842788, 3818.3317919364, 3924.1955399143108, 3934.272159650474, 3941.3693808990424, 3942.0, 1138.5445821671399, 1219.951201951912, 1223.2660403757852, 1235.092207227687, 1240.088534926828, 1119.9832002519968, 1125.1280257800106, 1140.2474366917795, 1234.623439850854, 1250.4560516175493, 7743.148253692089, 7798.883016754753, 7816.804579885435, 7895.328897043815, 8128.59357032146, 1202.4408649977627, 1204.680759598707, 1206.8250103735086, 1207.5449083853935, 1238.120934136755, 6318.62088274705, 6328.873422531616, 6377.904331435032, 6408.61548307103, 6417.871642567123, 10630.681079567625, 10747.247692661595, 10790.244682872124, 10883.23817332779, 10987.340759554452, 10584.841227381596, 10700.732481688021, 10726.624568140078, 10731.570737170427, 10774.138068954464, 8153.1439198884445, 8193.09875913649, 8216.342692584698, 8220.794480137925, 8227.341812654973, 7829.491083079582, 7866.410019248465, 7887.84224315499, 7922.286994170552, 7977.920220797718, 9320.0, 9397.483138427453, 9453.810923781624, 9509.476978766234, 9672.08115229052, 9169.816603668023, 9298.070192980918, 9309.953450232706, 9608.66369677058, 9669.516524173903, 7245.601491917995, 7255.09311336083, 7288.380487658396, 7299.5620262784405, 7378.0, 7573.886391704019, 7650.120236172911, 7677.155512893689, 7704.6918123274445, 7728.072631284057, 7183.173934997333, 7515.173330933702, 7547.698092076255, 7609.771706848804, 7818.6481608328895, 7337.926620733724, 7339.229380914927, 7392.4825262231125, 7469.066366704162, 7489.363404110712, 7478.551286922802, 7485.438592105723, 7519.43604229674, 7533.811654708456, 7571.848563028819, 6817.556858804361, 6822.931770682229, 6846.623435711083, 6864.725410983505, 6874.587524748531, 6787.864242715217, 6810.5913645181445, 6818.522703410912, 6850.725970961105, 6855.931440685529], "unit": "score", "name": "mootools.html", "value": 4898.304777770366}, {"lowerIsBetter": false, "replicates": [362.15798269024515, 366.06653034761354, 368.77320447924535, 369.4107897902844, 375.70131745262506, 6314.747410103596, 6321.146645202896, 6334.208223972004, 6336.9227231370605, 6552.967235163817, 6272.4041216084515, 6468.385503377183, 6469.353064693529, 6469.805905822821, 6471.482281417487, 4950.6287028472825, 4985.700857948535, 5000.07498612756, 5007.974960125194, 5024.5226703463295, 4985.6759310644875, 5013.097642424362, 5014.373203349582, 5017.272495488152, 5020.322256495363, 4757.785899634525, 4860.100881336946, 4890.877728056809, 4907.1412502812045, 4936.580390666798, 4897.485763994782, 4902.142125128106, 4908.410990681141, 4917.7786999585105, 4920.581750551208, 4264.722793018444, 4278.7860606969525, 4302.902759796263, 4303.311470164758, 4303.483581970152, 6008.909866351964, 6084.056971169476, 6129.846753831145, 6131.325554189036, 6171.765646870599, 5761.9135712964335, 5764.250647415851, 5764.596478246524, 5774.97112514439, 5777.826665200051, 6766.932330676679, 6796.932030679679, 6811.659417029129, 6821.795346139624, 6839.213490448612, 4771.427428708577, 4790.8323208687525, 4792.784324705397, 4802.231642937113, 4805.567498925078, 6992.720291188346, 7055.435565154775, 7159.0, 7189.496735228536, 7195.028671129383, 4871.196252618278, 4874.317595536628, 4874.390701162355, 4876.829310974099, 4880.023995200903, 4929.06347793918, 4932.975335123301, 4937.086638971802, 4940.086084074458, 4940.851774446773, 5636.60543761941, 5686.857828554236, 5703.17303990919, 5715.742791574389, 5733.770649173986, 6898.586084834926, 6909.689063992132, 6918.619475928772, 6918.93081069193, 6919.238883722786, 1726.7496213049037, 1763.0303333166707, 1767.4344209852723, 1768.5843826700716, 1772.6277481728723, 1163.8777928317575, 1180.7166280092888, 1187.554666999875, 1196.1328037173155, 1197.1918954705714, 6500.869982600416, 6511.674416279167, 6564.80305590833, 6576.309487503839, 6587.0, 7002.614856182959, 7004.509684322048, 7026.051483049825, 7037.824054398681, 7049.400800931979, 6394.8721025579225, 6477.222733272038, 6503.382178693017, 6532.444742196966, 6550.181227346582, 3773.811309434517, 3799.5820459749407, 3826.368649172911, 3838.7120965927666, 3841.7887016214377, 7169.749058782918, 7201.711931522786, 7202.567845929261, 7210.062691850026, 7217.639118044077, 7128.821779455555, 7177.7487787927175, 7218.242084581043, 7251.746188883364, 7260.745873894389, 7175.390091842148, 7189.245129261352, 7201.603911784798, 7213.242609526029, 7213.567185968858, 7003.684834182576, 7036.190838053484, 7041.964790176016, 7047.964760176166, 7055.470839686941, 6775.559588626724, 6936.7572134975035, 6946.097007389007, 6948.478864085315, 6951.756688515878, 7126.322999315057, 7172.784816455514, 7189.196213476853, 7197.676104575411, 7213.3868621167785, 4903.6077113831525, 4905.920697446556, 4908.0, 4910.238912968495, 4926.8768280793265, 6896.758583455026, 6997.545159564816, 7007.264237255219, 7015.894761578478, 7221.386182174574, 6913.723451061901, 6927.480438966997, 6950.131233595801, 6971.5468494547695, 7000.964995174992, 6957.826054348479, 6960.825979350557, 6978.267281935527, 6979.162500499972, 6979.790606281819, 6731.990201469819, 6743.494237932273, 6829.4877884157895, 6837.1111755471475, 6842.178938527409, 6989.615571143432, 6996.895046574407, 7005.789826305219, 7007.7196912122945, 7010.193827709879, 6636.867262654623, 6751.662416879235, 6769.627670478171, 6803.251642319242, 6845.212800528003], "unit": "score", "name": "prototype.html", "value": 5175.085488170421}, {"lowerIsBetter": false, "replicates": [877.166691642939, 891.7057371067548, 891.9197272245497, 898.6764764684714, 926.5876684875232, 13386.933065334671, 13603.455861765542, 13614.183149011042, 13634.250116243615, 13644.727105457885, 11545.307281563111, 11547.076233901289, 11586.0, 11591.072714182867, 11647.883521164786, 843.8818565400849, 866.3545658484438, 869.0440515433037, 872.3108744092191, 873.7946582553095, 860.8837806896083, 862.6032025268353, 862.8101817600118, 862.9611667474978, 865.8051938313861, 907.3512438606396, 907.37844576465, 910.2945217456459, 911.1344222988155, 911.4850109688039, 890.866370044492, 893.5085702863399, 896.4218079338823, 897.4435849773117, 898.137787723786, 652.2043107409, 663.058456991069, 670.6311528659218, 671.2079745899837, 671.318611609217, 14215.431382744679, 14263.857361426357, 14312.284385780773, 14315.069520481135, 14341.928290358586, 13681.726365472734, 13750.518731844337, 13806.93096534521, 13808.723825523533, 13894.583162505141, 11137.331760094421, 11376.943115284454, 11458.312501249868, 11619.360935148563, 11784.646460606196, 3798.297314996707, 3803.1442925341853, 3830.6552410283207, 3892.163184915257, 3976.0258736609717, 49137.26294105591, 50671.746641266924, 51252.231216531785, 51368.229476557884, 52435.47564524344, 10722.0, 10797.406142662228, 11042.723931901766, 11083.556657733761, 11211.159163062803, 17444.215010324566, 17526.474205773848, 17543.210555524776, 17547.21037553313, 17559.648807024045, 7647.08235011791, 7738.342240909473, 7740.0, 7874.21257874208, 8181.754547363588, 4096.426500289962, 4177.60050383119, 4394.516603173648, 4518.661100417482, 4593.954060459419, 3380.645032271625, 3427.7771944823508, 3430.451127819587, 3451.0854623524788, 3460.8096554689732, 631.4916492223804, 638.7476946606065, 638.8083574927504, 639.0637715746453, 646.4279112984948, 568.3293713418124, 572.3818276261627, 613.883362161188, 660.8744338575656, 670.2058061197497, 8846.734597962071, 8959.641614335484, 9059.139381758854, 9263.861042084374, 9379.437233765995, 695.3984803145344, 705.4885208224099, 742.224375527575, 745.2919726259967, 748.1172216784138, 4346.630536404441, 4460.888477788081, 4489.214387482178, 4548.317752337176, 4556.931646025312, 60782.39217607767, 61552.69223653853, 62047.0, 62375.6881215591, 62461.0, 54214.186787198225, 54406.18390724142, 54570.0, 54621.0, 54963.0, 43212.567874320855, 46969.0, 48629.270560941615, 50826.237606435934, 51285.48714512807, 9386.0, 9609.423434593948, 9657.951710241405, 9689.321747477608, 9711.611535538499, 36509.45235821518, 36682.63317366792, 37033.81483092567, 37617.4357384634, 38492.80753596214, 47030.76484617555, 47688.52311476841, 47812.2828157571, 47912.0, 48586.271205932644, 12621.747565048465, 12657.303848288433, 12714.61856144317, 12833.230006199658, 13028.218306901616, 13376.398062087424, 13428.328583570978, 13582.86417135816, 13970.091944023607, 14338.068025578305, 12557.43491542901, 12641.3679316032, 12687.555935542212, 12777.16948398351, 12891.935540322613, 12512.687182820502, 12643.747125057631, 12843.935780321039, 12861.356932153169, 13239.139455935334, 12468.314242716737, 12570.685732856751, 12900.806487902877, 12964.481420743441, 13149.21104733719, 9816.263780216656, 9976.451295178835, 10555.577776889146, 10623.36259824413, 10804.729881753019, 10359.792804144026, 10653.786924261316, 10760.623378181726, 10892.455377231265, 10898.673039808818], "unit": "score", "name": "yui.html", "value": 6761.996790781104}], "name": "dromaeo_css", "value": 7336.586441158015}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 109.0, 111.0, 120.0, 109.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 150.0, 167.0, 126.0, 149.0, 154.0, 134.0, 158.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 164.0, 161.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 73.0, 152.0, 74.0, 76.0, 76.0, 76.0, 153.0, 73.0], "unit": "score", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [99.0, 95.0, 136.0, 95.0, 96.0, 96.0, 147.0, 95.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 148.0, 147.0, 148.0, 148.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 101.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 60.0, 56.0, 56.0, 58.0, 55.0, 61.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 66.0, 65.0, 63.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [89.0, 82.0, 84.0, 82.0, 83.0, 82.0, 84.0, 82.0, 90.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [122.0, 115.0, 120.0, 122.0, 115.0, 112.0, 112.0, 117.0, 127.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [149.0, 138.0, 138.0, 139.0, 148.0, 143.0, 149.0, 136.0, 139.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 65.0, 67.0, 70.0, 66.0, 66.0, 66.0, 69.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1500.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "Richards", "value": 213.25938200000004}, {"lowerIsBetter": false, "replicates": [178.25311942959001], "unit": "score", "name": "DeltaBlue", "value": 370.9219800000001}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [905.7971014492754], "unit": "score", "name": "RayTrace", "value": 816.9478559999999}, {"lowerIsBetter": false, "replicates": [563.6978579481398], "unit": "score", "name": "Earley", "value": 1182.3053619999998}, {"lowerIsBetter": false, "replicates": [11269.662921348314], "unit": "score", "name": "Boyer", "value": 59.1377936191426}, {"lowerIsBetter": false, "replicates": [39538.46153846154], "unit": "score", "name": "RegExp", "value": 23.040476653696484}, {"lowerIsBetter": false, "replicates": [506.53923541247485], "unit": "score", "name": "Splay", "value": 160.87796226415097}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21958.18139020111}]} 01:15:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21958.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1500.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7336.59"}}} 01:15:29 INFO - Return code: 0 01:15:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:15:29 INFO - # TBPL SUCCESS # 01:15:29 INFO - Running post-action listener: _resource_record_post_action 01:15:29 INFO - Running post-run listener: _resource_record_post_run 01:15:30 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 262144; Write bytes: 498110464; Read time: 16; Write time: 321884 01:15:30 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 239624192; Read time: 0; Write time: 197112 01:15:30 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 262144; Write bytes: 258486272; Read time: 16; Write time: 124772 01:15:30 INFO - Running post-run listener: _upload_blobber_files 01:15:30 INFO - Blob upload gear active. 01:15:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:15:30 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 01:15:30 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'] 01:15:30 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 01:15:31 INFO - (blobuploader) - INFO - Open directory for files ... 01:15:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:15:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:32 INFO - (blobuploader) - INFO - Done attempting. 01:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:15:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:33 INFO - (blobuploader) - INFO - Done attempting. 01:15:33 INFO - (blobuploader) - INFO - Iteration through files over. 01:15:33 INFO - Return code: 0 01:15:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:15:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:15:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba5ddc0422a2cdef1a2b92bd7c30c1b5c65578abb8a1a78288ff841f764ec547840f3ac888e4ae0b3f6cd586ac5404a485e597380fb76b597025c1b65e4c8c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fb571459ff56b679825b1b1a10eaea03f355c3f5054ac61ce70d1b69db4c1ace030675cd8042aed5ed85d22f87f036fa8ae570a5c83c0dde5a5ea220db89b1c"} 01:15:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:15:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:15:33 INFO - Contents: 01:15:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba5ddc0422a2cdef1a2b92bd7c30c1b5c65578abb8a1a78288ff841f764ec547840f3ac888e4ae0b3f6cd586ac5404a485e597380fb76b597025c1b65e4c8c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fb571459ff56b679825b1b1a10eaea03f355c3f5054ac61ce70d1b69db4c1ace030675cd8042aed5ed85d22f87f036fa8ae570a5c83c0dde5a5ea220db89b1c"} 01:15:33 INFO - Running post-run listener: copy_logs_to_upload_dir 01:15:33 INFO - Copying logs to upload dir... 01:15:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:15:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.749884 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-03 01:15:32.600282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-03 01:15:32.604192) ========= 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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 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/ba5ddc0422a2cdef1a2b92bd7c30c1b5c65578abb8a1a78288ff841f764ec547840f3ac888e4ae0b3f6cd586ac5404a485e597380fb76b597025c1b65e4c8c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fb571459ff56b679825b1b1a10eaea03f355c3f5054ac61ce70d1b69db4c1ace030675cd8042aed5ed85d22f87f036fa8ae570a5c83c0dde5a5ea220db89b1c"} build_url:https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/Aq8_RZzoS5ePDnwKQ6_T5w/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/ba5ddc0422a2cdef1a2b92bd7c30c1b5c65578abb8a1a78288ff841f764ec547840f3ac888e4ae0b3f6cd586ac5404a485e597380fb76b597025c1b65e4c8c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fb571459ff56b679825b1b1a10eaea03f355c3f5054ac61ce70d1b69db4c1ace030675cd8042aed5ed85d22f87f036fa8ae570a5c83c0dde5a5ea220db89b1c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-03 01:15:32.629320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 01:15:32.629672) ========= 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=82e07478c745e68b1fe4678a000001bc-1454483995.320141-1021917807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 01:15:32.714907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 01:15:32.715222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 01:15:32.715522) ========= ========= Total master_lag: 0.33 =========