builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1456579071.05 results: success (0) buildid: 20160225003532 builduid: 19b21cca3a27485ea0911c3d30dd0afb revision: a6621cd9929e1b7337f85a8b8a237918c15436ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.049410) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.050252) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.050876) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.076331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.077100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.089696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.090321) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004677 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.143187) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.143528) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.143937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.144246) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 05:17:51-- 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% 39.5M=0s 2016-02-27 05:17:52 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.331406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.331933) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016453 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.384590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:51.385444) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6621cd9929e1b7337f85a8b8a237918c15436ed --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 a6621cd9929e1b7337f85a8b8a237918c15436ed --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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 05:17:52,161 truncating revision to first 12 chars 2016-02-27 05:17:52,161 Setting DEBUG logging. 2016-02-27 05:17:52,161 attempt 1/10 2016-02-27 05:17:52,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6621cd9929e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 05:17:52,809 unpacking tar archive at: mozilla-aurora-a6621cd9929e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.950279 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:52.350122) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:52.350576) ========= echo a6621cd9929e1b7337f85a8b8a237918c15436ed in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a6621cd9929e1b7337f85a8b8a237918c15436ed'] 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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a6621cd9929e1b7337f85a8b8a237918c15436ed program finished with exit code 0 elapsedTime=0.004168 script_repo_revision: 'a6621cd9929e1b7337f85a8b8a237918c15436ed' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:52.404533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:52.404901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:17:52.414510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-27 05:17:52.414986) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:53 INFO - MultiFileLogger online at 20160227 05:17:53 in /builds/slave/test-pgo 05:17:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:17:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:17:53 INFO - {'append_to_log': False, 05:17:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:17:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:17:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:17:53 INFO - 'branch': 'Mozilla-Aurora', 05:17:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:53 INFO - 'config_files': ('talos/linux_config.py',), 05:17:53 INFO - 'default_actions': ('clobber', 05:17:53 INFO - 'read-buildbot-config', 05:17:53 INFO - 'download-and-extract', 05:17:53 INFO - 'populate-webroot', 05:17:53 INFO - 'create-virtualenv', 05:17:53 INFO - 'install', 05:17:53 INFO - 'run-tests'), 05:17:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:53 INFO - 'download_minidump_stackwalk': True, 05:17:53 INFO - 'download_symbols': 'ondemand', 05:17:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:53 INFO - 'installer_path': 'installer.exe', 05:17:53 INFO - 'log_level': 'info', 05:17:53 INFO - 'log_name': 'talos', 05:17:53 INFO - 'log_to_console': True, 05:17:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:53 INFO - 'opt_config_files': (), 05:17:53 INFO - 'pip_index': False, 05:17:53 INFO - 'sps_profile': False, 05:17:53 INFO - 'sps_profile_interval': 0, 05:17:53 INFO - 'suite': 'dromaeojs-e10s', 05:17:53 INFO - 'system_bits': '32', 05:17:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:53 INFO - 'title': 'talos-linux64-ix-014', 05:17:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:53 INFO - 'use_talos_json': True, 05:17:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:17:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:53 INFO - 'work_dir': 'build'} 05:17:53 INFO - ##### 05:17:53 INFO - ##### Running clobber step. 05:17:53 INFO - ##### 05:17:53 INFO - Running pre-action listener: _resource_record_pre_action 05:17:53 INFO - Running main action method: clobber 05:17:53 INFO - rmtree: /builds/slave/test-pgo/build 05:17:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:17:53 INFO - Running post-action listener: _resource_record_post_action 05:17:53 INFO - ##### 05:17:53 INFO - ##### Running read-buildbot-config step. 05:17:53 INFO - ##### 05:17:53 INFO - Running pre-action listener: _resource_record_pre_action 05:17:53 INFO - Running main action method: read_buildbot_config 05:17:53 INFO - Using buildbot properties: 05:17:53 INFO - { 05:17:53 INFO - "project": "", 05:17:53 INFO - "product": "firefox", 05:17:53 INFO - "script_repo_revision": "production", 05:17:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:17:53 INFO - "repository": "", 05:17:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:17:53 INFO - "buildid": "20160225003532", 05:17:53 INFO - "pgo_build": "True", 05:17:53 INFO - "basedir": "/builds/slave/test-pgo", 05:17:53 INFO - "buildnumber": 174, 05:17:53 INFO - "slavename": "talos-linux64-ix-014", 05:17:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:17:53 INFO - "platform": "ubuntu64_hw", 05:17:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:17:53 INFO - "branch": "mozilla-aurora", 05:17:53 INFO - "repo_path": "releases/mozilla-aurora", 05:17:53 INFO - "revision": "a6621cd9929e1b7337f85a8b8a237918c15436ed", 05:17:53 INFO - "stage_platform": "linux64-pgo", 05:17:53 INFO - "builduid": "19b21cca3a27485ea0911c3d30dd0afb", 05:17:53 INFO - "slavebuilddir": "test" 05:17:53 INFO - } 05:17:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 05:17:53 INFO - Running post-action listener: _resource_record_post_action 05:17:53 INFO - ##### 05:17:53 INFO - ##### Running download-and-extract step. 05:17:53 INFO - ##### 05:17:53 INFO - Running pre-action listener: _resource_record_pre_action 05:17:53 INFO - Running main action method: download_and_extract 05:17:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:53 INFO - https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:17:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/test_packages.json 05:17:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/test_packages.json 05:17:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:17:54 INFO - Downloaded 1448 bytes. 05:17:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:17:54 INFO - Using the following test package requirements: 05:17:54 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:17:54 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:17:54 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:17:54 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'jsshell-linux-x86_64.zip'], 05:17:54 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:17:54 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:17:54 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:17:54 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:17:54 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:17:54 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:17:54 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:17:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:17:54 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:54 INFO - https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:17:55 INFO - Downloaded 23078876 bytes. 05:17:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:17:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:17:56 INFO - Return code: 0 05:17:56 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:56 INFO - https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:17:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:17:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:17:57 INFO - Downloaded 23078876 bytes. 05:17:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:17:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:17:59 INFO - Return code: 0 05:17: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')]} 05:17:59 INFO - https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:18:00 INFO - Downloaded 10706649 bytes. 05:18:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:18:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:18:00 INFO - Return code: 0 05:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:00 INFO - https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:18:02 INFO - Downloaded 59959118 bytes. 05:18:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:18:02 INFO - mkdir: /builds/slave/test-pgo/properties 05:18:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:18:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:18:02 INFO - Contents: 05:18:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:18:02 INFO - Running post-action listener: _resource_record_post_action 05:18:02 INFO - Running post-action listener: set_extra_try_arguments 05:18:02 INFO - ##### 05:18:02 INFO - ##### Running populate-webroot step. 05:18:02 INFO - ##### 05:18:02 INFO - Running pre-action listener: _resource_record_pre_action 05:18:02 INFO - Running main action method: populate_webroot 05:18:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:02 INFO - '--tppagecycles', 05:18:02 INFO - '7'], 05:18:02 INFO - 'tests': ['tsvgm']}}, 05:18:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:18:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:18:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:18:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'tests': ['damp', 'tps']}, 05:18:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['damp', 'tps']}, 05:18:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:18:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:02 INFO - 'other': {'tests': ['a11yr', 05:18:02 INFO - 'ts_paint', 05:18:02 INFO - 'tpaint', 05:18:02 INFO - 'sessionrestore', 05:18:02 INFO - 'sessionrestore_no_auto_restore']}, 05:18:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['a11yr', 05:18:02 INFO - 'ts_paint', 05:18:02 INFO - 'tpaint', 05:18:02 INFO - 'sessionrestore', 05:18:02 INFO - 'sessionrestore_no_auto_restore']}, 05:18:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['a11yr', 05:18:02 INFO - 'ts_paint', 05:18:02 INFO - 'tpaint', 05:18:02 INFO - 'sessionrestore', 05:18:02 INFO - 'sessionrestore_no_auto_restore']}, 05:18:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['a11yr', 05:18:02 INFO - 'ts_paint', 05:18:02 INFO - 'tpaint', 05:18:02 INFO - 'sessionrestore', 05:18:02 INFO - 'sessionrestore_no_auto_restore']}, 05:18:02 INFO - 'other_l64': {'tests': ['a11yr', 05:18:02 INFO - 'ts_paint', 05:18:02 INFO - 'tpaint', 05:18:02 INFO - 'sessionrestore', 05:18:02 INFO - 'sessionrestore_no_auto_restore']}, 05:18:02 INFO - 'other_nol64': {'tests': ['a11yr', 05:18:02 INFO - 'ts_paint', 05:18:02 INFO - 'tpaint', 05:18:02 INFO - 'sessionrestore', 05:18:02 INFO - 'sessionrestore_no_auto_restore']}, 05:18:02 INFO - 'svgr': {'tests': ['tsvgx', 05:18:02 INFO - 'tsvgr_opacity', 05:18:02 INFO - 'tart', 05:18:02 INFO - 'tscrollx', 05:18:02 INFO - 'cart']}, 05:18:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['tsvgx', 05:18:02 INFO - 'tsvgr_opacity', 05:18:02 INFO - 'tart', 05:18:02 INFO - 'tscrollx', 05:18:02 INFO - 'cart']}, 05:18:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'tests': ['tp5o']}, 05:18:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'talos_options': ['--e10s'], 05:18:02 INFO - 'tests': ['tp5o']}, 05:18:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'talos_options': ['--xperf_path', 05:18:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:02 INFO - 'tests': ['tp5n']}, 05:18:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:02 INFO - 'talos_options': ['--e10s', 05:18:02 INFO - '--xperf_path', 05:18:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:02 INFO - 'tests': ['tp5n']}}, 05:18:02 INFO - 'talos.zip': {'path': '', 05:18:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:02 INFO - Running post-action listener: _resource_record_post_action 05:18:02 INFO - ##### 05:18:02 INFO - ##### Running create-virtualenv step. 05:18:02 INFO - ##### 05:18:02 INFO - Running pre-action listener: _resource_record_pre_action 05:18:02 INFO - Running main action method: create_virtualenv 05:18:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:18:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:18:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:18:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:03 INFO - Using real prefix '/usr' 05:18:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:18:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:05 INFO - Installing pip.................done. 05:18:05 INFO - Return code: 0 05:18:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:05 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 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:18:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:18:05 INFO - Using env: {'DISPLAY': ':0', 05:18:05 INFO - 'HOME': '/home/cltbld', 05:18:05 INFO - 'LANG': 'en_US.UTF-8', 05:18:05 INFO - 'LANGUAGE': 'en_US:en', 05:18:05 INFO - 'LOGNAME': 'cltbld', 05:18:05 INFO - 'MAIL': '/var/mail/cltbld', 05:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:05 INFO - 'MOZ_NO_REMOTE': '1', 05:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:05 INFO - 'NO_EM_RESTART': '1', 05:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:05 INFO - 'SHELL': '/bin/bash', 05:18:05 INFO - 'SHLVL': '1', 05:18:05 INFO - 'TERM': 'linux', 05:18:05 INFO - 'TMOUT': '86400', 05:18:05 INFO - 'USER': 'cltbld', 05:18:05 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:05 INFO - '_': '/tools/buildbot/bin/python'} 05:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:18:05 INFO - Cleaning up... 05:18:05 INFO - Return code: 0 05:18:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:05 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 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:18:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:18:05 INFO - Using env: {'DISPLAY': ':0', 05:18:05 INFO - 'HOME': '/home/cltbld', 05:18:05 INFO - 'LANG': 'en_US.UTF-8', 05:18:05 INFO - 'LANGUAGE': 'en_US:en', 05:18:05 INFO - 'LOGNAME': 'cltbld', 05:18:05 INFO - 'MAIL': '/var/mail/cltbld', 05:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:05 INFO - 'MOZ_NO_REMOTE': '1', 05:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:05 INFO - 'NO_EM_RESTART': '1', 05:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:05 INFO - 'SHELL': '/bin/bash', 05:18:05 INFO - 'SHLVL': '1', 05:18:05 INFO - 'TERM': 'linux', 05:18:05 INFO - 'TMOUT': '86400', 05:18:05 INFO - 'USER': 'cltbld', 05:18:05 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:05 INFO - '_': '/tools/buildbot/bin/python'} 05:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:06 INFO - Downloading/unpacking psutil>=0.7.1 05:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:08 INFO - Installing collected packages: psutil 05:18:08 INFO - Running setup.py install for psutil 05:18:08 INFO - building 'psutil._psutil_linux' extension 05:18:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:18:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:18:08 INFO - building 'psutil._psutil_posix' extension 05:18:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:18:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:18:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:08 INFO - Successfully installed psutil 05:18:08 INFO - Cleaning up... 05:18:08 INFO - Return code: 0 05:18:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:18:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:18:08 INFO - Using env: {'DISPLAY': ':0', 05:18:08 INFO - 'HOME': '/home/cltbld', 05:18:08 INFO - 'LANG': 'en_US.UTF-8', 05:18:08 INFO - 'LANGUAGE': 'en_US:en', 05:18:08 INFO - 'LOGNAME': 'cltbld', 05:18:08 INFO - 'MAIL': '/var/mail/cltbld', 05:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:08 INFO - 'MOZ_NO_REMOTE': '1', 05:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:08 INFO - 'NO_EM_RESTART': '1', 05:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:08 INFO - 'SHELL': '/bin/bash', 05:18:08 INFO - 'SHLVL': '1', 05:18:08 INFO - 'TERM': 'linux', 05:18:08 INFO - 'TMOUT': '86400', 05:18:08 INFO - 'USER': 'cltbld', 05:18:08 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:08 INFO - '_': '/tools/buildbot/bin/python'} 05:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:18:10 INFO - Installing collected packages: mozsystemmonitor 05:18:10 INFO - Running setup.py install for mozsystemmonitor 05:18:10 INFO - Successfully installed mozsystemmonitor 05:18:10 INFO - Cleaning up... 05:18:10 INFO - Return code: 0 05:18:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:10 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 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:18:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:18:10 INFO - Using env: {'DISPLAY': ':0', 05:18:10 INFO - 'HOME': '/home/cltbld', 05:18:10 INFO - 'LANG': 'en_US.UTF-8', 05:18:10 INFO - 'LANGUAGE': 'en_US:en', 05:18:10 INFO - 'LOGNAME': 'cltbld', 05:18:10 INFO - 'MAIL': '/var/mail/cltbld', 05:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:10 INFO - 'MOZ_NO_REMOTE': '1', 05:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:10 INFO - 'NO_EM_RESTART': '1', 05:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:10 INFO - 'SHELL': '/bin/bash', 05:18:10 INFO - 'SHLVL': '1', 05:18:10 INFO - 'TERM': 'linux', 05:18:10 INFO - 'TMOUT': '86400', 05:18:10 INFO - 'USER': 'cltbld', 05:18:10 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:10 INFO - '_': '/tools/buildbot/bin/python'} 05:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:11 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:12 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:18:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:13 INFO - Downloading docopt-0.6.1.tar.gz 05:18:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:13 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:13 INFO - Running setup.py install for blobuploader 05:18:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:18:13 INFO - Running setup.py install for requests 05:18:14 INFO - Running setup.py install for docopt 05:18:14 INFO - Successfully installed blobuploader requests docopt 05:18:14 INFO - Cleaning up... 05:18:14 INFO - Return code: 0 05:18:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:18:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:14 INFO - Using env: {'DISPLAY': ':0', 05:18:14 INFO - 'HOME': '/home/cltbld', 05:18:14 INFO - 'LANG': 'en_US.UTF-8', 05:18:14 INFO - 'LANGUAGE': 'en_US:en', 05:18:14 INFO - 'LOGNAME': 'cltbld', 05:18:14 INFO - 'MAIL': '/var/mail/cltbld', 05:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:14 INFO - 'MOZ_NO_REMOTE': '1', 05:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:14 INFO - 'NO_EM_RESTART': '1', 05:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:14 INFO - 'SHELL': '/bin/bash', 05:18:14 INFO - 'SHLVL': '1', 05:18:14 INFO - 'TERM': 'linux', 05:18:14 INFO - 'TMOUT': '86400', 05:18:14 INFO - 'USER': 'cltbld', 05:18:14 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:14 INFO - '_': '/tools/buildbot/bin/python'} 05:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:14 INFO - Running setup.py (path:/tmp/pip-lzhued-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:14 INFO - Running setup.py (path:/tmp/pip-83iwTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:14 INFO - Running setup.py (path:/tmp/pip-IeXTyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:14 INFO - Running setup.py (path:/tmp/pip-ruuUtu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:14 INFO - Running setup.py (path:/tmp/pip-gwfwIe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:14 INFO - Running setup.py (path:/tmp/pip-HCG4_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:15 INFO - Running setup.py (path:/tmp/pip-DlBwlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:15 INFO - Running setup.py (path:/tmp/pip-b2vA8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:15 INFO - Running setup.py (path:/tmp/pip-xFTaqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:15 INFO - Running setup.py (path:/tmp/pip-qkTMOx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:15 INFO - Running setup.py (path:/tmp/pip-AjdOUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:15 INFO - Running setup.py (path:/tmp/pip-BglNBP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:15 INFO - Running setup.py (path:/tmp/pip-fnAS0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:15 INFO - Running setup.py (path:/tmp/pip-xeO6gA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:15 INFO - Running setup.py (path:/tmp/pip-bUj546-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:15 INFO - Running setup.py (path:/tmp/pip-Kys6RC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:15 INFO - Running setup.py (path:/tmp/pip-GU6QRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:15 INFO - Running setup.py install for manifestparser 05:18:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:18:15 INFO - Running setup.py install for mozcrash 05:18:16 INFO - Running setup.py install for mozdebug 05:18:16 INFO - Running setup.py install for mozdevice 05:18:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Running setup.py install for mozfile 05:18:16 INFO - Running setup.py install for mozhttpd 05:18:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Running setup.py install for mozinfo 05:18:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Running setup.py install for mozInstall 05:18:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Running setup.py install for mozleak 05:18:16 INFO - Running setup.py install for mozlog 05:18:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Running setup.py install for moznetwork 05:18:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Running setup.py install for mozprocess 05:18:17 INFO - Running setup.py install for mozprofile 05:18:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:18:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:18:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:18:17 INFO - Running setup.py install for mozrunner 05:18:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:18:17 INFO - Running setup.py install for mozscreenshot 05:18:17 INFO - Running setup.py install for moztest 05:18:17 INFO - Running setup.py install for mozversion 05:18:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:18:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:17 INFO - Cleaning up... 05:18:17 INFO - Return code: 0 05:18:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:18:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:17 INFO - Using env: {'DISPLAY': ':0', 05:18:17 INFO - 'HOME': '/home/cltbld', 05:18:17 INFO - 'LANG': 'en_US.UTF-8', 05:18:17 INFO - 'LANGUAGE': 'en_US:en', 05:18:17 INFO - 'LOGNAME': 'cltbld', 05:18:17 INFO - 'MAIL': '/var/mail/cltbld', 05:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:17 INFO - 'MOZ_NO_REMOTE': '1', 05:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:17 INFO - 'NO_EM_RESTART': '1', 05:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:17 INFO - 'SHELL': '/bin/bash', 05:18:17 INFO - 'SHLVL': '1', 05:18:17 INFO - 'TERM': 'linux', 05:18:17 INFO - 'TMOUT': '86400', 05:18:17 INFO - 'USER': 'cltbld', 05:18:17 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:17 INFO - '_': '/tools/buildbot/bin/python'} 05:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:17 INFO - Running setup.py (path:/tmp/pip-ltk4ju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:18:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:17 INFO - Running setup.py (path:/tmp/pip-NNZtNW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:17 INFO - Running setup.py (path:/tmp/pip-RrOl4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:18 INFO - Running setup.py (path:/tmp/pip-pUmaBM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:18 INFO - Running setup.py (path:/tmp/pip-iNmur5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:18 INFO - Running setup.py (path:/tmp/pip-bIGJCn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:18 INFO - Running setup.py (path:/tmp/pip-9tYL3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:18 INFO - Running setup.py (path:/tmp/pip-eDYHeA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:18 INFO - Running setup.py (path:/tmp/pip-tD2EzF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:18 INFO - Running setup.py (path:/tmp/pip-p6XmI4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:18 INFO - Running setup.py (path:/tmp/pip-pCy6FE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:18 INFO - Running setup.py (path:/tmp/pip-kqAh0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:18 INFO - Running setup.py (path:/tmp/pip-rafiCa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:18 INFO - Running setup.py (path:/tmp/pip-vijAy2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:18 INFO - Running setup.py (path:/tmp/pip-VpSGqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:18 INFO - Running setup.py (path:/tmp/pip-1f8MXA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:19 INFO - Running setup.py (path:/tmp/pip-B4cpwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - Downloading blessings-1.6.tar.gz 05:18:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:21 INFO - Installing collected packages: blessings 05:18:21 INFO - Running setup.py install for blessings 05:18:21 INFO - Successfully installed blessings 05:18:21 INFO - Cleaning up... 05:18:21 INFO - Return code: 0 05:18:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:18:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:18:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:18:21 INFO - Reading from file tmpfile_stdout 05:18:21 INFO - Current package versions: 05:18:21 INFO - argparse == 1.2.1 05:18:21 INFO - blessings == 1.6 05:18:21 INFO - blobuploader == 1.2.4 05:18:21 INFO - docopt == 0.6.1 05:18:21 INFO - manifestparser == 1.1 05:18:21 INFO - mozInstall == 1.12 05:18:21 INFO - mozcrash == 0.16 05:18:21 INFO - mozdebug == 0.1 05:18:21 INFO - mozdevice == 0.48 05:18:21 INFO - mozfile == 1.2 05:18:21 INFO - mozhttpd == 0.7 05:18:21 INFO - mozinfo == 0.9 05:18:21 INFO - mozleak == 0.1 05:18:21 INFO - mozlog == 3.1 05:18:21 INFO - moznetwork == 0.27 05:18:21 INFO - mozprocess == 0.22 05:18:21 INFO - mozprofile == 0.28 05:18:21 INFO - mozrunner == 6.11 05:18:21 INFO - mozscreenshot == 0.1 05:18:21 INFO - mozsystemmonitor == 0.0 05:18:21 INFO - moztest == 0.7 05:18:21 INFO - mozversion == 1.4 05:18:21 INFO - psutil == 3.1.1 05:18:21 INFO - requests == 1.2.3 05:18:21 INFO - wsgiref == 0.1.2 05:18:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:18:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:21 INFO - Using env: {'DISPLAY': ':0', 05:18:21 INFO - 'HOME': '/home/cltbld', 05:18:21 INFO - 'LANG': 'en_US.UTF-8', 05:18:21 INFO - 'LANGUAGE': 'en_US:en', 05:18:21 INFO - 'LOGNAME': 'cltbld', 05:18:21 INFO - 'MAIL': '/var/mail/cltbld', 05:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:21 INFO - 'MOZ_NO_REMOTE': '1', 05:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:21 INFO - 'NO_EM_RESTART': '1', 05:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:21 INFO - 'SHELL': '/bin/bash', 05:18:21 INFO - 'SHLVL': '1', 05:18:21 INFO - 'TERM': 'linux', 05:18:21 INFO - 'TMOUT': '86400', 05:18:21 INFO - 'USER': 'cltbld', 05:18:21 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:21 INFO - '_': '/tools/buildbot/bin/python'} 05:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:18:21 INFO - Cleaning up... 05:18:21 INFO - Return code: 0 05:18:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:18:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:18:21 INFO - Using env: {'DISPLAY': ':0', 05:18:21 INFO - 'HOME': '/home/cltbld', 05:18:21 INFO - 'LANG': 'en_US.UTF-8', 05:18:21 INFO - 'LANGUAGE': 'en_US:en', 05:18:21 INFO - 'LOGNAME': 'cltbld', 05:18:21 INFO - 'MAIL': '/var/mail/cltbld', 05:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:21 INFO - 'MOZ_NO_REMOTE': '1', 05:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:21 INFO - 'NO_EM_RESTART': '1', 05:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:21 INFO - 'SHELL': '/bin/bash', 05:18:21 INFO - 'SHLVL': '1', 05:18:21 INFO - 'TERM': 'linux', 05:18:21 INFO - 'TMOUT': '86400', 05:18:21 INFO - 'USER': 'cltbld', 05:18:21 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:21 INFO - '_': '/tools/buildbot/bin/python'} 05:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:21 INFO - Downloading/unpacking jsonschema 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:23 INFO - Downloading/unpacking functools32 (from jsonschema) 05:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:23 INFO - warning: no files found matching '*.txt' 05:18:23 INFO - no previously-included directories found matching 'build' 05:18:23 INFO - no previously-included directories found matching 'dist' 05:18:23 INFO - no previously-included directories found matching '.git*' 05:18:23 INFO - Installing collected packages: jsonschema, functools32 05:18:24 INFO - Running setup.py install for functools32 05:18:24 INFO - warning: no files found matching '*.txt' 05:18:24 INFO - no previously-included directories found matching 'build' 05:18:24 INFO - no previously-included directories found matching 'dist' 05:18:24 INFO - no previously-included directories found matching '.git*' 05:18:24 INFO - Successfully installed jsonschema functools32 05:18:24 INFO - Cleaning up... 05:18:24 INFO - Return code: 0 05:18:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:24 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 0x7f4f2db83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:18:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:18:24 INFO - Using env: {'DISPLAY': ':0', 05:18:24 INFO - 'HOME': '/home/cltbld', 05:18:24 INFO - 'LANG': 'en_US.UTF-8', 05:18:24 INFO - 'LANGUAGE': 'en_US:en', 05:18:24 INFO - 'LOGNAME': 'cltbld', 05:18:24 INFO - 'MAIL': '/var/mail/cltbld', 05:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:24 INFO - 'MOZ_NO_REMOTE': '1', 05:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:24 INFO - 'NO_EM_RESTART': '1', 05:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:24 INFO - 'SHELL': '/bin/bash', 05:18:24 INFO - 'SHLVL': '1', 05:18:24 INFO - 'TERM': 'linux', 05:18:24 INFO - 'TMOUT': '86400', 05:18:24 INFO - 'USER': 'cltbld', 05:18:24 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:24 INFO - '_': '/tools/buildbot/bin/python'} 05:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:24 INFO - Downloading/unpacking flake8 05:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:18:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:18:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:18:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:26 INFO - no previously-included directories found matching 'docs/_build' 05:18:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:18:26 INFO - Running setup.py install for pep8 05:18:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:27 INFO - no previously-included directories found matching 'docs/_build' 05:18:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:18:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:18:27 INFO - Cleaning up... 05:18:27 INFO - Return code: 0 05:18:27 INFO - Running post-action listener: _resource_record_post_action 05:18:27 INFO - Running post-action listener: _start_resource_monitoring 05:18:27 INFO - Starting resource monitoring. 05:18:27 INFO - ##### 05:18:27 INFO - ##### Running install step. 05:18:27 INFO - ##### 05:18:27 INFO - Running pre-action listener: _resource_record_pre_action 05:18:27 INFO - Running main action method: install 05:18:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:18:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:18:27 INFO - Reading from file tmpfile_stdout 05:18:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:18:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:18:27 INFO - Reading from file tmpfile_stdout 05:18:27 INFO - Output received: 05:18:27 INFO - Usage: mozinstall [options] installer 05:18:27 INFO - Options: 05:18:27 INFO - -h, --help show this help message and exit 05:18:27 INFO - -d DEST, --destination=DEST 05:18:27 INFO - Directory to install application into. [default: 05:18:27 INFO - "/builds/slave/test-pgo"] 05:18:27 INFO - --app=APP Application being installed. [default: firefox] 05:18:27 INFO - mkdir: /builds/slave/test-pgo/build/application 05:18:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:18:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:18:42 INFO - Reading from file tmpfile_stdout 05:18:42 INFO - Output received: 05:18:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:18:42 INFO - Running post-action listener: _resource_record_post_action 05:18:42 INFO - ##### 05:18:42 INFO - ##### Running run-tests step. 05:18:42 INFO - ##### 05:18:42 INFO - Running pre-action listener: _resource_record_pre_action 05:18:42 INFO - Running main action method: run_tests 05:18:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:18:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:18:42 INFO - Python 2.7.3 05:18:42 INFO - Return code: 0 05:18:42 INFO - grabbing minidump binary from tooltool 05:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd97f0>, '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 0xf452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf45760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:18:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:18:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:18:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:42 INFO - Return code: 0 05:18:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:18:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:18:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:18:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:18:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:18:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:18:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:18:43 INFO - Return code: 0 05:18:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:18:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:18:43 INFO - Using env: {'DISPLAY': ':0', 05:18:43 INFO - 'HOME': '/home/cltbld', 05:18:43 INFO - 'LANG': 'en_US.UTF-8', 05:18:43 INFO - 'LANGUAGE': 'en_US:en', 05:18:43 INFO - 'LOGNAME': 'cltbld', 05:18:43 INFO - 'MAIL': '/var/mail/cltbld', 05:18:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:18:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:43 INFO - 'MOZ_NO_REMOTE': '1', 05:18:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:43 INFO - 'NO_EM_RESTART': '1', 05:18:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:18:43 INFO - 'SHELL': '/bin/bash', 05:18:43 INFO - 'SHLVL': '1', 05:18:43 INFO - 'TERM': 'linux', 05:18:43 INFO - 'TMOUT': '86400', 05:18:43 INFO - 'USER': 'cltbld', 05:18:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080', 05:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:43 INFO - '_': '/tools/buildbot/bin/python'} 05:18:43 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:18:43 INFO - mozversion application_buildid: 20160225003532 05:18:43 INFO - mozversion application_changeset: a6621cd9929e1b7337f85a8b8a237918c15436ed 05:18:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:18:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:43 INFO - mozversion application_name: Firefox 05:18:43 INFO - mozversion application_remotingname: firefox-dev 05:18:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:18:43 INFO - mozversion application_vendor: Mozilla 05:18:43 INFO - mozversion application_version: 46.0a2 05:18:43 INFO - mozversion platform_buildid: 20160225003532 05:18:43 INFO - mozversion platform_changeset: a6621cd9929e1b7337f85a8b8a237918c15436ed 05:18:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:18:43 INFO - mozversion platform_version: 46.0a2 05:18:43 INFO - using testdate: 1456579123 05:18:43 INFO - actual date: 1456579123 05:18:43 INFO - starting webserver on 'localhost:42023' 05:18:43 INFO - SUITE-START | Running 3 tests 05:18:43 INFO - TEST-START | dromaeo_css 05:18:43 INFO - operating with platform_type : linux_ 05:18:43 INFO - Initialising browser for dromaeo_css test... 05:18:43 INFO - TEST-INFO | started process 20556 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcyNiYX/profile http://localhost:42023/getInfo.html) 05:18:47 INFO - PROCESS | 20556 | 05:18:47 INFO - PROCESS | 20556 | (process:20637): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:48 INFO - PROCESS | 20556 | __metrics Screen width/height:1600/1200 05:18:48 INFO - PROCESS | 20556 | colorDepth:24 05:18:48 INFO - PROCESS | 20556 | Browser inner width/height: 1024/697 05:18:48 INFO - PROCESS | 20556 | __metrics 05:18:49 INFO - TEST-INFO | 20556: exit 0 05:18:49 INFO - Browser initialized. 05:18:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:49 INFO - TEST-INFO | started process 20686 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcyNiYX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:50 INFO - PROCESS | 20686 | 05:18:50 INFO - PROCESS | 20686 | (process:20749): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:01 INFO - PROCESS | 20686 | RSS: Main: 141283328 05:19:01 INFO - PROCESS | 20686 | 05:19:51 INFO - PROCESS | 20686 | 1456579191044 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:21:58 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:42023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42023/tests/dromaeo/cssquery-ext.html) 05:21:59 INFO - PROCESS | 20686 | RSS: Main: 145739776 05:21:59 INFO - PROCESS | 20686 | 05:25:01 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:42023/tests/dromaeo/cssquery-ext.html (next: http://localhost:42023/tests/dromaeo/cssquery-jquery.html) 05:25:02 INFO - PROCESS | 20686 | RSS: Main: 144617472 05:25:02 INFO - PROCESS | 20686 | 05:28:04 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:42023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42023/tests/dromaeo/cssquery-mootools.html) 05:28:04 INFO - PROCESS | 20686 | RSS: Main: 143564800 05:28:04 INFO - PROCESS | 20686 | 05:31:06 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:42023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42023/tests/dromaeo/cssquery-prototype.html) 05:31:06 INFO - PROCESS | 20686 | RSS: Main: 143323136 05:31:06 INFO - PROCESS | 20686 | 05:34:09 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:42023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42023/tests/dromaeo/cssquery-yui.html) 05:34:09 INFO - PROCESS | 20686 | RSS: Main: 143519744 05:34:09 INFO - PROCESS | 20686 | 05:37:11 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:42023/tests/dromaeo/cssquery-yui.html (next: http://localhost:42023/tests/dromaeo/cssquery-dojo.html) 05:37:12 INFO - PROCESS | 20686 | RSS: Main: 146706432 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | __start_tp_report 05:37:12 INFO - PROCESS | 20686 | _x_x_mozilla_page_load 05:37:12 INFO - PROCESS | 20686 | _x_x_mozilla_page_load_details 05:37:12 INFO - PROCESS | 20686 | |i|pagename|runs| 05:37:12 INFO - PROCESS | 20686 | |0;dojo.html;3322.916927076821;3324.6675332466757;3329.8335083245834;3349.933001339974;3361.3109312590923;5405.405405405402;5406.432324605914;5419.458054194583;5453.936482385927;5473;5420.5934554908445;5448.346198456191;5455.5908306877045;5461.890762184764;5474.534664553507;5007.724575148356;5049.798008079672;5055.191169412895;5118;5134.589232861381;4836.419629644448;5016.598672106241;5018.146915024455;5023.246513023039;5028.421731500869;5049.091163590552;5056.84829455117;5103.56619687327;5107.208382700687;5124.461931497195;5014.974925125388;5016.3227964224725;5021.698698078127;5026.547610715053;5051.747412629354;4878.951210487885;4890.559849613516;4957.231629097496;4963.404391473046;5044.798208071673;5169.914317993226;5285.841424757225;5294.41761406245;5298.125809241471;5306.522412982811;5832.6792026438525;5906.320773111104;5943.286805583314;5957.582969192158;5960.7019649017375;5822.359540450547;5918.970405147989;5937.406259374071;5978.163057172;5995.1906492623375;5545.750441230154;5551.611387202897;5553.0837411827;5563.304586926634;5572.665640061609;5994.430529099728;6003.609765365237;6017.819465416044;6025.0359942409;6043.184170136975;5701.572382071278;5780.739866706008;5811.244538210006;5837.124431335249;5930.318013428425;5839.416058394127;5858.297004359504;5861.00362938293;5869.853253668693;5897.292324921037;5727.770889164387;5777.0467872801355;5778.3354914184565;5809.7966571170655;5836.212111364912;5725.456081672234;5831.854203644858;5864.266966629171;5963.850903727354;5981.461668449861;4480;4480.081583275421;4492.505824359318;4498.662600304925;4513.50351461339;4008.9198216036098;4045.0898547826505;4060.715749897479;4070.8575199867864;4079.8164082616354;5450.427705090988;5478.58910581708;5517.724113794295;5614.354349249807;5630.746616402272;5863.149843272701;5874.9118763218585;5875.559333049953;5878.676672783038;5880.176775251468;5426.348838139448;5511.834644960658;5513;5531.751071201806;5544.584156188302;5109.3613298337705;5142.537171654569;5177;5177.611679124081;5204.42751297357;5998.1602575639445;6010.639361638316;6034.2155519782145;6046.727897244635;6061.636301821904;5755.5683323750045;5764.07774756037;5865.648061116347;5866.735996880236;5895.970520147372;6048.969755151196;6053;6054.27348718139;6080.726367313393;6121.8469538260115;5752.108423194411;5768.1636162757;5790.276215473066;5815.5929084963645;5818.679972601548;5872.236609240771;5885.970570147122;5964.522838172849;5979.13302571116;6075.1191077294425;5702.885942281214;5738.540916726735;5739.8565035874435;5750.022496175577;5754.856128596819;5742;5778.653280803165;5779.8555036124435;5783.681897495678;5791.305043394651;5570.693611851387;5655.321361436654;5667.858303542444;5672.177534257592;5675.035244008611;5691.971540142273;5731.971340143439;5742.799002035076;5851.444112809277;5888.764449421975;5668.943310566841;5732.484076433141;5753.194552762533;5774.971125144348;5778.797742079007 05:37:12 INFO - PROCESS | 20686 | |1;ext.html;520.9635325527212;564.6894208185497;576.8413686236283;583.6498101139317;594.9851253718657;36365.818170909144;36744.26511469776;37037;37057.07357316072;37113.628863711354;39706;40187.598124018754;40308.59691403085;40315.19369612606;40471.392929106085;8633.09352517986;8850.247728943015;8872.11278872114;8877.46735195887;8912.598933048028;8750.6937257196;8898.911010889906;8907.153820387086;8921;8934.061923498037;8911.420757650732;8979.326550508706;8980.730578082635;8984.685536006242;8996.325275604357;8744.038155802857;8876.644934202592;8912.64349426022;8926.37515373924;8949.59726812295;8730.51982140982;8922.553872306358;8923.910760892373;8927.732168034969;8971.730848074569;40128;40350;40364;40389.79805100956;40412.17114801965;3631.055925459373;3693.8522459101605;3726.254749050174;4281.165172791307;4298.978505107454;30369;30674.846625766728;30810.383792324028;30822;30834.383312333626;4273.358996150602;4280.72175308604;4313.762743049131;4332.025294308787;4372.3878656988045;286751;286966;287314;288458;485460;61924.38075619276;62056;62685;62698;62851.685741571;67477.66261168761;67668;67704.3229567698;67734.66132669404;67828.32171678319;17912.462626121236;18085.186166622534;18149.364772232908;18156;18220.90889545544;13879.167249965034;13977.79033314501;14162.929185354213;14177.645558860904;14179.50371737005;21542.35372938814;21719.13123475075;21757.891210544163;21794.782052179275;21817.127314907226;8429.578521073921;8659.52372619512;8734.859959309882;8741.431806932529;8842.823143537093;1076.9353838769698;1138.0326722286156;1148.9080873530097;1157.8147496400536;1176.0591526778544;29171.85414072916;29380.853095734383;29758.702412976025;29830;30030.84984575107;1144.6279959013355;1155.763068570941;1229.674136353867;1231.956881509161;1252.2298786246392;14195.574132776033;16986.830131698523;17216.225269862887;17336.266373362814;17401.129943502776;333895;727207;732122;733558;743292;56065;56588.43411565914;56595;56684.71657641685;57202;1500.9549713508611;1504.9699006019819;1506.864382205585;1508.9245537723289;1509.0115974037024;29546.704532954394;30328.241793955327;30784;31013.379732404774;31504.36991260116;45292.32061519014;45356;45834;45987.31019034784;46001.53998459972;318312;322168;322988;323020;323303;32834.835825820715;32902.67097328996;33364;33370.4994425079;33624;42306;42824.57175428206;43135;43398.78300608477;43446.56553434425;35433.46849797307;40328.59671403249;42290.788546057076;42350.36474452824;42971.57028429801;35323;35612.10969725777;35730;36090.8195459021;40619.7969010153;36222.63777362193;36616.816915916315;36646;39180.41229381619;39322.2135557293;33444.49833252455;33588.832055839564;33671.663283366855;33809.32381352408;33855;26500.337491562866;28895.277618059717;30357.401100079325;30533.54199687051;30700 05:37:12 INFO - PROCESS | 20686 | |2;jquery.html;394.48519681815236;395.4996928884961;397.7653184621073;400.2095860675167;401.29572600086846;15011.474598389059;15690.921545392257;17295.308187672494;17754.55613609662;17768.466945991608;16636.50090497284;17123.914380428112;17290.135493225353;17740.82259177411;17851.821481785177;5103.566196873261;5209.661372010826;5212.113940630083;5245.239440281157;5248.343957005374;5156.819511317105;5170.508801663836;5355.973220133913;5388.7305634718305;5392.245085688007;5365.087935051031;5389.541888939425;5547.44525547446;5815.592908496407;5857.414258574151;5833.912491312633;5927.525797936155;5968.373320801318;6023.849403764897;6242.781502647431;5582.7766889324785;5587.441255874421;5608.943910560883;5624.184493248456;5625.662460252398;15883.444079457278;20738.896305518527;21203.15187392518;21508.569828603497;21570.35288941334;2288.233441797;2324.418895276181;2373.003338597793;2397.976020239793;2420.8668523231217;9617.374870633457;9664.75838104046;9906.40561566301;9997.200223982063;10100.747481313027;1795.9461216163536;1835.6695794756938;1902.6289873474677;1956.1979588368702;1975.2395327798756;58575.121373179434;58698.70650646762;58717.41282587162;59848;60346.396536034954;10622.893771062345;10798.568057277778;10838.729031774268;10874.945625271823;10880;14226.359813808403;14365.78451323231;14375.065620734827;14389.928050359682;14476.927615362067;8352.791180220544;8392.580370981426;8441.662333506714;8472;8486.575671216538;8125.837483250302;8229.835403291901;8241.79395515105;8265.83468330642;8286.544240066734;4553.248713962159;4645.698029628131;4712.104700106968;4762.238041913347;4795.088933102699;1991.153759652171;2047.30391666834;2074.6369385357802;2081.5420607466335;2088.070808490207;963.3882484622316;981.8919918808925;1034.7051090439188;1111.360967443723;1144.1819099343843;15057.924710376597;17109.315627375014;17288.827111728722;17622;17938;1022.7425649306832;1034.534459493231;1042.4006196437078;1056.6460235821087;1130.3556972525582;10478.266521343585;10505.264631475877;10608.840867386996;10638.468076596295;10655;538177;586340;595929;600432;610306;71411.28588714151;73061;74889;75099.62450187714;80327.59836200898;1167.2937872587133;1169.7309618787726;1210.062201793617;1211.7031327324862;1217.4034722985673;16095.75856362132;16234.431794887123;16323.18384080815;16333.101679407746;16639.001659900445;24139.758602414455;35795.64204358027;36215.27569448543;36364.27271454609;36675.083122922144;43913.56086439094;45148.32277515905;45819.77090114528;46497.76751116223;50518;7478.572852302216;7619.771406857803;7981.241782030698;8046.316063134699;8090.474119182234;11338;11607.535698571963;11715;12076.335801531;12107.394630268274;9822.65620703272;10244.795104098026;10489.895101048893;10555.788884222426;10570.8414373786;10250.231232657432;10327.380357178594;10616.256862019585;10688.679339619825;10720.73198170052;10111.292209545261;10267.383956962607;10588.682339529827;10834.566617335218;10870.130389568974;7469.365103966224;7807.687692492236;7833.725819596287;7854.293113619801;7918.326942209977;8600.78498037554;10225.43760093202;10509.842352364567;10666.626668066581;10685.839712404164 05:37:12 INFO - PROCESS | 20686 | |3;mootools.html;1572.48108124319;1586.9523914282568;1804.5037614655969;1859.553707110294;1904.2383046781295;7917.089534703504;8001.159878212791;8142.552159631218;8165;8176.059753128392;8116.675332986673;8135.877961830577;8173.182681731824;8207.343412526998;8258.710945116922;2362.4684445999596;2367.538330025646;2385.2009576791797;2395.8562486250794;2399.3042017814814;2374.287713685896;2399.3881560202126;2400.135951057618;2419.395151212197;2435.0868424340874;2376.6197408414655;2377.1917548033666;2401.987990060056;2414.9758502415016;2438.9512209755794;2379.6073647848084;2418.637204419342;2420.5884999550117;2422.91519796808;2427.465957489367;2370.4784947311564;2419.6249581314923;2422.2733180046093;2424.624183251599;2429.927102186937;8061.677532898736;8091.514509129471;8112.553809540473;8127.471714338608;8160.224778646078;4638.46657634373;4782.976085119587;4788.066327066189;4801.663883528155;4815.783289751935;3067.156531953731;3116.7506599472213;3201.535777312277;3213.8714451421915;3230.305484320859;1096.2216826053432;1104.8563686720756;1109.5949978257959;1111.4609414433994;1116.1294190531398;11396.829047564293;11481.253718508271;11522;11532.192746507748;11549.53801847925;4326.6538676905775;4328.09110086879;4382.342648602671;4485.618722408566;4486.147631949919;9126.908730912606;9243.722688319362;9264.90735092654;9266.258699304039;9271.211946984447;4996.90006199874;5044.2937988681615;5048.570871475892;5059.139946209153;5072.6195535335;4626.83806066786;4627.8611641650805;4638.304254361873;4701.247800351927;4729.0541891621815;3598.9640103599154;3629.292288003814;3647.6534729200685;3651.434027725654;3684.373656478405;1122.680036189682;1137.9089672826153;1145.931244125355;1155.2490880927296;1155.7861795567846;1162.7209469727204;1178.699431644925;1191.4757506697026;1204.0187247393346;1284.9977017926033;7559.886601700979;7569.470137090461;7616.200298968639;7662.885056724153;7863.685452581947;1198.6198919048375;1200.381803371247;1202.5911190195375;1206.8853458921565;1210.062201793617;6158.815235542941;6169.660668663267;6218.782342617987;6222.564420490613;6244.843878903063;9653.131218190396;9862.358946668444;9901.653442129491;10011.44937028456;10021.298509104292;9814.46020468881;9855.507224638739;10021.048000439947;10041.04610062043;10059.094681478702;7850.607469626496;7877.133515313311;7878.881816772753;7910.406719496176;8004.319632831158;7529.736459223901;7622.504537205064;7640.388768898586;7705.6147192641265;7706.229377062249;8710.041895391629;8953.373263871466;8955.238804701412;8970.730878073668;9098.363114581916;9068.863967040368;9179.678711245075;9260.259179265508;9262.16640502358;9466.05339466048;7033.120859892513;7087.078679771596;7154.749583764543;7162.928370716435;7216.639168041682;7870.173631768582;7880.763577092696;7992.560409177551;8016.4388492807275;8023;7200.49596528238;7285.7814265572115;7378.631068446663;7457;7474.962625186839;6982.930170698228;7070.045543851515;7076.221615622175;7119.644017798986;7255.709771609288;7183;7259.455540834353;7323.523970942085;7345.632718363953;7356.080489938758;6928.618925959121;6975.965120174366;6996.635656047022;7045.929540704527;7055.153381594241;6940.895886561605;6957.826054348479;7033.753818616324;7042.7887163385185;7056.576605403487 05:37:12 INFO - PROCESS | 20686 | |4;prototype.html;380.32682152589916;380.8457574682253;382.4721883800355;382.47600786921913;388.41526571587923;6416.679166041691;6531.902021469676;6583.308752580976;6615.272320044791;6615.536912416127;6348.555601107924;6379.457746091588;6413.390727880844;6436.613803171801;6456.903146452807;4964.4787297333805;4966.081274964144;4969.279454479117;4974.253861920704;4993.525615066581;4978.950210497903;4984.352034235562;4988.326575912241;4997.025580011899;4998.850034498971;4823.638227132961;4850.4179498460235;4889.828855990041;4898.559129678329;4944;4850.902981940341;4877.53663401978;4884.413870335565;4918.434380046269;4923.1630622793855;4376.124775044972;4382.978085109554;4385.802638881258;4386.793631751262;4388.210122178007;6145.477634401082;6150.138980542728;6170.691465426756;6171.475424588915;6186.9381306186815;5670.6030577859565;5762.135679648044;5773.1051686988585;5845.970770146165;5884.852878678024;6829.804784162801;6838.897416538756;6843.7604683835825;6862.794116176523;6880.174379074543;4881.755912204411;4885.511448855122;4943.92584111235;4953.331300274453;4958.925616115761;6929.688164032631;7073.186583542907;7150.034745309369;7166;7201.819954501127;4904.681195722266;4940.036692844861;4948.307236986825;4948.529889660476;4964.90070198594;5006.3992320921725;5010.423801262901;5017.573506251936;5018.422881368616;5033.924491132636;5658.321001479849;5742.31092268922;5755.107958266475;5761.078227483583;5778.5377169826315;6872.072270243453;6879.58722476653;6886.035954966309;6905.929580914966;6930.203026652;1794.9641007180044;1811.7282407638695;1812.957549409095;1817.0914542728635;1825.1330617956364;1246.2397937258265;1253.1290752926811;1256.8051951947464;1273.7388835288743;1274.7323062156865;6482.416582507597;6494.772682956074;6495.545311828127;6510.316416776171;6527.640979746159;7087;7091.468139889529;7094.6097964612445;7095.290470952863;7115;6334.746610135635;6475.158229430144;6475.838104047342;6484.610923344614;6580.374864387875;3811.818336315751;3837.788921609338;3849.3071247175776;3861.9806900965314;3881.514810648669;7411.703531858665;7418.925810741824;7431.554106753612;7445.478816482902;7470.140933792683;7206.891896621555;7327.010853534811;7381.224971377928;7384.741534046282;7396.963015184997;7391.92817041526;7392.334689877936;7436.888446673304;7446.25537446251;7451.888221676679;6992.405645520188;7123.786286411416;7129.572225666477;7138.107736532934;7144.142702875481;7062.505624606229;7069.82325441868;7078.256783037707;7105.076340075757;7105.934109883558;7408.555486670817;7424.962875185805;7427.331540161412;7440.107187137578;7466.626668666654;4827.08285425768;4978.925316120189;5116.6418350716585;5118.948810511847;5137.640365174402;7137.607431591105;7163.820904477429;7164.283571642794;7168.103987001625;7169.283071692789;6853.417459515997;6910.585364878123;6930.341617546325;6944.652767361511;6950.29717719162;6748.898766518604;6883.174019117738;6923.8961415579815;6935.653217339213;6936.895946560907;6767.458603311822;6770.695318710768;6774.424173945073;6780.25417204117;6790.626515541692;6904.102466679299;6942.340477654615;6943.236244013054;6949.930500694928;6977;6652.567583107082;6739.966300168468;6800.591964482147;6804.081449004321;6816.352446517573 05:37:12 INFO - PROCESS | 20686 | |5;yui.html;838.5555655502582;847.9364047696424;917.0920788419464;950.2018304624114;965.5751469353481;14010.439582416704;16432.50702478926;16573.502794916156;16583.751243731353;16605.33578656852;14518.056326338807;14592.635184120401;14654;14682.265886705649;14694.118352898808;712.5688958180278;756.277754744218;890.430124720178;903.7650210945136;903.9457632542036;908.1644886704248;928.8003079337941;929.0755698080419;929.530587053537;933.9206167475772;971.7910649210419;987.0474991633073;987.9456629885353;988.1600639456441;988.3378136648463;934.7756538430796;938.5588773276584;941.5857022909897;941.9529023548795;945.3004776465435;689.018149137477;689.1798759476208;690.5614934516568;694.9965250173767;695.9721611135549;15379.692406151815;15415.845841541553;15513.45702900393;15517.689646207125;15529.378824847106;14510.274486275644;14531.927340363336;14545.345459454244;14602.853971460256;14612.415503379852;10880.836787448194;10941.726456838564;10953.945230273877;11017.28387654808;11105.278156919856;3892.3966785148345;3918.706826747167;3942.4874766280486;3963.54419241788;3977.482927219472;52177.47822521802;52496;53234.20148697734;53333.200002;53340.19989700158;11042.392668403154;11364.886351136383;11368.090552755759;11420.698710806953;11512.251703639236;20122.496937576678;20544.58910821775;20553.588928221652;20555.691664625043;20599.07304171316;7636.274553917369;7707.884381734279;7721.884171737428;7820.843583128306;8123.6750529978135;3724.8696295630066;4215.072684009513;4226.344916537942;4300.4194433751045;4321.935170972438;3032.2570970112465;3049.6950304969328;3068.769842261839;3070.3398769264268;3073.9077827665205;556.7188569772239;558.1766893831566;561.0238185557101;564.7261078376984;571.5598988778701;633.7407143533289;638.9840253993594;693.3066933066933;730.3280981497036;753.2806170107534;8581.613827377783;8634.438761480484;8772.517511536927;8852.911470885338;8980.603136067797;697.0485287582515;705.2383425900016;720.2689270390558;730.9524880882832;739.0429393934867;4174;4179.414881916534;4198.664106871504;4202.159568086395;4255.787210639455;65092.34907650863;65373.34626653768;65585.67207163933;65926.34073659201;67406;53274;53596;53909.46090539044;54453.72773136109;55012.0745773896;50307.49692503102;50359;51402.74298628483;51441.742791285804;52431;9111.772205694911;9244.907550924405;9395;9605;9649.276304277068;36605.26789464249;36895;37446;38654.61345386622;39248.80375598104;47520.287195692785;47586;48259.5174048255;48744.2688359682;48949.51050489592;11788.646340609796;11803.173777835469;11890.821637675268;11905;12078.698032549257;12441.875581244072;12593.559225427432;12878.549250776177;13027.804582931452;13374.732505349644;11546;11605.883941160819;11806;12113.394330283627;12171.878281217074;11925.284482931052;11964.341961192218;12324.630261092181;12577.622671319876;12578.182418142791;11693.415329233674;11966.282023078644;11988.520459181535;11993.460294286953;12099.153059286118;9559.713208603753;9696.272779541421;9940.552675129491;10055.648052318134;10193.490325483845;9511.952440238032;9853;10054.94972525162;10401.479926003518;10471.162307015267 05:37:12 INFO - PROCESS | 20686 | __end_tp_report 05:37:12 INFO - PROCESS | 20686 | __start_cc_report 05:37:12 INFO - PROCESS | 20686 | _x_x_mozilla_cycle_collect,291 05:37:12 INFO - PROCESS | 20686 | __end_cc_report 05:37:12 INFO - PROCESS | 20686 | __startTimestamp1456580232244__endTimestamp 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | ------- Summary: start ------- 05:37:12 INFO - PROCESS | 20686 | Number of tests: 6 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | [#0] dojo.html Cycles:165 Average:5465.43 Median:5701.57 stddev:596.16 (10.5%) stddev-sans-first:573.81 05:37:12 INFO - PROCESS | 20686 | Values: 3322.9 3324.7 3329.8 3349.9 3361.3 5405.4 5406.4 5419.5 5453.9 5473.0 5420.6 5448.3 5455.6 5461.9 5474.5 5007.7 5049.8 5055.2 5118.0 5134.6 4836.4 5016.6 5018.1 5023.2 5028.4 5049.1 5056.8 5103.6 5107.2 5124.5 5015.0 5016.3 5021.7 5026.5 5051.7 4879.0 4890.6 4957.2 4963.4 5044.8 5169.9 5285.8 5294.4 5298.1 5306.5 5832.7 5906.3 5943.3 5957.6 5960.7 5822.4 5919.0 5937.4 5978.2 5995.2 5545.8 5551.6 5553.1 5563.3 5572.7 5994.4 6003.6 6017.8 6025.0 6043.2 5701.6 5780.7 5811.2 5837.1 5930.3 5839.4 5858.3 5861.0 5869.9 5897.3 5727.8 5777.0 5778.3 5809.8 5836.2 5725.5 5831.9 5864.3 5963.9 5981.5 4480.0 4480.1 4492.5 4498.7 4513.5 4008.9 4045.1 4060.7 4070.9 4079.8 5450.4 5478.6 5517.7 5614.4 5630.7 5863.1 5874.9 5875.6 5878.7 5880.2 5426.3 5511.8 5513.0 5531.8 5544.6 5109.4 5142.5 5177.0 5177.6 5204.4 5998.2 6010.6 6034.2 6046.7 6061.6 5755.6 5764.1 5865.6 5866.7 5896.0 6049.0 6053.0 6054.3 6080.7 6121.8 5752.1 5768.2 5790.3 5815.6 5818.7 5872.2 5886.0 5964.5 5979.1 6075.1 5702.9 5738.5 5739.9 5750.0 5754.9 5742.0 5778.7 5779.9 5783.7 5791.3 5570.7 5655.3 5667.9 5672.2 5675.0 5692.0 5732.0 5742.8 5851.4 5888.8 5668.9 5732.5 5753.2 5775.0 5778.8 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | [#1] ext.html Cycles:180 Average:59287.89 Median:21453.33 stddev:126844.56 (591.3%) stddev-sans-first:127123.65 05:37:12 INFO - PROCESS | 20686 | Values: 521.0 564.7 576.8 583.6 595.0 36365.8 36744.3 37037.0 37057.1 37113.6 39706.0 40187.6 40308.6 40315.2 40471.4 8633.1 8850.2 8872.1 8877.5 8912.6 8750.7 8898.9 8907.2 8921.0 8934.1 8911.4 8979.3 8980.7 8984.7 8996.3 8744.0 8876.6 8912.6 8926.4 8949.6 8730.5 8922.6 8923.9 8927.7 8971.7 40128.0 40350.0 40364.0 40389.8 40412.2 3631.1 3693.9 3726.3 4281.2 4299.0 30369.0 30674.8 30810.4 30822.0 30834.4 4273.4 4280.7 4313.8 4332.0 4372.4 286751.0 286966.0 287314.0 288458.0 485460.0 61924.4 62056.0 62685.0 62698.0 62851.7 67477.7 67668.0 67704.3 67734.7 67828.3 17912.5 18085.2 18149.4 18156.0 18220.9 13879.2 13977.8 14162.9 14177.6 14179.5 21542.4 21719.1 21757.9 21794.8 21817.1 8429.6 8659.5 8734.9 8741.4 8842.8 1076.9 1138.0 1148.9 1157.8 1176.1 29171.9 29380.9 29758.7 29830.0 30030.8 1144.6 1155.8 1229.7 1232.0 1252.2 14195.6 16986.8 17216.2 17336.3 17401.1 333895.0 727207.0 732122.0 733558.0 743292.0 56065.0 56588.4 56595.0 56684.7 57202.0 1501.0 1505.0 1506.9 1508.9 1509.0 29546.7 30328.2 30784.0 31013.4 31504.4 45292.3 45356.0 45834.0 45987.3 46001.5 318312.0 322168.0 322988.0 323020.0 323303.0 32834.8 32902.7 33364.0 33370.5 33624.0 42306.0 42824.6 43135.0 43398.8 43446.6 35433.5 40328.6 42290.8 42350.4 42971.6 35323.0 35612.1 35730.0 36090.8 40619.8 36222.6 36616.8 36646.0 39180.4 39322.2 33444.5 33588.8 33671.7 33809.3 33855.0 26500.3 28895.3 30357.4 30533.5 30700.0 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | [#2] jquery.html Cycles:180 Average:29493.65 Median:13268.87 stddev:95800.54 (722.0%) stddev-sans-first:96044.37 05:37:12 INFO - PROCESS | 20686 | Values: 394.5 395.5 397.8 400.2 401.3 15011.5 15690.9 17295.3 17754.6 17768.5 16636.5 17123.9 17290.1 17740.8 17851.8 5103.6 5209.7 5212.1 5245.2 5248.3 5156.8 5170.5 5356.0 5388.7 5392.2 5365.1 5389.5 5547.4 5815.6 5857.4 5833.9 5927.5 5968.4 6023.8 6242.8 5582.8 5587.4 5608.9 5624.2 5625.7 15883.4 20738.9 21203.2 21508.6 21570.4 2288.2 2324.4 2373.0 2398.0 2420.9 9617.4 9664.8 9906.4 9997.2 10100.7 1795.9 1835.7 1902.6 1956.2 1975.2 58575.1 58698.7 58717.4 59848.0 60346.4 10622.9 10798.6 10838.7 10874.9 10880.0 14226.4 14365.8 14375.1 14389.9 14476.9 8352.8 8392.6 8441.7 8472.0 8486.6 8125.8 8229.8 8241.8 8265.8 8286.5 4553.2 4645.7 4712.1 4762.2 4795.1 1991.2 2047.3 2074.6 2081.5 2088.1 963.4 981.9 1034.7 1111.4 1144.2 15057.9 17109.3 17288.8 17622.0 17938.0 1022.7 1034.5 1042.4 1056.6 1130.4 10478.3 10505.3 10608.8 10638.5 10655.0 538177.0 586340.0 595929.0 600432.0 610306.0 71411.3 73061.0 74889.0 75099.6 80327.6 1167.3 1169.7 1210.1 1211.7 1217.4 16095.8 16234.4 16323.2 16333.1 16639.0 24139.8 35795.6 36215.3 36364.3 36675.1 43913.6 45148.3 45819.8 46497.8 50518.0 7478.6 7619.8 7981.2 8046.3 8090.5 11338.0 11607.5 11715.0 12076.3 12107.4 9822.7 10244.8 10489.9 10555.8 10570.8 10250.2 10327.4 10616.3 10688.7 10720.7 10111.3 10267.4 10588.7 10834.6 10870.1 7469.4 7807.7 7833.7 7854.3 7918.3 8600.8 10225.4 10509.8 10666.6 10685.8 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | [#3] mootools.html Cycles:180 Average:5763.62 Median:6164.24 stddev:2989.55 (48.5%) stddev-sans-first:2981.34 05:37:12 INFO - PROCESS | 20686 | Values: 1572.5 1587.0 1804.5 1859.6 1904.2 7917.1 8001.2 8142.6 8165.0 8176.1 8116.7 8135.9 8173.2 8207.3 8258.7 2362.5 2367.5 2385.2 2395.9 2399.3 2374.3 2399.4 2400.1 2419.4 2435.1 2376.6 2377.2 2402.0 2415.0 2439.0 2379.6 2418.6 2420.6 2422.9 2427.5 2370.5 2419.6 2422.3 2424.6 2429.9 8061.7 8091.5 8112.6 8127.5 8160.2 4638.5 4783.0 4788.1 4801.7 4815.8 3067.2 3116.8 3201.5 3213.9 3230.3 1096.2 1104.9 1109.6 1111.5 1116.1 11396.8 11481.3 11522.0 11532.2 11549.5 4326.7 4328.1 4382.3 4485.6 4486.1 9126.9 9243.7 9264.9 9266.3 9271.2 4996.9 5044.3 5048.6 5059.1 5072.6 4626.8 4627.9 4638.3 4701.2 4729.1 3599.0 3629.3 3647.7 3651.4 3684.4 1122.7 1137.9 1145.9 1155.2 1155.8 1162.7 1178.7 1191.5 1204.0 1285.0 7559.9 7569.5 7616.2 7662.9 7863.7 1198.6 1200.4 1202.6 1206.9 1210.1 6158.8 6169.7 6218.8 6222.6 6244.8 9653.1 9862.4 9901.7 10011.4 10021.3 9814.5 9855.5 10021.0 10041.0 10059.1 7850.6 7877.1 7878.9 7910.4 8004.3 7529.7 7622.5 7640.4 7705.6 7706.2 8710.0 8953.4 8955.2 8970.7 9098.4 9068.9 9179.7 9260.3 9262.2 9466.1 7033.1 7087.1 7154.7 7162.9 7216.6 7870.2 7880.8 7992.6 8016.4 8023.0 7200.5 7285.8 7378.6 7457.0 7475.0 6982.9 7070.0 7076.2 7119.6 7255.7 7183.0 7259.5 7323.5 7345.6 7356.1 6928.6 6976.0 6996.6 7045.9 7055.2 6940.9 6957.8 7033.8 7042.8 7056.6 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | [#4] prototype.html Cycles:180 Average:5782.83 Median:6489.69 stddev:1723.20 (26.6%) stddev-sans-first:1679.64 05:37:12 INFO - PROCESS | 20686 | Values: 380.3 380.8 382.5 382.5 388.4 6416.7 6531.9 6583.3 6615.3 6615.5 6348.6 6379.5 6413.4 6436.6 6456.9 4964.5 4966.1 4969.3 4974.3 4993.5 4979.0 4984.4 4988.3 4997.0 4998.9 4823.6 4850.4 4889.8 4898.6 4944.0 4850.9 4877.5 4884.4 4918.4 4923.2 4376.1 4383.0 4385.8 4386.8 4388.2 6145.5 6150.1 6170.7 6171.5 6186.9 5670.6 5762.1 5773.1 5846.0 5884.9 6829.8 6838.9 6843.8 6862.8 6880.2 4881.8 4885.5 4943.9 4953.3 4958.9 6929.7 7073.2 7150.0 7166.0 7201.8 4904.7 4940.0 4948.3 4948.5 4964.9 5006.4 5010.4 5017.6 5018.4 5033.9 5658.3 5742.3 5755.1 5761.1 5778.5 6872.1 6879.6 6886.0 6905.9 6930.2 1795.0 1811.7 1813.0 1817.1 1825.1 1246.2 1253.1 1256.8 1273.7 1274.7 6482.4 6494.8 6495.5 6510.3 6527.6 7087.0 7091.5 7094.6 7095.3 7115.0 6334.7 6475.2 6475.8 6484.6 6580.4 3811.8 3837.8 3849.3 3862.0 3881.5 7411.7 7418.9 7431.6 7445.5 7470.1 7206.9 7327.0 7381.2 7384.7 7397.0 7391.9 7392.3 7436.9 7446.3 7451.9 6992.4 7123.8 7129.6 7138.1 7144.1 7062.5 7069.8 7078.3 7105.1 7105.9 7408.6 7425.0 7427.3 7440.1 7466.6 4827.1 4978.9 5116.6 5118.9 5137.6 7137.6 7163.8 7164.3 7168.1 7169.3 6853.4 6910.6 6930.3 6944.7 6950.3 6748.9 6883.2 6923.9 6935.7 6936.9 6767.5 6770.7 6774.4 6780.3 6790.6 6904.1 6942.3 6943.2 6949.9 6977.0 6652.6 6740.0 6800.6 6804.1 6816.4 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - PROCESS | 20686 | [#5] yui.html Cycles:180 Average:15079.48 Median:47553.14 stddev:17587.76 (37.0%) stddev-sans-first:17604.58 05:37:12 INFO - PROCESS | 20686 | Values: 838.6 847.9 917.1 950.2 965.6 14010.4 16432.5 16573.5 16583.8 16605.3 14518.1 14592.6 14654.0 14682.3 14694.1 712.6 756.3 890.4 903.8 903.9 908.2 928.8 929.1 929.5 933.9 971.8 987.0 987.9 988.2 988.3 934.8 938.6 941.6 942.0 945.3 689.0 689.2 690.6 695.0 696.0 15379.7 15415.8 15513.5 15517.7 15529.4 14510.3 14531.9 14545.3 14602.9 14612.4 10880.8 10941.7 10953.9 11017.3 11105.3 3892.4 3918.7 3942.5 3963.5 3977.5 52177.5 52496.0 53234.2 53333.2 53340.2 11042.4 11364.9 11368.1 11420.7 11512.3 20122.5 20544.6 20553.6 20555.7 20599.1 7636.3 7707.9 7721.9 7820.8 8123.7 3724.9 4215.1 4226.3 4300.4 4321.9 3032.3 3049.7 3068.8 3070.3 3073.9 556.7 558.2 561.0 564.7 571.6 633.7 639.0 693.3 730.3 753.3 8581.6 8634.4 8772.5 8852.9 8980.6 697.0 705.2 720.3 731.0 739.0 4174.0 4179.4 4198.7 4202.2 4255.8 65092.3 65373.3 65585.7 65926.3 67406.0 53274.0 53596.0 53909.5 54453.7 55012.1 50307.5 50359.0 51402.7 51441.7 52431.0 9111.8 9244.9 9395.0 9605.0 9649.3 36605.3 36895.0 37446.0 38654.6 39248.8 47520.3 47586.0 48259.5 48744.3 48949.5 11788.6 11803.2 11890.8 11905.0 12078.7 12441.9 12593.6 12878.5 13027.8 13374.7 11546.0 11605.9 11806.0 12113.4 12171.9 11925.3 11964.3 12324.6 12577.6 12578.2 11693.4 11966.3 11988.5 11993.5 12099.2 9559.7 9696.3 9940.6 10055.6 10193.5 9512.0 9853.0 10054.9 10401.5 10471.2 05:37:12 INFO - PROCESS | 20686 | -------- Summary: end -------- 05:37:12 INFO - PROCESS | 20686 | 05:37:12 INFO - TEST-INFO | 20686: exit 0 05:37:12 INFO - TEST-OK | dromaeo_css | took 1109046ms 05:37:12 INFO - TEST-START | kraken 05:37:12 INFO - operating with platform_type : linux_ 05:37:12 INFO - Initialising browser for kraken test... 05:37:12 INFO - TEST-INFO | started process 20928 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKJyJl0/profile http://localhost:42023/getInfo.html) 05:37:16 INFO - PROCESS | 20928 | 05:37:16 INFO - PROCESS | 20928 | (process:21007): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:37:17 INFO - PROCESS | 20928 | __metrics Screen width/height:1600/1200 05:37:17 INFO - PROCESS | 20928 | colorDepth:24 05:37:17 INFO - PROCESS | 20928 | Browser inner width/height: 1024/697 05:37:17 INFO - PROCESS | 20928 | __metrics 05:37:18 INFO - TEST-INFO | 20928: exit 0 05:37:18 INFO - Browser initialized. 05:37:18 INFO - Running cycle 1/1 for kraken test... 05:37:18 INFO - TEST-INFO | started process 21056 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKJyJl0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:19 INFO - PROCESS | 21056 | 05:37:19 INFO - PROCESS | 21056 | (process:21118): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:37:29 INFO - PROCESS | 21056 | RSS: Main: 140902400 05:37:29 INFO - PROCESS | 21056 | 05:37:32 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42023/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:33 INFO - PROCESS | 21056 | RSS: Main: 144969728 05:37:33 INFO - PROCESS | 21056 | 05:37:35 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42023/tests/kraken/driver.html?testName=audio-dft) 05:37:36 INFO - PROCESS | 21056 | RSS: Main: 146538496 05:37:36 INFO - PROCESS | 21056 | 05:37:39 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42023/tests/kraken/driver.html?testName=audio-fft) 05:37:39 INFO - PROCESS | 21056 | RSS: Main: 145002496 05:37:39 INFO - PROCESS | 21056 | 05:37:41 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42023/tests/kraken/driver.html?testName=audio-oscillator) 05:37:42 INFO - PROCESS | 21056 | RSS: Main: 145965056 05:37:42 INFO - PROCESS | 21056 | 05:37:44 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:45 INFO - PROCESS | 21056 | RSS: Main: 146685952 05:37:45 INFO - PROCESS | 21056 | 05:37:48 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42023/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:48 INFO - PROCESS | 21056 | RSS: Main: 145465344 05:37:48 INFO - PROCESS | 21056 | 05:37:52 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42023/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:52 INFO - PROCESS | 21056 | RSS: Main: 146243584 05:37:52 INFO - PROCESS | 21056 | 05:37:55 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42023/tests/kraken/driver.html?testName=json-parse-financial) 05:37:56 INFO - PROCESS | 21056 | RSS: Main: 146776064 05:37:56 INFO - PROCESS | 21056 | 05:37:57 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:58 INFO - PROCESS | 21056 | RSS: Main: 146558976 05:37:58 INFO - PROCESS | 21056 | 05:37:59 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:00 INFO - PROCESS | 21056 | RSS: Main: 147197952 05:38:00 INFO - PROCESS | 21056 | 05:38:02 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:03 INFO - PROCESS | 21056 | RSS: Main: 147636224 05:38:03 INFO - PROCESS | 21056 | 05:38:05 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:06 INFO - PROCESS | 21056 | RSS: Main: 147628032 05:38:06 INFO - PROCESS | 21056 | 05:38:08 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:09 INFO - PROCESS | 21056 | RSS: Main: 146010112 05:38:09 INFO - PROCESS | 21056 | 05:38:10 INFO - PROCESS | 21056 | Cycle 1(1): loaded http://localhost:42023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42023/tests/kraken/driver.html?testName=ai-astar) 05:38:11 INFO - PROCESS | 21056 | RSS: Main: 149065728 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | __start_tp_report 05:38:11 INFO - PROCESS | 21056 | _x_x_mozilla_page_load 05:38:11 INFO - PROCESS | 21056 | _x_x_mozilla_page_load_details 05:38:11 INFO - PROCESS | 21056 | |i|pagename|runs| 05:38:11 INFO - PROCESS | 21056 | |0;ai-astar;112;107;111;111;112;121;110;112;111;112 05:38:11 INFO - PROCESS | 21056 | |1;audio-beat-detection;162;127;150;161;129;151;162;134;168;129 05:38:11 INFO - PROCESS | 21056 | |2;audio-dft;162;166;165;161;164;160;161;162;165;162 05:38:11 INFO - PROCESS | 21056 | |3;audio-fft;74;77;73;158;74;73;77;76;152;76 05:38:11 INFO - PROCESS | 21056 | |4;audio-oscillator;95;101;149;94;95;95;139;94;95;135 05:38:11 INFO - PROCESS | 21056 | |5;imaging-gaussian-blur;109;109;109;111;110;109;110;110;110;110 05:38:11 INFO - PROCESS | 21056 | |6;imaging-darkroom;146;148;147;146;146;146;148;147;146;149 05:38:11 INFO - PROCESS | 21056 | |7;imaging-desaturate;96;96;96;96;96;97;97;97;97;96 05:38:11 INFO - PROCESS | 21056 | |8;json-parse-financial;52;55;64;56;56;54;67;61;52;53 05:38:11 INFO - PROCESS | 21056 | |9;json-stringify-tinderbox;63;66;64;64;65;65;65;64;64;66 05:38:11 INFO - PROCESS | 21056 | |10;stanford-crypto-aes;83;81;82;80;81;82;82;82;82;82 05:38:11 INFO - PROCESS | 21056 | |11;stanford-crypto-ccm;113;116;127;124;114;115;115;115;110;114 05:38:11 INFO - PROCESS | 21056 | |12;stanford-crypto-pbkdf2;140;142;128;128;141;136;142;136;140;142 05:38:11 INFO - PROCESS | 21056 | |13;stanford-crypto-sha256-iterative;65;66;67;64;65;66;64;64;63;64 05:38:11 INFO - PROCESS | 21056 | __end_tp_report 05:38:11 INFO - PROCESS | 21056 | __start_cc_report 05:38:11 INFO - PROCESS | 21056 | _x_x_mozilla_cycle_collect,737 05:38:11 INFO - PROCESS | 21056 | __end_cc_report 05:38:11 INFO - PROCESS | 21056 | __startTimestamp1456580291109__endTimestamp 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | ------- Summary: start ------- 05:38:11 INFO - PROCESS | 21056 | Number of tests: 14 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:3.54 (3.2%) stddev-sans-first:3.76 05:38:11 INFO - PROCESS | 21056 | Values: 112.0 107.0 111.0 111.0 112.0 121.0 110.0 112.0 111.0 112.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:156.00 stddev:16.08 (10.3%) stddev-sans-first:16.16 05:38:11 INFO - PROCESS | 21056 | Values: 162.0 127.0 150.0 161.0 129.0 151.0 162.0 134.0 168.0 129.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:2.04 (1.3%) stddev-sans-first:2.15 05:38:11 INFO - PROCESS | 21056 | Values: 162.0 166.0 165.0 161.0 164.0 160.0 161.0 162.0 165.0 162.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#3] audio-fft Cycles:10 Average:91.00 Median:75.00 stddev:33.79 (45.1%) stddev-sans-first:35.28 05:38:11 INFO - PROCESS | 21056 | Values: 74.0 77.0 73.0 158.0 74.0 73.0 77.0 76.0 152.0 76.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.50 stddev:22.29 (23.6%) stddev-sans-first:23.05 05:38:11 INFO - PROCESS | 21056 | Values: 95.0 101.0 149.0 94.0 95.0 95.0 139.0 94.0 95.0 135.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 05:38:11 INFO - PROCESS | 21056 | Values: 109.0 109.0 109.0 111.0 110.0 109.0 110.0 110.0 110.0 110.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 05:38:11 INFO - PROCESS | 21056 | Values: 146.0 148.0 147.0 146.0 146.0 146.0 148.0 147.0 146.0 149.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:38:11 INFO - PROCESS | 21056 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 97.0 96.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:5.23 (9.3%) stddev-sans-first:5.22 05:38:11 INFO - PROCESS | 21056 | Values: 52.0 55.0 64.0 56.0 56.0 54.0 67.0 61.0 52.0 53.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 05:38:11 INFO - PROCESS | 21056 | Values: 63.0 66.0 64.0 64.0 65.0 65.0 65.0 64.0 64.0 66.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 05:38:11 INFO - PROCESS | 21056 | Values: 83.0 81.0 82.0 80.0 81.0 82.0 82.0 82.0 82.0 82.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:115.00 stddev:5.17 (4.5%) stddev-sans-first:5.34 05:38:11 INFO - PROCESS | 21056 | Values: 113.0 116.0 127.0 124.0 114.0 115.0 115.0 115.0 110.0 114.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.50 Median:140.50 stddev:5.48 (3.9%) stddev-sans-first:5.74 05:38:11 INFO - PROCESS | 21056 | Values: 140.0 142.0 128.0 128.0 141.0 136.0 142.0 136.0 140.0 142.0 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - PROCESS | 21056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.30 05:38:11 INFO - PROCESS | 21056 | Values: 65.0 66.0 67.0 64.0 65.0 66.0 64.0 64.0 63.0 64.0 05:38:11 INFO - PROCESS | 21056 | -------- Summary: end -------- 05:38:11 INFO - PROCESS | 21056 | 05:38:11 INFO - TEST-INFO | 21056: exit 0 05:38:12 INFO - TEST-OK | kraken | took 59097ms 05:38:12 INFO - TEST-START | v8_7 05:38:12 INFO - operating with platform_type : linux_ 05:38:12 INFO - Initialising browser for v8_7 test... 05:38:12 INFO - TEST-INFO | started process 21346 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptd9jjG/profile http://localhost:42023/getInfo.html) 05:38:15 INFO - PROCESS | 21346 | 05:38:15 INFO - PROCESS | 21346 | (process:21425): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:38:16 INFO - PROCESS | 21346 | __metrics Screen width/height:1600/1200 05:38:16 INFO - PROCESS | 21346 | colorDepth:24 05:38:16 INFO - PROCESS | 21346 | Browser inner width/height: 1024/697 05:38:16 INFO - PROCESS | 21346 | __metrics 05:38:17 INFO - TEST-INFO | 21346: exit 0 05:38:17 INFO - Browser initialized. 05:38:17 INFO - Running cycle 1/1 for v8_7 test... 05:38:17 INFO - TEST-INFO | started process 21474 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptd9jjG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:18 INFO - PROCESS | 21474 | 05:38:18 INFO - PROCESS | 21474 | (process:21536): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:38:28 INFO - PROCESS | 21474 | RSS: Main: 141144064 05:38:28 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | Cycle 1(1): loaded http://localhost:42023/tests/v8_7/run.html (next: http://localhost:42023/tests/v8_7/run.html) 05:38:51 INFO - PROCESS | 21474 | RSS: Main: 145002496 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | __start_tp_report 05:38:51 INFO - PROCESS | 21474 | _x_x_mozilla_page_load 05:38:51 INFO - PROCESS | 21474 | _x_x_mozilla_page_load_details 05:38:51 INFO - PROCESS | 21474 | |i|pagename|runs| 05:38:51 INFO - PROCESS | 21474 | |0;Richards;166.5278934221482 05:38:51 INFO - PROCESS | 21474 | |1;DeltaBlue;170.50298380221653 05:38:51 INFO - PROCESS | 21474 | |2;Encrypt;278.8622420524261 05:38:51 INFO - PROCESS | 21474 | |3;Decrypt;5202.072538860104 05:38:51 INFO - PROCESS | 21474 | |4;RayTrace;931.9664492078285 05:38:51 INFO - PROCESS | 21474 | |5;Earley;550.357732526142 05:38:51 INFO - PROCESS | 21474 | |6;Boyer;11144.444444444445 05:38:51 INFO - PROCESS | 21474 | |7;RegExp;39480.769230769234 05:38:51 INFO - PROCESS | 21474 | |8;Splay;489.71596474045054 05:38:51 INFO - PROCESS | 21474 | |9;NavierStokes;4830.917874396136 05:38:51 INFO - PROCESS | 21474 | __end_tp_report 05:38:51 INFO - PROCESS | 21474 | __startTimestamp1456580331637__endTimestamp 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | ------- Summary: start ------- 05:38:51 INFO - PROCESS | 21474 | Number of tests: 10 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 166.5 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#1] DeltaBlue Cycles:1 Average:170.50 Median:170.50 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 170.5 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 278.9 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 5202.1 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#4] RayTrace Cycles:1 Average:931.97 Median:931.97 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 932.0 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#5] Earley Cycles:1 Average:550.36 Median:550.36 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 550.4 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#6] Boyer Cycles:1 Average:11144.44 Median:11144.44 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 11144.4 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#7] RegExp Cycles:1 Average:39480.77 Median:39480.77 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 39480.8 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#8] Splay Cycles:1 Average:489.72 Median:489.72 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 489.7 05:38:51 INFO - PROCESS | 21474 | 05:38:51 INFO - PROCESS | 21474 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:38:51 INFO - PROCESS | 21474 | Values: 4830.9 05:38:51 INFO - PROCESS | 21474 | -------- Summary: end -------- 05:38:51 INFO - PROCESS | 21474 | 05:38:52 INFO - TEST-INFO | 21474: exit 0 05:38:52 INFO - TEST-OK | v8_7 | took 40547ms 05:38:52 INFO - SUITE-END | took 1208s 05:38:52 INFO - Completed test suite (00:20:08) 05:38:52 INFO - Working with test: dromaeo_css 05:38:52 INFO - Generating results file: dromaeo_css 05:38:52 INFO - Working with test: kraken 05:38:52 INFO - Generating results file: kraken 05:38:52 INFO - javascript benchmark 05:38:52 INFO - Working with test: v8_7 05:38:52 INFO - Generating results file: v8_7 05:38:52 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:38:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:38:52 INFO - process_Request line: dromaeo_css 7378.69 graph.html#tests=[[72,52,43]] 05:38:52 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:38:52 INFO - process_Request line: kraken 1497.10 graph.html#tests=[[232,52,43]] 05:38:52 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:38:52 INFO - process_Request line: v8_7 22172.17 graph.html#tests=[[230,52,43]] 05:38:52 INFO - RETURN: dromaeo_css: 7378.69 05:38:52 INFO - RETURN: kraken: 1497.10 05:38:52 INFO - RETURN: v8_7: 22172.17 05:38:52 INFO - javascript benchmark 05:38:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3322.916927076821, 3324.6675332466757, 3329.8335083245834, 3349.933001339974, 3361.3109312590923, 5405.405405405402, 5406.432324605914, 5419.458054194583, 5453.936482385927, 5473.0, 5420.5934554908445, 5448.346198456191, 5455.5908306877045, 5461.890762184764, 5474.534664553507, 5007.724575148356, 5049.798008079672, 5055.191169412895, 5118.0, 5134.589232861381, 4836.419629644448, 5016.598672106241, 5018.146915024455, 5023.246513023039, 5028.421731500869, 5049.091163590552, 5056.84829455117, 5103.56619687327, 5107.208382700687, 5124.461931497195, 5014.974925125388, 5016.3227964224725, 5021.698698078127, 5026.547610715053, 5051.747412629354, 4878.951210487885, 4890.559849613516, 4957.231629097496, 4963.404391473046, 5044.798208071673, 5169.914317993226, 5285.841424757225, 5294.41761406245, 5298.125809241471, 5306.522412982811, 5832.6792026438525, 5906.320773111104, 5943.286805583314, 5957.582969192158, 5960.7019649017375, 5822.359540450547, 5918.970405147989, 5937.406259374071, 5978.163057172, 5995.1906492623375, 5545.750441230154, 5551.611387202897, 5553.0837411827, 5563.304586926634, 5572.665640061609, 5994.430529099728, 6003.609765365237, 6017.819465416044, 6025.0359942409, 6043.184170136975, 5701.572382071278, 5780.739866706008, 5811.244538210006, 5837.124431335249, 5930.318013428425, 5839.416058394127, 5858.297004359504, 5861.00362938293, 5869.853253668693, 5897.292324921037, 5727.770889164387, 5777.0467872801355, 5778.3354914184565, 5809.7966571170655, 5836.212111364912, 5725.456081672234, 5831.854203644858, 5864.266966629171, 5963.850903727354, 5981.461668449861, 4480.0, 4480.081583275421, 4492.505824359318, 4498.662600304925, 4513.50351461339, 4008.9198216036098, 4045.0898547826505, 4060.715749897479, 4070.8575199867864, 4079.8164082616354, 5450.427705090988, 5478.58910581708, 5517.724113794295, 5614.354349249807, 5630.746616402272, 5863.149843272701, 5874.9118763218585, 5875.559333049953, 5878.676672783038, 5880.176775251468, 5426.348838139448, 5511.834644960658, 5513.0, 5531.751071201806, 5544.584156188302, 5109.3613298337705, 5142.537171654569, 5177.0, 5177.611679124081, 5204.42751297357, 5998.1602575639445, 6010.639361638316, 6034.2155519782145, 6046.727897244635, 6061.636301821904, 5755.5683323750045, 5764.07774756037, 5865.648061116347, 5866.735996880236, 5895.970520147372, 6048.969755151196, 6053.0, 6054.27348718139, 6080.726367313393, 6121.8469538260115, 5752.108423194411, 5768.1636162757, 5790.276215473066, 5815.5929084963645, 5818.679972601548, 5872.236609240771, 5885.970570147122, 5964.522838172849, 5979.13302571116, 6075.1191077294425, 5702.885942281214, 5738.540916726735, 5739.8565035874435, 5750.022496175577, 5754.856128596819, 5742.0, 5778.653280803165, 5779.8555036124435, 5783.681897495678, 5791.305043394651, 5570.693611851387, 5655.321361436654, 5667.858303542444, 5672.177534257592, 5675.035244008611, 5691.971540142273, 5731.971340143439, 5742.799002035076, 5851.444112809277, 5888.764449421975, 5668.943310566841, 5732.484076433141, 5753.194552762533, 5774.971125144348, 5778.797742079007], "unit": "score", "name": "dojo.html", "value": 5427.4957695708645}, {"lowerIsBetter": false, "replicates": [520.9635325527212, 564.6894208185497, 576.8413686236283, 583.6498101139317, 594.9851253718657, 36365.818170909144, 36744.26511469776, 37037.0, 37057.07357316072, 37113.628863711354, 39706.0, 40187.598124018754, 40308.59691403085, 40315.19369612606, 40471.392929106085, 8633.09352517986, 8850.247728943015, 8872.11278872114, 8877.46735195887, 8912.598933048028, 8750.6937257196, 8898.911010889906, 8907.153820387086, 8921.0, 8934.061923498037, 8911.420757650732, 8979.326550508706, 8980.730578082635, 8984.685536006242, 8996.325275604357, 8744.038155802857, 8876.644934202592, 8912.64349426022, 8926.37515373924, 8949.59726812295, 8730.51982140982, 8922.553872306358, 8923.910760892373, 8927.732168034969, 8971.730848074569, 40128.0, 40350.0, 40364.0, 40389.79805100956, 40412.17114801965, 3631.055925459373, 3693.8522459101605, 3726.254749050174, 4281.165172791307, 4298.978505107454, 30369.0, 30674.846625766728, 30810.383792324028, 30822.0, 30834.383312333626, 4273.358996150602, 4280.72175308604, 4313.762743049131, 4332.025294308787, 4372.3878656988045, 286751.0, 286966.0, 287314.0, 288458.0, 485460.0, 61924.38075619276, 62056.0, 62685.0, 62698.0, 62851.685741571, 67477.66261168761, 67668.0, 67704.3229567698, 67734.66132669404, 67828.32171678319, 17912.462626121236, 18085.186166622534, 18149.364772232908, 18156.0, 18220.90889545544, 13879.167249965034, 13977.79033314501, 14162.929185354213, 14177.645558860904, 14179.50371737005, 21542.35372938814, 21719.13123475075, 21757.891210544163, 21794.782052179275, 21817.127314907226, 8429.578521073921, 8659.52372619512, 8734.859959309882, 8741.431806932529, 8842.823143537093, 1076.9353838769698, 1138.0326722286156, 1148.9080873530097, 1157.8147496400536, 1176.0591526778544, 29171.85414072916, 29380.853095734383, 29758.702412976025, 29830.0, 30030.84984575107, 1144.6279959013355, 1155.763068570941, 1229.674136353867, 1231.956881509161, 1252.2298786246392, 14195.574132776033, 16986.830131698523, 17216.225269862887, 17336.266373362814, 17401.129943502776, 333895.0, 727207.0, 732122.0, 733558.0, 743292.0, 56065.0, 56588.43411565914, 56595.0, 56684.71657641685, 57202.0, 1500.9549713508611, 1504.9699006019819, 1506.864382205585, 1508.9245537723289, 1509.0115974037024, 29546.704532954394, 30328.241793955327, 30784.0, 31013.379732404774, 31504.36991260116, 45292.32061519014, 45356.0, 45834.0, 45987.31019034784, 46001.53998459972, 318312.0, 322168.0, 322988.0, 323020.0, 323303.0, 32834.835825820715, 32902.67097328996, 33364.0, 33370.4994425079, 33624.0, 42306.0, 42824.57175428206, 43135.0, 43398.78300608477, 43446.56553434425, 35433.46849797307, 40328.59671403249, 42290.788546057076, 42350.36474452824, 42971.57028429801, 35323.0, 35612.10969725777, 35730.0, 36090.8195459021, 40619.7969010153, 36222.63777362193, 36616.816915916315, 36646.0, 39180.41229381619, 39322.2135557293, 33444.49833252455, 33588.832055839564, 33671.663283366855, 33809.32381352408, 33855.0, 26500.337491562866, 28895.277618059717, 30357.401100079325, 30533.54199687051, 30700.0], "unit": "score", "name": "ext.html", "value": 20139.24386171681}, {"lowerIsBetter": false, "replicates": [394.48519681815236, 395.4996928884961, 397.7653184621073, 400.2095860675167, 401.29572600086846, 15011.474598389059, 15690.921545392257, 17295.308187672494, 17754.55613609662, 17768.466945991608, 16636.50090497284, 17123.914380428112, 17290.135493225353, 17740.82259177411, 17851.821481785177, 5103.566196873261, 5209.661372010826, 5212.113940630083, 5245.239440281157, 5248.343957005374, 5156.819511317105, 5170.508801663836, 5355.973220133913, 5388.7305634718305, 5392.245085688007, 5365.087935051031, 5389.541888939425, 5547.44525547446, 5815.592908496407, 5857.414258574151, 5833.912491312633, 5927.525797936155, 5968.373320801318, 6023.849403764897, 6242.781502647431, 5582.7766889324785, 5587.441255874421, 5608.943910560883, 5624.184493248456, 5625.662460252398, 15883.444079457278, 20738.896305518527, 21203.15187392518, 21508.569828603497, 21570.35288941334, 2288.233441797, 2324.418895276181, 2373.003338597793, 2397.976020239793, 2420.8668523231217, 9617.374870633457, 9664.75838104046, 9906.40561566301, 9997.200223982063, 10100.747481313027, 1795.9461216163536, 1835.6695794756938, 1902.6289873474677, 1956.1979588368702, 1975.2395327798756, 58575.121373179434, 58698.70650646762, 58717.41282587162, 59848.0, 60346.396536034954, 10622.893771062345, 10798.568057277778, 10838.729031774268, 10874.945625271823, 10880.0, 14226.359813808403, 14365.78451323231, 14375.065620734827, 14389.928050359682, 14476.927615362067, 8352.791180220544, 8392.580370981426, 8441.662333506714, 8472.0, 8486.575671216538, 8125.837483250302, 8229.835403291901, 8241.79395515105, 8265.83468330642, 8286.544240066734, 4553.248713962159, 4645.698029628131, 4712.104700106968, 4762.238041913347, 4795.088933102699, 1991.153759652171, 2047.30391666834, 2074.6369385357802, 2081.5420607466335, 2088.070808490207, 963.3882484622316, 981.8919918808925, 1034.7051090439188, 1111.360967443723, 1144.1819099343843, 15057.924710376597, 17109.315627375014, 17288.827111728722, 17622.0, 17938.0, 1022.7425649306832, 1034.534459493231, 1042.4006196437078, 1056.6460235821087, 1130.3556972525582, 10478.266521343585, 10505.264631475877, 10608.840867386996, 10638.468076596295, 10655.0, 538177.0, 586340.0, 595929.0, 600432.0, 610306.0, 71411.28588714151, 73061.0, 74889.0, 75099.62450187714, 80327.59836200898, 1167.2937872587133, 1169.7309618787726, 1210.062201793617, 1211.7031327324862, 1217.4034722985673, 16095.75856362132, 16234.431794887123, 16323.18384080815, 16333.101679407746, 16639.001659900445, 24139.758602414455, 35795.64204358027, 36215.27569448543, 36364.27271454609, 36675.083122922144, 43913.56086439094, 45148.32277515905, 45819.77090114528, 46497.76751116223, 50518.0, 7478.572852302216, 7619.771406857803, 7981.241782030698, 8046.316063134699, 8090.474119182234, 11338.0, 11607.535698571963, 11715.0, 12076.335801531, 12107.394630268274, 9822.65620703272, 10244.795104098026, 10489.895101048893, 10555.788884222426, 10570.8414373786, 10250.231232657432, 10327.380357178594, 10616.256862019585, 10688.679339619825, 10720.73198170052, 10111.292209545261, 10267.383956962607, 10588.682339529827, 10834.566617335218, 10870.130389568974, 7469.365103966224, 7807.687692492236, 7833.725819596287, 7854.293113619801, 7918.326942209977, 8600.78498037554, 10225.43760093202, 10509.842352364567, 10666.626668066581, 10685.839712404164], "unit": "score", "name": "jquery.html", "value": 8723.862490911617}, {"lowerIsBetter": false, "replicates": [1572.48108124319, 1586.9523914282568, 1804.5037614655969, 1859.553707110294, 1904.2383046781295, 7917.089534703504, 8001.159878212791, 8142.552159631218, 8165.0, 8176.059753128392, 8116.675332986673, 8135.877961830577, 8173.182681731824, 8207.343412526998, 8258.710945116922, 2362.4684445999596, 2367.538330025646, 2385.2009576791797, 2395.8562486250794, 2399.3042017814814, 2374.287713685896, 2399.3881560202126, 2400.135951057618, 2419.395151212197, 2435.0868424340874, 2376.6197408414655, 2377.1917548033666, 2401.987990060056, 2414.9758502415016, 2438.9512209755794, 2379.6073647848084, 2418.637204419342, 2420.5884999550117, 2422.91519796808, 2427.465957489367, 2370.4784947311564, 2419.6249581314923, 2422.2733180046093, 2424.624183251599, 2429.927102186937, 8061.677532898736, 8091.514509129471, 8112.553809540473, 8127.471714338608, 8160.224778646078, 4638.46657634373, 4782.976085119587, 4788.066327066189, 4801.663883528155, 4815.783289751935, 3067.156531953731, 3116.7506599472213, 3201.535777312277, 3213.8714451421915, 3230.305484320859, 1096.2216826053432, 1104.8563686720756, 1109.5949978257959, 1111.4609414433994, 1116.1294190531398, 11396.829047564293, 11481.253718508271, 11522.0, 11532.192746507748, 11549.53801847925, 4326.6538676905775, 4328.09110086879, 4382.342648602671, 4485.618722408566, 4486.147631949919, 9126.908730912606, 9243.722688319362, 9264.90735092654, 9266.258699304039, 9271.211946984447, 4996.90006199874, 5044.2937988681615, 5048.570871475892, 5059.139946209153, 5072.6195535335, 4626.83806066786, 4627.8611641650805, 4638.304254361873, 4701.247800351927, 4729.0541891621815, 3598.9640103599154, 3629.292288003814, 3647.6534729200685, 3651.434027725654, 3684.373656478405, 1122.680036189682, 1137.9089672826153, 1145.931244125355, 1155.2490880927296, 1155.7861795567846, 1162.7209469727204, 1178.699431644925, 1191.4757506697026, 1204.0187247393346, 1284.9977017926033, 7559.886601700979, 7569.470137090461, 7616.200298968639, 7662.885056724153, 7863.685452581947, 1198.6198919048375, 1200.381803371247, 1202.5911190195375, 1206.8853458921565, 1210.062201793617, 6158.815235542941, 6169.660668663267, 6218.782342617987, 6222.564420490613, 6244.843878903063, 9653.131218190396, 9862.358946668444, 9901.653442129491, 10011.44937028456, 10021.298509104292, 9814.46020468881, 9855.507224638739, 10021.048000439947, 10041.04610062043, 10059.094681478702, 7850.607469626496, 7877.133515313311, 7878.881816772753, 7910.406719496176, 8004.319632831158, 7529.736459223901, 7622.504537205064, 7640.388768898586, 7705.6147192641265, 7706.229377062249, 8710.041895391629, 8953.373263871466, 8955.238804701412, 8970.730878073668, 9098.363114581916, 9068.863967040368, 9179.678711245075, 9260.259179265508, 9262.16640502358, 9466.05339466048, 7033.120859892513, 7087.078679771596, 7154.749583764543, 7162.928370716435, 7216.639168041682, 7870.173631768582, 7880.763577092696, 7992.560409177551, 8016.4388492807275, 8023.0, 7200.49596528238, 7285.7814265572115, 7378.631068446663, 7457.0, 7474.962625186839, 6982.930170698228, 7070.045543851515, 7076.221615622175, 7119.644017798986, 7255.709771609288, 7183.0, 7259.455540834353, 7323.523970942085, 7345.632718363953, 7356.080489938758, 6928.618925959121, 6975.965120174366, 6996.635656047022, 7045.929540704527, 7055.153381594241, 6940.895886561605, 6957.826054348479, 7033.753818616324, 7042.7887163385185, 7056.576605403487], "unit": "score", "name": "mootools.html", "value": 4736.079191210584}, {"lowerIsBetter": false, "replicates": [380.32682152589916, 380.8457574682253, 382.4721883800355, 382.47600786921913, 388.41526571587923, 6416.679166041691, 6531.902021469676, 6583.308752580976, 6615.272320044791, 6615.536912416127, 6348.555601107924, 6379.457746091588, 6413.390727880844, 6436.613803171801, 6456.903146452807, 4964.4787297333805, 4966.081274964144, 4969.279454479117, 4974.253861920704, 4993.525615066581, 4978.950210497903, 4984.352034235562, 4988.326575912241, 4997.025580011899, 4998.850034498971, 4823.638227132961, 4850.4179498460235, 4889.828855990041, 4898.559129678329, 4944.0, 4850.902981940341, 4877.53663401978, 4884.413870335565, 4918.434380046269, 4923.1630622793855, 4376.124775044972, 4382.978085109554, 4385.802638881258, 4386.793631751262, 4388.210122178007, 6145.477634401082, 6150.138980542728, 6170.691465426756, 6171.475424588915, 6186.9381306186815, 5670.6030577859565, 5762.135679648044, 5773.1051686988585, 5845.970770146165, 5884.852878678024, 6829.804784162801, 6838.897416538756, 6843.7604683835825, 6862.794116176523, 6880.174379074543, 4881.755912204411, 4885.511448855122, 4943.92584111235, 4953.331300274453, 4958.925616115761, 6929.688164032631, 7073.186583542907, 7150.034745309369, 7166.0, 7201.819954501127, 4904.681195722266, 4940.036692844861, 4948.307236986825, 4948.529889660476, 4964.90070198594, 5006.3992320921725, 5010.423801262901, 5017.573506251936, 5018.422881368616, 5033.924491132636, 5658.321001479849, 5742.31092268922, 5755.107958266475, 5761.078227483583, 5778.5377169826315, 6872.072270243453, 6879.58722476653, 6886.035954966309, 6905.929580914966, 6930.203026652, 1794.9641007180044, 1811.7282407638695, 1812.957549409095, 1817.0914542728635, 1825.1330617956364, 1246.2397937258265, 1253.1290752926811, 1256.8051951947464, 1273.7388835288743, 1274.7323062156865, 6482.416582507597, 6494.772682956074, 6495.545311828127, 6510.316416776171, 6527.640979746159, 7087.0, 7091.468139889529, 7094.6097964612445, 7095.290470952863, 7115.0, 6334.746610135635, 6475.158229430144, 6475.838104047342, 6484.610923344614, 6580.374864387875, 3811.818336315751, 3837.788921609338, 3849.3071247175776, 3861.9806900965314, 3881.514810648669, 7411.703531858665, 7418.925810741824, 7431.554106753612, 7445.478816482902, 7470.140933792683, 7206.891896621555, 7327.010853534811, 7381.224971377928, 7384.741534046282, 7396.963015184997, 7391.92817041526, 7392.334689877936, 7436.888446673304, 7446.25537446251, 7451.888221676679, 6992.405645520188, 7123.786286411416, 7129.572225666477, 7138.107736532934, 7144.142702875481, 7062.505624606229, 7069.82325441868, 7078.256783037707, 7105.076340075757, 7105.934109883558, 7408.555486670817, 7424.962875185805, 7427.331540161412, 7440.107187137578, 7466.626668666654, 4827.08285425768, 4978.925316120189, 5116.6418350716585, 5118.948810511847, 5137.640365174402, 7137.607431591105, 7163.820904477429, 7164.283571642794, 7168.103987001625, 7169.283071692789, 6853.417459515997, 6910.585364878123, 6930.341617546325, 6944.652767361511, 6950.29717719162, 6748.898766518604, 6883.174019117738, 6923.8961415579815, 6935.653217339213, 6936.895946560907, 6767.458603311822, 6770.695318710768, 6774.424173945073, 6780.25417204117, 6790.626515541692, 6904.102466679299, 6942.340477654615, 6943.236244013054, 6949.930500694928, 6977.0, 6652.567583107082, 6739.966300168468, 6800.591964482147, 6804.081449004321, 6816.352446517573], "unit": "score", "name": "prototype.html", "value": 5235.708463917232}, {"lowerIsBetter": false, "replicates": [838.5555655502582, 847.9364047696424, 917.0920788419464, 950.2018304624114, 965.5751469353481, 14010.439582416704, 16432.50702478926, 16573.502794916156, 16583.751243731353, 16605.33578656852, 14518.056326338807, 14592.635184120401, 14654.0, 14682.265886705649, 14694.118352898808, 712.5688958180278, 756.277754744218, 890.430124720178, 903.7650210945136, 903.9457632542036, 908.1644886704248, 928.8003079337941, 929.0755698080419, 929.530587053537, 933.9206167475772, 971.7910649210419, 987.0474991633073, 987.9456629885353, 988.1600639456441, 988.3378136648463, 934.7756538430796, 938.5588773276584, 941.5857022909897, 941.9529023548795, 945.3004776465435, 689.018149137477, 689.1798759476208, 690.5614934516568, 694.9965250173767, 695.9721611135549, 15379.692406151815, 15415.845841541553, 15513.45702900393, 15517.689646207125, 15529.378824847106, 14510.274486275644, 14531.927340363336, 14545.345459454244, 14602.853971460256, 14612.415503379852, 10880.836787448194, 10941.726456838564, 10953.945230273877, 11017.28387654808, 11105.278156919856, 3892.3966785148345, 3918.706826747167, 3942.4874766280486, 3963.54419241788, 3977.482927219472, 52177.47822521802, 52496.0, 53234.20148697734, 53333.200002, 53340.19989700158, 11042.392668403154, 11364.886351136383, 11368.090552755759, 11420.698710806953, 11512.251703639236, 20122.496937576678, 20544.58910821775, 20553.588928221652, 20555.691664625043, 20599.07304171316, 7636.274553917369, 7707.884381734279, 7721.884171737428, 7820.843583128306, 8123.6750529978135, 3724.8696295630066, 4215.072684009513, 4226.344916537942, 4300.4194433751045, 4321.935170972438, 3032.2570970112465, 3049.6950304969328, 3068.769842261839, 3070.3398769264268, 3073.9077827665205, 556.7188569772239, 558.1766893831566, 561.0238185557101, 564.7261078376984, 571.5598988778701, 633.7407143533289, 638.9840253993594, 693.3066933066933, 730.3280981497036, 753.2806170107534, 8581.613827377783, 8634.438761480484, 8772.517511536927, 8852.911470885338, 8980.603136067797, 697.0485287582515, 705.2383425900016, 720.2689270390558, 730.9524880882832, 739.0429393934867, 4174.0, 4179.414881916534, 4198.664106871504, 4202.159568086395, 4255.787210639455, 65092.34907650863, 65373.34626653768, 65585.67207163933, 65926.34073659201, 67406.0, 53274.0, 53596.0, 53909.46090539044, 54453.72773136109, 55012.0745773896, 50307.49692503102, 50359.0, 51402.74298628483, 51441.742791285804, 52431.0, 9111.772205694911, 9244.907550924405, 9395.0, 9605.0, 9649.276304277068, 36605.26789464249, 36895.0, 37446.0, 38654.61345386622, 39248.80375598104, 47520.287195692785, 47586.0, 48259.5174048255, 48744.2688359682, 48949.51050489592, 11788.646340609796, 11803.173777835469, 11890.821637675268, 11905.0, 12078.698032549257, 12441.875581244072, 12593.559225427432, 12878.549250776177, 13027.804582931452, 13374.732505349644, 11546.0, 11605.883941160819, 11806.0, 12113.394330283627, 12171.878281217074, 11925.284482931052, 11964.341961192218, 12324.630261092181, 12577.622671319876, 12578.182418142791, 11693.415329233674, 11966.282023078644, 11988.520459181535, 11993.460294286953, 12099.153059286118, 9559.713208603753, 9696.272779541421, 9940.552675129491, 10055.648052318134, 10193.490325483845, 9511.952440238032, 9853.0, 10054.94972525162, 10401.479926003518, 10471.162307015267], "unit": "score", "name": "yui.html", "value": 6824.815577158924}], "name": "dromaeo_css", "value": 7378.68348337896}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 111.0, 111.0, 112.0, 121.0, 110.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [162.0, 127.0, 150.0, 161.0, 129.0, 151.0, 162.0, 134.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [162.0, 166.0, 165.0, 161.0, 164.0, 160.0, 161.0, 162.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 73.0, 158.0, 74.0, 73.0, 77.0, 76.0, 152.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.0}, {"lowerIsBetter": true, "replicates": [95.0, 101.0, 149.0, 94.0, 95.0, 95.0, 139.0, 94.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [52.0, 55.0, 64.0, 56.0, 56.0, 54.0, 67.0, 61.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 82.0, 80.0, 81.0, 82.0, 82.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [113.0, 116.0, 127.0, 124.0, 114.0, 115.0, 115.0, 115.0, 110.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [140.0, 142.0, 128.0, 128.0, 141.0, 136.0, 142.0, 136.0, 140.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 64.0, 65.0, 66.0, 64.0, 64.0, 63.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.8}], "name": "kraken", "value": 1497.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [170.50298380221653], "unit": "score", "name": "DeltaBlue", "value": 387.78207000000015}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [931.9664492078285], "unit": "score", "name": "RayTrace", "value": 794.0081969999997}, {"lowerIsBetter": false, "replicates": [550.357732526142], "unit": "score", "name": "Earley", "value": 1210.9632709999996}, {"lowerIsBetter": false, "replicates": [11144.444444444445], "unit": "score", "name": "Boyer", "value": 59.80226321036885}, {"lowerIsBetter": false, "replicates": [39480.769230769234], "unit": "score", "name": "RegExp", "value": 23.074145153433975}, {"lowerIsBetter": false, "replicates": [489.71596474045054], "unit": "score", "name": "Splay", "value": 166.40462200000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 22172.17186799534}]} 05:38:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22172.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1497.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7378.69"}}} 05:38:52 INFO - Return code: 0 05:38:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:38:52 INFO - # TBPL SUCCESS # 05:38:52 INFO - Running post-action listener: _resource_record_post_action 05:38:52 INFO - Running post-run listener: _resource_record_post_run 05:38:53 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 0; Write bytes: 501198848; Read time: 0; Write time: 423040 05:38:53 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242380800; Read time: 0; Write time: 280044 05:38:53 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 258818048; Read time: 0; Write time: 142996 05:38:53 INFO - Running post-run listener: _upload_blobber_files 05:38:53 INFO - Blob upload gear active. 05:38:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:38:53 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:38:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:38:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:38:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:38:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:38:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:55 INFO - (blobuploader) - INFO - Done attempting. 05:38:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:38:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:38:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:55 INFO - (blobuploader) - INFO - Done attempting. 05:38:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:55 INFO - Return code: 0 05:38:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:38:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1750e825653a938e14651a9513e720fa79c5498d853cf90ee4d7eedb82f0e13f66e4a33ff297af89531a71ad93c0bbca76959e73e1307d9610463d57f67ceb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34ddda8da0cd2bab7e9bd36109d3ac52e6b7e9f8788aadf59a23ceabc7957411b97afd8d00886eb4947f18d75337ca85b3583f8de57bff1ea7e9546b2cb69fa7"} 05:38:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:38:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:38:55 INFO - Contents: 05:38:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1750e825653a938e14651a9513e720fa79c5498d853cf90ee4d7eedb82f0e13f66e4a33ff297af89531a71ad93c0bbca76959e73e1307d9610463d57f67ceb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34ddda8da0cd2bab7e9bd36109d3ac52e6b7e9f8788aadf59a23ceabc7957411b97afd8d00886eb4947f18d75337ca85b3583f8de57bff1ea7e9546b2cb69fa7"} 05:38:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:55 INFO - Copying logs to upload dir... 05:38:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:38:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.826749 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-27 05:38:55.280764) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:38:55.289093) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 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/1750e825653a938e14651a9513e720fa79c5498d853cf90ee4d7eedb82f0e13f66e4a33ff297af89531a71ad93c0bbca76959e73e1307d9610463d57f67ceb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34ddda8da0cd2bab7e9bd36109d3ac52e6b7e9f8788aadf59a23ceabc7957411b97afd8d00886eb4947f18d75337ca85b3583f8de57bff1ea7e9546b2cb69fa7"} build_url:https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010323 build_url: 'https://queue.taskcluster.net/v1/task/ZMVROnBWR8ii_vT4i7D6BQ/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/1750e825653a938e14651a9513e720fa79c5498d853cf90ee4d7eedb82f0e13f66e4a33ff297af89531a71ad93c0bbca76959e73e1307d9610463d57f67ceb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34ddda8da0cd2bab7e9bd36109d3ac52e6b7e9f8788aadf59a23ceabc7957411b97afd8d00886eb4947f18d75337ca85b3583f8de57bff1ea7e9546b2cb69fa7"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:38:55.683244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:38:55.683617) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1456579071.107358-1408568080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:38:55.768589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:38:55.771991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:38:55.772326) ========= ========= Total master_lag: 0.69 =========