builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1456576729.23 results: success (0) buildid: 20160225075428 builduid: bc5949c8e08840b78974dcb15c9a025f revision: f29d0f7b017e6647f93c6980e14f57c546ec6c33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.225992) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.226380) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.226677) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009172 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.285421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.285705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.471986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.472234) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.584393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.584663) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.585007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.585282) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 04:38: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.8M=0s 2016-02-27 04:38:51 (82.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097872 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.733347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.733632) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016199 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.771182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:49.771526) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f29d0f7b017e6647f93c6980e14f57c546ec6c33 --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 f29d0f7b017e6647f93c6980e14f57c546ec6c33 --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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 04:38:51,827 truncating revision to first 12 chars 2016-02-27 04:38:51,827 Setting DEBUG logging. 2016-02-27 04:38:51,827 attempt 1/10 2016-02-27 04:38:51,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f29d0f7b017e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 04:38:52,499 unpacking tar archive at: mozilla-aurora-f29d0f7b017e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.960005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:50.743803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:50.744136) ========= echo f29d0f7b017e6647f93c6980e14f57c546ec6c33 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f29d0f7b017e6647f93c6980e14f57c546ec6c33'] 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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f29d0f7b017e6647f93c6980e14f57c546ec6c33 program finished with exit code 0 elapsedTime=0.003533 script_repo_revision: 'f29d0f7b017e6647f93c6980e14f57c546ec6c33' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:50.795977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:50.796246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 04:38:50.806137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-02-27 04:38:50.806402) ========= /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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:38:52 INFO - MultiFileLogger online at 20160227 04:38:52 in /builds/slave/test-pgo 04:38:52 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 04:38:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:38:52 INFO - {'append_to_log': False, 04:38:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:38:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:38:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:38:52 INFO - 'branch': 'Mozilla-Aurora', 04:38:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:52 INFO - 'config_files': ('talos/linux_config.py',), 04:38:52 INFO - 'default_actions': ('clobber', 04:38:52 INFO - 'read-buildbot-config', 04:38:52 INFO - 'download-and-extract', 04:38:52 INFO - 'populate-webroot', 04:38:52 INFO - 'create-virtualenv', 04:38:52 INFO - 'install', 04:38:52 INFO - 'run-tests'), 04:38:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:52 INFO - 'download_minidump_stackwalk': True, 04:38:52 INFO - 'download_symbols': 'ondemand', 04:38:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:52 INFO - 'installer_path': 'installer.exe', 04:38:52 INFO - 'log_level': 'info', 04:38:52 INFO - 'log_name': 'talos', 04:38:52 INFO - 'log_to_console': True, 04:38:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:38:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:38:52 INFO - 'opt_config_files': (), 04:38:52 INFO - 'pip_index': False, 04:38:52 INFO - 'sps_profile': False, 04:38:52 INFO - 'sps_profile_interval': 0, 04:38:52 INFO - 'suite': 'dromaeojs-e10s', 04:38:52 INFO - 'system_bits': '32', 04:38:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:52 INFO - 'title': 'talos-linux64-ix-059', 04:38:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:52 INFO - 'use_talos_json': True, 04:38:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:38:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:52 INFO - 'work_dir': 'build'} 04:38:52 INFO - ##### 04:38:52 INFO - ##### Running clobber step. 04:38:52 INFO - ##### 04:38:52 INFO - Running pre-action listener: _resource_record_pre_action 04:38:52 INFO - Running main action method: clobber 04:38:52 INFO - rmtree: /builds/slave/test-pgo/build 04:38:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:38:53 INFO - Running post-action listener: _resource_record_post_action 04:38:53 INFO - ##### 04:38:53 INFO - ##### Running read-buildbot-config step. 04:38:53 INFO - ##### 04:38:53 INFO - Running pre-action listener: _resource_record_pre_action 04:38:53 INFO - Running main action method: read_buildbot_config 04:38:53 INFO - Using buildbot properties: 04:38:53 INFO - { 04:38:53 INFO - "project": "", 04:38:53 INFO - "product": "firefox", 04:38:53 INFO - "script_repo_revision": "production", 04:38:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:38:53 INFO - "repository": "", 04:38:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:38:53 INFO - "buildid": "20160225075428", 04:38:53 INFO - "pgo_build": "True", 04:38:53 INFO - "basedir": "/builds/slave/test-pgo", 04:38:53 INFO - "buildnumber": 162, 04:38:53 INFO - "slavename": "talos-linux64-ix-059", 04:38:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:38:53 INFO - "platform": "ubuntu64_hw", 04:38:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:38:53 INFO - "branch": "mozilla-aurora", 04:38:53 INFO - "repo_path": "releases/mozilla-aurora", 04:38:53 INFO - "revision": "f29d0f7b017e6647f93c6980e14f57c546ec6c33", 04:38:53 INFO - "stage_platform": "linux64-pgo", 04:38:53 INFO - "builduid": "bc5949c8e08840b78974dcb15c9a025f", 04:38:53 INFO - "slavebuilddir": "test" 04:38:53 INFO - } 04:38:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 04:38:53 INFO - Running post-action listener: _resource_record_post_action 04:38:53 INFO - ##### 04:38:53 INFO - ##### Running download-and-extract step. 04:38:53 INFO - ##### 04:38:53 INFO - Running pre-action listener: _resource_record_pre_action 04:38:53 INFO - Running main action method: download_and_extract 04:38:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:38: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')]} 04:38:53 INFO - https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:38:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/test_packages.json 04:38:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/test_packages.json 04:38:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:38:58 INFO - Downloaded 1448 bytes. 04:38:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:38:58 INFO - Using the following test package requirements: 04:38:58 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:38:58 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:38:58 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:38:58 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'jsshell-linux-x86_64.zip'], 04:38:58 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:38:58 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:38:58 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:38:58 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:38:58 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:38:58 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:38:58 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:38:58 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:38:58 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:58 INFO - https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:38:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:38:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:38:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:39:00 INFO - Downloaded 23081567 bytes. 04:39:00 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'] 04:39:00 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 04:39:01 INFO - Return code: 0 04:39:01 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 04:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:01 INFO - https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:39:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:39:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:39:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:39:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:39:22 INFO - Downloaded 23081567 bytes. 04:39:22 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'] 04:39:22 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 04:39:24 INFO - Return code: 0 04:39: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')]} 04:39:24 INFO - https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:39:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:39:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:39:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:39:25 INFO - Downloaded 10706649 bytes. 04:39:25 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'] 04:39:25 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 04:39:25 INFO - Return code: 0 04:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:25 INFO - https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:39:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:39:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:39:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/REhFKxAHRdm7a1xsDirB-A/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 04:39:35 INFO - Downloaded 59962407 bytes. 04:39:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:39:35 INFO - mkdir: /builds/slave/test-pgo/properties 04:39:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:39:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:39:35 INFO - Contents: 04:39:35 INFO - build_url:https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:39:36 INFO - Running post-action listener: _resource_record_post_action 04:39:36 INFO - Running post-action listener: set_extra_try_arguments 04:39:36 INFO - ##### 04:39:36 INFO - ##### Running populate-webroot step. 04:39:36 INFO - ##### 04:39:36 INFO - Running pre-action listener: _resource_record_pre_action 04:39:36 INFO - Running main action method: populate_webroot 04:39:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:36 INFO - '--tppagecycles', 04:39:36 INFO - '7'], 04:39:36 INFO - 'tests': ['tsvgm']}}, 04:39:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:39:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:39:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'tests': ['damp', 'tps']}, 04:39:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['damp', 'tps']}, 04:39:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:36 INFO - 'other': {'tests': ['a11yr', 04:39:36 INFO - 'ts_paint', 04:39:36 INFO - 'tpaint', 04:39:36 INFO - 'sessionrestore', 04:39:36 INFO - 'sessionrestore_no_auto_restore']}, 04:39:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['a11yr', 04:39:36 INFO - 'ts_paint', 04:39:36 INFO - 'tpaint', 04:39:36 INFO - 'sessionrestore', 04:39:36 INFO - 'sessionrestore_no_auto_restore']}, 04:39:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['a11yr', 04:39:36 INFO - 'ts_paint', 04:39:36 INFO - 'tpaint', 04:39:36 INFO - 'sessionrestore', 04:39:36 INFO - 'sessionrestore_no_auto_restore']}, 04:39:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['a11yr', 04:39:36 INFO - 'ts_paint', 04:39:36 INFO - 'tpaint', 04:39:36 INFO - 'sessionrestore', 04:39:36 INFO - 'sessionrestore_no_auto_restore']}, 04:39:36 INFO - 'other_l64': {'tests': ['a11yr', 04:39:36 INFO - 'ts_paint', 04:39:36 INFO - 'tpaint', 04:39:36 INFO - 'sessionrestore', 04:39:36 INFO - 'sessionrestore_no_auto_restore']}, 04:39:36 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:36 INFO - 'ts_paint', 04:39:36 INFO - 'tpaint', 04:39:36 INFO - 'sessionrestore', 04:39:36 INFO - 'sessionrestore_no_auto_restore']}, 04:39:36 INFO - 'svgr': {'tests': ['tsvgx', 04:39:36 INFO - 'tsvgr_opacity', 04:39:36 INFO - 'tart', 04:39:36 INFO - 'tscrollx', 04:39:36 INFO - 'cart']}, 04:39:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['tsvgx', 04:39:36 INFO - 'tsvgr_opacity', 04:39:36 INFO - 'tart', 04:39:36 INFO - 'tscrollx', 04:39:36 INFO - 'cart']}, 04:39:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'tests': ['tp5o']}, 04:39:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'talos_options': ['--e10s'], 04:39:36 INFO - 'tests': ['tp5o']}, 04:39:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'talos_options': ['--xperf_path', 04:39:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:36 INFO - 'tests': ['tp5n']}, 04:39:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:36 INFO - 'talos_options': ['--e10s', 04:39:36 INFO - '--xperf_path', 04:39:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:36 INFO - 'tests': ['tp5n']}}, 04:39:36 INFO - 'talos.zip': {'path': '', 04:39:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:36 INFO - Running post-action listener: _resource_record_post_action 04:39:36 INFO - ##### 04:39:36 INFO - ##### Running create-virtualenv step. 04:39:36 INFO - ##### 04:39:36 INFO - Running pre-action listener: _resource_record_pre_action 04:39:36 INFO - Running main action method: create_virtualenv 04:39:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:39:36 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 04:39:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:39:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:36 INFO - Using real prefix '/usr' 04:39:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:39:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:38 INFO - Installing pip.................done. 04:39:38 INFO - Return code: 0 04:39:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:38 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 04:39:38 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 04:39:38 INFO - Using env: {'DISPLAY': ':0', 04:39:38 INFO - 'HOME': '/home/cltbld', 04:39:38 INFO - 'LANG': 'en_US.UTF-8', 04:39:38 INFO - 'LANGUAGE': 'en_US:en', 04:39:38 INFO - 'LOGNAME': 'cltbld', 04:39:38 INFO - 'MAIL': '/var/mail/cltbld', 04:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:38 INFO - 'MOZ_NO_REMOTE': '1', 04:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:38 INFO - 'NO_EM_RESTART': '1', 04:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:38 INFO - 'SHELL': '/bin/bash', 04:39:38 INFO - 'SHLVL': '1', 04:39:38 INFO - 'TERM': 'linux', 04:39:38 INFO - 'TMOUT': '86400', 04:39:38 INFO - 'USER': 'cltbld', 04:39:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:38 INFO - '_': '/tools/buildbot/bin/python'} 04:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:38 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 04:39:38 INFO - Cleaning up... 04:39:38 INFO - Return code: 0 04:39:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:38 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 04:39:38 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 04:39:38 INFO - Using env: {'DISPLAY': ':0', 04:39:38 INFO - 'HOME': '/home/cltbld', 04:39:38 INFO - 'LANG': 'en_US.UTF-8', 04:39:38 INFO - 'LANGUAGE': 'en_US:en', 04:39:38 INFO - 'LOGNAME': 'cltbld', 04:39:38 INFO - 'MAIL': '/var/mail/cltbld', 04:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:38 INFO - 'MOZ_NO_REMOTE': '1', 04:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:38 INFO - 'NO_EM_RESTART': '1', 04:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:38 INFO - 'SHELL': '/bin/bash', 04:39:38 INFO - 'SHLVL': '1', 04:39:38 INFO - 'TERM': 'linux', 04:39:38 INFO - 'TMOUT': '86400', 04:39:38 INFO - 'USER': 'cltbld', 04:39:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:38 INFO - '_': '/tools/buildbot/bin/python'} 04:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:39 INFO - Downloading/unpacking psutil>=0.7.1 04:39:39 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 04:39:39 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 04:39:39 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 04:39:39 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 04:39:39 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 04:39:39 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 04:39:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:41 INFO - Installing collected packages: psutil 04:39:41 INFO - Running setup.py install for psutil 04:39:41 INFO - building 'psutil._psutil_linux' extension 04:39:41 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 04:39:41 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 04:39:41 INFO - building 'psutil._psutil_posix' extension 04:39:41 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 04:39:41 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 04:39:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:41 INFO - Successfully installed psutil 04:39:41 INFO - Cleaning up... 04:39:41 INFO - Return code: 0 04:39:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:39:41 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')]} 04:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:41 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')]} 04:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:41 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:41 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 04:39:41 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 04:39:41 INFO - Using env: {'DISPLAY': ':0', 04:39:41 INFO - 'HOME': '/home/cltbld', 04:39:41 INFO - 'LANG': 'en_US.UTF-8', 04:39:41 INFO - 'LANGUAGE': 'en_US:en', 04:39:41 INFO - 'LOGNAME': 'cltbld', 04:39:41 INFO - 'MAIL': '/var/mail/cltbld', 04:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:41 INFO - 'MOZ_NO_REMOTE': '1', 04:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:41 INFO - 'NO_EM_RESTART': '1', 04:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:41 INFO - 'SHELL': '/bin/bash', 04:39:41 INFO - 'SHLVL': '1', 04:39:41 INFO - 'TERM': 'linux', 04:39:41 INFO - 'TMOUT': '86400', 04:39:41 INFO - 'USER': 'cltbld', 04:39:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:41 INFO - '_': '/tools/buildbot/bin/python'} 04:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:39:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:39:43 INFO - Installing collected packages: mozsystemmonitor 04:39:43 INFO - Running setup.py install for mozsystemmonitor 04:39:43 INFO - Successfully installed mozsystemmonitor 04:39:43 INFO - Cleaning up... 04:39:43 INFO - Return code: 0 04:39:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:39:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:39:43 INFO - Using env: {'DISPLAY': ':0', 04:39:43 INFO - 'HOME': '/home/cltbld', 04:39:43 INFO - 'LANG': 'en_US.UTF-8', 04:39:43 INFO - 'LANGUAGE': 'en_US:en', 04:39:43 INFO - 'LOGNAME': 'cltbld', 04:39:43 INFO - 'MAIL': '/var/mail/cltbld', 04:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:43 INFO - 'MOZ_NO_REMOTE': '1', 04:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:43 INFO - 'NO_EM_RESTART': '1', 04:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:43 INFO - 'SHELL': '/bin/bash', 04:39:43 INFO - 'SHLVL': '1', 04:39:43 INFO - 'TERM': 'linux', 04:39:43 INFO - 'TMOUT': '86400', 04:39:43 INFO - 'USER': 'cltbld', 04:39:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:43 INFO - '_': '/tools/buildbot/bin/python'} 04:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:39:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:46 INFO - Downloading docopt-0.6.1.tar.gz 04:39:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:46 INFO - Running setup.py install for blobuploader 04:39:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:39:46 INFO - Running setup.py install for requests 04:39:47 INFO - Running setup.py install for docopt 04:39:47 INFO - Successfully installed blobuploader requests docopt 04:39:47 INFO - Cleaning up... 04:39:47 INFO - Return code: 0 04:39:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:39:47 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')]} 04:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:47 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')]} 04:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:47 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:47 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 04:39:47 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 04:39:47 INFO - Using env: {'DISPLAY': ':0', 04:39:47 INFO - 'HOME': '/home/cltbld', 04:39:47 INFO - 'LANG': 'en_US.UTF-8', 04:39:47 INFO - 'LANGUAGE': 'en_US:en', 04:39:47 INFO - 'LOGNAME': 'cltbld', 04:39:47 INFO - 'MAIL': '/var/mail/cltbld', 04:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:47 INFO - 'MOZ_NO_REMOTE': '1', 04:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:47 INFO - 'NO_EM_RESTART': '1', 04:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:47 INFO - 'SHELL': '/bin/bash', 04:39:47 INFO - 'SHLVL': '1', 04:39:47 INFO - 'TERM': 'linux', 04:39:47 INFO - 'TMOUT': '86400', 04:39:47 INFO - 'USER': 'cltbld', 04:39:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:47 INFO - '_': '/tools/buildbot/bin/python'} 04:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:39:47 INFO - Running setup.py (path:/tmp/pip-TPGQO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:39:47 INFO - Running setup.py (path:/tmp/pip-4aYTbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:39:47 INFO - Running setup.py (path:/tmp/pip-NJtHn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:39:47 INFO - Running setup.py (path:/tmp/pip-m6hQIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:39:47 INFO - Running setup.py (path:/tmp/pip-0mngA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:39:47 INFO - Running setup.py (path:/tmp/pip-1jAhZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:39:47 INFO - Running setup.py (path:/tmp/pip-UzeqxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:39:47 INFO - Running setup.py (path:/tmp/pip-ibSK_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:39:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:39:48 INFO - Running setup.py (path:/tmp/pip-po856P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:39:48 INFO - Running setup.py (path:/tmp/pip-mJzrXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:39:48 INFO - Running setup.py (path:/tmp/pip-v3lJt4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:39:48 INFO - Running setup.py (path:/tmp/pip-HU8AjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:39:48 INFO - Running setup.py (path:/tmp/pip-udEuN9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:39:48 INFO - Running setup.py (path:/tmp/pip-oklEq3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:39:48 INFO - Running setup.py (path:/tmp/pip-Bbs0dK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:39:48 INFO - Running setup.py (path:/tmp/pip-n9n9ha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:39:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:39:48 INFO - Running setup.py (path:/tmp/pip-Og5gm8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:39:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:48 INFO - Running setup.py install for manifestparser 04:39:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:39:48 INFO - Running setup.py install for mozcrash 04:39:48 INFO - Running setup.py install for mozdebug 04:39:48 INFO - Running setup.py install for mozdevice 04:39:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Running setup.py install for mozfile 04:39:49 INFO - Running setup.py install for mozhttpd 04:39:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Running setup.py install for mozinfo 04:39:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Running setup.py install for mozInstall 04:39:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Running setup.py install for mozleak 04:39:49 INFO - Running setup.py install for mozlog 04:39:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Running setup.py install for moznetwork 04:39:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Running setup.py install for mozprocess 04:39:49 INFO - Running setup.py install for mozprofile 04:39:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:39:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:39:50 INFO - Running setup.py install for mozrunner 04:39:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:39:50 INFO - Running setup.py install for mozscreenshot 04:39:50 INFO - Running setup.py install for moztest 04:39:50 INFO - Running setup.py install for mozversion 04:39:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:39:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:50 INFO - Cleaning up... 04:39:50 INFO - Return code: 0 04:39:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:39:50 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')]} 04:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:50 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')]} 04:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:50 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:50 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 04:39:50 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 04:39:50 INFO - Using env: {'DISPLAY': ':0', 04:39:50 INFO - 'HOME': '/home/cltbld', 04:39:50 INFO - 'LANG': 'en_US.UTF-8', 04:39:50 INFO - 'LANGUAGE': 'en_US:en', 04:39:50 INFO - 'LOGNAME': 'cltbld', 04:39:50 INFO - 'MAIL': '/var/mail/cltbld', 04:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:50 INFO - 'MOZ_NO_REMOTE': '1', 04:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:50 INFO - 'NO_EM_RESTART': '1', 04:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:50 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:50 INFO - 'SHELL': '/bin/bash', 04:39:50 INFO - 'SHLVL': '1', 04:39:50 INFO - 'TERM': 'linux', 04:39:50 INFO - 'TMOUT': '86400', 04:39:50 INFO - 'USER': 'cltbld', 04:39:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:50 INFO - '_': '/tools/buildbot/bin/python'} 04:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:39:50 INFO - Running setup.py (path:/tmp/pip-PbhIEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:39:50 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)) 04:39:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:39:50 INFO - Running setup.py (path:/tmp/pip-_7Y3bS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:39:50 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)) 04:39:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:39:50 INFO - Running setup.py (path:/tmp/pip-nEY9EN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:39:50 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)) 04:39:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:39:50 INFO - Running setup.py (path:/tmp/pip-dPpVLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:39:50 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)) 04:39:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:39:50 INFO - Running setup.py (path:/tmp/pip-zCwXN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:39:51 INFO - Running setup.py (path:/tmp/pip-gzZNlC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:39:51 INFO - Running setup.py (path:/tmp/pip-eXgxaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:39:51 INFO - Running setup.py (path:/tmp/pip-1SlOLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:39:51 INFO - Running setup.py (path:/tmp/pip-m49bKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:39:51 INFO - Running setup.py (path:/tmp/pip-vM_X1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:39:51 INFO - Running setup.py (path:/tmp/pip-YFsVMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:39:51 INFO - Running setup.py (path:/tmp/pip-Z1Fbr4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:39:51 INFO - Running setup.py (path:/tmp/pip-Cmjq4D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:39:51 INFO - Running setup.py (path:/tmp/pip-mNxkWm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:39:51 INFO - Running setup.py (path:/tmp/pip-2W2MZE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:39:51 INFO - Running setup.py (path:/tmp/pip-j1AMy4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:39:51 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)) 04:39:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:39:51 INFO - Running setup.py (path:/tmp/pip-ClrdPR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:39:51 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)) 04:39:51 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)) 04:39:51 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)) 04:39:51 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)) 04:39:51 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)) 04:39:51 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)) 04:39:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:53 INFO - Downloading blessings-1.6.tar.gz 04:39:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:53 INFO - Installing collected packages: blessings 04:39:53 INFO - Running setup.py install for blessings 04:39:53 INFO - Successfully installed blessings 04:39:53 INFO - Cleaning up... 04:39:53 INFO - Return code: 0 04:39:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:39:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:39:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:39:54 INFO - Reading from file tmpfile_stdout 04:39:54 INFO - Current package versions: 04:39:54 INFO - argparse == 1.2.1 04:39:54 INFO - blessings == 1.6 04:39:54 INFO - blobuploader == 1.2.4 04:39:54 INFO - docopt == 0.6.1 04:39:54 INFO - manifestparser == 1.1 04:39:54 INFO - mozInstall == 1.12 04:39:54 INFO - mozcrash == 0.16 04:39:54 INFO - mozdebug == 0.1 04:39:54 INFO - mozdevice == 0.48 04:39:54 INFO - mozfile == 1.2 04:39:54 INFO - mozhttpd == 0.7 04:39:54 INFO - mozinfo == 0.9 04:39:54 INFO - mozleak == 0.1 04:39:54 INFO - mozlog == 3.1 04:39:54 INFO - moznetwork == 0.27 04:39:54 INFO - mozprocess == 0.22 04:39:54 INFO - mozprofile == 0.28 04:39:54 INFO - mozrunner == 6.11 04:39:54 INFO - mozscreenshot == 0.1 04:39:54 INFO - mozsystemmonitor == 0.0 04:39:54 INFO - moztest == 0.7 04:39:54 INFO - mozversion == 1.4 04:39:54 INFO - psutil == 3.1.1 04:39:54 INFO - requests == 1.2.3 04:39:54 INFO - wsgiref == 0.1.2 04:39:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:39: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')]} 04:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:54 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:54 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 04:39:54 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 04:39:54 INFO - Using env: {'DISPLAY': ':0', 04:39:54 INFO - 'HOME': '/home/cltbld', 04:39:54 INFO - 'LANG': 'en_US.UTF-8', 04:39:54 INFO - 'LANGUAGE': 'en_US:en', 04:39:54 INFO - 'LOGNAME': 'cltbld', 04:39:54 INFO - 'MAIL': '/var/mail/cltbld', 04:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:54 INFO - 'MOZ_NO_REMOTE': '1', 04:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:54 INFO - 'NO_EM_RESTART': '1', 04:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:54 INFO - 'SHELL': '/bin/bash', 04:39:54 INFO - 'SHLVL': '1', 04:39:54 INFO - 'TERM': 'linux', 04:39:54 INFO - 'TMOUT': '86400', 04:39:54 INFO - 'USER': 'cltbld', 04:39:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:54 INFO - '_': '/tools/buildbot/bin/python'} 04:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 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)) 04:39:54 INFO - Cleaning up... 04:39:54 INFO - Return code: 0 04:39:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:39: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')]} 04:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:54 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:54 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 04:39:54 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 04:39:54 INFO - Using env: {'DISPLAY': ':0', 04:39:54 INFO - 'HOME': '/home/cltbld', 04:39:54 INFO - 'LANG': 'en_US.UTF-8', 04:39:54 INFO - 'LANGUAGE': 'en_US:en', 04:39:54 INFO - 'LOGNAME': 'cltbld', 04:39:54 INFO - 'MAIL': '/var/mail/cltbld', 04:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:54 INFO - 'MOZ_NO_REMOTE': '1', 04:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:54 INFO - 'NO_EM_RESTART': '1', 04:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:54 INFO - 'SHELL': '/bin/bash', 04:39:54 INFO - 'SHLVL': '1', 04:39:54 INFO - 'TERM': 'linux', 04:39:54 INFO - 'TMOUT': '86400', 04:39:54 INFO - 'USER': 'cltbld', 04:39:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:54 INFO - '_': '/tools/buildbot/bin/python'} 04:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:54 INFO - Downloading/unpacking jsonschema 04:39:54 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 04:39:54 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 04:39:54 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 04:39:54 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 04:39:54 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 04:39:54 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 04:39:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:56 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:56 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:56 INFO - warning: no files found matching '*.txt' 04:39:56 INFO - no previously-included directories found matching 'build' 04:39:56 INFO - no previously-included directories found matching 'dist' 04:39:56 INFO - no previously-included directories found matching '.git*' 04:39:56 INFO - Installing collected packages: jsonschema, functools32 04:39:56 INFO - Running setup.py install for functools32 04:39:56 INFO - warning: no files found matching '*.txt' 04:39:56 INFO - no previously-included directories found matching 'build' 04:39:56 INFO - no previously-included directories found matching 'dist' 04:39:56 INFO - no previously-included directories found matching '.git*' 04:39:56 INFO - Successfully installed jsonschema functools32 04:39:56 INFO - Cleaning up... 04:39:57 INFO - Return code: 0 04:39:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:57 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 0x7f253a446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', '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 04:39:57 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 04:39:57 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 04:39:57 INFO - Using env: {'DISPLAY': ':0', 04:39:57 INFO - 'HOME': '/home/cltbld', 04:39:57 INFO - 'LANG': 'en_US.UTF-8', 04:39:57 INFO - 'LANGUAGE': 'en_US:en', 04:39:57 INFO - 'LOGNAME': 'cltbld', 04:39:57 INFO - 'MAIL': '/var/mail/cltbld', 04:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:57 INFO - 'MOZ_NO_REMOTE': '1', 04:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:57 INFO - 'NO_EM_RESTART': '1', 04:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:39:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:39:57 INFO - 'SHELL': '/bin/bash', 04:39:57 INFO - 'SHLVL': '1', 04:39:57 INFO - 'TERM': 'linux', 04:39:57 INFO - 'TMOUT': '86400', 04:39:57 INFO - 'USER': 'cltbld', 04:39:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:57 INFO - '_': '/tools/buildbot/bin/python'} 04:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:57 INFO - Downloading/unpacking flake8 04:39:57 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 04:39:57 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 04:39:57 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 04:39:57 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 04:39:57 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 04:39:57 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 04:39:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:59 INFO - no previously-included directories found matching 'docs/_build' 04:39:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:59 INFO - Running setup.py install for pep8 04:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:59 INFO - no previously-included directories found matching 'docs/_build' 04:39:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:39:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:59 INFO - Cleaning up... 04:40:00 INFO - Return code: 0 04:40:00 INFO - Running post-action listener: _resource_record_post_action 04:40:00 INFO - Running post-action listener: _start_resource_monitoring 04:40:00 INFO - Starting resource monitoring. 04:40:00 INFO - ##### 04:40:00 INFO - ##### Running install step. 04:40:00 INFO - ##### 04:40:00 INFO - Running pre-action listener: _resource_record_pre_action 04:40:00 INFO - Running main action method: install 04:40:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:40:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:40:00 INFO - Reading from file tmpfile_stdout 04:40:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:40:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:40:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:40:00 INFO - Reading from file tmpfile_stdout 04:40:00 INFO - Output received: 04:40:00 INFO - Usage: mozinstall [options] installer 04:40:00 INFO - Options: 04:40:00 INFO - -h, --help show this help message and exit 04:40:00 INFO - -d DEST, --destination=DEST 04:40:00 INFO - Directory to install application into. [default: 04:40:00 INFO - "/builds/slave/test-pgo"] 04:40:00 INFO - --app=APP Application being installed. [default: firefox] 04:40:00 INFO - mkdir: /builds/slave/test-pgo/build/application 04:40:00 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'] 04:40:00 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 04:40:15 INFO - Reading from file tmpfile_stdout 04:40:15 INFO - Output received: 04:40:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:40:15 INFO - Running post-action listener: _resource_record_post_action 04:40:15 INFO - ##### 04:40:15 INFO - ##### Running run-tests step. 04:40:15 INFO - ##### 04:40:15 INFO - Running pre-action listener: _resource_record_pre_action 04:40:15 INFO - Running main action method: run_tests 04:40:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:40:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:40:15 INFO - Python 2.7.3 04:40:15 INFO - Return code: 0 04:40:15 INFO - grabbing minidump binary from tooltool 04:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:15 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 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:40:15 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 04:40:15 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 04:40:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:15 INFO - Return code: 0 04:40:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:40:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:40:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:40:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:40:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:40:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:40:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:40:16 INFO - Return code: 0 04:40:16 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/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 04:40:16 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/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 04:40:16 INFO - Using env: {'DISPLAY': ':0', 04:40:16 INFO - 'HOME': '/home/cltbld', 04:40:16 INFO - 'LANG': 'en_US.UTF-8', 04:40:16 INFO - 'LANGUAGE': 'en_US:en', 04:40:16 INFO - 'LOGNAME': 'cltbld', 04:40:16 INFO - 'MAIL': '/var/mail/cltbld', 04:40:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:40:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:16 INFO - 'MOZ_NO_REMOTE': '1', 04:40:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:16 INFO - 'NO_EM_RESTART': '1', 04:40:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:40:16 INFO - 'PWD': '/builds/slave/test-pgo', 04:40:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:40:16 INFO - 'SHELL': '/bin/bash', 04:40:16 INFO - 'SHLVL': '1', 04:40:16 INFO - 'TERM': 'linux', 04:40:16 INFO - 'TMOUT': '86400', 04:40:16 INFO - 'USER': 'cltbld', 04:40:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829', 04:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:16 INFO - '_': '/tools/buildbot/bin/python'} 04:40:16 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/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 04:40:16 INFO - mozversion application_buildid: 20160225075428 04:40:16 INFO - mozversion application_changeset: f29d0f7b017e6647f93c6980e14f57c546ec6c33 04:40:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:40:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:16 INFO - mozversion application_name: Firefox 04:40:16 INFO - mozversion application_remotingname: firefox-dev 04:40:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:40:16 INFO - mozversion application_vendor: Mozilla 04:40:16 INFO - mozversion application_version: 46.0a2 04:40:16 INFO - mozversion platform_buildid: 20160225075428 04:40:16 INFO - mozversion platform_changeset: f29d0f7b017e6647f93c6980e14f57c546ec6c33 04:40:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:40:16 INFO - mozversion platform_version: 46.0a2 04:40:16 INFO - using testdate: 1456576816 04:40:16 INFO - actual date: 1456576816 04:40:16 INFO - starting webserver on 'localhost:38650' 04:40:16 INFO - SUITE-START | Running 3 tests 04:40:16 INFO - TEST-START | dromaeo_css 04:40:16 INFO - operating with platform_type : linux_ 04:40:16 INFO - Initialising browser for dromaeo_css test... 04:40:16 INFO - TEST-INFO | started process 29851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp62RWMy/profile http://localhost:38650/getInfo.html) 04:40:20 INFO - PROCESS | 29851 | 04:40:20 INFO - PROCESS | 29851 | (process:29935): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:40:20 INFO - PROCESS | 29851 | __metrics Screen width/height:1600/1200 04:40:20 INFO - PROCESS | 29851 | colorDepth:24 04:40:20 INFO - PROCESS | 29851 | Browser inner width/height: 1024/697 04:40:20 INFO - PROCESS | 29851 | __metrics 04:40:21 INFO - TEST-INFO | 29851: exit 0 04:40:21 INFO - Browser initialized. 04:40:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:21 INFO - TEST-INFO | started process 29984 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp62RWMy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:23 INFO - PROCESS | 29984 | 04:40:23 INFO - PROCESS | 29984 | (process:30044): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:40:33 INFO - PROCESS | 29984 | RSS: Main: 141361152 04:40:33 INFO - PROCESS | 29984 | 04:41:23 INFO - PROCESS | 29984 | 1456576883275 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] 04:43:30 INFO - PROCESS | 29984 | Cycle 1(1): loaded http://localhost:38650/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38650/tests/dromaeo/cssquery-ext.html) 04:43:31 INFO - PROCESS | 29984 | RSS: Main: 145874944 04:43:31 INFO - PROCESS | 29984 | 04:46:33 INFO - PROCESS | 29984 | Cycle 1(1): loaded http://localhost:38650/tests/dromaeo/cssquery-ext.html (next: http://localhost:38650/tests/dromaeo/cssquery-jquery.html) 04:46:34 INFO - PROCESS | 29984 | RSS: Main: 145371136 04:46:34 INFO - PROCESS | 29984 | 04:49:35 INFO - PROCESS | 29984 | Cycle 1(1): loaded http://localhost:38650/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38650/tests/dromaeo/cssquery-mootools.html) 04:49:36 INFO - PROCESS | 29984 | RSS: Main: 144568320 04:49:36 INFO - PROCESS | 29984 | 04:52:38 INFO - PROCESS | 29984 | Cycle 1(1): loaded http://localhost:38650/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38650/tests/dromaeo/cssquery-prototype.html) 04:52:38 INFO - PROCESS | 29984 | RSS: Main: 142790656 04:52:38 INFO - PROCESS | 29984 | 04:55:41 INFO - PROCESS | 29984 | Cycle 1(1): loaded http://localhost:38650/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38650/tests/dromaeo/cssquery-yui.html) 04:55:41 INFO - PROCESS | 29984 | RSS: Main: 142925824 04:55:41 INFO - PROCESS | 29984 | 04:58:43 INFO - PROCESS | 29984 | Cycle 1(1): loaded http://localhost:38650/tests/dromaeo/cssquery-yui.html (next: http://localhost:38650/tests/dromaeo/cssquery-dojo.html) 04:58:44 INFO - PROCESS | 29984 | RSS: Main: 145240064 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | __start_tp_report 04:58:44 INFO - PROCESS | 29984 | _x_x_mozilla_page_load 04:58:44 INFO - PROCESS | 29984 | _x_x_mozilla_page_load_details 04:58:44 INFO - PROCESS | 29984 | |i|pagename|runs| 04:58:44 INFO - PROCESS | 29984 | |0;dojo.html;3312.6024877014756;3323.7174840138573;3341.3818443587925;3363.8990830275093;3375.426177549816;5292.947070529293;5313.070212712779;5346.171343441763;5351.892962140755;5363.973180134104;5302.072137375953;5332.173513105475;5353.5984801139875;5389.1646794746775;5392.379876314225;4925.1627223372025;4960.3926811261645;5024.497550244982;5042.3949126104735;5099.464556221599;4793.760311984387;4920.212765957447;4942.579880710144;4948.901021979558;5055.090083784918;4978.87552811179;5001.149804533238;5029.547340739333;5040.344755181821;5057.367829021372;5006.324146240284;5012.674176178555;5026.623003274751;5039.77321020555;5039.916417970117;4805.135075686375;4834.323194752737;4838.709677419331;4958.479359667219;4997.550220480138;5151.04705629456;5169.844904652867;5196.792128314863;5213.348331458567;5216.817411390583;5810.82567522975;5821;5823.272090988627;5837.86161698469;5889.293284805851;5708.5433165347085;5753.741081651294;5762.510186634141;5841.883162336772;5860.208871802337;5439.428859969726;5444.455554444524;5449.972750136224;5451.700156491392;5464.23500709901;5928.436798504135;5929.881402371929;5933;5933.9406605934255;5935.554833387513;5531.6957567333375;5626.43735626434;5634.295713035871;5634.830955071355;5658.547316214693;5765.625234359753;5768.394318596571;5771.105478650816;5809.593328466966;5828.475437210672;5723.255976723;5750.741216645261;5777.133429985536;5777.364489906107;5799.217105690678;5602.355729091207;5652.095664693629;5764.308283006066;5783.913241301384;5785.4214578541805;4396.560343965578;4408.647308215335;4419.292913133883;4424.358468022118;4438.955610443919;3976.980115099406;3983.263096327131;3988.680905527609;4021.3766866135797;4034.6973976951845;5303.920441193385;5358.946410535923;5371.435999220103;5402.135658294654;5408;5809;5816.040353341736;5828.446297601721;5834.533237341003;5853.619514731528;5519.613627046068;5535.916961245504;5539.058360078796;5539.750711218005;5547.944520554743;4868.2210846264425;4949.925751113737;4952.2324039773175;4954.3311652926395;5054.595632349477;5918.467337939606;6015.30823955242;6017.969910150421;6027.57806953509;6044.516438684895;5724.942750572441;5750.856228594319;5768.451997060272;5780.3930587289415;5782.739776710142;5729.942700572941;5840.503557197516;5938.257717785277;5943.940560594512;5944.256967879015;5661.179129026185;5731.140328950691;5739.081746920473;5739.253896993531;5741.5406767459335;5688.431156884279;5727.0550359190265;5744.827655170351;5763.02028655138;5788.450097240755;5466.644668096561;5525.475079867406;5608.355039170548;5614.24207731951;5614.943850561442;5612.214289999321;5638.633488823213;5640.943590564042;5686.2323586315315;5688.914666279927;5591.664500130005;5607.102863541813;5608.046632072639;5608.4111168326735;5612.017896868113;5480.945190548044;5545.195946587642;5587.664740115606;5699.344575373885;5720.513756330759;5535.114381698909;5539.944600553943;5562.72186390687;5566.860828479321;5568.805091821767 04:58:44 INFO - PROCESS | 29984 | |1;ext.html;544.686805087075;555.6582701638494;562.7017680629267;574.6121368076547;577.8988676981533;36900.26199476012;37738;37838.43242351367;37846.81076594617;38109;40461.39307910384;40873;40873.79563102188;40897.79551102248;41095.58904410955;8549.786255343619;8748.081451447602;8761.51811650359;8766.517841518715;8772.429792063496;8654.350923680719;8774.078721734222;8791.164839340252;8794.736157915273;8844.204021638052;8792.120787921222;8865.468071915706;8886.111388861127;8891.555422228863;8928.37501374904;8730.781730456758;8789.64841406343;8802.603882825224;8809.207171354608;8832.602532886036;8580.141985801432;8760.167784060568;8763.167499087576;8784.78038049054;8792.648294068229;39241.80379098115;39668.40497392541;39744.801275993435;39773.60226397728;39846.800765996275;3505.6319086495805;3548.2193917338145;3602.5316708827945;3650.653187947167;4226.873193804191;27626.861865690746;27746.722532774817;27947.28398578642;28225.01212457554;28431.573526397122;4087.734297270668;4148.211839750437;4172.8122234499215;4195.727277726938;4269.274223382033;284750;284977;285534.5723271391;286930;287240;57020;58185.709071454374;64827;65270.347296527376;65587.67206164035;65281.34718652753;65712.34287657158;65770;65824.34175658182;66009.33990660032;15283.847161528465;15469.07185568847;15472.071675699493;15515;15620.531384058497;11794.764104717857;11911.761764764657;11931.821022684666;11936.224145430519;11953.760924781456;21433.571328573653;21783.45541361447;21901.342959710917;21957;22060.117595296007;8227.71203007892;8472.788180295542;8525.616347264264;8583.613737381833;8594.785130371665;1042.1818872185297;1109.6837401340579;1120.294214644785;1164.3130552973787;1175.488662431845;28142.859285703442;28245.43509129806;28382.749326145637;29060.27349316284;29279.707202927697;1112.9054030407344;1139.4473680265064;1155.3645494977898;1167.6963989362657;1243.4839541590138;15376.15431151275;15609.687806243812;16796.908200966896;17076.573085672957;17170.742438863428;411796;496898;504988;506740;779233;53599.73200133974;54327;54331.45668543264;54459.72770136124;54820.72589637026;1435.440178330431;1446.4720377062506;1447.261896432827;1449.9710005799825;1453.4404254362146;30026.24934376658;32588.348233035682;32640.673593263764;33128;33132.66867331296;49023.26465102955;49641.751791240815;49765.253521197934;49839.75080124576;49967;303318;304381;304554;305936;307454;33793.66206337905;34545.654543455246;34550.82724586462;34699.30601388009;34788.652113479555;43683.344749828146;44358.55641443673;44616.33075503935;45487.31769023401;46147.76926115348;38606;39152.80423597864;40398;42032;42894;38308.23383532369;38440.61559384482;38537.229255414175;38629.22741545209;38714.6128538711;38893.22213555656;39235.41146882742;39324.410133848585;39513.407298889964;39621.40567891426;33878.491822622185;34328.656713432545;34779;36267.63732362748;36820.26359472742;24065.879670601535;24642.50714985726;24695;24862;24962.126325578516 04:58:44 INFO - PROCESS | 29984 | |2;jquery.html;380.5490493764889;380.82291734343534;381.5897909747023;382.53139903618063;391.77081407376664;15827.129507877062;17556.209970551325;17577.209025593846;17661.558461038465;18371.44885653429;14318;14480.203588802611;14541.98206125569;14687.192204428753;16593.66812663746;4995.100881841267;5149.356330458692;5161.27742116104;5177.30106435632;5198.792048318062;5050.823221187259;5062.468440813716;5136.820211292606;5148.588112950955;5493.423190564993;5208.76560554774;5387.595930305223;5533.446655334475;5572.052751032314;5582.665040097587;5265.578753699733;5278.076336641073;5329.786808527673;5332.440093790135;5367.114426119686;5321.095413779628;5350.625456218067;5360.865978350534;5373.1402975524115;5383.919241211346;12691.492340306377;18822.62354752911;20176.899115504475;20617.690734638993;20661.5867682647;2119.671450925109;2138.9465263368384;2171.337741988693;2204.162418281043;2313.306008197551;10025.749356266078;10075.093241608218;10386.636467723669;11750.842591436774;13313.068085234037;1822.6901426757483;1839.7516335294831;1870.9522667306217;1917.424772568224;1952.541152829084;55902.72048639772;56746.43253567494;57097.14354284689;57404.42595574074;57915.71042144804;10570;10752.892471075345;10798.460076996118;10824.242303038869;10845.83731244032;14272.21502817355;14302.427902883768;14381.78427323591;14394.784078238834;14424.927875360556;7473.1032276126125;7506.812329691692;7691.615419229016;7695.576743279062;7730.265624765639;7045.225025247219;7073.752418665425;7091.290870912971;7129.073220481408;7178.318059784312;4668.5564871337165;4737.928931066037;4755.334253204554;4763.071201115818;4786.210275304606;1888.10315100329;1920.4238728381429;1930.44982180078;1935.129191863667;1955.2276850643916;963.7446076789656;1057.6721216422934;1084.208527774713;1110.4170310587006;1126.3748619516084;13487.865121348857;15353.541413565694;15522.767158492632;17000.149992500326;17006.914965425094;984.8571957066185;1009.5305682857506;1015.2740790334798;1058.1799105693149;1158.4844744088969;8855.203031727175;9308.301877359225;9397.859032114524;9466.29002824791;9502.619895204252;395127;395811;396164;397890;448834;46735.76632116818;48941.510584893695;71662;73707.2629273711;73785.6310718443;1126.8591426071741;1144.1647597253884;1156.9305841649696;1165.8367828504017;1173.1142987044898;15422.922885385502;15659.37362505487;15784.21078946025;16032.278547465625;16127.193640318172;32909;33349.499757503174;33646.158846029044;33694.3261134771;34458.483122752674;42594.148117036864;42616;43554.78222608867;44342.77828610836;44774.55225447834;7432.3682486987045;7700.114486834086;7709.3447057000785;7717.498362606412;7804.453688241996;9480.525973701426;10754.193435492212;10872.836907446237;10976.176786741185;10984.450777461256;9708.563114659715;10020.398776073167;10290.742731431774;10333.586656533655;10422.374657520573;9877.654282100379;9995.800083998425;10138.847917281098;10155;10407.583696652351;10267.897321026992;10405.167586593207;10517.158627309644;10679.839802402816;10715.785684286426;7668.80827979305;7724.884126737991;7763.961180194063;7794.181610930771;7957.960210198912;9937.980723872635;9970.700878973643;10564.84152737725;10914.563417463212;10996.560137594406 04:58:44 INFO - PROCESS | 29984 | |3;mootools.html;1514.575918742752;1538.6845696632192;1714.4856543037095;1794.8653850961166;1804.2873065139263;7956.283934445899;8052.91947080529;8095.150009249032;8227.13615070418;8232.176782321772;8152.796180095485;8208.58957052148;8235.464694794835;8247.83504329913;8254.174582541742;2323.23333300011;2328.8369814112934;2332.1604222479896;2342.2973108067595;2353.8469999450067;2341.9531609367887;2366.8461549999283;2413.8431001984904;2414.0947144820693;2414.4326083370484;2266.150193677371;2324.7094113235844;2328.092044102801;2334.6614740862565;2349.518348738513;2341.438054866837;2351.106579499796;2358.8702621355906;2359.103540654549;2366.9053237870467;2322.082777302956;2336.9649455258186;2361.2325994052003;2369.064219633235;2369.9526009479714;8062.677492900277;8073.07159676633;8082.232187942195;8114.391420643476;8124.1875812418875;4665.5567721066445;4786.95213047872;4796.328514008042;4842.709437433765;4857.2714092886;3070.6622271550114;3096.6748491408302;3121.2977080156784;3125.5467957146316;3145.308032232905;1056.6935588679273;1073.0717928991444;1082.3992684060343;1096.6874440784418;1107.6566264458045;10562.419066951315;10604.098651614622;10669.359838409642;10700.090492308163;10716.892831071746;3976.8069579126145;3994.360902255625;4017.2367250222946;4035.334169861999;4051.7771522565954;8974.19232269099;8998.955005224932;8999.595018224196;9015.053419391;9030.86453703195;4579.7252164870215;4584.908301834012;4609.562091601292;4623.329617205486;4628.0281140960105;4173.937390939138;4204.936925946114;4220.282551966173;4233.534311225762;4264.445622069111;3418.418868792311;3526.4181410067563;3533.187366905575;3536.504889315498;3543.4153364694535;1020.8928062553473;1026.0406519903913;1032.200044965158;1049.2602715085998;1052.1162223732101;1122.6183097746805;1127.2391135983178;1171.701216189866;1369.0621923982103;1443.8050863133553;7536.321731044232;7563.054618172729;7617.5048621840515;7626.8093297668;7648.464607477423;1172.3434876469205;1195.3403676819007;1197.2696655040418;1201.3752848518895;1231.9199252048768;5892.587518873637;5896.410358964069;5900.852478687982;5902.937471255215;6028.4272994065495;9319.953400232955;9942.701718948443;9960.402375857471;10067.093961543496;10100;9727.41635501858;9782.804343913223;9833.4099954003;9844.753881153028;9859;7424.294692004251;7500.587467689329;7508.211637777955;7519.398448124137;7533.322001019935;7561.546307221584;7617.5048621839405;7629.961850190713;7745.380369570534;7767.300942915164;8595.226429621363;8733.912660873564;8749.956250218707;8784.560771961504;8832.470051796912;8790.472571645465;8942.552872356486;9015.233705135137;9041.77395565116;9304.95347523258;7203.71185152588;7339.74310899116;7388.482806203514;7391.1869694334655;7396.630168491446;7734.265244801735;7784.065912090586;7866.567338796421;7901.565413902291;7919.208079192034;6632.568883022781;7547.50941188821;7580.583067931096;7581;7722.266384693445;6975.372216500539;7183.604901730455;7296.379807716404;7412.369948554433;7442.702291908263;7488.513246638951;7518.473706840688;7532.510386824839;7539.509931854412;7572.3942084632;6754.2570317266045;6790.558613690095;6840.144981877265;6891.793246202622;6907.551009184387;6843.076184715;6926.653667316513;6929;6930.410915072275;7019.964900175466 04:58:44 INFO - PROCESS | 29984 | |4;prototype.html;349.1968472513219;355.32310947644737;360.5313092979126;361.39285999520797;365.1127759544308;6149.907751383733;6277.089821975811;6291.496680265579;6293.5279854010905;6388.073729309253;6096.298925623554;6214.098955651428;6255.843603909893;6256.280527739312;6292.119103325526;4851.878703032426;4871.707697538159;4881.1213981483315;4884.926726099111;4889.3888263967;4808.735519546423;4837.5646191842725;4885.413750349963;4888.266759985995;4890.951090489085;4724.669273150881;4836.1778497655305;4843.104025755229;4858.441279252896;4871.658983871131;4758.953030333321;4817.831375901862;4837.0567739290855;4839.830605928811;4856.732879691634;4251;4279.978600107011;4286.635635970946;4300.09697963425;4306.461692288464;5930.644161350289;5945.821625351246;5957.314908785502;5972.104184372335;5995.340512543617;5459.863503412446;5629.4652008059165;5633.295838020247;5635.408282130399;5662.065759149736;6639.33606639337;6670.93329066708;6679.231888332855;6694.49791265657;6705.798826035227;4696.849271928365;4700.31845382421;4707.199776038082;4708.764561771932;4726.243800991825;6924.099867017256;6951.826204344881;6965.164180298397;6967.47743919203;7003;4709.576138147583;4722.858314250578;4727.5745182933015;4729.314249433813;4759.667293157921;4769.952300476951;4821.590164835958;4822.348982887265;4830.9275360869615;4832.323474713543;5540.504063902724;5565.41563135873;5573.888522229614;5576.10782274834;5594.748236329375;6535.640539770263;6735.797926062226;6775.728970841111;6777.1189745332795;6777.423918966844;1665.6335606166867;1685.3006002509067;1696.4062578097567;1699.269314194908;1704.0883127526713;1109.4341885638382;1132.5696235430648;1135.3017893995134;1155.162507182303;1164.976700466003;6411.775587854496;6437.806865794034;6447.484201263981;6448.1295025171;6474.061261117112;6802.285759995129;6838.384545390939;6844.041834143224;6846.4522838172825;6869.519133660596;6284.308726040132;6393.041043843367;6397.904031439532;6441.25925518562;6447.1618689571;3783.735138540276;3785.905352366213;3817.5991520889906;3822.1591249924973;3822.617738226211;7248.891266631004;7256.600886951268;7262.927370726331;7266.491345605863;7288.96355518219;7090.645467726593;7133.750318738819;7227.7831665050135;7228.31331023552;7229.710811567478;7235.782926512213;7246.058012458347;7272.200057993617;7273.89089163663;7278;7008.299170082951;7024.683889224895;7041.5422997505;7051.012858199959;7059.647017648994;6688.264290928091;6883.380495755406;6909.654517274217;6933.514653974174;6977.79066628002;7203.819904502429;7243.529170603894;7256.4194864411775;7268.672909719181;7270.200277969313;4763.73799441034;4770.642201834807;4788.808447662054;4791.329213910125;4805.783739731651;6702.798916032527;6838.213605435439;6865.450763938773;6989.161300643956;7006.509544331848;6597.868042639217;6715.127033485615;6754.966225168842;6784.3894049535775;6809.557378770364;6686.69909854048;6772.627505487048;6789.558678685869;6796.626185559841;6803.319668033157;6490;6642.90035649456;6651.933480665325;6655.2346480153465;6672.633005184762;6740.595564266159;6763.492738044764;6768.864622707617;6794.524383293122;6807;6605.966970165311;6634.668266586747;6638.568493048129;6662.267150613526;6674.632895190811 04:58:44 INFO - PROCESS | 29984 | |5;yui.html;777.6073083093037;788.4480863395621;882.929365650748;919.5953780336653;933.3746389918756;13752.724945501084;13815.171089734624;13862.514811981582;13868.514601988945;14024.439022439103;13804.654883627914;13874.722505549882;13911.443542258323;13913;13926.442942282296;734.7391675955039;748.7791101625033;872.3021582733819;885.3536918049828;892.6830975003877;863.7408777366765;871.4466313890694;877.8376000439939;879.6041781198486;880.4761167105594;905.814308066848;921.262989608314;928.4986107501941;929.916307532322;930.5905401623264;912.110692075228;913.3515204205022;916.6333466613374;917.0508523677995;917.9954100229489;682.0996284903929;683.7948615415355;683.7982795075415;684.7397988764287;686.2245662401455;14390.568282951528;14442.71114577713;14461.421543138262;14463.421463141462;14495.62291582298;13822.792658110136;13930.51243206493;14007.509737159253;14025.579232623038;14047.22740249286;11403.600873969453;11441.313521188755;11580.073594112451;11666.708332291675;11942.522299108025;3883.5533913600016;3904.297226499229;3909.139989202371;3937.803109844525;4007.8797636070963;51229.48770512285;52117.218241726405;52122.47877521214;52192;52519.47480525184;10024;10067.5469603868;10279.434631095211;10324.793504130026;10412.114970227616;18584.721229181574;18723.25106995732;18743.34398296053;18819.153138108817;18875.150618222215;7276.7089316426745;7502.249775022454;7535.472516923763;7561.281678240558;7812.335951444191;4096.754194748325;4129.112240868228;4163.375493675972;4197.160567886435;4221.662267018631;3118.9220269493444;3136.8431578421446;3137.654857965622;3145.3394787094508;3147.6380216274965;542.3464725006357;558.600600570594;564.3679079431064;596.1534620838333;623.6538721009792;622.6948795090464;733.6478490324674;737.2516895351223;740.1894925057054;750.8798592225218;8834.249088827393;9439;9468.100530449596;9510.33427660071;9551.283653725859;615.6460035479618;726.1612837172968;748.3713680508399;761.3072104384983;767.8963339949036;4065.654419374386;4474.149911516802;4555.954440455619;4568.543145685405;4599.4710608280475;54407;57142.7142864283;58267.12599311014;58694.7065264671;58757;52132;53396.46603533992;53900;54260.914781704145;54506;43192.56807431886;43438.13123737508;44166;47705;47864;8728.519931403835;9078.45529268246;9081.97032238087;9112.225460835904;9412.717618471457;34145.48781768226;34505.482417763254;35073.82463087668;35218.295634087684;35316.117097072776;41217;44989.77505112453;45133;45655;45741.771291144665;10205.438700871524;10289.125424339016;10416.479176041319;10557.15542756593;10641.680749577525;11018.338899666045;11133.387663678575;11288;11423.143264255381;11554.537818487166;10426.791464170827;10507;10564.207684423545;10582.576696932036;10812.459377031275;10411;10567.154627629925;10647;10653;10804.135669146606;10627.681169564925;11062.502187401748;12416.192947458747;12589.370531473573;12662.366881655696;9750.268729845431;9850.655227067018;10033.347832390871;10241.74395640115;10407.531661075422;10049.131740695882;10264.948675256575;10389.688309350731;10627.946860265649;10856.511456984297 04:58:44 INFO - PROCESS | 29984 | __end_tp_report 04:58:44 INFO - PROCESS | 29984 | __start_cc_report 04:58:44 INFO - PROCESS | 29984 | _x_x_mozilla_cycle_collect,298 04:58:44 INFO - PROCESS | 29984 | __end_cc_report 04:58:44 INFO - PROCESS | 29984 | __startTimestamp1456577924015__endTimestamp 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | ------- Summary: start ------- 04:58:44 INFO - PROCESS | 29984 | Number of tests: 6 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | [#0] dojo.html Cycles:165 Average:5369.51 Median:5562.72 stddev:572.76 (10.3%) stddev-sans-first:551.32 04:58:44 INFO - PROCESS | 29984 | Values: 3312.6 3323.7 3341.4 3363.9 3375.4 5292.9 5313.1 5346.2 5351.9 5364.0 5302.1 5332.2 5353.6 5389.2 5392.4 4925.2 4960.4 5024.5 5042.4 5099.5 4793.8 4920.2 4942.6 4948.9 5055.1 4978.9 5001.1 5029.5 5040.3 5057.4 5006.3 5012.7 5026.6 5039.8 5039.9 4805.1 4834.3 4838.7 4958.5 4997.6 5151.0 5169.8 5196.8 5213.3 5216.8 5810.8 5821.0 5823.3 5837.9 5889.3 5708.5 5753.7 5762.5 5841.9 5860.2 5439.4 5444.5 5450.0 5451.7 5464.2 5928.4 5929.9 5933.0 5933.9 5935.6 5531.7 5626.4 5634.3 5634.8 5658.5 5765.6 5768.4 5771.1 5809.6 5828.5 5723.3 5750.7 5777.1 5777.4 5799.2 5602.4 5652.1 5764.3 5783.9 5785.4 4396.6 4408.6 4419.3 4424.4 4439.0 3977.0 3983.3 3988.7 4021.4 4034.7 5303.9 5358.9 5371.4 5402.1 5408.0 5809.0 5816.0 5828.4 5834.5 5853.6 5519.6 5535.9 5539.1 5539.8 5547.9 4868.2 4949.9 4952.2 4954.3 5054.6 5918.5 6015.3 6018.0 6027.6 6044.5 5724.9 5750.9 5768.5 5780.4 5782.7 5729.9 5840.5 5938.3 5943.9 5944.3 5661.2 5731.1 5739.1 5739.3 5741.5 5688.4 5727.1 5744.8 5763.0 5788.5 5466.6 5525.5 5608.4 5614.2 5614.9 5612.2 5638.6 5640.9 5686.2 5688.9 5591.7 5607.1 5608.0 5608.4 5612.0 5480.9 5545.2 5587.7 5699.3 5720.5 5535.1 5539.9 5562.7 5566.9 5568.8 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | [#1] ext.html Cycles:180 Average:54381.07 Median:39023.01 stddev:106722.24 (273.5%) stddev-sans-first:106945.07 04:58:44 INFO - PROCESS | 29984 | Values: 544.7 555.7 562.7 574.6 577.9 36900.3 37738.0 37838.4 37846.8 38109.0 40461.4 40873.0 40873.8 40897.8 41095.6 8549.8 8748.1 8761.5 8766.5 8772.4 8654.4 8774.1 8791.2 8794.7 8844.2 8792.1 8865.5 8886.1 8891.6 8928.4 8730.8 8789.6 8802.6 8809.2 8832.6 8580.1 8760.2 8763.2 8784.8 8792.6 39241.8 39668.4 39744.8 39773.6 39846.8 3505.6 3548.2 3602.5 3650.7 4226.9 27626.9 27746.7 27947.3 28225.0 28431.6 4087.7 4148.2 4172.8 4195.7 4269.3 284750.0 284977.0 285534.6 286930.0 287240.0 57020.0 58185.7 64827.0 65270.3 65587.7 65281.3 65712.3 65770.0 65824.3 66009.3 15283.8 15469.1 15472.1 15515.0 15620.5 11794.8 11911.8 11931.8 11936.2 11953.8 21433.6 21783.5 21901.3 21957.0 22060.1 8227.7 8472.8 8525.6 8583.6 8594.8 1042.2 1109.7 1120.3 1164.3 1175.5 28142.9 28245.4 28382.7 29060.3 29279.7 1112.9 1139.4 1155.4 1167.7 1243.5 15376.2 15609.7 16796.9 17076.6 17170.7 411796.0 496898.0 504988.0 506740.0 779233.0 53599.7 54327.0 54331.5 54459.7 54820.7 1435.4 1446.5 1447.3 1450.0 1453.4 30026.2 32588.3 32640.7 33128.0 33132.7 49023.3 49641.8 49765.3 49839.8 49967.0 303318.0 304381.0 304554.0 305936.0 307454.0 33793.7 34545.7 34550.8 34699.3 34788.7 43683.3 44358.6 44616.3 45487.3 46147.8 38606.0 39152.8 40398.0 42032.0 42894.0 38308.2 38440.6 38537.2 38629.2 38714.6 38893.2 39235.4 39324.4 39513.4 39621.4 33878.5 34328.7 34779.0 36267.6 36820.3 24065.9 24642.5 24695.0 24862.0 24962.1 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | [#2] jquery.html Cycles:180 Average:23742.99 Median:34076.40 stddev:66614.85 (195.5%) stddev-sans-first:66778.62 04:58:44 INFO - PROCESS | 29984 | Values: 380.5 380.8 381.6 382.5 391.8 15827.1 17556.2 17577.2 17661.6 18371.4 14318.0 14480.2 14542.0 14687.2 16593.7 4995.1 5149.4 5161.3 5177.3 5198.8 5050.8 5062.5 5136.8 5148.6 5493.4 5208.8 5387.6 5533.4 5572.1 5582.7 5265.6 5278.1 5329.8 5332.4 5367.1 5321.1 5350.6 5360.9 5373.1 5383.9 12691.5 18822.6 20176.9 20617.7 20661.6 2119.7 2138.9 2171.3 2204.2 2313.3 10025.7 10075.1 10386.6 11750.8 13313.1 1822.7 1839.8 1871.0 1917.4 1952.5 55902.7 56746.4 57097.1 57404.4 57915.7 10570.0 10752.9 10798.5 10824.2 10845.8 14272.2 14302.4 14381.8 14394.8 14424.9 7473.1 7506.8 7691.6 7695.6 7730.3 7045.2 7073.8 7091.3 7129.1 7178.3 4668.6 4737.9 4755.3 4763.1 4786.2 1888.1 1920.4 1930.4 1935.1 1955.2 963.7 1057.7 1084.2 1110.4 1126.4 13487.9 15353.5 15522.8 17000.1 17006.9 984.9 1009.5 1015.3 1058.2 1158.5 8855.2 9308.3 9397.9 9466.3 9502.6 395127.0 395811.0 396164.0 397890.0 448834.0 46735.8 48941.5 71662.0 73707.3 73785.6 1126.9 1144.2 1156.9 1165.8 1173.1 15422.9 15659.4 15784.2 16032.3 16127.2 32909.0 33349.5 33646.2 33694.3 34458.5 42594.1 42616.0 43554.8 44342.8 44774.6 7432.4 7700.1 7709.3 7717.5 7804.5 9480.5 10754.2 10872.8 10976.2 10984.5 9708.6 10020.4 10290.7 10333.6 10422.4 9877.7 9995.8 10138.8 10155.0 10407.6 10267.9 10405.2 10517.2 10679.8 10715.8 7668.8 7724.9 7764.0 7794.2 7958.0 9938.0 9970.7 10564.8 10914.6 10996.6 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | [#3] mootools.html Cycles:180 Average:5655.87 Median:5965.68 stddev:2951.12 (49.5%) stddev-sans-first:2942.99 04:58:44 INFO - PROCESS | 29984 | Values: 1514.6 1538.7 1714.5 1794.9 1804.3 7956.3 8052.9 8095.2 8227.1 8232.2 8152.8 8208.6 8235.5 8247.8 8254.2 2323.2 2328.8 2332.2 2342.3 2353.8 2342.0 2366.8 2413.8 2414.1 2414.4 2266.2 2324.7 2328.1 2334.7 2349.5 2341.4 2351.1 2358.9 2359.1 2366.9 2322.1 2337.0 2361.2 2369.1 2370.0 8062.7 8073.1 8082.2 8114.4 8124.2 4665.6 4787.0 4796.3 4842.7 4857.3 3070.7 3096.7 3121.3 3125.5 3145.3 1056.7 1073.1 1082.4 1096.7 1107.7 10562.4 10604.1 10669.4 10700.1 10716.9 3976.8 3994.4 4017.2 4035.3 4051.8 8974.2 8999.0 8999.6 9015.1 9030.9 4579.7 4584.9 4609.6 4623.3 4628.0 4173.9 4204.9 4220.3 4233.5 4264.4 3418.4 3526.4 3533.2 3536.5 3543.4 1020.9 1026.0 1032.2 1049.3 1052.1 1122.6 1127.2 1171.7 1369.1 1443.8 7536.3 7563.1 7617.5 7626.8 7648.5 1172.3 1195.3 1197.3 1201.4 1231.9 5892.6 5896.4 5900.9 5902.9 6028.4 9320.0 9942.7 9960.4 10067.1 10100.0 9727.4 9782.8 9833.4 9844.8 9859.0 7424.3 7500.6 7508.2 7519.4 7533.3 7561.5 7617.5 7630.0 7745.4 7767.3 8595.2 8733.9 8750.0 8784.6 8832.5 8790.5 8942.6 9015.2 9041.8 9305.0 7203.7 7339.7 7388.5 7391.2 7396.6 7734.3 7784.1 7866.6 7901.6 7919.2 6632.6 7547.5 7580.6 7581.0 7722.3 6975.4 7183.6 7296.4 7412.4 7442.7 7488.5 7518.5 7532.5 7539.5 7572.4 6754.3 6790.6 6840.1 6891.8 6907.6 6843.1 6926.7 6929.0 6930.4 7020.0 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | [#4] prototype.html Cycles:180 Average:5629.81 Median:6390.56 stddev:1697.40 (26.6%) stddev-sans-first:1655.24 04:58:44 INFO - PROCESS | 29984 | Values: 349.2 355.3 360.5 361.4 365.1 6149.9 6277.1 6291.5 6293.5 6388.1 6096.3 6214.1 6255.8 6256.3 6292.1 4851.9 4871.7 4881.1 4884.9 4889.4 4808.7 4837.6 4885.4 4888.3 4891.0 4724.7 4836.2 4843.1 4858.4 4871.7 4759.0 4817.8 4837.1 4839.8 4856.7 4251.0 4280.0 4286.6 4300.1 4306.5 5930.6 5945.8 5957.3 5972.1 5995.3 5459.9 5629.5 5633.3 5635.4 5662.1 6639.3 6670.9 6679.2 6694.5 6705.8 4696.8 4700.3 4707.2 4708.8 4726.2 6924.1 6951.8 6965.2 6967.5 7003.0 4709.6 4722.9 4727.6 4729.3 4759.7 4770.0 4821.6 4822.3 4830.9 4832.3 5540.5 5565.4 5573.9 5576.1 5594.7 6535.6 6735.8 6775.7 6777.1 6777.4 1665.6 1685.3 1696.4 1699.3 1704.1 1109.4 1132.6 1135.3 1155.2 1165.0 6411.8 6437.8 6447.5 6448.1 6474.1 6802.3 6838.4 6844.0 6846.5 6869.5 6284.3 6393.0 6397.9 6441.3 6447.2 3783.7 3785.9 3817.6 3822.2 3822.6 7248.9 7256.6 7262.9 7266.5 7289.0 7090.6 7133.8 7227.8 7228.3 7229.7 7235.8 7246.1 7272.2 7273.9 7278.0 7008.3 7024.7 7041.5 7051.0 7059.6 6688.3 6883.4 6909.7 6933.5 6977.8 7203.8 7243.5 7256.4 7268.7 7270.2 4763.7 4770.6 4788.8 4791.3 4805.8 6702.8 6838.2 6865.5 6989.2 7006.5 6597.9 6715.1 6755.0 6784.4 6809.6 6686.7 6772.6 6789.6 6796.6 6803.3 6490.0 6642.9 6651.9 6655.2 6672.6 6740.6 6763.5 6768.9 6794.5 6807.0 6606.0 6634.7 6638.6 6662.3 6674.6 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - PROCESS | 29984 | [#5] yui.html Cycles:180 Average:14127.14 Median:43315.35 stddev:16245.63 (37.5%) stddev-sans-first:16260.28 04:58:44 INFO - PROCESS | 29984 | Values: 777.6 788.4 882.9 919.6 933.4 13752.7 13815.2 13862.5 13868.5 14024.4 13804.7 13874.7 13911.4 13913.0 13926.4 734.7 748.8 872.3 885.4 892.7 863.7 871.4 877.8 879.6 880.5 905.8 921.3 928.5 929.9 930.6 912.1 913.4 916.6 917.1 918.0 682.1 683.8 683.8 684.7 686.2 14390.6 14442.7 14461.4 14463.4 14495.6 13822.8 13930.5 14007.5 14025.6 14047.2 11403.6 11441.3 11580.1 11666.7 11942.5 3883.6 3904.3 3909.1 3937.8 4007.9 51229.5 52117.2 52122.5 52192.0 52519.5 10024.0 10067.5 10279.4 10324.8 10412.1 18584.7 18723.3 18743.3 18819.2 18875.2 7276.7 7502.2 7535.5 7561.3 7812.3 4096.8 4129.1 4163.4 4197.2 4221.7 3118.9 3136.8 3137.7 3145.3 3147.6 542.3 558.6 564.4 596.2 623.7 622.7 733.6 737.3 740.2 750.9 8834.2 9439.0 9468.1 9510.3 9551.3 615.6 726.2 748.4 761.3 767.9 4065.7 4474.1 4556.0 4568.5 4599.5 54407.0 57142.7 58267.1 58694.7 58757.0 52132.0 53396.5 53900.0 54260.9 54506.0 43192.6 43438.1 44166.0 47705.0 47864.0 8728.5 9078.5 9082.0 9112.2 9412.7 34145.5 34505.5 35073.8 35218.3 35316.1 41217.0 44989.8 45133.0 45655.0 45741.8 10205.4 10289.1 10416.5 10557.2 10641.7 11018.3 11133.4 11288.0 11423.1 11554.5 10426.8 10507.0 10564.2 10582.6 10812.5 10411.0 10567.2 10647.0 10653.0 10804.1 10627.7 11062.5 12416.2 12589.4 12662.4 9750.3 9850.7 10033.3 10241.7 10407.5 10049.1 10264.9 10389.7 10627.9 10856.5 04:58:44 INFO - PROCESS | 29984 | -------- Summary: end -------- 04:58:44 INFO - PROCESS | 29984 | 04:58:44 INFO - TEST-INFO | 29984: exit 0 04:58:44 INFO - TEST-OK | dromaeo_css | took 1107975ms 04:58:44 INFO - TEST-START | kraken 04:58:44 INFO - operating with platform_type : linux_ 04:58:44 INFO - Initialising browser for kraken test... 04:58:44 INFO - TEST-INFO | started process 30226 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbjHUmZ/profile http://localhost:38650/getInfo.html) 04:58:48 INFO - PROCESS | 30226 | 04:58:48 INFO - PROCESS | 30226 | (process:30302): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:58:48 INFO - PROCESS | 30226 | __metrics Screen width/height:1600/1200 04:58:48 INFO - PROCESS | 30226 | colorDepth:24 04:58:48 INFO - PROCESS | 30226 | Browser inner width/height: 1024/697 04:58:48 INFO - PROCESS | 30226 | __metrics 04:58:49 INFO - TEST-INFO | 30226: exit 0 04:58:49 INFO - Browser initialized. 04:58:49 INFO - Running cycle 1/1 for kraken test... 04:58:49 INFO - TEST-INFO | started process 30351 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbjHUmZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:51 INFO - PROCESS | 30351 | 04:58:51 INFO - PROCESS | 30351 | (process:30414): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:59:01 INFO - PROCESS | 30351 | RSS: Main: 140607488 04:59:01 INFO - PROCESS | 30351 | 04:59:04 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38650/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:04 INFO - PROCESS | 30351 | RSS: Main: 146460672 04:59:04 INFO - PROCESS | 30351 | 04:59:07 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38650/tests/kraken/driver.html?testName=audio-dft) 04:59:07 INFO - PROCESS | 30351 | RSS: Main: 145403904 04:59:07 INFO - PROCESS | 30351 | 04:59:10 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38650/tests/kraken/driver.html?testName=audio-fft) 04:59:11 INFO - PROCESS | 30351 | RSS: Main: 146984960 04:59:11 INFO - PROCESS | 30351 | 04:59:13 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38650/tests/kraken/driver.html?testName=audio-oscillator) 04:59:14 INFO - PROCESS | 30351 | RSS: Main: 146870272 04:59:14 INFO - PROCESS | 30351 | 04:59:16 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38650/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:16 INFO - PROCESS | 30351 | RSS: Main: 146444288 04:59:16 INFO - PROCESS | 30351 | 04:59:19 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38650/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:20 INFO - PROCESS | 30351 | RSS: Main: 144834560 04:59:20 INFO - PROCESS | 30351 | 04:59:23 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38650/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:24 INFO - PROCESS | 30351 | RSS: Main: 145821696 04:59:24 INFO - PROCESS | 30351 | 04:59:27 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38650/tests/kraken/driver.html?testName=json-parse-financial) 04:59:27 INFO - PROCESS | 30351 | RSS: Main: 145842176 04:59:27 INFO - PROCESS | 30351 | 04:59:29 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38650/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:29 INFO - PROCESS | 30351 | RSS: Main: 146993152 04:59:29 INFO - PROCESS | 30351 | 04:59:31 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:32 INFO - PROCESS | 30351 | RSS: Main: 146571264 04:59:32 INFO - PROCESS | 30351 | 04:59:34 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:34 INFO - PROCESS | 30351 | RSS: Main: 146694144 04:59:34 INFO - PROCESS | 30351 | 04:59:37 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:37 INFO - PROCESS | 30351 | RSS: Main: 147476480 04:59:37 INFO - PROCESS | 30351 | 04:59:40 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:40 INFO - PROCESS | 30351 | RSS: Main: 146620416 04:59:40 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | Cycle 1(1): loaded http://localhost:38650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38650/tests/kraken/driver.html?testName=ai-astar) 04:59:42 INFO - PROCESS | 30351 | RSS: Main: 146726912 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | __start_tp_report 04:59:42 INFO - PROCESS | 30351 | _x_x_mozilla_page_load 04:59:42 INFO - PROCESS | 30351 | _x_x_mozilla_page_load_details 04:59:42 INFO - PROCESS | 30351 | |i|pagename|runs| 04:59:42 INFO - PROCESS | 30351 | |0;ai-astar;112;105;111;110;113;122;113;110;111;111 04:59:42 INFO - PROCESS | 30351 | |1;audio-beat-detection;156;137;160;170;132;158;168;128;163;127 04:59:42 INFO - PROCESS | 30351 | |2;audio-dft;162;163;161;162;161;162;163;161;163;166 04:59:42 INFO - PROCESS | 30351 | |3;audio-fft;76;72;72;162;74;84;73;74;147;76 04:59:42 INFO - PROCESS | 30351 | |4;audio-oscillator;95;94;142;94;95;95;134;96;96;137 04:59:42 INFO - PROCESS | 30351 | |5;imaging-gaussian-blur;111;111;110;109;110;110;109;109;110;109 04:59:42 INFO - PROCESS | 30351 | |6;imaging-darkroom;147;147;146;147;145;147;146;149;146;149 04:59:42 INFO - PROCESS | 30351 | |7;imaging-desaturate;96;97;102;96;97;100;96;96;96;96 04:59:42 INFO - PROCESS | 30351 | |8;json-parse-financial;56;54;60;55;63;55;59;62;53;52 04:59:42 INFO - PROCESS | 30351 | |9;json-stringify-tinderbox;65;65;66;66;65;66;66;65;65;66 04:59:42 INFO - PROCESS | 30351 | |10;stanford-crypto-aes;81;83;83;83;89;82;84;82;85;84 04:59:42 INFO - PROCESS | 30351 | |11;stanford-crypto-ccm;115;111;113;119;110;119;119;112;126;116 04:59:42 INFO - PROCESS | 30351 | |12;stanford-crypto-pbkdf2;147;139;131;140;137;149;137;135;138;137 04:59:42 INFO - PROCESS | 30351 | |13;stanford-crypto-sha256-iterative;65;65;67;70;68;67;65;65;66;66 04:59:42 INFO - PROCESS | 30351 | __end_tp_report 04:59:42 INFO - PROCESS | 30351 | __start_cc_report 04:59:42 INFO - PROCESS | 30351 | _x_x_mozilla_cycle_collect,742 04:59:42 INFO - PROCESS | 30351 | __end_cc_report 04:59:42 INFO - PROCESS | 30351 | __startTimestamp1456577982793__endTimestamp 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | ------- Summary: start ------- 04:59:42 INFO - PROCESS | 30351 | Number of tests: 14 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:4.24 (3.8%) stddev-sans-first:4.49 04:59:42 INFO - PROCESS | 30351 | Values: 112.0 105.0 111.0 110.0 113.0 122.0 113.0 110.0 111.0 111.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:159.00 stddev:16.99 (10.7%) stddev-sans-first:17.88 04:59:42 INFO - PROCESS | 30351 | Values: 156.0 137.0 160.0 170.0 132.0 158.0 168.0 128.0 163.0 127.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 04:59:42 INFO - PROCESS | 30351 | Values: 162.0 163.0 161.0 162.0 161.0 162.0 163.0 161.0 163.0 166.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#3] audio-fft Cycles:10 Average:91.00 Median:74.00 stddev:33.83 (45.7%) stddev-sans-first:35.44 04:59:42 INFO - PROCESS | 30351 | Values: 76.0 72.0 72.0 162.0 74.0 84.0 73.0 74.0 147.0 76.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:95.00 stddev:20.71 (21.8%) stddev-sans-first:21.44 04:59:42 INFO - PROCESS | 30351 | Values: 95.0 94.0 142.0 94.0 95.0 95.0 134.0 96.0 96.0 137.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 04:59:42 INFO - PROCESS | 30351 | Values: 111.0 111.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 04:59:42 INFO - PROCESS | 30351 | Values: 147.0 147.0 146.0 147.0 145.0 147.0 146.0 149.0 146.0 149.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.00 stddev:2.10 (2.2%) stddev-sans-first:2.18 04:59:42 INFO - PROCESS | 30351 | Values: 96.0 97.0 102.0 96.0 97.0 100.0 96.0 96.0 96.0 96.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:3.84 (6.7%) stddev-sans-first:4.06 04:59:42 INFO - PROCESS | 30351 | Values: 56.0 54.0 60.0 55.0 63.0 55.0 59.0 62.0 53.0 52.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:59:42 INFO - PROCESS | 30351 | Values: 65.0 65.0 66.0 66.0 65.0 66.0 66.0 65.0 65.0 66.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.22 (2.7%) stddev-sans-first:2.15 04:59:42 INFO - PROCESS | 30351 | Values: 81.0 83.0 83.0 83.0 89.0 82.0 84.0 82.0 85.0 84.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:117.50 stddev:4.88 (4.1%) stddev-sans-first:5.16 04:59:42 INFO - PROCESS | 30351 | Values: 115.0 111.0 113.0 119.0 110.0 119.0 119.0 112.0 126.0 116.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:138.50 stddev:5.35 (3.9%) stddev-sans-first:4.83 04:59:42 INFO - PROCESS | 30351 | Values: 147.0 139.0 131.0 140.0 137.0 149.0 137.0 135.0 138.0 137.0 04:59:42 INFO - PROCESS | 30351 | 04:59:42 INFO - PROCESS | 30351 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.65 (2.5%) stddev-sans-first:1.67 04:59:42 INFO - PROCESS | 30351 | Values: 65.0 65.0 67.0 70.0 68.0 67.0 65.0 65.0 66.0 66.0 04:59:42 INFO - PROCESS | 30351 | -------- Summary: end -------- 04:59:42 INFO - PROCESS | 30351 | 04:59:43 INFO - TEST-INFO | 30351: exit 0 04:59:43 INFO - TEST-OK | kraken | took 58952ms 04:59:43 INFO - TEST-START | v8_7 04:59:43 INFO - operating with platform_type : linux_ 04:59:43 INFO - Initialising browser for v8_7 test... 04:59:43 INFO - TEST-INFO | started process 30642 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppzSpM9/profile http://localhost:38650/getInfo.html) 04:59:46 INFO - PROCESS | 30642 | 04:59:46 INFO - PROCESS | 30642 | (process:30723): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:59:47 INFO - PROCESS | 30642 | __metrics Screen width/height:1600/1200 04:59:47 INFO - PROCESS | 30642 | colorDepth:24 04:59:47 INFO - PROCESS | 30642 | Browser inner width/height: 1024/697 04:59:47 INFO - PROCESS | 30642 | __metrics 04:59:48 INFO - TEST-INFO | 30642: exit 0 04:59:48 INFO - Browser initialized. 04:59:48 INFO - Running cycle 1/1 for v8_7 test... 04:59:48 INFO - TEST-INFO | started process 30772 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppzSpM9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:49 INFO - PROCESS | 30772 | 04:59:49 INFO - PROCESS | 30772 | (process:30835): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:00 INFO - PROCESS | 30772 | RSS: Main: 141205504 05:00:00 INFO - PROCESS | 30772 | 05:00:22 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:38650/tests/v8_7/run.html (next: http://localhost:38650/tests/v8_7/run.html) 05:00:23 INFO - PROCESS | 30772 | RSS: Main: 144908288 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | __start_tp_report 05:00:23 INFO - PROCESS | 30772 | _x_x_mozilla_page_load 05:00:23 INFO - PROCESS | 30772 | _x_x_mozilla_page_load_details 05:00:23 INFO - PROCESS | 30772 | |i|pagename|runs| 05:00:23 INFO - PROCESS | 30772 | |0;Richards;166.77785190126752 05:00:23 INFO - PROCESS | 30772 | |1;DeltaBlue;170.79419299743807 05:00:23 INFO - PROCESS | 30772 | |2;Encrypt;280.0336040324839 05:00:23 INFO - PROCESS | 30772 | |3;Decrypt;5223.958333333333 05:00:23 INFO - PROCESS | 30772 | |4;RayTrace;925.0693802035153 05:00:23 INFO - PROCESS | 30772 | |5;Earley;570.4506560182544 05:00:23 INFO - PROCESS | 30772 | |6;Boyer;11303.370786516854 05:00:23 INFO - PROCESS | 30772 | |7;RegExp;38735.84905660377 05:00:23 INFO - PROCESS | 30772 | |8;Splay;528.8207297726071 05:00:23 INFO - PROCESS | 30772 | |9;NavierStokes;4822.115384615385 05:00:23 INFO - PROCESS | 30772 | __end_tp_report 05:00:23 INFO - PROCESS | 30772 | __startTimestamp1456578023074__endTimestamp 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | ------- Summary: start ------- 05:00:23 INFO - PROCESS | 30772 | Number of tests: 10 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 166.8 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#1] DeltaBlue Cycles:1 Average:170.79 Median:170.79 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 170.8 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 280.0 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 5224.0 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#4] RayTrace Cycles:1 Average:925.07 Median:925.07 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 925.1 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#5] Earley Cycles:1 Average:570.45 Median:570.45 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 570.5 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#6] Boyer Cycles:1 Average:11303.37 Median:11303.37 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 11303.4 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#7] RegExp Cycles:1 Average:38735.85 Median:38735.85 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 38735.8 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#8] Splay Cycles:1 Average:528.82 Median:528.82 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 528.8 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - PROCESS | 30772 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:00:23 INFO - PROCESS | 30772 | Values: 4822.1 05:00:23 INFO - PROCESS | 30772 | -------- Summary: end -------- 05:00:23 INFO - PROCESS | 30772 | 05:00:23 INFO - TEST-INFO | 30772: exit 0 05:00:23 INFO - TEST-OK | v8_7 | took 40317ms 05:00:23 INFO - SUITE-END | took 1207s 05:00:24 INFO - Completed test suite (00:20:07) 05:00:24 INFO - Working with test: dromaeo_css 05:00:24 INFO - Generating results file: dromaeo_css 05:00:24 INFO - Working with test: kraken 05:00:24 INFO - Generating results file: kraken 05:00:24 INFO - javascript benchmark 05:00:24 INFO - Working with test: v8_7 05:00:24 INFO - Generating results file: v8_7 05:00:24 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:00:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:00:24 INFO - process_Request line: dromaeo_css 7152.20 graph.html#tests=[[72,52,43]] 05:00:24 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:00:24 INFO - process_Request line: kraken 1504.20 graph.html#tests=[[232,52,43]] 05:00:24 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:00:24 INFO - process_Request line: v8_7 21928.30 graph.html#tests=[[230,52,43]] 05:00:24 INFO - RETURN: dromaeo_css: 7152.20 05:00:24 INFO - RETURN: kraken: 1504.20 05:00:24 INFO - RETURN: v8_7: 21928.30 05:00:24 INFO - javascript benchmark 05:00:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3312.6024877014756, 3323.7174840138573, 3341.3818443587925, 3363.8990830275093, 3375.426177549816, 5292.947070529293, 5313.070212712779, 5346.171343441763, 5351.892962140755, 5363.973180134104, 5302.072137375953, 5332.173513105475, 5353.5984801139875, 5389.1646794746775, 5392.379876314225, 4925.1627223372025, 4960.3926811261645, 5024.497550244982, 5042.3949126104735, 5099.464556221599, 4793.760311984387, 4920.212765957447, 4942.579880710144, 4948.901021979558, 5055.090083784918, 4978.87552811179, 5001.149804533238, 5029.547340739333, 5040.344755181821, 5057.367829021372, 5006.324146240284, 5012.674176178555, 5026.623003274751, 5039.77321020555, 5039.916417970117, 4805.135075686375, 4834.323194752737, 4838.709677419331, 4958.479359667219, 4997.550220480138, 5151.04705629456, 5169.844904652867, 5196.792128314863, 5213.348331458567, 5216.817411390583, 5810.82567522975, 5821.0, 5823.272090988627, 5837.86161698469, 5889.293284805851, 5708.5433165347085, 5753.741081651294, 5762.510186634141, 5841.883162336772, 5860.208871802337, 5439.428859969726, 5444.455554444524, 5449.972750136224, 5451.700156491392, 5464.23500709901, 5928.436798504135, 5929.881402371929, 5933.0, 5933.9406605934255, 5935.554833387513, 5531.6957567333375, 5626.43735626434, 5634.295713035871, 5634.830955071355, 5658.547316214693, 5765.625234359753, 5768.394318596571, 5771.105478650816, 5809.593328466966, 5828.475437210672, 5723.255976723, 5750.741216645261, 5777.133429985536, 5777.364489906107, 5799.217105690678, 5602.355729091207, 5652.095664693629, 5764.308283006066, 5783.913241301384, 5785.4214578541805, 4396.560343965578, 4408.647308215335, 4419.292913133883, 4424.358468022118, 4438.955610443919, 3976.980115099406, 3983.263096327131, 3988.680905527609, 4021.3766866135797, 4034.6973976951845, 5303.920441193385, 5358.946410535923, 5371.435999220103, 5402.135658294654, 5408.0, 5809.0, 5816.040353341736, 5828.446297601721, 5834.533237341003, 5853.619514731528, 5519.613627046068, 5535.916961245504, 5539.058360078796, 5539.750711218005, 5547.944520554743, 4868.2210846264425, 4949.925751113737, 4952.2324039773175, 4954.3311652926395, 5054.595632349477, 5918.467337939606, 6015.30823955242, 6017.969910150421, 6027.57806953509, 6044.516438684895, 5724.942750572441, 5750.856228594319, 5768.451997060272, 5780.3930587289415, 5782.739776710142, 5729.942700572941, 5840.503557197516, 5938.257717785277, 5943.940560594512, 5944.256967879015, 5661.179129026185, 5731.140328950691, 5739.081746920473, 5739.253896993531, 5741.5406767459335, 5688.431156884279, 5727.0550359190265, 5744.827655170351, 5763.02028655138, 5788.450097240755, 5466.644668096561, 5525.475079867406, 5608.355039170548, 5614.24207731951, 5614.943850561442, 5612.214289999321, 5638.633488823213, 5640.943590564042, 5686.2323586315315, 5688.914666279927, 5591.664500130005, 5607.102863541813, 5608.046632072639, 5608.4111168326735, 5612.017896868113, 5480.945190548044, 5545.195946587642, 5587.664740115606, 5699.344575373885, 5720.513756330759, 5535.114381698909, 5539.944600553943, 5562.72186390687, 5566.860828479321, 5568.805091821767], "unit": "score", "name": "dojo.html", "value": 5334.152821924586}, {"lowerIsBetter": false, "replicates": [544.686805087075, 555.6582701638494, 562.7017680629267, 574.6121368076547, 577.8988676981533, 36900.26199476012, 37738.0, 37838.43242351367, 37846.81076594617, 38109.0, 40461.39307910384, 40873.0, 40873.79563102188, 40897.79551102248, 41095.58904410955, 8549.786255343619, 8748.081451447602, 8761.51811650359, 8766.517841518715, 8772.429792063496, 8654.350923680719, 8774.078721734222, 8791.164839340252, 8794.736157915273, 8844.204021638052, 8792.120787921222, 8865.468071915706, 8886.111388861127, 8891.555422228863, 8928.37501374904, 8730.781730456758, 8789.64841406343, 8802.603882825224, 8809.207171354608, 8832.602532886036, 8580.141985801432, 8760.167784060568, 8763.167499087576, 8784.78038049054, 8792.648294068229, 39241.80379098115, 39668.40497392541, 39744.801275993435, 39773.60226397728, 39846.800765996275, 3505.6319086495805, 3548.2193917338145, 3602.5316708827945, 3650.653187947167, 4226.873193804191, 27626.861865690746, 27746.722532774817, 27947.28398578642, 28225.01212457554, 28431.573526397122, 4087.734297270668, 4148.211839750437, 4172.8122234499215, 4195.727277726938, 4269.274223382033, 284750.0, 284977.0, 285534.5723271391, 286930.0, 287240.0, 57020.0, 58185.709071454374, 64827.0, 65270.347296527376, 65587.67206164035, 65281.34718652753, 65712.34287657158, 65770.0, 65824.34175658182, 66009.33990660032, 15283.847161528465, 15469.07185568847, 15472.071675699493, 15515.0, 15620.531384058497, 11794.764104717857, 11911.761764764657, 11931.821022684666, 11936.224145430519, 11953.760924781456, 21433.571328573653, 21783.45541361447, 21901.342959710917, 21957.0, 22060.117595296007, 8227.71203007892, 8472.788180295542, 8525.616347264264, 8583.613737381833, 8594.785130371665, 1042.1818872185297, 1109.6837401340579, 1120.294214644785, 1164.3130552973787, 1175.488662431845, 28142.859285703442, 28245.43509129806, 28382.749326145637, 29060.27349316284, 29279.707202927697, 1112.9054030407344, 1139.4473680265064, 1155.3645494977898, 1167.6963989362657, 1243.4839541590138, 15376.15431151275, 15609.687806243812, 16796.908200966896, 17076.573085672957, 17170.742438863428, 411796.0, 496898.0, 504988.0, 506740.0, 779233.0, 53599.73200133974, 54327.0, 54331.45668543264, 54459.72770136124, 54820.72589637026, 1435.440178330431, 1446.4720377062506, 1447.261896432827, 1449.9710005799825, 1453.4404254362146, 30026.24934376658, 32588.348233035682, 32640.673593263764, 33128.0, 33132.66867331296, 49023.26465102955, 49641.751791240815, 49765.253521197934, 49839.75080124576, 49967.0, 303318.0, 304381.0, 304554.0, 305936.0, 307454.0, 33793.66206337905, 34545.654543455246, 34550.82724586462, 34699.30601388009, 34788.652113479555, 43683.344749828146, 44358.55641443673, 44616.33075503935, 45487.31769023401, 46147.76926115348, 38606.0, 39152.80423597864, 40398.0, 42032.0, 42894.0, 38308.23383532369, 38440.61559384482, 38537.229255414175, 38629.22741545209, 38714.6128538711, 38893.22213555656, 39235.41146882742, 39324.410133848585, 39513.407298889964, 39621.40567891426, 33878.491822622185, 34328.656713432545, 34779.0, 36267.63732362748, 36820.26359472742, 24065.879670601535, 24642.50714985726, 24695.0, 24862.0, 24962.126325578516], "unit": "score", "name": "ext.html", "value": 19590.756131455044}, {"lowerIsBetter": false, "replicates": [380.5490493764889, 380.82291734343534, 381.5897909747023, 382.53139903618063, 391.77081407376664, 15827.129507877062, 17556.209970551325, 17577.209025593846, 17661.558461038465, 18371.44885653429, 14318.0, 14480.203588802611, 14541.98206125569, 14687.192204428753, 16593.66812663746, 4995.100881841267, 5149.356330458692, 5161.27742116104, 5177.30106435632, 5198.792048318062, 5050.823221187259, 5062.468440813716, 5136.820211292606, 5148.588112950955, 5493.423190564993, 5208.76560554774, 5387.595930305223, 5533.446655334475, 5572.052751032314, 5582.665040097587, 5265.578753699733, 5278.076336641073, 5329.786808527673, 5332.440093790135, 5367.114426119686, 5321.095413779628, 5350.625456218067, 5360.865978350534, 5373.1402975524115, 5383.919241211346, 12691.492340306377, 18822.62354752911, 20176.899115504475, 20617.690734638993, 20661.5867682647, 2119.671450925109, 2138.9465263368384, 2171.337741988693, 2204.162418281043, 2313.306008197551, 10025.749356266078, 10075.093241608218, 10386.636467723669, 11750.842591436774, 13313.068085234037, 1822.6901426757483, 1839.7516335294831, 1870.9522667306217, 1917.424772568224, 1952.541152829084, 55902.72048639772, 56746.43253567494, 57097.14354284689, 57404.42595574074, 57915.71042144804, 10570.0, 10752.892471075345, 10798.460076996118, 10824.242303038869, 10845.83731244032, 14272.21502817355, 14302.427902883768, 14381.78427323591, 14394.784078238834, 14424.927875360556, 7473.1032276126125, 7506.812329691692, 7691.615419229016, 7695.576743279062, 7730.265624765639, 7045.225025247219, 7073.752418665425, 7091.290870912971, 7129.073220481408, 7178.318059784312, 4668.5564871337165, 4737.928931066037, 4755.334253204554, 4763.071201115818, 4786.210275304606, 1888.10315100329, 1920.4238728381429, 1930.44982180078, 1935.129191863667, 1955.2276850643916, 963.7446076789656, 1057.6721216422934, 1084.208527774713, 1110.4170310587006, 1126.3748619516084, 13487.865121348857, 15353.541413565694, 15522.767158492632, 17000.149992500326, 17006.914965425094, 984.8571957066185, 1009.5305682857506, 1015.2740790334798, 1058.1799105693149, 1158.4844744088969, 8855.203031727175, 9308.301877359225, 9397.859032114524, 9466.29002824791, 9502.619895204252, 395127.0, 395811.0, 396164.0, 397890.0, 448834.0, 46735.76632116818, 48941.510584893695, 71662.0, 73707.2629273711, 73785.6310718443, 1126.8591426071741, 1144.1647597253884, 1156.9305841649696, 1165.8367828504017, 1173.1142987044898, 15422.922885385502, 15659.37362505487, 15784.21078946025, 16032.278547465625, 16127.193640318172, 32909.0, 33349.499757503174, 33646.158846029044, 33694.3261134771, 34458.483122752674, 42594.148117036864, 42616.0, 43554.78222608867, 44342.77828610836, 44774.55225447834, 7432.3682486987045, 7700.114486834086, 7709.3447057000785, 7717.498362606412, 7804.453688241996, 9480.525973701426, 10754.193435492212, 10872.836907446237, 10976.176786741185, 10984.450777461256, 9708.563114659715, 10020.398776073167, 10290.742731431774, 10333.586656533655, 10422.374657520573, 9877.654282100379, 9995.800083998425, 10138.847917281098, 10155.0, 10407.583696652351, 10267.897321026992, 10405.167586593207, 10517.158627309644, 10679.839802402816, 10715.785684286426, 7668.80827979305, 7724.884126737991, 7763.961180194063, 7794.181610930771, 7957.960210198912, 9937.980723872635, 9970.700878973643, 10564.84152737725, 10914.563417463212, 10996.560137594406], "unit": "score", "name": "jquery.html", "value": 8300.550494536004}, {"lowerIsBetter": false, "replicates": [1514.575918742752, 1538.6845696632192, 1714.4856543037095, 1794.8653850961166, 1804.2873065139263, 7956.283934445899, 8052.91947080529, 8095.150009249032, 8227.13615070418, 8232.176782321772, 8152.796180095485, 8208.58957052148, 8235.464694794835, 8247.83504329913, 8254.174582541742, 2323.23333300011, 2328.8369814112934, 2332.1604222479896, 2342.2973108067595, 2353.8469999450067, 2341.9531609367887, 2366.8461549999283, 2413.8431001984904, 2414.0947144820693, 2414.4326083370484, 2266.150193677371, 2324.7094113235844, 2328.092044102801, 2334.6614740862565, 2349.518348738513, 2341.438054866837, 2351.106579499796, 2358.8702621355906, 2359.103540654549, 2366.9053237870467, 2322.082777302956, 2336.9649455258186, 2361.2325994052003, 2369.064219633235, 2369.9526009479714, 8062.677492900277, 8073.07159676633, 8082.232187942195, 8114.391420643476, 8124.1875812418875, 4665.5567721066445, 4786.95213047872, 4796.328514008042, 4842.709437433765, 4857.2714092886, 3070.6622271550114, 3096.6748491408302, 3121.2977080156784, 3125.5467957146316, 3145.308032232905, 1056.6935588679273, 1073.0717928991444, 1082.3992684060343, 1096.6874440784418, 1107.6566264458045, 10562.419066951315, 10604.098651614622, 10669.359838409642, 10700.090492308163, 10716.892831071746, 3976.8069579126145, 3994.360902255625, 4017.2367250222946, 4035.334169861999, 4051.7771522565954, 8974.19232269099, 8998.955005224932, 8999.595018224196, 9015.053419391, 9030.86453703195, 4579.7252164870215, 4584.908301834012, 4609.562091601292, 4623.329617205486, 4628.0281140960105, 4173.937390939138, 4204.936925946114, 4220.282551966173, 4233.534311225762, 4264.445622069111, 3418.418868792311, 3526.4181410067563, 3533.187366905575, 3536.504889315498, 3543.4153364694535, 1020.8928062553473, 1026.0406519903913, 1032.200044965158, 1049.2602715085998, 1052.1162223732101, 1122.6183097746805, 1127.2391135983178, 1171.701216189866, 1369.0621923982103, 1443.8050863133553, 7536.321731044232, 7563.054618172729, 7617.5048621840515, 7626.8093297668, 7648.464607477423, 1172.3434876469205, 1195.3403676819007, 1197.2696655040418, 1201.3752848518895, 1231.9199252048768, 5892.587518873637, 5896.410358964069, 5900.852478687982, 5902.937471255215, 6028.4272994065495, 9319.953400232955, 9942.701718948443, 9960.402375857471, 10067.093961543496, 10100.0, 9727.41635501858, 9782.804343913223, 9833.4099954003, 9844.753881153028, 9859.0, 7424.294692004251, 7500.587467689329, 7508.211637777955, 7519.398448124137, 7533.322001019935, 7561.546307221584, 7617.5048621839405, 7629.961850190713, 7745.380369570534, 7767.300942915164, 8595.226429621363, 8733.912660873564, 8749.956250218707, 8784.560771961504, 8832.470051796912, 8790.472571645465, 8942.552872356486, 9015.233705135137, 9041.77395565116, 9304.95347523258, 7203.71185152588, 7339.74310899116, 7388.482806203514, 7391.1869694334655, 7396.630168491446, 7734.265244801735, 7784.065912090586, 7866.567338796421, 7901.565413902291, 7919.208079192034, 6632.568883022781, 7547.50941188821, 7580.583067931096, 7581.0, 7722.266384693445, 6975.372216500539, 7183.604901730455, 7296.379807716404, 7412.369948554433, 7442.702291908263, 7488.513246638951, 7518.473706840688, 7532.510386824839, 7539.509931854412, 7572.3942084632, 6754.2570317266045, 6790.558613690095, 6840.144981877265, 6891.793246202622, 6907.551009184387, 6843.076184715, 6926.653667316513, 6929.0, 6930.410915072275, 7019.964900175466], "unit": "score", "name": "mootools.html", "value": 4632.702224832417}, {"lowerIsBetter": false, "replicates": [349.1968472513219, 355.32310947644737, 360.5313092979126, 361.39285999520797, 365.1127759544308, 6149.907751383733, 6277.089821975811, 6291.496680265579, 6293.5279854010905, 6388.073729309253, 6096.298925623554, 6214.098955651428, 6255.843603909893, 6256.280527739312, 6292.119103325526, 4851.878703032426, 4871.707697538159, 4881.1213981483315, 4884.926726099111, 4889.3888263967, 4808.735519546423, 4837.5646191842725, 4885.413750349963, 4888.266759985995, 4890.951090489085, 4724.669273150881, 4836.1778497655305, 4843.104025755229, 4858.441279252896, 4871.658983871131, 4758.953030333321, 4817.831375901862, 4837.0567739290855, 4839.830605928811, 4856.732879691634, 4251.0, 4279.978600107011, 4286.635635970946, 4300.09697963425, 4306.461692288464, 5930.644161350289, 5945.821625351246, 5957.314908785502, 5972.104184372335, 5995.340512543617, 5459.863503412446, 5629.4652008059165, 5633.295838020247, 5635.408282130399, 5662.065759149736, 6639.33606639337, 6670.93329066708, 6679.231888332855, 6694.49791265657, 6705.798826035227, 4696.849271928365, 4700.31845382421, 4707.199776038082, 4708.764561771932, 4726.243800991825, 6924.099867017256, 6951.826204344881, 6965.164180298397, 6967.47743919203, 7003.0, 4709.576138147583, 4722.858314250578, 4727.5745182933015, 4729.314249433813, 4759.667293157921, 4769.952300476951, 4821.590164835958, 4822.348982887265, 4830.9275360869615, 4832.323474713543, 5540.504063902724, 5565.41563135873, 5573.888522229614, 5576.10782274834, 5594.748236329375, 6535.640539770263, 6735.797926062226, 6775.728970841111, 6777.1189745332795, 6777.423918966844, 1665.6335606166867, 1685.3006002509067, 1696.4062578097567, 1699.269314194908, 1704.0883127526713, 1109.4341885638382, 1132.5696235430648, 1135.3017893995134, 1155.162507182303, 1164.976700466003, 6411.775587854496, 6437.806865794034, 6447.484201263981, 6448.1295025171, 6474.061261117112, 6802.285759995129, 6838.384545390939, 6844.041834143224, 6846.4522838172825, 6869.519133660596, 6284.308726040132, 6393.041043843367, 6397.904031439532, 6441.25925518562, 6447.1618689571, 3783.735138540276, 3785.905352366213, 3817.5991520889906, 3822.1591249924973, 3822.617738226211, 7248.891266631004, 7256.600886951268, 7262.927370726331, 7266.491345605863, 7288.96355518219, 7090.645467726593, 7133.750318738819, 7227.7831665050135, 7228.31331023552, 7229.710811567478, 7235.782926512213, 7246.058012458347, 7272.200057993617, 7273.89089163663, 7278.0, 7008.299170082951, 7024.683889224895, 7041.5422997505, 7051.012858199959, 7059.647017648994, 6688.264290928091, 6883.380495755406, 6909.654517274217, 6933.514653974174, 6977.79066628002, 7203.819904502429, 7243.529170603894, 7256.4194864411775, 7268.672909719181, 7270.200277969313, 4763.73799441034, 4770.642201834807, 4788.808447662054, 4791.329213910125, 4805.783739731651, 6702.798916032527, 6838.213605435439, 6865.450763938773, 6989.161300643956, 7006.509544331848, 6597.868042639217, 6715.127033485615, 6754.966225168842, 6784.3894049535775, 6809.557378770364, 6686.69909854048, 6772.627505487048, 6789.558678685869, 6796.626185559841, 6803.319668033157, 6490.0, 6642.90035649456, 6651.933480665325, 6655.2346480153465, 6672.633005184762, 6740.595564266159, 6763.492738044764, 6768.864622707617, 6794.524383293122, 6807.0, 6605.966970165311, 6634.668266586747, 6638.568493048129, 6662.267150613526, 6674.632895190811], "unit": "score", "name": "prototype.html", "value": 5078.013587649667}, {"lowerIsBetter": false, "replicates": [777.6073083093037, 788.4480863395621, 882.929365650748, 919.5953780336653, 933.3746389918756, 13752.724945501084, 13815.171089734624, 13862.514811981582, 13868.514601988945, 14024.439022439103, 13804.654883627914, 13874.722505549882, 13911.443542258323, 13913.0, 13926.442942282296, 734.7391675955039, 748.7791101625033, 872.3021582733819, 885.3536918049828, 892.6830975003877, 863.7408777366765, 871.4466313890694, 877.8376000439939, 879.6041781198486, 880.4761167105594, 905.814308066848, 921.262989608314, 928.4986107501941, 929.916307532322, 930.5905401623264, 912.110692075228, 913.3515204205022, 916.6333466613374, 917.0508523677995, 917.9954100229489, 682.0996284903929, 683.7948615415355, 683.7982795075415, 684.7397988764287, 686.2245662401455, 14390.568282951528, 14442.71114577713, 14461.421543138262, 14463.421463141462, 14495.62291582298, 13822.792658110136, 13930.51243206493, 14007.509737159253, 14025.579232623038, 14047.22740249286, 11403.600873969453, 11441.313521188755, 11580.073594112451, 11666.708332291675, 11942.522299108025, 3883.5533913600016, 3904.297226499229, 3909.139989202371, 3937.803109844525, 4007.8797636070963, 51229.48770512285, 52117.218241726405, 52122.47877521214, 52192.0, 52519.47480525184, 10024.0, 10067.5469603868, 10279.434631095211, 10324.793504130026, 10412.114970227616, 18584.721229181574, 18723.25106995732, 18743.34398296053, 18819.153138108817, 18875.150618222215, 7276.7089316426745, 7502.249775022454, 7535.472516923763, 7561.281678240558, 7812.335951444191, 4096.754194748325, 4129.112240868228, 4163.375493675972, 4197.160567886435, 4221.662267018631, 3118.9220269493444, 3136.8431578421446, 3137.654857965622, 3145.3394787094508, 3147.6380216274965, 542.3464725006357, 558.600600570594, 564.3679079431064, 596.1534620838333, 623.6538721009792, 622.6948795090464, 733.6478490324674, 737.2516895351223, 740.1894925057054, 750.8798592225218, 8834.249088827393, 9439.0, 9468.100530449596, 9510.33427660071, 9551.283653725859, 615.6460035479618, 726.1612837172968, 748.3713680508399, 761.3072104384983, 767.8963339949036, 4065.654419374386, 4474.149911516802, 4555.954440455619, 4568.543145685405, 4599.4710608280475, 54407.0, 57142.7142864283, 58267.12599311014, 58694.7065264671, 58757.0, 52132.0, 53396.46603533992, 53900.0, 54260.914781704145, 54506.0, 43192.56807431886, 43438.13123737508, 44166.0, 47705.0, 47864.0, 8728.519931403835, 9078.45529268246, 9081.97032238087, 9112.225460835904, 9412.717618471457, 34145.48781768226, 34505.482417763254, 35073.82463087668, 35218.295634087684, 35316.117097072776, 41217.0, 44989.77505112453, 45133.0, 45655.0, 45741.771291144665, 10205.438700871524, 10289.125424339016, 10416.479176041319, 10557.15542756593, 10641.680749577525, 11018.338899666045, 11133.387663678575, 11288.0, 11423.143264255381, 11554.537818487166, 10426.791464170827, 10507.0, 10564.207684423545, 10582.576696932036, 10812.459377031275, 10411.0, 10567.154627629925, 10647.0, 10653.0, 10804.135669146606, 10627.681169564925, 11062.502187401748, 12416.192947458747, 12589.370531473573, 12662.366881655696, 9750.268729845431, 9850.655227067018, 10033.347832390871, 10241.74395640115, 10407.531661075422, 10049.131740695882, 10264.948675256575, 10389.688309350731, 10627.946860265649, 10856.511456984297], "unit": "score", "name": "yui.html", "value": 6559.19973763687}], "name": "dromaeo_css", "value": 7152.204928565152}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 110.0, 113.0, 122.0, 113.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [156.0, 137.0, 160.0, 170.0, 132.0, 158.0, 168.0, 128.0, 163.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 162.0, 161.0, 162.0, 163.0, 161.0, 163.0, 166.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 72.0, 162.0, 74.0, 84.0, 73.0, 74.0, 147.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 142.0, 94.0, 95.0, 95.0, 134.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 149.0, 146.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 102.0, 96.0, 97.0, 100.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 60.0, 55.0, 63.0, 55.0, 59.0, 62.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 83.0, 89.0, 82.0, 84.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [115.0, 111.0, 113.0, 119.0, 110.0, 119.0, 119.0, 112.0, 126.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [147.0, 139.0, 131.0, 140.0, 137.0, 149.0, 137.0, 135.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 70.0, 68.0, 67.0, 65.0, 65.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1504.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [170.79419299743807], "unit": "score", "name": "DeltaBlue", "value": 387.1208899999999}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [925.0693802035153], "unit": "score", "name": "RayTrace", "value": 799.928109}, {"lowerIsBetter": false, "replicates": [570.4506560182544], "unit": "score", "name": "Earley", "value": 1168.3096389999998}, {"lowerIsBetter": false, "replicates": [11303.370786516854], "unit": "score", "name": "Boyer", "value": 58.96143836978135}, {"lowerIsBetter": false, "replicates": [38735.84905660377], "unit": "score", "name": "RegExp", "value": 23.517878714076947}, {"lowerIsBetter": false, "replicates": [528.8207297726071], "unit": "score", "name": "Splay", "value": 154.099481}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21928.301177382746}]} 05:00:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21928.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7152.20"}}} 05:00:24 INFO - Return code: 0 05:00:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:00:24 INFO - # TBPL SUCCESS # 05:00:24 INFO - Running post-action listener: _resource_record_post_action 05:00:24 INFO - Running post-run listener: _resource_record_post_run 05:00:25 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 278564864; Read time: 0; Write time: 182288 05:00:25 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 24768512; Read time: 0; Write time: 7536 05:00:25 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 0; Write bytes: 253796352; Read time: 0; Write time: 174752 05:00:25 INFO - Running post-run listener: _upload_blobber_files 05:00:25 INFO - Blob upload gear active. 05:00:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:00:25 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:00:25 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:00:25 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:00:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:00:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:00:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:00:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:26 INFO - (blobuploader) - INFO - Done attempting. 05:00:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:00:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:00:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:27 INFO - (blobuploader) - INFO - Done attempting. 05:00:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:00:27 INFO - Return code: 0 05:00:27 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:00:27 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:00:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/542a7813ed2a9ef996485d8f3ad4ffce86ba20895cd2092fadd3c7ba84a43d62b5f3d4bffe99c36ea2f85e7cec8c4f794bc21b77a9c741016b555cde352d027f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/751165eab1938824436edd2d4f40acb545bb357ea54f83446de5308e93094cafc54b205db46632155caa383ce82f5b2c4caf3b3d8505df0cd9f68af1b4ea4550"} 05:00:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:00:27 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:00:27 INFO - Contents: 05:00:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/542a7813ed2a9ef996485d8f3ad4ffce86ba20895cd2092fadd3c7ba84a43d62b5f3d4bffe99c36ea2f85e7cec8c4f794bc21b77a9c741016b555cde352d027f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/751165eab1938824436edd2d4f40acb545bb357ea54f83446de5308e93094cafc54b205db46632155caa383ce82f5b2c4caf3b3d8505df0cd9f68af1b4ea4550"} 05:00:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:00:27 INFO - Copying logs to upload dir... 05:00:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:00:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1294.546392 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-02-27 05:00:25.366191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:00:25.378147) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 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/542a7813ed2a9ef996485d8f3ad4ffce86ba20895cd2092fadd3c7ba84a43d62b5f3d4bffe99c36ea2f85e7cec8c4f794bc21b77a9c741016b555cde352d027f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/751165eab1938824436edd2d4f40acb545bb357ea54f83446de5308e93094cafc54b205db46632155caa383ce82f5b2c4caf3b3d8505df0cd9f68af1b4ea4550"} build_url:https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/REhFKxAHRdm7a1xsDirB-A/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/542a7813ed2a9ef996485d8f3ad4ffce86ba20895cd2092fadd3c7ba84a43d62b5f3d4bffe99c36ea2f85e7cec8c4f794bc21b77a9c741016b555cde352d027f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/751165eab1938824436edd2d4f40acb545bb357ea54f83446de5308e93094cafc54b205db46632155caa383ce82f5b2c4caf3b3d8505df0cd9f68af1b4ea4550"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:00:25.410043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:00:25.410365) ========= 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=3a3620fb28aea1604ab609ef000001d2-1456572389.115176-1408730829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:00:25.491915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:00:25.492183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:00:25.492434) ========= ========= Total master_lag: 0.40 =========