builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1451919145.84 results: success (0) buildid: 20160104043003 builduid: b0604e4538dd4b359ba0b545bf794cd8 revision: 0771c5eab32f0cee4f7d12bc382298a81e0eabb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.840241) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.840691) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.840974) ========= 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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005595 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.890980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.891287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.930734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.931082) ========= 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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003355 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.982961) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.983311) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.984044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:25.984332) ========= 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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 06:52:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-04 06:52:26 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225443 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:26.237223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:26.237560) ========= 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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004328 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:26.287342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:26.287718) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0771c5eab32f0cee4f7d12bc382298a81e0eabb2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0771c5eab32f0cee4f7d12bc382298a81e0eabb2 --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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 06:52:26,301 truncating revision to first 12 chars 2016-01-04 06:52:26,301 Setting DEBUG logging. 2016-01-04 06:52:26,301 attempt 1/10 2016-01-04 06:52:26,301 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0771c5eab32f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 06:52:26,950 unpacking tar archive at: mozilla-central-0771c5eab32f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.941771 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:27.244345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:27.244685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:27.254958) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:27.255524) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 06:52:27.256120) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-04 06:52:27.256405) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:52:27 INFO - MultiFileLogger online at 20160104 06:52:27 in /builds/slave/test-pgo 06:52:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:52:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:52:27 INFO - {'append_to_log': False, 06:52:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:52:27 INFO - 'blob_upload_branch': 'Firefox', 06:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:52:27 INFO - 'branch': 'Firefox', 06:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:27 INFO - 'config_files': ('talos/linux_config.py',), 06:52:27 INFO - 'default_actions': ('clobber', 06:52:27 INFO - 'read-buildbot-config', 06:52:27 INFO - 'download-and-extract', 06:52:27 INFO - 'populate-webroot', 06:52:27 INFO - 'create-virtualenv', 06:52:27 INFO - 'install', 06:52:27 INFO - 'run-tests'), 06:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:27 INFO - 'download_minidump_stackwalk': True, 06:52:27 INFO - 'download_symbols': 'ondemand', 06:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:27 INFO - 'installer_path': 'installer.exe', 06:52:27 INFO - 'log_level': 'info', 06:52:27 INFO - 'log_name': 'talos', 06:52:27 INFO - 'log_to_console': True, 06:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:52:27 INFO - 'opt_config_files': (), 06:52:27 INFO - 'pip_index': False, 06:52:27 INFO - 'sps_profile': False, 06:52:27 INFO - 'sps_profile_interval': 0, 06:52:27 INFO - 'suite': 'dromaeojs', 06:52:27 INFO - 'system_bits': '32', 06:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:27 INFO - 'title': 'talos-linux64-ix-034', 06:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:27 INFO - 'use_talos_json': True, 06:52:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:27 INFO - 'work_dir': 'build'} 06:52:27 INFO - ##### 06:52:27 INFO - ##### Running clobber step. 06:52:27 INFO - ##### 06:52:27 INFO - Running pre-action listener: _resource_record_pre_action 06:52:27 INFO - Running main action method: clobber 06:52:27 INFO - rmtree: /builds/slave/test-pgo/build 06:52:27 INFO - Running post-action listener: _resource_record_post_action 06:52:27 INFO - ##### 06:52:27 INFO - ##### Running read-buildbot-config step. 06:52:27 INFO - ##### 06:52:27 INFO - Running pre-action listener: _resource_record_pre_action 06:52:27 INFO - Running main action method: read_buildbot_config 06:52:27 INFO - Using buildbot properties: 06:52:27 INFO - { 06:52:27 INFO - "project": "", 06:52:27 INFO - "product": "firefox", 06:52:27 INFO - "script_repo_revision": "production", 06:52:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:52:27 INFO - "repository": "", 06:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:52:27 INFO - "buildid": "20160104043003", 06:52:27 INFO - "pgo_build": "True", 06:52:27 INFO - "basedir": "/builds/slave/test-pgo", 06:52:27 INFO - "buildnumber": 151, 06:52:27 INFO - "slavename": "talos-linux64-ix-034", 06:52:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:52:27 INFO - "platform": "ubuntu64_hw", 06:52:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:52:27 INFO - "branch": "mozilla-central", 06:52:27 INFO - "repo_path": "mozilla-central", 06:52:27 INFO - "revision": "0771c5eab32f0cee4f7d12bc382298a81e0eabb2", 06:52:27 INFO - "stage_platform": "linux64-pgo", 06:52:27 INFO - "builduid": "b0604e4538dd4b359ba0b545bf794cd8", 06:52:27 INFO - "slavebuilddir": "test" 06:52:27 INFO - } 06:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:52:27 INFO - Running post-action listener: _resource_record_post_action 06:52:27 INFO - ##### 06:52:27 INFO - ##### Running download-and-extract step. 06:52:27 INFO - ##### 06:52:27 INFO - Running pre-action listener: _resource_record_pre_action 06:52:27 INFO - Running main action method: download_and_extract 06:52:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:52:27 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')]} 06:52:27 INFO - https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/test_packages.json 06:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/test_packages.json 06:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:52:28 INFO - Downloaded 1302 bytes. 06:52:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:52:28 INFO - Using the following test package requirements: 06:52:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:52:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:28 INFO - u'jsshell-linux-x86_64.zip'], 06:52:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:52:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:52:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:52:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:52:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:52:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:28 INFO - https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:52:30 INFO - Downloaded 23197904 bytes. 06:52:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:52:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:52:31 INFO - Return code: 0 06:52:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:52:31 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')]} 06:52:31 INFO - https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:52:36 INFO - Downloaded 23197904 bytes. 06:52:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:52:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:52:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:52:38 INFO - Return code: 0 06:52: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')]} 06:52:38 INFO - https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:52:39 INFO - Downloaded 11132285 bytes. 06:52:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:52:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:52:39 INFO - Return code: 0 06:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:39 INFO - https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:52:40 INFO - Downloaded 54982889 bytes. 06:52:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:40 INFO - mkdir: /builds/slave/test-pgo/properties 06:52:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:52:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:52:40 INFO - Contents: 06:52:40 INFO - build_url:https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:52:40 INFO - Running post-action listener: _resource_record_post_action 06:52:40 INFO - Running post-action listener: set_extra_try_arguments 06:52:40 INFO - ##### 06:52:40 INFO - ##### Running populate-webroot step. 06:52:40 INFO - ##### 06:52:40 INFO - Running pre-action listener: _resource_record_pre_action 06:52:40 INFO - Running main action method: populate_webroot 06:52:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:52:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:52:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:52:40 INFO - '--tppagecycles', 06:52:40 INFO - '7'], 06:52:40 INFO - 'tests': ['tsvgm']}}, 06:52:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:52:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:52:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'tests': ['damp', 'tps']}, 06:52:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['damp', 'tps']}, 06:52:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:52:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:52:40 INFO - 'other': {'tests': ['a11yr', 06:52:40 INFO - 'ts_paint', 06:52:40 INFO - 'tpaint', 06:52:40 INFO - 'sessionrestore', 06:52:40 INFO - 'sessionrestore_no_auto_restore']}, 06:52:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['a11yr', 06:52:40 INFO - 'ts_paint', 06:52:40 INFO - 'tpaint', 06:52:40 INFO - 'sessionrestore', 06:52:40 INFO - 'sessionrestore_no_auto_restore']}, 06:52:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['a11yr', 06:52:40 INFO - 'ts_paint', 06:52:40 INFO - 'tpaint', 06:52:40 INFO - 'sessionrestore', 06:52:40 INFO - 'sessionrestore_no_auto_restore']}, 06:52:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['a11yr', 06:52:40 INFO - 'ts_paint', 06:52:40 INFO - 'tpaint', 06:52:40 INFO - 'sessionrestore', 06:52:40 INFO - 'sessionrestore_no_auto_restore']}, 06:52:40 INFO - 'other_l64': {'tests': ['a11yr', 06:52:40 INFO - 'ts_paint', 06:52:40 INFO - 'tpaint', 06:52:40 INFO - 'sessionrestore', 06:52:40 INFO - 'sessionrestore_no_auto_restore']}, 06:52:40 INFO - 'other_nol64': {'tests': ['a11yr', 06:52:40 INFO - 'ts_paint', 06:52:40 INFO - 'tpaint', 06:52:40 INFO - 'sessionrestore', 06:52:40 INFO - 'sessionrestore_no_auto_restore']}, 06:52:40 INFO - 'svgr': {'tests': ['tsvgx', 06:52:40 INFO - 'tsvgr_opacity', 06:52:40 INFO - 'tart', 06:52:40 INFO - 'tscrollx', 06:52:40 INFO - 'cart']}, 06:52:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['tsvgx', 06:52:40 INFO - 'tsvgr_opacity', 06:52:40 INFO - 'tart', 06:52:40 INFO - 'tscrollx', 06:52:40 INFO - 'cart']}, 06:52:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'tests': ['tp5o']}, 06:52:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'talos_options': ['--e10s'], 06:52:40 INFO - 'tests': ['tp5o']}, 06:52:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'talos_options': ['--xperf_path', 06:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:40 INFO - 'tests': ['tp5n']}, 06:52:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:40 INFO - 'talos_options': ['--e10s', 06:52:40 INFO - '--xperf_path', 06:52:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:40 INFO - 'tests': ['tp5n']}}, 06:52:40 INFO - 'talos.zip': {'path': '', 06:52:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:52:40 INFO - Running post-action listener: _resource_record_post_action 06:52:40 INFO - ##### 06:52:40 INFO - ##### Running create-virtualenv step. 06:52:40 INFO - ##### 06:52:40 INFO - Running pre-action listener: _resource_record_pre_action 06:52:40 INFO - Running main action method: create_virtualenv 06:52:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:52:40 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 06:52:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:52:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:52:41 INFO - Using real prefix '/usr' 06:52:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:52:42 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:44 INFO - Installing pip.................done. 06:52:44 INFO - Return code: 0 06:52:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:52:44 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')]} 06:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 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')]} 06:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:52:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:52:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:52:44 INFO - Using env: {'DISPLAY': ':0', 06:52:44 INFO - 'HOME': '/home/cltbld', 06:52:44 INFO - 'LANG': 'en_US.UTF-8', 06:52:44 INFO - 'LANGUAGE': 'en_US:en', 06:52:44 INFO - 'LOGNAME': 'cltbld', 06:52:44 INFO - 'MAIL': '/var/mail/cltbld', 06:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:44 INFO - 'MOZ_NO_REMOTE': '1', 06:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:44 INFO - 'NO_EM_RESTART': '1', 06:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:44 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:44 INFO - 'SHELL': '/bin/bash', 06:52:44 INFO - 'SHLVL': '1', 06:52:44 INFO - 'TERM': 'linux', 06:52:44 INFO - 'TMOUT': '86400', 06:52:44 INFO - 'USER': 'cltbld', 06:52:44 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:44 INFO - '_': '/tools/buildbot/bin/python'} 06:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:45 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 06:52:45 INFO - Cleaning up... 06:52:45 INFO - Return code: 0 06:52:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:52:45 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')]} 06:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:45 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')]} 06:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:52:45 INFO - Using env: {'DISPLAY': ':0', 06:52:45 INFO - 'HOME': '/home/cltbld', 06:52:45 INFO - 'LANG': 'en_US.UTF-8', 06:52:45 INFO - 'LANGUAGE': 'en_US:en', 06:52:45 INFO - 'LOGNAME': 'cltbld', 06:52:45 INFO - 'MAIL': '/var/mail/cltbld', 06:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:45 INFO - 'MOZ_NO_REMOTE': '1', 06:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:45 INFO - 'NO_EM_RESTART': '1', 06:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:45 INFO - 'SHELL': '/bin/bash', 06:52:45 INFO - 'SHLVL': '1', 06:52:45 INFO - 'TERM': 'linux', 06:52:45 INFO - 'TMOUT': '86400', 06:52:45 INFO - 'USER': 'cltbld', 06:52:45 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:45 INFO - '_': '/tools/buildbot/bin/python'} 06:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:45 INFO - Downloading/unpacking psutil>=0.7.1 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:52:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:52:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:47 INFO - Installing collected packages: psutil 06:52:47 INFO - Running setup.py install for psutil 06:52:47 INFO - building 'psutil._psutil_linux' extension 06:52:47 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 06:52:48 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 06:52:48 INFO - building 'psutil._psutil_posix' extension 06:52:48 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 06:52:48 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 06:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:48 INFO - Successfully installed psutil 06:52:48 INFO - Cleaning up... 06:52:49 INFO - Return code: 0 06:52:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:52:49 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')]} 06:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:49 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')]} 06:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:52:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:52:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:52:49 INFO - Using env: {'DISPLAY': ':0', 06:52:49 INFO - 'HOME': '/home/cltbld', 06:52:49 INFO - 'LANG': 'en_US.UTF-8', 06:52:49 INFO - 'LANGUAGE': 'en_US:en', 06:52:49 INFO - 'LOGNAME': 'cltbld', 06:52:49 INFO - 'MAIL': '/var/mail/cltbld', 06:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:49 INFO - 'MOZ_NO_REMOTE': '1', 06:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:49 INFO - 'NO_EM_RESTART': '1', 06:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:49 INFO - 'SHELL': '/bin/bash', 06:52:49 INFO - 'SHLVL': '1', 06:52:49 INFO - 'TERM': 'linux', 06:52:49 INFO - 'TMOUT': '86400', 06:52:49 INFO - 'USER': 'cltbld', 06:52:49 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:49 INFO - '_': '/tools/buildbot/bin/python'} 06:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:52:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:52:50 INFO - Installing collected packages: mozsystemmonitor 06:52:50 INFO - Running setup.py install for mozsystemmonitor 06:52:51 INFO - Successfully installed mozsystemmonitor 06:52:51 INFO - Cleaning up... 06:52:51 INFO - Return code: 0 06:52:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:52:51 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')]} 06:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:51 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')]} 06:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:52:51 INFO - Using env: {'DISPLAY': ':0', 06:52:51 INFO - 'HOME': '/home/cltbld', 06:52:51 INFO - 'LANG': 'en_US.UTF-8', 06:52:51 INFO - 'LANGUAGE': 'en_US:en', 06:52:51 INFO - 'LOGNAME': 'cltbld', 06:52:51 INFO - 'MAIL': '/var/mail/cltbld', 06:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:51 INFO - 'MOZ_NO_REMOTE': '1', 06:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:51 INFO - 'NO_EM_RESTART': '1', 06:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:51 INFO - 'SHELL': '/bin/bash', 06:52:51 INFO - 'SHLVL': '1', 06:52:51 INFO - 'TERM': 'linux', 06:52:51 INFO - 'TMOUT': '86400', 06:52:51 INFO - 'USER': 'cltbld', 06:52:51 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:51 INFO - '_': '/tools/buildbot/bin/python'} 06:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:52:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 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 06:52:53 INFO - Downloading docopt-0.6.1.tar.gz 06:52:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:53 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:53 INFO - Running setup.py install for blobuploader 06:52:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:52:53 INFO - Running setup.py install for requests 06:52:54 INFO - Running setup.py install for docopt 06:52:54 INFO - Successfully installed blobuploader requests docopt 06:52:54 INFO - Cleaning up... 06:52:54 INFO - Return code: 0 06:52:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:52:54 INFO - Using env: {'DISPLAY': ':0', 06:52:54 INFO - 'HOME': '/home/cltbld', 06:52:54 INFO - 'LANG': 'en_US.UTF-8', 06:52:54 INFO - 'LANGUAGE': 'en_US:en', 06:52:54 INFO - 'LOGNAME': 'cltbld', 06:52:54 INFO - 'MAIL': '/var/mail/cltbld', 06:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:54 INFO - 'MOZ_NO_REMOTE': '1', 06:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:54 INFO - 'NO_EM_RESTART': '1', 06:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:54 INFO - 'SHELL': '/bin/bash', 06:52:54 INFO - 'SHLVL': '1', 06:52:54 INFO - 'TERM': 'linux', 06:52:54 INFO - 'TMOUT': '86400', 06:52:54 INFO - 'USER': 'cltbld', 06:52:54 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:54 INFO - '_': '/tools/buildbot/bin/python'} 06:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:54 INFO - Running setup.py (path:/tmp/pip-5ruxzj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:54 INFO - Running setup.py (path:/tmp/pip-U3EiDO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:54 INFO - Running setup.py (path:/tmp/pip-7_Pw3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:54 INFO - Running setup.py (path:/tmp/pip-BTsWIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:54 INFO - Running setup.py (path:/tmp/pip-AmB21v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:54 INFO - Running setup.py (path:/tmp/pip-i9PmmN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:54 INFO - Running setup.py (path:/tmp/pip-1hI1PJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:55 INFO - Running setup.py (path:/tmp/pip-WCV8Sc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:55 INFO - Running setup.py (path:/tmp/pip-TKScEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:55 INFO - Running setup.py (path:/tmp/pip-HDfs24-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:55 INFO - Running setup.py (path:/tmp/pip-iHOIwI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:55 INFO - Running setup.py (path:/tmp/pip-j0yO6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:55 INFO - Running setup.py (path:/tmp/pip-2hwmQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:55 INFO - Running setup.py (path:/tmp/pip-FSCr77-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:55 INFO - Running setup.py (path:/tmp/pip-2hZsWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:55 INFO - Running setup.py (path:/tmp/pip-qyI8mN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:55 INFO - Running setup.py (path:/tmp/pip-xd190E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:55 INFO - Running setup.py install for manifestparser 06:52:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:52:55 INFO - Running setup.py install for mozcrash 06:52:55 INFO - Running setup.py install for mozdebug 06:52:56 INFO - Running setup.py install for mozdevice 06:52:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozfile 06:52:56 INFO - Running setup.py install for mozhttpd 06:52:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozinfo 06:52:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozInstall 06:52:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozleak 06:52:56 INFO - Running setup.py install for mozlog 06:52:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for moznetwork 06:52:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:52:56 INFO - Running setup.py install for mozprocess 06:52:56 INFO - Running setup.py install for mozprofile 06:52:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Running setup.py install for mozrunner 06:52:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Running setup.py install for mozscreenshot 06:52:57 INFO - Running setup.py install for moztest 06:52:57 INFO - Running setup.py install for mozversion 06:52:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:52:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:57 INFO - Cleaning up... 06:52:57 INFO - Return code: 0 06:52:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:52:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:52:57 INFO - Using env: {'DISPLAY': ':0', 06:52:57 INFO - 'HOME': '/home/cltbld', 06:52:57 INFO - 'LANG': 'en_US.UTF-8', 06:52:57 INFO - 'LANGUAGE': 'en_US:en', 06:52:57 INFO - 'LOGNAME': 'cltbld', 06:52:57 INFO - 'MAIL': '/var/mail/cltbld', 06:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:57 INFO - 'MOZ_NO_REMOTE': '1', 06:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:57 INFO - 'NO_EM_RESTART': '1', 06:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:57 INFO - 'SHELL': '/bin/bash', 06:52:57 INFO - 'SHLVL': '1', 06:52:57 INFO - 'TERM': 'linux', 06:52:57 INFO - 'TMOUT': '86400', 06:52:57 INFO - 'USER': 'cltbld', 06:52:57 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:57 INFO - '_': '/tools/buildbot/bin/python'} 06:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:57 INFO - Running setup.py (path:/tmp/pip-MA_sk3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:57 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)) 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:57 INFO - Running setup.py (path:/tmp/pip-QSjZI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:57 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)) 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:57 INFO - Running setup.py (path:/tmp/pip-YdC0tr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:57 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)) 06:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:57 INFO - Running setup.py (path:/tmp/pip-wqUUGu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:58 INFO - Running setup.py (path:/tmp/pip-gn6GYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:58 INFO - Running setup.py (path:/tmp/pip-i20xOR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:58 INFO - Running setup.py (path:/tmp/pip-_xVTAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:58 INFO - Running setup.py (path:/tmp/pip-b3wmYn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:58 INFO - Running setup.py (path:/tmp/pip-N_cz2v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:58 INFO - Running setup.py (path:/tmp/pip-rZHVbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:58 INFO - Running setup.py (path:/tmp/pip-vPm72o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:58 INFO - Running setup.py (path:/tmp/pip-9mtT3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:58 INFO - Running setup.py (path:/tmp/pip-2k_mJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:58 INFO - Running setup.py (path:/tmp/pip-SbFypD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:58 INFO - Running setup.py (path:/tmp/pip-6D_gS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:58 INFO - Running setup.py (path:/tmp/pip-Y9VNPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:58 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)) 06:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:58 INFO - Running setup.py (path:/tmp/pip-4B86E7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:58 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)) 06:52:58 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)) 06:52:58 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)) 06:52:58 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)) 06:52:58 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:58 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:58 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 06:52:58 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 06:52:58 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 06:52:58 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 06:52:58 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 06:52:58 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 06:53:00 INFO - Downloading blessings-1.5.1.tar.gz 06:53:00 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:53:00 INFO - Installing collected packages: blessings 06:53:00 INFO - Running setup.py install for blessings 06:53:00 INFO - Successfully installed blessings 06:53:00 INFO - Cleaning up... 06:53:00 INFO - Return code: 0 06:53:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:53:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:01 INFO - Reading from file tmpfile_stdout 06:53:01 INFO - Current package versions: 06:53:01 INFO - argparse == 1.2.1 06:53:01 INFO - blessings == 1.5.1 06:53:01 INFO - blobuploader == 1.2.4 06:53:01 INFO - docopt == 0.6.1 06:53:01 INFO - manifestparser == 1.1 06:53:01 INFO - mozInstall == 1.12 06:53:01 INFO - mozcrash == 0.16 06:53:01 INFO - mozdebug == 0.1 06:53:01 INFO - mozdevice == 0.47 06:53:01 INFO - mozfile == 1.2 06:53:01 INFO - mozhttpd == 0.7 06:53:01 INFO - mozinfo == 0.9 06:53:01 INFO - mozleak == 0.1 06:53:01 INFO - mozlog == 3.1 06:53:01 INFO - moznetwork == 0.27 06:53:01 INFO - mozprocess == 0.22 06:53:01 INFO - mozprofile == 0.28 06:53:01 INFO - mozrunner == 6.11 06:53:01 INFO - mozscreenshot == 0.1 06:53:01 INFO - mozsystemmonitor == 0.0 06:53:01 INFO - moztest == 0.7 06:53:01 INFO - mozversion == 1.4 06:53:01 INFO - psutil == 3.1.1 06:53:01 INFO - requests == 1.2.3 06:53:01 INFO - wsgiref == 0.1.2 06:53:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53: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')]} 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:53:01 INFO - Using env: {'DISPLAY': ':0', 06:53:01 INFO - 'HOME': '/home/cltbld', 06:53:01 INFO - 'LANG': 'en_US.UTF-8', 06:53:01 INFO - 'LANGUAGE': 'en_US:en', 06:53:01 INFO - 'LOGNAME': 'cltbld', 06:53:01 INFO - 'MAIL': '/var/mail/cltbld', 06:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:01 INFO - 'MOZ_NO_REMOTE': '1', 06:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:01 INFO - 'NO_EM_RESTART': '1', 06:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:01 INFO - 'SHELL': '/bin/bash', 06:53:01 INFO - 'SHLVL': '1', 06:53:01 INFO - 'TERM': 'linux', 06:53:01 INFO - 'TMOUT': '86400', 06:53:01 INFO - 'USER': 'cltbld', 06:53:01 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:01 INFO - '_': '/tools/buildbot/bin/python'} 06:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 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)) 06:53:01 INFO - Cleaning up... 06:53:01 INFO - Return code: 0 06:53:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:53: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')]} 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:53:01 INFO - Using env: {'DISPLAY': ':0', 06:53:01 INFO - 'HOME': '/home/cltbld', 06:53:01 INFO - 'LANG': 'en_US.UTF-8', 06:53:01 INFO - 'LANGUAGE': 'en_US:en', 06:53:01 INFO - 'LOGNAME': 'cltbld', 06:53:01 INFO - 'MAIL': '/var/mail/cltbld', 06:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:01 INFO - 'MOZ_NO_REMOTE': '1', 06:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:01 INFO - 'NO_EM_RESTART': '1', 06:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:01 INFO - 'SHELL': '/bin/bash', 06:53:01 INFO - 'SHLVL': '1', 06:53:01 INFO - 'TERM': 'linux', 06:53:01 INFO - 'TMOUT': '86400', 06:53:01 INFO - 'USER': 'cltbld', 06:53:01 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:01 INFO - '_': '/tools/buildbot/bin/python'} 06:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:01 INFO - Downloading/unpacking jsonschema 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:53:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:53:03 INFO - Downloading/unpacking functools32 (from jsonschema) 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:53:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:53:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:53:03 INFO - warning: no files found matching '*.txt' 06:53:03 INFO - no previously-included directories found matching 'build' 06:53:03 INFO - no previously-included directories found matching 'dist' 06:53:03 INFO - no previously-included directories found matching '.git*' 06:53:03 INFO - Installing collected packages: jsonschema, functools32 06:53:03 INFO - Running setup.py install for functools32 06:53:03 INFO - warning: no files found matching '*.txt' 06:53:03 INFO - no previously-included directories found matching 'build' 06:53:03 INFO - no previously-included directories found matching 'dist' 06:53:03 INFO - no previously-included directories found matching '.git*' 06:53:03 INFO - Successfully installed jsonschema functools32 06:53:03 INFO - Cleaning up... 06:53:03 INFO - Return code: 0 06:53:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:53:03 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')]} 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:03 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')]} 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2538dd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, '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': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', '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 06:53:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:53:03 INFO - Using env: {'DISPLAY': ':0', 06:53:03 INFO - 'HOME': '/home/cltbld', 06:53:03 INFO - 'LANG': 'en_US.UTF-8', 06:53:03 INFO - 'LANGUAGE': 'en_US:en', 06:53:03 INFO - 'LOGNAME': 'cltbld', 06:53:03 INFO - 'MAIL': '/var/mail/cltbld', 06:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:03 INFO - 'MOZ_NO_REMOTE': '1', 06:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:03 INFO - 'NO_EM_RESTART': '1', 06:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:03 INFO - 'SHELL': '/bin/bash', 06:53:03 INFO - 'SHLVL': '1', 06:53:03 INFO - 'TERM': 'linux', 06:53:03 INFO - 'TMOUT': '86400', 06:53:03 INFO - 'USER': 'cltbld', 06:53:03 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:03 INFO - '_': '/tools/buildbot/bin/python'} 06:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:03 INFO - Downloading/unpacking flake8 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:53:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:53:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:05 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 06:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:53:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:53:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:06 INFO - no previously-included directories found matching 'docs/_build' 06:53:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:53:06 INFO - Running setup.py install for pep8 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:53:06 INFO - no previously-included directories found matching 'docs/_build' 06:53:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:53:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:53:06 INFO - Cleaning up... 06:53:06 INFO - Return code: 0 06:53:06 INFO - Running post-action listener: _resource_record_post_action 06:53:06 INFO - Running post-action listener: _start_resource_monitoring 06:53:06 INFO - Starting resource monitoring. 06:53:06 INFO - ##### 06:53:06 INFO - ##### Running install step. 06:53:06 INFO - ##### 06:53:06 INFO - Running pre-action listener: _resource_record_pre_action 06:53:06 INFO - Running main action method: install 06:53:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:06 INFO - Reading from file tmpfile_stdout 06:53:06 INFO - Detecting whether we're running mozinstall >=1.0... 06:53:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:53:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:53:06 INFO - Reading from file tmpfile_stdout 06:53:06 INFO - Output received: 06:53:06 INFO - Usage: mozinstall [options] installer 06:53:06 INFO - Options: 06:53:06 INFO - -h, --help show this help message and exit 06:53:06 INFO - -d DEST, --destination=DEST 06:53:06 INFO - Directory to install application into. [default: 06:53:06 INFO - "/builds/slave/test-pgo"] 06:53:06 INFO - --app=APP Application being installed. [default: firefox] 06:53:06 INFO - mkdir: /builds/slave/test-pgo/build/application 06:53:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:53:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:53:22 INFO - Reading from file tmpfile_stdout 06:53:22 INFO - Output received: 06:53:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:53:22 INFO - Running post-action listener: _resource_record_post_action 06:53:22 INFO - ##### 06:53:22 INFO - ##### Running run-tests step. 06:53:22 INFO - ##### 06:53:22 INFO - Running pre-action listener: _resource_record_pre_action 06:53:22 INFO - Running main action method: run_tests 06:53:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:53:22 INFO - Python 2.7.3 06:53:22 INFO - Return code: 0 06:53:22 INFO - grabbing minidump binary from tooltool 06:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:22 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 0x2c3e840>, '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 0x2bab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2babb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:53:22 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 06:53:22 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 06:53:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:22 INFO - Return code: 0 06:53:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:53:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:53:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:53:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:53:23 INFO - Return code: 0 06:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:53:23 INFO - Using env: {'DISPLAY': ':0', 06:53:23 INFO - 'HOME': '/home/cltbld', 06:53:23 INFO - 'LANG': 'en_US.UTF-8', 06:53:23 INFO - 'LANGUAGE': 'en_US:en', 06:53:23 INFO - 'LOGNAME': 'cltbld', 06:53:23 INFO - 'MAIL': '/var/mail/cltbld', 06:53:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:23 INFO - 'MOZ_NO_REMOTE': '1', 06:53:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:23 INFO - 'NO_EM_RESTART': '1', 06:53:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:53:23 INFO - 'SHELL': '/bin/bash', 06:53:23 INFO - 'SHLVL': '1', 06:53:23 INFO - 'TERM': 'linux', 06:53:23 INFO - 'TMOUT': '86400', 06:53:23 INFO - 'USER': 'cltbld', 06:53:23 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020', 06:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:23 INFO - '_': '/tools/buildbot/bin/python'} 06:53:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:53:23 INFO - mozversion application_buildid: 20160104043003 06:53:23 INFO - mozversion application_changeset: 0771c5eab32f0cee4f7d12bc382298a81e0eabb2 06:53:23 INFO - mozversion application_display_name: Nightly 06:53:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:23 INFO - mozversion application_name: Firefox 06:53:23 INFO - mozversion application_remotingname: firefox 06:53:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:53:23 INFO - mozversion application_vendor: Mozilla 06:53:23 INFO - mozversion application_version: 46.0a1 06:53:23 INFO - mozversion platform_buildid: 20160104043003 06:53:23 INFO - mozversion platform_changeset: 0771c5eab32f0cee4f7d12bc382298a81e0eabb2 06:53:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:53:23 INFO - mozversion platform_version: 46.0a1 06:53:23 INFO - using testdate: 1451919203 06:53:23 INFO - actual date: 1451919203 06:53:23 INFO - starting webserver on 'localhost:38499' 06:53:23 INFO - SUITE-START | Running 3 tests 06:53:23 INFO - TEST-START | dromaeo_css 06:53:23 INFO - operating with platform_type : linux_ 06:53:23 INFO - Initialising browser for dromaeo_css test... 06:53:24 INFO - TEST-INFO | started process 4367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt08PGF/profile http://localhost:38499/getInfo.html) 06:53:30 INFO - PROCESS | 4367 | __metrics Screen width/height:1600/1200 06:53:30 INFO - PROCESS | 4367 | colorDepth:24 06:53:30 INFO - PROCESS | 4367 | Browser inner width/height: 1024/697 06:53:30 INFO - PROCESS | 4367 | __metrics 06:53:31 INFO - PROCESS | 4367 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:53:32 INFO - PROCESS | 4367 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:53:33 INFO - TEST-INFO | 4367: exit 0 06:53:33 INFO - Browser initialized. 06:53:33 INFO - Running cycle 1/1 for dromaeo_css test... 06:53:33 INFO - TEST-INFO | started process 4467 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt08PGF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:44 INFO - PROCESS | 4467 | RSS: Main: 150880256 06:53:44 INFO - PROCESS | 4467 | 06:54:36 INFO - PROCESS | 4467 | 1451919276635 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] 06:56:44 INFO - PROCESS | 4467 | Cycle 1(1): loaded http://localhost:38499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38499/tests/dromaeo/cssquery-ext.html) 06:56:46 INFO - PROCESS | 4467 | RSS: Main: 237907968 06:56:46 INFO - PROCESS | 4467 | 06:59:48 INFO - PROCESS | 4467 | Cycle 1(1): loaded http://localhost:38499/tests/dromaeo/cssquery-ext.html (next: http://localhost:38499/tests/dromaeo/cssquery-jquery.html) 06:59:49 INFO - PROCESS | 4467 | RSS: Main: 239865856 06:59:49 INFO - PROCESS | 4467 | 07:02:51 INFO - PROCESS | 4467 | Cycle 1(1): loaded http://localhost:38499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38499/tests/dromaeo/cssquery-mootools.html) 07:02:51 INFO - PROCESS | 4467 | RSS: Main: 230359040 07:02:51 INFO - PROCESS | 4467 | 07:05:53 INFO - PROCESS | 4467 | Cycle 1(1): loaded http://localhost:38499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38499/tests/dromaeo/cssquery-prototype.html) 07:05:54 INFO - PROCESS | 4467 | RSS: Main: 217387008 07:05:54 INFO - PROCESS | 4467 | 07:08:56 INFO - PROCESS | 4467 | Cycle 1(1): loaded http://localhost:38499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38499/tests/dromaeo/cssquery-yui.html) 07:08:57 INFO - PROCESS | 4467 | RSS: Main: 219578368 07:08:57 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | Cycle 1(1): loaded http://localhost:38499/tests/dromaeo/cssquery-yui.html (next: http://localhost:38499/tests/dromaeo/cssquery-dojo.html) 07:12:00 INFO - PROCESS | 4467 | RSS: Main: 263630848 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | __start_tp_report 07:12:00 INFO - PROCESS | 4467 | _x_x_mozilla_page_load 07:12:00 INFO - PROCESS | 4467 | _x_x_mozilla_page_load_details 07:12:00 INFO - PROCESS | 4467 | |i|pagename|runs| 07:12:00 INFO - PROCESS | 4467 | |0;dojo.html;3114.9844250778747;3142.135912624027;3189.856456459459;3195.616526016877;3199.360127974405;5142.922856157161;5261.736913154346;5277.841664750059;5291.947080529194;5345.732713364336;5253.50091741284;5275.525202731754;5286.894262114765;5390.51485366317;5407.783688652449;4804.663673542854;4811.085893680199;4827.251775974712;4829.251466022772;4891.951080489203;4918.188498897677;4922.532359425849;4955.281484184791;4959.851204463854;4988.376452943382;4752.263399173099;4787.904241915177;4875.488073752258;4889.657723959324;4892.559669629751;4854.587360074398;4857.635677324215;4861;4871.512848715136;4907.2639104134305;4804.7837847296605;4808.663393562452;4808.735519546459;4811.109944660249;4858.78135483904;5073.822416215415;5095.414027386861;5184.844454666366;5188.688678679291;5212.4266330703595;5741.598088133832;5748.310202775652;5754.108113242454;5756.683382413966;5757.510611598019;5769.913451298234;5773.018586840247;5776.36459989405;5784.566157538202;5793.971030144864;5270.7628156733035;5331.173668081454;5391.649542779707;5395.298611180521;5456.836294911159;5820.88358232833;5833.38749431312;5835.299764028259;5838.67887266196;5882.176495290662;5594.804181853616;5604.271444712162;5605.04714198579;5608.719564021782;5612.747426365823;5567.749451274703;5602.075657516464;5681.943180568224;5688.971555142198;5806.593538452268;5564.304461942257;5609.074502707008;5612.130119831351;5616.747246373923;5637.323521177403;5637.210790489335;5639.971800141055;5641.492265696107;5642.4357564244065;5653.604247702621;4306.849260275875;4348.7390756554705;4395.912081758411;4432.268675668543;4474.888127796766;3918.1967696622123;3923.6272554107886;3926.155876486569;3954.307996100671;3959.5248570171766;5271.1039123348355;5332.786688532416;5336.119540275811;5345.973270133624;5352.5450336721815;5701.629394089454;5709.800156994485;5730.484256416942;5788.016037273674;5833.4749872511675;5315.229291752751;5342.198670199424;5344.786208551692;5345.572354211654;5352.866178345573;4774.785134668949;4873.829415970424;4883.169861123546;4886.657933944661;4934.777934992934;5897.085951677497;5921.289445266596;5946.643201407929;5999.820005399845;6010.398960104042;5767.5674324425;5777.537796976148;5779.335376431764;5784.971075144597;5792.275965504312;5851.765929362949;5966.105084237399;6008.669523176267;6013.639181649115;6017.608855424383;5638.915416268841;5684.914726279027;5687.203791469115;5690.032694441872;5693.601447898607;5735.655860648374;5778.364379918122;5780.855478613068;5785.450382213683;5786.971065144648;5566.805161819317;5644.774209031592;5648.548116150616;5650.463205995424;5727.284089488814;5655.179998900218;5657.4059723728415;5667.40492248308;5671.177679236405;5679.091345384719;5539.058360078716;5543.1408131739645;5559.499645031967;5564;5564.415736347787;5522.834314970557;5633.239512665901;5684.118961560965;5688.715564221855;5717.656940583578;5489.64317319373;5493.862653433696;5495.038368285614;5498.092814685692;5549.805756798492 07:12:00 INFO - PROCESS | 4467 | |1;ext.html;536.3724442402389;540.9107497262952;559.222680474141;566.9914951275734;573.6787399056526;27703.722962770367;28299.86800527979;35002.824985875064;35649.28701425977;35670;38430.61569384305;38786;38792.41811372824;38832.61167388325;38886.611133888655;7344.853102937938;8455.915440845574;8638.697645582406;8647.351448641377;8655.523946182957;6791.3548212919695;6896.137982752156;10174.64388746394;10350.844737328945;10353.17174626032;10085;10229.846552301722;10233.130183934374;10239.539220735047;10240;10132.54403551842;10159.390436573829;10175.440350780704;10194.133498652624;10244.129249013842;9778.266630002707;9988.101070903653;10002.299839011272;10024.849627255597;10055.245856560787;38891.416628750594;39277.607223927684;39419;39453.21093578141;39496;3223.9355212895844;3311.1391038329966;3650.5984341722387;3656.9490510985097;3692.335379631665;30189.396212075637;30214.84892575545;30518;30529.389412211855;30741.692583074106;3840.3855383138844;3931.253061918226;3950.032242100675;4019.799010049515;4046.3728122141115;271457;272035;272580;273234;273849;50576.24135637969;58277.4172258272;58584.70707646434;58622.7068864653;58731;38225.426618600744;62516.37483625196;63902.36097639057;64020.35979640144;64039.35960640334;13816.447342106203;14083.577492675236;14116.153030818185;14116.364763585458;14116.929415352857;10405.739856503647;10587.735306617396;11534;11618;11798.5870494534;19008.809911900982;19022;19052.333168339042;19092.33176838804;19153;6785.728570857209;7014.159265497482;7020;7058.329458701415;7113.608751518613;890.550272112579;916.5417291354323;953.575658831827;999.3753903810118;1048.3814549415881;27548.311292217855;28695.282617934718;29186.124416267547;29955.25111872177;30858.382832343228;1022.3405903192399;1041.6250149946013;1047.1361127070197;1049.9895001050045;1077.7036315013434;12955.481780728665;13118.475260989453;13227.801582976263;13268.270245136417;13371.598852034454;253035;256022;256218;256348;256767;46121.53878461239;46323.30515042277;46405.67971601406;46451.30323045157;46472;1263.740933108729;1265.240855486719;1319.1886989501388;1355.4645914863574;1366.030118615774;23935;24701.876490617433;24719.50560988806;24917.12790052412;25029.74970250274;39471.802640986614;39520.2095958085;39700.40449393204;40557;40598.39102413525;308850;310018;310060;310840;311297;27030.32424189411;30489.08532744021;30904.536431953988;30982.535261971538;31076.68923310738;38004.809975949946;38972.80513597414;39537.209255815294;39980.400293996194;40143.39784903287;31771.84114079415;33225.50161747624;33791.15522111967;34140.829295853364;34377.484337735455;33105;33233.66766332403;33505.66494335025;33582;33588.832055839564;33354.166145846546;33526.66473335236;34231.144221394665;34929;34998.47502287417;28097.859510702314;30633.54049689301;31252.531212031383;31449;31449;23919.282421527383;23946.76053239445;23989.76010239945;24054.87972560196;24244.75755242425 07:12:00 INFO - PROCESS | 4467 | |2;jquery.html;364.6535790998552;366.7231240413488;367.7646306363926;369.84836217150973;370.4739270236264;12717.36413179342;12879.678008049803;16190.919045404771;16692.91653541732;17305.134743262835;15322;16114.11372374519;16498.34006639736;16502.33990640373;16604.418845340417;5255.369355677314;5387.811426600069;5393.838184854441;5396.676199428027;5397.028534863723;3524.1189702574356;3612.584552776438;5377.946220537803;5419.430959749228;5869.325027621835;5934.673592952386;5985.042393217086;6015.368386319439;6020.6688632125215;6023.066424704156;5725.742341594618;5942.049272116441;5947.4052594740615;5959.314678811948;5963.254593175853;5189.66267192635;5278.868028299285;5285;5295.602829787743;5297.920531192035;11725.237859539187;12099.818502722466;20142.39572812818;21098.683519747217;21117.68323475149;1719.785026871641;1931.430228082719;2240.260713964388;2244.5735310290993;2265.444965983328;9001.279897608176;9111.772205694844;9339.17886012228;9964.302498825085;12768.850803427737;1633.5099470159023;1668.991655041717;1680.7226807576735;1717.0384584632645;1768.7612172356696;55588.722056389866;59850.401495984916;61457;64091.679541601996;64279.678601607164;9919.950400247953;10028.849567256497;10114.898851011396;10484.10885074762;10488;13676.452941882413;13683.31583420825;13723.588292351245;13724;13773.793393099111;7540.773776786705;7611.65747541362;7634.274743899321;7646.9617651911385;7719.691212351556;7295.489315747953;7332.046833911664;7345.88981165283;7384.630768461556;7386.446016548781;4218.325067989168;4258.787060647017;4471.06107717383;4538.2738761797955;4579.473360563577;1707.7353010283425;1714.2114627271594;1803.305727295001;1817.7457554287498;1832.0931139086238;934.6261495401758;943.9528023598792;954.3462728031182;957.363353370015;988.7626969527405;14444.422223111169;15500;16281.267342969595;16348.264328105264;17069.231884565223;935.6163972771132;962.2206013129388;980.5930538826307;994.16986816008;1007.2495990487134;9280.582373793195;9684.176844968115;9726.756831079138;9798.461084640414;9880.407175569346;578605;580199.6622330578;596631;613787.3795679205;617813;71287.64356178186;78785;80010.19989800027;81399.59300203579;84383.57808211043;1052.8052310322614;1080.821664425361;1159.2986243322669;1187.4537712652277;1190.7142285851332;14538.200398978157;14746;15087;15107.848921510644;15260.23698815077;31738.36523269568;31984;35609.329300302066;35968.10079748027;36902.63097368992;44001.77999109984;44422;45168.32247516356;47492.52507474881;47857.282140767216;9411.011843756582;9602.90397096048;9683.757906052406;9712.077352651488;9718.173955213886;11973.700657483632;13880.51418200358;17530.386436474662;17727.468175954742;17904.731429028834;11373.715657108307;13822.032457727862;14072.507462238773;14122.576322710334;14125.364358603681;13380.197188168351;13524.864751352361;13619.591412257649;14250.572482825532;14720.411183552538;14320.57038288853;14504.129752214902;14771.556853294418;14827.33277002516;14856;8871.512066836385;9343.81312373735;9344.112309330603;9756.853647195156;9783.168430683472;12740.872591273968;13207.801882971571;13313.068085234328;13726.656833578842;13756.17462952226 07:12:00 INFO - PROCESS | 4467 | |3;mootools.html;1178.8526434195726;1468.2878803780166;1477.6527516033734;1646.5142782879057;1819.2541058166155;6844.965775171129;7364.263573642633;7483.438742094344;7487.401007919367;7491.026166598334;7261.092363454568;7492.7752167435065;7497.137829149649;7500.699972001114;7505.849883002336;1948.9415317540497;1977.4166620846813;2206.735191776989;2219.1123550579737;2260.9660855087186;2230.163688616769;2230.208276061999;2232.1294695068937;2233.20721143994;2233.8659680419146;2144.356692992104;2230.553889222154;2231.1856172497005;2234.709487766588;2242.1479837661745;2190.0582749417745;2203.162798136706;2221.389117992549;2250.2686626846175;2264.8754318512474;2231.497912969569;2252.9436764080865;2263.5020295534955;2298.6322188449935;2303.0557471436796;7604.391648668094;7609.429292803062;7666.4250181236075;7699.5380277182985;7710.614469276514;4501.122281155176;4548.044910568785;4578.519255478193;4607.95392046082;4611.746353950532;3034.9696503034907;3049.588305578741;3061.8928337508305;3080.1067690369764;3217.501287300472;977.1645243317004;979.4123525884484;984.6258421799741;1022.723864556573;1090.7709381029993;10485.056344928993;10520.473976301231;10525.736856578571;10552.630657927013;10561.313514621525;4163.83344666216;4201.831926722897;4229.6827737919775;4250.362445633118;4278.507971583245;9020.639174432948;9042.819143617222;9091.090890910857;9095.499747513817;9109.817803644022;4634.096351211549;4635.698679585884;4652.953470465252;4654.092451971833;4674.275487299474;4251.277282861921;4255.829766809355;4256.510501292391;4267.039916018933;4273.081287523135;3289.753268504872;3335.8999230023137;3537.7700449470703;3591.982040089783;3595.1910820065277;1116.5547451082105;1132.8980391764617;1140.6064907606863;1147.1359041557469;1170.0931777872047;1038.4859494550246;1040.453761775059;1098.4068602954476;1162.5291756838494;1281.8974482041415;7171.282871712787;7205.89191162133;7262.455315851333;7266.418686505067;7270.600116993616;1103.9613613523488;1104.7514309280348;1110.7278716714457;1113.9554417823197;1118.82658187981;5639.774409023676;5728.541716662657;5729.512991395694;5733.025385684444;5735.455131762559;9072.183503484717;9120.224780893566;9310.208632266198;9431.386959847589;9448.244140468745;9298.395604285699;9304.395214311047;9310.581023853943;9313.254939604816;9321.394109382869;6576.750417420675;6699.866002680016;6700.195976482756;6935.618540980194;6988.825279367955;7145.249748776304;7364.226756190523;7364.3003914628025;7367.594782287026;7392.630368481447;8156.83686326282;8403.201695838885;8411.873821892554;8541.103184165573;8543.273821725223;8459.703910363107;8487.702930397407;8612.440191387539;8639.784005399915;8652.524111173945;6485.459680948523;6525.64108974011;6591.242007169045;6594.604323740591;6603.7688680895935;6627.436667883091;6733.93266067333;7075.82310442243;7217.314355136254;7220.927790722026;6781.11845460087;6887.5178737487895;6898.931010690029;6945.930540694529;7000.264972177848;6659.4006539411685;6681.665916704243;6692;6807.0810440589885;6832;6595.439387651912;6621.437177839937;6624.403803657694;6626.204855417381;6629.602223866584;6081.665508397081;6105.145279660762;6189.659568723763;6296.338884417253;6304.747810087545;6388.680565971776;6401.583897046677;6420.775272865428;6424.10062591247;6425.8714825704155 07:12:00 INFO - PROCESS | 4467 | |4;prototype.html;318.84057971014494;322.97900636458644;328.02576348245714;328.7123766704134;330.9106541233867;5652.717364131798;5847.970760146193;5886.058230683092;5979;5982.162497250389;5648.068068768658;5703.287089113861;5840.06558950568;5856.941430585693;5873;4493.033997690496;4500.279955207167;4502.054568540594;4505.662075344346;4512.345709872066;4342.044750154961;4403.713758605696;4441.644668426534;4500.099980003996;4502.954970450302;4442.822287108528;4462.352958820969;4471.552844715535;4474.776261186944;4477.932831007537;4427.424434823484;4428.623566996793;4440.600345968846;4454.398656181439;4462.57605527476;3928.7249892507534;3935.9212815743526;3937.0551067743536;3943.842246310144;3965.1871366369824;5366.490183432567;5502.8349149525575;5504.862378440571;5505.421930697259;5552.77788888444;5316.946830531684;5317.255584218213;5317.707526086064;5319.414864364955;5321.175217841241;6214.316425193225;6215.440610345091;6215.782447614311;6218.533609979225;6229.3459186785185;4277.465316835395;4324.978375108104;4370.8033138508845;4427.512973572904;4458.5318541553;6404.103425520431;6410.551261411703;6443;6443.935560644427;6458.2895881453005;4446.3108218226225;4459.464864216315;4462.3752674625575;4462.799174037176;4467.5755803198645;4340.52254252032;4515.096980603892;4515.706479078849;4518.593326600621;4522.186006518858;5126.282320475137;5153.896922061538;5154.020736060212;5160.8967820643375;5162.174052151638;6218.098375735493;6222.657753823492;6226.844328891814;6228.906566401508;6234.563580549318;1615.063263307279;1653.6940665976833;1654.1563802460591;1655;1658.07147997122;1105.4638500327335;1117.932924024545;1132.9830052549219;1141.3608379307614;1141.657502749172;5923.674197919156;5925.762969481259;5928.881422371528;5930.970345148246;5933.258342707161;6363.3636636336;6366.236051673736;6369.076483909807;6372.044193371032;6376.107344971708;5928.407159284124;5928.525717942554;5928.584999050025;5933.821985340447;5939.198208241832;3373.0049635357627;3473.374792537317;3475.860965561349;3481.3559491494157;3482.407990641597;6705.094812200388;6706.061151438803;6721.899171512431;6752.628605426748;6760.3239676032;6600.108985287021;6606.306337834458;6611.735530578723;6613;6617.636030018395;6569.408753212234;6734.966325168343;6737.898931516129;6739.696713647898;6742.056112144303;6130.877382452415;6410.1025856381075;6410.519211059096;6410.551261411656;6416.550841441054;6179;6246.6876656167915;6308.810735677937;6310.6213627182515;6313.116163737172;6690.799276021728;6702.296258892941;6710.194776626836;6710.228323742832;6713.093732346071;4418.204723149864;4458.977705111453;4463.419755431773;4465.955340446684;4466.397036400174;6279.30927597973;6446.258680251831;6450.580712253689;6456.7740129095255;6466.482681385572;6282.2147231596055;6285;6289.811305660837;6290.21372328459;6297.149884765498;6220.813375598558;6264.436200741955;6271.122042914087;6272.780452684134;6276.089966954857;5957.076653118774;6162.630242185483;6163.167972323679;6169.753209871555;6170.876582468415;6302.527310451643;6308.589941653778;6310.716017779303;6310.873782524415;6311.147995020613;6118.012267863259;6167.475764560063;6168.383161683796;6176.073588961692;6203.658798766111 07:12:00 INFO - PROCESS | 4467 | |5;yui.html;810.8905297784797;831.7463173732009;846.5640195299422;861.1646702698382;873.8470767615668;12009.099317551176;12110.515579376814;12202.877971220274;12232.20490668107;12243.367675949668;12863.16389434686;12978.870211297908;12997.155184912997;12999.545015924445;13000.089993700445;798.932090772285;809.6963638635511;810.080558566026;811.1037303779327;811.7077851973314;681.6557638392604;682.3347236444476;814.4136221920209;817.1175130858659;823.0041649603957;854.9016863060765;856.7729551668813;866.9942866275122;867.1501928110456;867.6876324523166;849.6856163219618;853.8292341531657;854.6068808348167;854.6581367453007;863.1368631368631;506.589662373475;512.4465577176677;516.5325380530626;609.7713357490941;610.8259146143372;11942.820857687142;11966.162368634199;12097.455614497369;12099.334536600483;12107.697307567294;11459.656210313704;11890.762184756342;12147;12322.507099716;12341.753164936741;9867.60529578816;9961.701148965543;10185.388876667424;10244;10291.53688084038;3520.8767693130617;3570.839312230956;3594.3530164570366;3599.1182160370877;3706.629337066299;47254.2911856319;48704.75647621739;48824.023519529765;48931.26603100956;49104.75447622775;9704;9821.705348839547;9847.45838978863;9919.107280344659;9946.254030947708;16445.177741112897;16576.336946522006;16584.50246492607;16597.170141492876;16616.501504954627;6515.641639709766;6672.86654266912;6697.799066028027;6729.461643068543;6866;4053.4730485036757;4072.165206132736;4126.66986641074;4174.457320548309;4251.851185208565;3012.051203870774;3039.3921215756936;3052.4810782167083;3054.373853360056;3087.505999040143;543.3371287029818;546.1998172677047;547.0809040811396;552.4889477233623;577.1400613086471;581.2588949089944;624.8906441372833;632.6141053957083;656.5502630697891;659.8350412396804;8454.87317690235;9167.404118732262;9192.310576706774;9294.72115836526;9329.486878221764;484.45740770336744;525.1309083466869;563.2902542796106;591.6124938165508;635.4662083849588;3924.9018774530864;3982.721209515364;4063.9433747225935;4083.3466645336603;4092.6316631502714;56382;56726.86546269134;56931;57145.42854571484;57187;50726;51817.48182518202;51994.48005519896;52256.73871630617;52754;44938;45733.54266457293;46182.76908615435;46621;47005;7672.846543068996;7783.221677832172;7833.412494063082;7844.254795794391;7877.803054923673;34701;34836.82581587076;35453.113672158404;36353.81823090868;36621.816890915376;40723.59276407198;42084;42199.57800422079;44532;44600.33099503575;10463.94768026155;10516.316439431412;10914.053205634593;11083.445827708421;11110.666679999613;11742.941285293518;11846;11897.82153267719;11985.520579176735;12095.939520302341;10677.839832402366;10770.730731731455;11158.888411115784;11629.287763502558;11696.415179241174;10943.781124377309;11109.666709998713;11166.776664466503;11180.720481988015;11213.327200368005;9218.539073046186;10352.792944140925;10848.511816968097;11153.051990580567;11162.162837787037;8630.82738345217;8974.282057435259;8992.595333210153;9043.638254469748;9104.453732776055;8848.513331766815;8878.556072196494;9176.908230917605;9260.814783704423;9474.857877131986 07:12:00 INFO - PROCESS | 4467 | __end_tp_report 07:12:00 INFO - PROCESS | 4467 | __start_cc_report 07:12:00 INFO - PROCESS | 4467 | _x_x_mozilla_cycle_collect,1399 07:12:00 INFO - PROCESS | 4467 | __end_cc_report 07:12:00 INFO - PROCESS | 4467 | __startTimestamp1451920320480__endTimestamp 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | ------- Summary: start ------- 07:12:00 INFO - PROCESS | 4467 | Number of tests: 6 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | [#0] dojo.html Cycles:165 Average:5311.67 Median:5549.81 stddev:599.83 (10.8%) stddev-sans-first:576.39 07:12:00 INFO - PROCESS | 4467 | Values: 3115.0 3142.1 3189.9 3195.6 3199.4 5142.9 5261.7 5277.8 5291.9 5345.7 5253.5 5275.5 5286.9 5390.5 5407.8 4804.7 4811.1 4827.3 4829.3 4892.0 4918.2 4922.5 4955.3 4959.9 4988.4 4752.3 4787.9 4875.5 4889.7 4892.6 4854.6 4857.6 4861.0 4871.5 4907.3 4804.8 4808.7 4808.7 4811.1 4858.8 5073.8 5095.4 5184.8 5188.7 5212.4 5741.6 5748.3 5754.1 5756.7 5757.5 5769.9 5773.0 5776.4 5784.6 5794.0 5270.8 5331.2 5391.6 5395.3 5456.8 5820.9 5833.4 5835.3 5838.7 5882.2 5594.8 5604.3 5605.0 5608.7 5612.7 5567.7 5602.1 5681.9 5689.0 5806.6 5564.3 5609.1 5612.1 5616.7 5637.3 5637.2 5640.0 5641.5 5642.4 5653.6 4306.8 4348.7 4395.9 4432.3 4474.9 3918.2 3923.6 3926.2 3954.3 3959.5 5271.1 5332.8 5336.1 5346.0 5352.5 5701.6 5709.8 5730.5 5788.0 5833.5 5315.2 5342.2 5344.8 5345.6 5352.9 4774.8 4873.8 4883.2 4886.7 4934.8 5897.1 5921.3 5946.6 5999.8 6010.4 5767.6 5777.5 5779.3 5785.0 5792.3 5851.8 5966.1 6008.7 6013.6 6017.6 5638.9 5684.9 5687.2 5690.0 5693.6 5735.7 5778.4 5780.9 5785.5 5787.0 5566.8 5644.8 5648.5 5650.5 5727.3 5655.2 5657.4 5667.4 5671.2 5679.1 5539.1 5543.1 5559.5 5564.0 5564.4 5522.8 5633.2 5684.1 5688.7 5717.7 5489.6 5493.9 5495.0 5498.1 5549.8 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | [#1] ext.html Cycles:180 Average:43993.57 Median:171274.77 stddev:73247.29 (42.8%) stddev-sans-first:73380.10 07:12:00 INFO - PROCESS | 4467 | Values: 536.4 540.9 559.2 567.0 573.7 27703.7 28299.9 35002.8 35649.3 35670.0 38430.6 38786.0 38792.4 38832.6 38886.6 7344.9 8455.9 8638.7 8647.4 8655.5 6791.4 6896.1 10174.6 10350.8 10353.2 10085.0 10229.8 10233.1 10239.5 10240.0 10132.5 10159.4 10175.4 10194.1 10244.1 9778.3 9988.1 10002.3 10024.8 10055.2 38891.4 39277.6 39419.0 39453.2 39496.0 3223.9 3311.1 3650.6 3656.9 3692.3 30189.4 30214.8 30518.0 30529.4 30741.7 3840.4 3931.3 3950.0 4019.8 4046.4 271457.0 272035.0 272580.0 273234.0 273849.0 50576.2 58277.4 58584.7 58622.7 58731.0 38225.4 62516.4 63902.4 64020.4 64039.4 13816.4 14083.6 14116.2 14116.4 14116.9 10405.7 10587.7 11534.0 11618.0 11798.6 19008.8 19022.0 19052.3 19092.3 19153.0 6785.7 7014.2 7020.0 7058.3 7113.6 890.6 916.5 953.6 999.4 1048.4 27548.3 28695.3 29186.1 29955.3 30858.4 1022.3 1041.6 1047.1 1050.0 1077.7 12955.5 13118.5 13227.8 13268.3 13371.6 253035.0 256022.0 256218.0 256348.0 256767.0 46121.5 46323.3 46405.7 46451.3 46472.0 1263.7 1265.2 1319.2 1355.5 1366.0 23935.0 24701.9 24719.5 24917.1 25029.7 39471.8 39520.2 39700.4 40557.0 40598.4 308850.0 310018.0 310060.0 310840.0 311297.0 27030.3 30489.1 30904.5 30982.5 31076.7 38004.8 38972.8 39537.2 39980.4 40143.4 31771.8 33225.5 33791.2 34140.8 34377.5 33105.0 33233.7 33505.7 33582.0 33588.8 33354.2 33526.7 34231.1 34929.0 34998.5 28097.9 30633.5 31252.5 31449.0 31449.0 23919.3 23946.8 23989.8 24054.9 24244.8 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | [#2] jquery.html Cycles:180 Average:30191.87 Median:18636.24 stddev:97588.92 (523.7%) stddev-sans-first:97836.98 07:12:00 INFO - PROCESS | 4467 | Values: 364.7 366.7 367.8 369.8 370.5 12717.4 12879.7 16190.9 16692.9 17305.1 15322.0 16114.1 16498.3 16502.3 16604.4 5255.4 5387.8 5393.8 5396.7 5397.0 3524.1 3612.6 5377.9 5419.4 5869.3 5934.7 5985.0 6015.4 6020.7 6023.1 5725.7 5942.0 5947.4 5959.3 5963.3 5189.7 5278.9 5285.0 5295.6 5297.9 11725.2 12099.8 20142.4 21098.7 21117.7 1719.8 1931.4 2240.3 2244.6 2265.4 9001.3 9111.8 9339.2 9964.3 12768.9 1633.5 1669.0 1680.7 1717.0 1768.8 55588.7 59850.4 61457.0 64091.7 64279.7 9920.0 10028.8 10114.9 10484.1 10488.0 13676.5 13683.3 13723.6 13724.0 13773.8 7540.8 7611.7 7634.3 7647.0 7719.7 7295.5 7332.0 7345.9 7384.6 7386.4 4218.3 4258.8 4471.1 4538.3 4579.5 1707.7 1714.2 1803.3 1817.7 1832.1 934.6 944.0 954.3 957.4 988.8 14444.4 15500.0 16281.3 16348.3 17069.2 935.6 962.2 980.6 994.2 1007.2 9280.6 9684.2 9726.8 9798.5 9880.4 578605.0 580199.7 596631.0 613787.4 617813.0 71287.6 78785.0 80010.2 81399.6 84383.6 1052.8 1080.8 1159.3 1187.5 1190.7 14538.2 14746.0 15087.0 15107.8 15260.2 31738.4 31984.0 35609.3 35968.1 36902.6 44001.8 44422.0 45168.3 47492.5 47857.3 9411.0 9602.9 9683.8 9712.1 9718.2 11973.7 13880.5 17530.4 17727.5 17904.7 11373.7 13822.0 14072.5 14122.6 14125.4 13380.2 13524.9 13619.6 14250.6 14720.4 14320.6 14504.1 14771.6 14827.3 14856.0 8871.5 9343.8 9344.1 9756.9 9783.2 12740.9 13207.8 13313.1 13726.7 13756.2 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | [#3] mootools.html Cycles:180 Average:5341.79 Median:6300.54 stddev:2774.18 (44.0%) stddev-sans-first:2764.30 07:12:00 INFO - PROCESS | 4467 | Values: 1178.9 1468.3 1477.7 1646.5 1819.3 6845.0 7364.3 7483.4 7487.4 7491.0 7261.1 7492.8 7497.1 7500.7 7505.8 1948.9 1977.4 2206.7 2219.1 2261.0 2230.2 2230.2 2232.1 2233.2 2233.9 2144.4 2230.6 2231.2 2234.7 2242.1 2190.1 2203.2 2221.4 2250.3 2264.9 2231.5 2252.9 2263.5 2298.6 2303.1 7604.4 7609.4 7666.4 7699.5 7710.6 4501.1 4548.0 4578.5 4608.0 4611.7 3035.0 3049.6 3061.9 3080.1 3217.5 977.2 979.4 984.6 1022.7 1090.8 10485.1 10520.5 10525.7 10552.6 10561.3 4163.8 4201.8 4229.7 4250.4 4278.5 9020.6 9042.8 9091.1 9095.5 9109.8 4634.1 4635.7 4653.0 4654.1 4674.3 4251.3 4255.8 4256.5 4267.0 4273.1 3289.8 3335.9 3537.8 3592.0 3595.2 1116.6 1132.9 1140.6 1147.1 1170.1 1038.5 1040.5 1098.4 1162.5 1281.9 7171.3 7205.9 7262.5 7266.4 7270.6 1104.0 1104.8 1110.7 1114.0 1118.8 5639.8 5728.5 5729.5 5733.0 5735.5 9072.2 9120.2 9310.2 9431.4 9448.2 9298.4 9304.4 9310.6 9313.3 9321.4 6576.8 6699.9 6700.2 6935.6 6988.8 7145.2 7364.2 7364.3 7367.6 7392.6 8156.8 8403.2 8411.9 8541.1 8543.3 8459.7 8487.7 8612.4 8639.8 8652.5 6485.5 6525.6 6591.2 6594.6 6603.8 6627.4 6733.9 7075.8 7217.3 7220.9 6781.1 6887.5 6898.9 6945.9 7000.3 6659.4 6681.7 6692.0 6807.1 6832.0 6595.4 6621.4 6624.4 6626.2 6629.6 6081.7 6105.1 6189.7 6296.3 6304.7 6388.7 6401.6 6420.8 6424.1 6425.9 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | [#4] prototype.html Cycles:180 Average:5216.15 Median:5928.47 stddev:1560.89 (26.3%) stddev-sans-first:1521.37 07:12:00 INFO - PROCESS | 4467 | Values: 318.8 323.0 328.0 328.7 330.9 5652.7 5848.0 5886.1 5979.0 5982.2 5648.1 5703.3 5840.1 5856.9 5873.0 4493.0 4500.3 4502.1 4505.7 4512.3 4342.0 4403.7 4441.6 4500.1 4503.0 4442.8 4462.4 4471.6 4474.8 4477.9 4427.4 4428.6 4440.6 4454.4 4462.6 3928.7 3935.9 3937.1 3943.8 3965.2 5366.5 5502.8 5504.9 5505.4 5552.8 5316.9 5317.3 5317.7 5319.4 5321.2 6214.3 6215.4 6215.8 6218.5 6229.3 4277.5 4325.0 4370.8 4427.5 4458.5 6404.1 6410.6 6443.0 6443.9 6458.3 4446.3 4459.5 4462.4 4462.8 4467.6 4340.5 4515.1 4515.7 4518.6 4522.2 5126.3 5153.9 5154.0 5160.9 5162.2 6218.1 6222.7 6226.8 6228.9 6234.6 1615.1 1653.7 1654.2 1655.0 1658.1 1105.5 1117.9 1133.0 1141.4 1141.7 5923.7 5925.8 5928.9 5931.0 5933.3 6363.4 6366.2 6369.1 6372.0 6376.1 5928.4 5928.5 5928.6 5933.8 5939.2 3373.0 3473.4 3475.9 3481.4 3482.4 6705.1 6706.1 6721.9 6752.6 6760.3 6600.1 6606.3 6611.7 6613.0 6617.6 6569.4 6735.0 6737.9 6739.7 6742.1 6130.9 6410.1 6410.5 6410.6 6416.6 6179.0 6246.7 6308.8 6310.6 6313.1 6690.8 6702.3 6710.2 6710.2 6713.1 4418.2 4459.0 4463.4 4466.0 4466.4 6279.3 6446.3 6450.6 6456.8 6466.5 6282.2 6285.0 6289.8 6290.2 6297.1 6220.8 6264.4 6271.1 6272.8 6276.1 5957.1 6162.6 6163.2 6169.8 6170.9 6302.5 6308.6 6310.7 6310.9 6311.1 6118.0 6167.5 6168.4 6176.1 6203.7 07:12:00 INFO - PROCESS | 4467 | 07:12:00 INFO - PROCESS | 4467 | [#5] yui.html Cycles:180 Average:13502.33 Median:48877.64 stddev:15913.99 (32.6%) stddev-sans-first:15930.10 07:12:00 INFO - PROCESS | 4467 | Values: 810.9 831.7 846.6 861.2 873.8 12009.1 12110.5 12202.9 12232.2 12243.4 12863.2 12978.9 12997.2 12999.5 13000.1 798.9 809.7 810.1 811.1 811.7 681.7 682.3 814.4 817.1 823.0 854.9 856.8 867.0 867.2 867.7 849.7 853.8 854.6 854.7 863.1 506.6 512.4 516.5 609.8 610.8 11942.8 11966.2 12097.5 12099.3 12107.7 11459.7 11890.8 12147.0 12322.5 12341.8 9867.6 9961.7 10185.4 10244.0 10291.5 3520.9 3570.8 3594.4 3599.1 3706.6 47254.3 48704.8 48824.0 48931.3 49104.8 9704.0 9821.7 9847.5 9919.1 9946.3 16445.2 16576.3 16584.5 16597.2 16616.5 6515.6 6672.9 6697.8 6729.5 6866.0 4053.5 4072.2 4126.7 4174.5 4251.9 3012.1 3039.4 3052.5 3054.4 3087.5 543.3 546.2 547.1 552.5 577.1 581.3 624.9 632.6 656.6 659.8 8454.9 9167.4 9192.3 9294.7 9329.5 484.5 525.1 563.3 591.6 635.5 3924.9 3982.7 4063.9 4083.3 4092.6 56382.0 56726.9 56931.0 57145.4 57187.0 50726.0 51817.5 51994.5 52256.7 52754.0 44938.0 45733.5 46182.8 46621.0 47005.0 7672.8 7783.2 7833.4 7844.3 7877.8 34701.0 34836.8 35453.1 36353.8 36621.8 40723.6 42084.0 42199.6 44532.0 44600.3 10463.9 10516.3 10914.1 11083.4 11110.7 11742.9 11846.0 11897.8 11985.5 12095.9 10677.8 10770.7 11158.9 11629.3 11696.4 10943.8 11109.7 11166.8 11180.7 11213.3 9218.5 10352.8 10848.5 11153.1 11162.2 8630.8 8974.3 8992.6 9043.6 9104.5 8848.5 8878.6 9176.9 9260.8 9474.9 07:12:00 INFO - PROCESS | 4467 | -------- Summary: end -------- 07:12:00 INFO - PROCESS | 4467 | 07:12:01 INFO - TEST-INFO | 4467: exit 0 07:12:01 INFO - TEST-OK | dromaeo_css | took 1117276ms 07:12:01 INFO - TEST-START | kraken 07:12:01 INFO - operating with platform_type : linux_ 07:12:01 INFO - Initialising browser for kraken test... 07:12:01 INFO - TEST-INFO | started process 4653 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSQvskL/profile http://localhost:38499/getInfo.html) 07:12:05 INFO - PROCESS | 4653 | __metrics Screen width/height:1600/1200 07:12:05 INFO - PROCESS | 4653 | colorDepth:24 07:12:05 INFO - PROCESS | 4653 | Browser inner width/height: 1024/697 07:12:05 INFO - PROCESS | 4653 | __metrics 07:12:05 INFO - PROCESS | 4653 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:12:05 INFO - PROCESS | 4653 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:12:06 INFO - TEST-INFO | 4653: exit 0 07:12:06 INFO - Browser initialized. 07:12:06 INFO - Running cycle 1/1 for kraken test... 07:12:06 INFO - TEST-INFO | started process 4739 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSQvskL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:18 INFO - PROCESS | 4739 | RSS: Main: 150646784 07:12:18 INFO - PROCESS | 4739 | 07:12:20 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38499/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:21 INFO - PROCESS | 4739 | RSS: Main: 187801600 07:12:21 INFO - PROCESS | 4739 | 07:12:23 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38499/tests/kraken/driver.html?testName=audio-dft) 07:12:24 INFO - PROCESS | 4739 | RSS: Main: 176181248 07:12:24 INFO - PROCESS | 4739 | 07:12:27 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38499/tests/kraken/driver.html?testName=audio-fft) 07:12:28 INFO - PROCESS | 4739 | RSS: Main: 161644544 07:12:28 INFO - PROCESS | 4739 | 07:12:30 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38499/tests/kraken/driver.html?testName=audio-oscillator) 07:12:30 INFO - PROCESS | 4739 | RSS: Main: 163790848 07:12:30 INFO - PROCESS | 4739 | 07:12:32 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:33 INFO - PROCESS | 4739 | RSS: Main: 164601856 07:12:33 INFO - PROCESS | 4739 | 07:12:36 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38499/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:36 INFO - PROCESS | 4739 | RSS: Main: 165740544 07:12:36 INFO - PROCESS | 4739 | 07:12:40 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38499/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:40 INFO - PROCESS | 4739 | RSS: Main: 166633472 07:12:40 INFO - PROCESS | 4739 | 07:12:43 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38499/tests/kraken/driver.html?testName=json-parse-financial) 07:12:44 INFO - PROCESS | 4739 | RSS: Main: 166178816 07:12:44 INFO - PROCESS | 4739 | 07:12:45 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:46 INFO - PROCESS | 4739 | RSS: Main: 175812608 07:12:46 INFO - PROCESS | 4739 | 07:12:48 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:12:48 INFO - PROCESS | 4739 | RSS: Main: 174907392 07:12:48 INFO - PROCESS | 4739 | 07:12:50 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:51 INFO - PROCESS | 4739 | RSS: Main: 182042624 07:12:51 INFO - PROCESS | 4739 | 07:12:53 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:54 INFO - PROCESS | 4739 | RSS: Main: 190275584 07:12:54 INFO - PROCESS | 4739 | 07:12:56 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:57 INFO - PROCESS | 4739 | RSS: Main: 187899904 07:12:57 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | Cycle 1(1): loaded http://localhost:38499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38499/tests/kraken/driver.html?testName=ai-astar) 07:12:59 INFO - PROCESS | 4739 | RSS: Main: 245735424 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | __start_tp_report 07:12:59 INFO - PROCESS | 4739 | _x_x_mozilla_page_load 07:12:59 INFO - PROCESS | 4739 | _x_x_mozilla_page_load_details 07:12:59 INFO - PROCESS | 4739 | |i|pagename|runs| 07:12:59 INFO - PROCESS | 4739 | |0;ai-astar;109;111;106;110;110;110;98;109;109;121 07:12:59 INFO - PROCESS | 4739 | |1;audio-beat-detection;151;125;148;173;136;150;147;124;165;131 07:12:59 INFO - PROCESS | 4739 | |2;audio-dft;162;162;161;161;160;160;159;163;163;162 07:12:59 INFO - PROCESS | 4739 | |3;audio-fft;71;72;82;98;72;74;71;107;88;70 07:12:59 INFO - PROCESS | 4739 | |4;audio-oscillator;96;95;136;95;97;95;144;96;95;147 07:12:59 INFO - PROCESS | 4739 | |5;imaging-gaussian-blur;109;110;109;109;110;110;110;109;109;109 07:12:59 INFO - PROCESS | 4739 | |6;imaging-darkroom;147;145;146;145;145;145;147;146;145;146 07:12:59 INFO - PROCESS | 4739 | |7;imaging-desaturate;95;95;96;95;96;96;96;96;95;95 07:12:59 INFO - PROCESS | 4739 | |8;json-parse-financial;56;57;57;57;57;56;58;67;55;55 07:12:59 INFO - PROCESS | 4739 | |9;json-stringify-tinderbox;68;67;67;68;68;69;68;68;68;68 07:12:59 INFO - PROCESS | 4739 | |10;stanford-crypto-aes;85;85;86;94;87;88;87;85;93;87 07:12:59 INFO - PROCESS | 4739 | |11;stanford-crypto-ccm;118;121;118;127;117;126;127;124;133;118 07:12:59 INFO - PROCESS | 4739 | |12;stanford-crypto-pbkdf2;143;153;153;158;156;146;155;145;154;146 07:12:59 INFO - PROCESS | 4739 | |13;stanford-crypto-sha256-iterative;70;69;69;69;70;68;68;68;70;68 07:12:59 INFO - PROCESS | 4739 | __end_tp_report 07:12:59 INFO - PROCESS | 4739 | __start_cc_report 07:12:59 INFO - PROCESS | 4739 | _x_x_mozilla_cycle_collect,930 07:12:59 INFO - PROCESS | 4739 | __end_cc_report 07:12:59 INFO - PROCESS | 4739 | __startTimestamp1451920379457__endTimestamp 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | ------- Summary: start ------- 07:12:59 INFO - PROCESS | 4739 | Number of tests: 14 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:5.58 (5.1%) stddev-sans-first:5.92 07:12:59 INFO - PROCESS | 4739 | Values: 109.0 111.0 106.0 110.0 110.0 110.0 98.0 109.0 109.0 121.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:149.00 stddev:16.25 (10.9%) stddev-sans-first:17.09 07:12:59 INFO - PROCESS | 4739 | Values: 151.0 125.0 148.0 173.0 136.0 150.0 147.0 124.0 165.0 131.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 07:12:59 INFO - PROCESS | 4739 | Values: 162.0 162.0 161.0 161.0 160.0 160.0 159.0 163.0 163.0 162.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#3] audio-fft Cycles:10 Average:80.50 Median:73.00 stddev:13.10 (17.9%) stddev-sans-first:13.44 07:12:59 INFO - PROCESS | 4739 | Values: 71.0 72.0 82.0 98.0 72.0 74.0 71.0 107.0 88.0 70.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.00 stddev:22.76 (24.0%) stddev-sans-first:23.60 07:12:59 INFO - PROCESS | 4739 | Values: 96.0 95.0 136.0 95.0 97.0 95.0 144.0 96.0 95.0 147.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:12:59 INFO - PROCESS | 4739 | Values: 109.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 07:12:59 INFO - PROCESS | 4739 | Values: 147.0 145.0 146.0 145.0 145.0 145.0 147.0 146.0 145.0 146.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:12:59 INFO - PROCESS | 4739 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:3.47 (6.1%) stddev-sans-first:3.64 07:12:59 INFO - PROCESS | 4739 | Values: 56.0 57.0 57.0 57.0 57.0 56.0 58.0 67.0 55.0 55.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 07:12:59 INFO - PROCESS | 4739 | Values: 68.0 67.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:3.23 (3.7%) stddev-sans-first:3.28 07:12:59 INFO - PROCESS | 4739 | Values: 85.0 85.0 86.0 94.0 87.0 88.0 87.0 85.0 93.0 87.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:125.00 stddev:5.34 (4.3%) stddev-sans-first:5.36 07:12:59 INFO - PROCESS | 4739 | Values: 118.0 121.0 118.0 127.0 117.0 126.0 127.0 124.0 133.0 118.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:153.50 stddev:5.34 (3.5%) stddev-sans-first:4.84 07:12:59 INFO - PROCESS | 4739 | Values: 143.0 153.0 153.0 158.0 156.0 146.0 155.0 145.0 154.0 146.0 07:12:59 INFO - PROCESS | 4739 | 07:12:59 INFO - PROCESS | 4739 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 07:12:59 INFO - PROCESS | 4739 | Values: 70.0 69.0 69.0 69.0 70.0 68.0 68.0 68.0 70.0 68.0 07:12:59 INFO - PROCESS | 4739 | -------- Summary: end -------- 07:12:59 INFO - PROCESS | 4739 | 07:13:00 INFO - TEST-INFO | 4739: exit 0 07:13:00 INFO - TEST-OK | kraken | took 59191ms 07:13:00 INFO - TEST-START | v8_7 07:13:00 INFO - operating with platform_type : linux_ 07:13:00 INFO - Initialising browser for v8_7 test... 07:13:00 INFO - TEST-INFO | started process 4989 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGaYrKG/profile http://localhost:38499/getInfo.html) 07:13:04 INFO - PROCESS | 4989 | __metrics Screen width/height:1600/1200 07:13:04 INFO - PROCESS | 4989 | colorDepth:24 07:13:04 INFO - PROCESS | 4989 | Browser inner width/height: 1024/697 07:13:04 INFO - PROCESS | 4989 | __metrics 07:13:04 INFO - PROCESS | 4989 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:13:04 INFO - PROCESS | 4989 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:05 INFO - TEST-INFO | 4989: exit 0 07:13:05 INFO - Browser initialized. 07:13:05 INFO - Running cycle 1/1 for v8_7 test... 07:13:05 INFO - TEST-INFO | started process 5075 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGaYrKG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:17 INFO - PROCESS | 5075 | RSS: Main: 149991424 07:13:17 INFO - PROCESS | 5075 | 07:13:38 INFO - PROCESS | 5075 | Cycle 1(1): loaded http://localhost:38499/tests/v8_7/run.html (next: http://localhost:38499/tests/v8_7/run.html) 07:13:39 INFO - PROCESS | 5075 | RSS: Main: 598724608 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | __start_tp_report 07:13:39 INFO - PROCESS | 5075 | _x_x_mozilla_page_load 07:13:39 INFO - PROCESS | 5075 | _x_x_mozilla_page_load_details 07:13:39 INFO - PROCESS | 5075 | |i|pagename|runs| 07:13:39 INFO - PROCESS | 5075 | |0;Richards;166.6944490748458 07:13:39 INFO - PROCESS | 5075 | |1;DeltaBlue;192.0860545524395 07:13:39 INFO - PROCESS | 5075 | |2;Encrypt;280.19052956010086 07:13:39 INFO - PROCESS | 5075 | |3;Decrypt;5268.421052631579 07:13:39 INFO - PROCESS | 5075 | |4;RayTrace;1141.552511415525 07:13:39 INFO - PROCESS | 5075 | |5;Earley;784.3137254901961 07:13:39 INFO - PROCESS | 5075 | |6;Boyer;12292.682926829268 07:13:39 INFO - PROCESS | 5075 | |7;RegExp;26102.5641025641 07:13:39 INFO - PROCESS | 5075 | |8;Splay;651.0416666666666 07:13:39 INFO - PROCESS | 5075 | |9;NavierStokes;4835.748792270531 07:13:39 INFO - PROCESS | 5075 | __end_tp_report 07:13:39 INFO - PROCESS | 5075 | __startTimestamp1451920419011__endTimestamp 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | ------- Summary: start ------- 07:13:39 INFO - PROCESS | 5075 | Number of tests: 10 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#0] Richards Cycles:1 Average:166.69 Median:166.69 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 166.7 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#1] DeltaBlue Cycles:1 Average:192.09 Median:192.09 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 192.1 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 280.2 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 5268.4 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#4] RayTrace Cycles:1 Average:1141.55 Median:1141.55 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 1141.6 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 784.3 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 12292.7 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#7] RegExp Cycles:1 Average:26102.56 Median:26102.56 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 26102.6 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#8] Splay Cycles:1 Average:651.04 Median:651.04 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 651.0 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - PROCESS | 5075 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:13:39 INFO - PROCESS | 5075 | Values: 4835.7 07:13:39 INFO - PROCESS | 5075 | -------- Summary: end -------- 07:13:39 INFO - PROCESS | 5075 | 07:13:39 INFO - TEST-INFO | 5075: exit 0 07:13:39 INFO - TEST-OK | v8_7 | took 39388ms 07:13:39 INFO - SUITE-END | took 1215s 07:13:40 INFO - Completed test suite (00:20:16) 07:13:40 INFO - Working with test: dromaeo_css 07:13:40 INFO - Generating results file: dromaeo_css 07:13:40 INFO - Working with test: kraken 07:13:40 INFO - Generating results file: kraken 07:13:40 INFO - javascript benchmark 07:13:40 INFO - Working with test: v8_7 07:13:40 INFO - Generating results file: v8_7 07:13:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:13:40 INFO - process_Request line: dromaeo_css 6860.29 graph.html#tests=[[72,1,35]] 07:13:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:40 INFO - process_Request line: kraken 1512.10 graph.html#tests=[[232,1,35]] 07:13:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:40 INFO - process_Request line: v8_7 20720.43 graph.html#tests=[[230,1,35]] 07:13:40 INFO - RETURN: dromaeo_css: 6860.29 07:13:40 INFO - RETURN: kraken: 1512.10 07:13:40 INFO - RETURN: v8_7: 20720.43 07:13:40 INFO - javascript benchmark 07:13:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.9844250778747, 3142.135912624027, 3189.856456459459, 3195.616526016877, 3199.360127974405, 5142.922856157161, 5261.736913154346, 5277.841664750059, 5291.947080529194, 5345.732713364336, 5253.50091741284, 5275.525202731754, 5286.894262114765, 5390.51485366317, 5407.783688652449, 4804.663673542854, 4811.085893680199, 4827.251775974712, 4829.251466022772, 4891.951080489203, 4918.188498897677, 4922.532359425849, 4955.281484184791, 4959.851204463854, 4988.376452943382, 4752.263399173099, 4787.904241915177, 4875.488073752258, 4889.657723959324, 4892.559669629751, 4854.587360074398, 4857.635677324215, 4861.0, 4871.512848715136, 4907.2639104134305, 4804.7837847296605, 4808.663393562452, 4808.735519546459, 4811.109944660249, 4858.78135483904, 5073.822416215415, 5095.414027386861, 5184.844454666366, 5188.688678679291, 5212.4266330703595, 5741.598088133832, 5748.310202775652, 5754.108113242454, 5756.683382413966, 5757.510611598019, 5769.913451298234, 5773.018586840247, 5776.36459989405, 5784.566157538202, 5793.971030144864, 5270.7628156733035, 5331.173668081454, 5391.649542779707, 5395.298611180521, 5456.836294911159, 5820.88358232833, 5833.38749431312, 5835.299764028259, 5838.67887266196, 5882.176495290662, 5594.804181853616, 5604.271444712162, 5605.04714198579, 5608.719564021782, 5612.747426365823, 5567.749451274703, 5602.075657516464, 5681.943180568224, 5688.971555142198, 5806.593538452268, 5564.304461942257, 5609.074502707008, 5612.130119831351, 5616.747246373923, 5637.323521177403, 5637.210790489335, 5639.971800141055, 5641.492265696107, 5642.4357564244065, 5653.604247702621, 4306.849260275875, 4348.7390756554705, 4395.912081758411, 4432.268675668543, 4474.888127796766, 3918.1967696622123, 3923.6272554107886, 3926.155876486569, 3954.307996100671, 3959.5248570171766, 5271.1039123348355, 5332.786688532416, 5336.119540275811, 5345.973270133624, 5352.5450336721815, 5701.629394089454, 5709.800156994485, 5730.484256416942, 5788.016037273674, 5833.4749872511675, 5315.229291752751, 5342.198670199424, 5344.786208551692, 5345.572354211654, 5352.866178345573, 4774.785134668949, 4873.829415970424, 4883.169861123546, 4886.657933944661, 4934.777934992934, 5897.085951677497, 5921.289445266596, 5946.643201407929, 5999.820005399845, 6010.398960104042, 5767.5674324425, 5777.537796976148, 5779.335376431764, 5784.971075144597, 5792.275965504312, 5851.765929362949, 5966.105084237399, 6008.669523176267, 6013.639181649115, 6017.608855424383, 5638.915416268841, 5684.914726279027, 5687.203791469115, 5690.032694441872, 5693.601447898607, 5735.655860648374, 5778.364379918122, 5780.855478613068, 5785.450382213683, 5786.971065144648, 5566.805161819317, 5644.774209031592, 5648.548116150616, 5650.463205995424, 5727.284089488814, 5655.179998900218, 5657.4059723728415, 5667.40492248308, 5671.177679236405, 5679.091345384719, 5539.058360078716, 5543.1408131739645, 5559.499645031967, 5564.0, 5564.415736347787, 5522.834314970557, 5633.239512665901, 5684.118961560965, 5688.715564221855, 5717.656940583578, 5489.64317319373, 5493.862653433696, 5495.038368285614, 5498.092814685692, 5549.805756798492], "unit": "score", "name": "dojo.html", "value": 5272.016148983209}, {"lowerIsBetter": false, "replicates": [536.3724442402389, 540.9107497262952, 559.222680474141, 566.9914951275734, 573.6787399056526, 27703.722962770367, 28299.86800527979, 35002.824985875064, 35649.28701425977, 35670.0, 38430.61569384305, 38786.0, 38792.41811372824, 38832.61167388325, 38886.611133888655, 7344.853102937938, 8455.915440845574, 8638.697645582406, 8647.351448641377, 8655.523946182957, 6791.3548212919695, 6896.137982752156, 10174.64388746394, 10350.844737328945, 10353.17174626032, 10085.0, 10229.846552301722, 10233.130183934374, 10239.539220735047, 10240.0, 10132.54403551842, 10159.390436573829, 10175.440350780704, 10194.133498652624, 10244.129249013842, 9778.266630002707, 9988.101070903653, 10002.299839011272, 10024.849627255597, 10055.245856560787, 38891.416628750594, 39277.607223927684, 39419.0, 39453.21093578141, 39496.0, 3223.9355212895844, 3311.1391038329966, 3650.5984341722387, 3656.9490510985097, 3692.335379631665, 30189.396212075637, 30214.84892575545, 30518.0, 30529.389412211855, 30741.692583074106, 3840.3855383138844, 3931.253061918226, 3950.032242100675, 4019.799010049515, 4046.3728122141115, 271457.0, 272035.0, 272580.0, 273234.0, 273849.0, 50576.24135637969, 58277.4172258272, 58584.70707646434, 58622.7068864653, 58731.0, 38225.426618600744, 62516.37483625196, 63902.36097639057, 64020.35979640144, 64039.35960640334, 13816.447342106203, 14083.577492675236, 14116.153030818185, 14116.364763585458, 14116.929415352857, 10405.739856503647, 10587.735306617396, 11534.0, 11618.0, 11798.5870494534, 19008.809911900982, 19022.0, 19052.333168339042, 19092.33176838804, 19153.0, 6785.728570857209, 7014.159265497482, 7020.0, 7058.329458701415, 7113.608751518613, 890.550272112579, 916.5417291354323, 953.575658831827, 999.3753903810118, 1048.3814549415881, 27548.311292217855, 28695.282617934718, 29186.124416267547, 29955.25111872177, 30858.382832343228, 1022.3405903192399, 1041.6250149946013, 1047.1361127070197, 1049.9895001050045, 1077.7036315013434, 12955.481780728665, 13118.475260989453, 13227.801582976263, 13268.270245136417, 13371.598852034454, 253035.0, 256022.0, 256218.0, 256348.0, 256767.0, 46121.53878461239, 46323.30515042277, 46405.67971601406, 46451.30323045157, 46472.0, 1263.740933108729, 1265.240855486719, 1319.1886989501388, 1355.4645914863574, 1366.030118615774, 23935.0, 24701.876490617433, 24719.50560988806, 24917.12790052412, 25029.74970250274, 39471.802640986614, 39520.2095958085, 39700.40449393204, 40557.0, 40598.39102413525, 308850.0, 310018.0, 310060.0, 310840.0, 311297.0, 27030.32424189411, 30489.08532744021, 30904.536431953988, 30982.535261971538, 31076.68923310738, 38004.809975949946, 38972.80513597414, 39537.209255815294, 39980.400293996194, 40143.39784903287, 31771.84114079415, 33225.50161747624, 33791.15522111967, 34140.829295853364, 34377.484337735455, 33105.0, 33233.66766332403, 33505.66494335025, 33582.0, 33588.832055839564, 33354.166145846546, 33526.66473335236, 34231.144221394665, 34929.0, 34998.47502287417, 28097.859510702314, 30633.54049689301, 31252.531212031383, 31449.0, 31449.0, 23919.282421527383, 23946.76053239445, 23989.76010239945, 24054.87972560196, 24244.75755242425], "unit": "score", "name": "ext.html", "value": 17808.90235735918}, {"lowerIsBetter": false, "replicates": [364.6535790998552, 366.7231240413488, 367.7646306363926, 369.84836217150973, 370.4739270236264, 12717.36413179342, 12879.678008049803, 16190.919045404771, 16692.91653541732, 17305.134743262835, 15322.0, 16114.11372374519, 16498.34006639736, 16502.33990640373, 16604.418845340417, 5255.369355677314, 5387.811426600069, 5393.838184854441, 5396.676199428027, 5397.028534863723, 3524.1189702574356, 3612.584552776438, 5377.946220537803, 5419.430959749228, 5869.325027621835, 5934.673592952386, 5985.042393217086, 6015.368386319439, 6020.6688632125215, 6023.066424704156, 5725.742341594618, 5942.049272116441, 5947.4052594740615, 5959.314678811948, 5963.254593175853, 5189.66267192635, 5278.868028299285, 5285.0, 5295.602829787743, 5297.920531192035, 11725.237859539187, 12099.818502722466, 20142.39572812818, 21098.683519747217, 21117.68323475149, 1719.785026871641, 1931.430228082719, 2240.260713964388, 2244.5735310290993, 2265.444965983328, 9001.279897608176, 9111.772205694844, 9339.17886012228, 9964.302498825085, 12768.850803427737, 1633.5099470159023, 1668.991655041717, 1680.7226807576735, 1717.0384584632645, 1768.7612172356696, 55588.722056389866, 59850.401495984916, 61457.0, 64091.679541601996, 64279.678601607164, 9919.950400247953, 10028.849567256497, 10114.898851011396, 10484.10885074762, 10488.0, 13676.452941882413, 13683.31583420825, 13723.588292351245, 13724.0, 13773.793393099111, 7540.773776786705, 7611.65747541362, 7634.274743899321, 7646.9617651911385, 7719.691212351556, 7295.489315747953, 7332.046833911664, 7345.88981165283, 7384.630768461556, 7386.446016548781, 4218.325067989168, 4258.787060647017, 4471.06107717383, 4538.2738761797955, 4579.473360563577, 1707.7353010283425, 1714.2114627271594, 1803.305727295001, 1817.7457554287498, 1832.0931139086238, 934.6261495401758, 943.9528023598792, 954.3462728031182, 957.363353370015, 988.7626969527405, 14444.422223111169, 15500.0, 16281.267342969595, 16348.264328105264, 17069.231884565223, 935.6163972771132, 962.2206013129388, 980.5930538826307, 994.16986816008, 1007.2495990487134, 9280.582373793195, 9684.176844968115, 9726.756831079138, 9798.461084640414, 9880.407175569346, 578605.0, 580199.6622330578, 596631.0, 613787.3795679205, 617813.0, 71287.64356178186, 78785.0, 80010.19989800027, 81399.59300203579, 84383.57808211043, 1052.8052310322614, 1080.821664425361, 1159.2986243322669, 1187.4537712652277, 1190.7142285851332, 14538.200398978157, 14746.0, 15087.0, 15107.848921510644, 15260.23698815077, 31738.36523269568, 31984.0, 35609.329300302066, 35968.10079748027, 36902.63097368992, 44001.77999109984, 44422.0, 45168.32247516356, 47492.52507474881, 47857.282140767216, 9411.011843756582, 9602.90397096048, 9683.757906052406, 9712.077352651488, 9718.173955213886, 11973.700657483632, 13880.51418200358, 17530.386436474662, 17727.468175954742, 17904.731429028834, 11373.715657108307, 13822.032457727862, 14072.507462238773, 14122.576322710334, 14125.364358603681, 13380.197188168351, 13524.864751352361, 13619.591412257649, 14250.572482825532, 14720.411183552538, 14320.57038288853, 14504.129752214902, 14771.556853294418, 14827.33277002516, 14856.0, 8871.512066836385, 9343.81312373735, 9344.112309330603, 9756.853647195156, 9783.168430683472, 12740.872591273968, 13207.801882971571, 13313.068085234328, 13726.656833578842, 13756.17462952226], "unit": "score", "name": "jquery.html", "value": 8786.459742291465}, {"lowerIsBetter": false, "replicates": [1178.8526434195726, 1468.2878803780166, 1477.6527516033734, 1646.5142782879057, 1819.2541058166155, 6844.965775171129, 7364.263573642633, 7483.438742094344, 7487.401007919367, 7491.026166598334, 7261.092363454568, 7492.7752167435065, 7497.137829149649, 7500.699972001114, 7505.849883002336, 1948.9415317540497, 1977.4166620846813, 2206.735191776989, 2219.1123550579737, 2260.9660855087186, 2230.163688616769, 2230.208276061999, 2232.1294695068937, 2233.20721143994, 2233.8659680419146, 2144.356692992104, 2230.553889222154, 2231.1856172497005, 2234.709487766588, 2242.1479837661745, 2190.0582749417745, 2203.162798136706, 2221.389117992549, 2250.2686626846175, 2264.8754318512474, 2231.497912969569, 2252.9436764080865, 2263.5020295534955, 2298.6322188449935, 2303.0557471436796, 7604.391648668094, 7609.429292803062, 7666.4250181236075, 7699.5380277182985, 7710.614469276514, 4501.122281155176, 4548.044910568785, 4578.519255478193, 4607.95392046082, 4611.746353950532, 3034.9696503034907, 3049.588305578741, 3061.8928337508305, 3080.1067690369764, 3217.501287300472, 977.1645243317004, 979.4123525884484, 984.6258421799741, 1022.723864556573, 1090.7709381029993, 10485.056344928993, 10520.473976301231, 10525.736856578571, 10552.630657927013, 10561.313514621525, 4163.83344666216, 4201.831926722897, 4229.6827737919775, 4250.362445633118, 4278.507971583245, 9020.639174432948, 9042.819143617222, 9091.090890910857, 9095.499747513817, 9109.817803644022, 4634.096351211549, 4635.698679585884, 4652.953470465252, 4654.092451971833, 4674.275487299474, 4251.277282861921, 4255.829766809355, 4256.510501292391, 4267.039916018933, 4273.081287523135, 3289.753268504872, 3335.8999230023137, 3537.7700449470703, 3591.982040089783, 3595.1910820065277, 1116.5547451082105, 1132.8980391764617, 1140.6064907606863, 1147.1359041557469, 1170.0931777872047, 1038.4859494550246, 1040.453761775059, 1098.4068602954476, 1162.5291756838494, 1281.8974482041415, 7171.282871712787, 7205.89191162133, 7262.455315851333, 7266.418686505067, 7270.600116993616, 1103.9613613523488, 1104.7514309280348, 1110.7278716714457, 1113.9554417823197, 1118.82658187981, 5639.774409023676, 5728.541716662657, 5729.512991395694, 5733.025385684444, 5735.455131762559, 9072.183503484717, 9120.224780893566, 9310.208632266198, 9431.386959847589, 9448.244140468745, 9298.395604285699, 9304.395214311047, 9310.581023853943, 9313.254939604816, 9321.394109382869, 6576.750417420675, 6699.866002680016, 6700.195976482756, 6935.618540980194, 6988.825279367955, 7145.249748776304, 7364.226756190523, 7364.3003914628025, 7367.594782287026, 7392.630368481447, 8156.83686326282, 8403.201695838885, 8411.873821892554, 8541.103184165573, 8543.273821725223, 8459.703910363107, 8487.702930397407, 8612.440191387539, 8639.784005399915, 8652.524111173945, 6485.459680948523, 6525.64108974011, 6591.242007169045, 6594.604323740591, 6603.7688680895935, 6627.436667883091, 6733.93266067333, 7075.82310442243, 7217.314355136254, 7220.927790722026, 6781.11845460087, 6887.5178737487895, 6898.931010690029, 6945.930540694529, 7000.264972177848, 6659.4006539411685, 6681.665916704243, 6692.0, 6807.0810440589885, 6832.0, 6595.439387651912, 6621.437177839937, 6624.403803657694, 6626.204855417381, 6629.602223866584, 6081.665508397081, 6105.145279660762, 6189.659568723763, 6296.338884417253, 6304.747810087545, 6388.680565971776, 6401.583897046677, 6420.775272865428, 6424.10062591247, 6425.8714825704155], "unit": "score", "name": "mootools.html", "value": 4391.688911512107}, {"lowerIsBetter": false, "replicates": [318.84057971014494, 322.97900636458644, 328.02576348245714, 328.7123766704134, 330.9106541233867, 5652.717364131798, 5847.970760146193, 5886.058230683092, 5979.0, 5982.162497250389, 5648.068068768658, 5703.287089113861, 5840.06558950568, 5856.941430585693, 5873.0, 4493.033997690496, 4500.279955207167, 4502.054568540594, 4505.662075344346, 4512.345709872066, 4342.044750154961, 4403.713758605696, 4441.644668426534, 4500.099980003996, 4502.954970450302, 4442.822287108528, 4462.352958820969, 4471.552844715535, 4474.776261186944, 4477.932831007537, 4427.424434823484, 4428.623566996793, 4440.600345968846, 4454.398656181439, 4462.57605527476, 3928.7249892507534, 3935.9212815743526, 3937.0551067743536, 3943.842246310144, 3965.1871366369824, 5366.490183432567, 5502.8349149525575, 5504.862378440571, 5505.421930697259, 5552.77788888444, 5316.946830531684, 5317.255584218213, 5317.707526086064, 5319.414864364955, 5321.175217841241, 6214.316425193225, 6215.440610345091, 6215.782447614311, 6218.533609979225, 6229.3459186785185, 4277.465316835395, 4324.978375108104, 4370.8033138508845, 4427.512973572904, 4458.5318541553, 6404.103425520431, 6410.551261411703, 6443.0, 6443.935560644427, 6458.2895881453005, 4446.3108218226225, 4459.464864216315, 4462.3752674625575, 4462.799174037176, 4467.5755803198645, 4340.52254252032, 4515.096980603892, 4515.706479078849, 4518.593326600621, 4522.186006518858, 5126.282320475137, 5153.896922061538, 5154.020736060212, 5160.8967820643375, 5162.174052151638, 6218.098375735493, 6222.657753823492, 6226.844328891814, 6228.906566401508, 6234.563580549318, 1615.063263307279, 1653.6940665976833, 1654.1563802460591, 1655.0, 1658.07147997122, 1105.4638500327335, 1117.932924024545, 1132.9830052549219, 1141.3608379307614, 1141.657502749172, 5923.674197919156, 5925.762969481259, 5928.881422371528, 5930.970345148246, 5933.258342707161, 6363.3636636336, 6366.236051673736, 6369.076483909807, 6372.044193371032, 6376.107344971708, 5928.407159284124, 5928.525717942554, 5928.584999050025, 5933.821985340447, 5939.198208241832, 3373.0049635357627, 3473.374792537317, 3475.860965561349, 3481.3559491494157, 3482.407990641597, 6705.094812200388, 6706.061151438803, 6721.899171512431, 6752.628605426748, 6760.3239676032, 6600.108985287021, 6606.306337834458, 6611.735530578723, 6613.0, 6617.636030018395, 6569.408753212234, 6734.966325168343, 6737.898931516129, 6739.696713647898, 6742.056112144303, 6130.877382452415, 6410.1025856381075, 6410.519211059096, 6410.551261411656, 6416.550841441054, 6179.0, 6246.6876656167915, 6308.810735677937, 6310.6213627182515, 6313.116163737172, 6690.799276021728, 6702.296258892941, 6710.194776626836, 6710.228323742832, 6713.093732346071, 4418.204723149864, 4458.977705111453, 4463.419755431773, 4465.955340446684, 4466.397036400174, 6279.30927597973, 6446.258680251831, 6450.580712253689, 6456.7740129095255, 6466.482681385572, 6282.2147231596055, 6285.0, 6289.811305660837, 6290.21372328459, 6297.149884765498, 6220.813375598558, 6264.436200741955, 6271.122042914087, 6272.780452684134, 6276.089966954857, 5957.076653118774, 6162.630242185483, 6163.167972323679, 6169.753209871555, 6170.876582468415, 6302.527310451643, 6308.589941653778, 6310.716017779303, 6310.873782524415, 6311.147995020613, 6118.012267863259, 6167.475764560063, 6168.383161683796, 6176.073588961692, 6203.658798766111], "unit": "score", "name": "prototype.html", "value": 4714.009381130397}, {"lowerIsBetter": false, "replicates": [810.8905297784797, 831.7463173732009, 846.5640195299422, 861.1646702698382, 873.8470767615668, 12009.099317551176, 12110.515579376814, 12202.877971220274, 12232.20490668107, 12243.367675949668, 12863.16389434686, 12978.870211297908, 12997.155184912997, 12999.545015924445, 13000.089993700445, 798.932090772285, 809.6963638635511, 810.080558566026, 811.1037303779327, 811.7077851973314, 681.6557638392604, 682.3347236444476, 814.4136221920209, 817.1175130858659, 823.0041649603957, 854.9016863060765, 856.7729551668813, 866.9942866275122, 867.1501928110456, 867.6876324523166, 849.6856163219618, 853.8292341531657, 854.6068808348167, 854.6581367453007, 863.1368631368631, 506.589662373475, 512.4465577176677, 516.5325380530626, 609.7713357490941, 610.8259146143372, 11942.820857687142, 11966.162368634199, 12097.455614497369, 12099.334536600483, 12107.697307567294, 11459.656210313704, 11890.762184756342, 12147.0, 12322.507099716, 12341.753164936741, 9867.60529578816, 9961.701148965543, 10185.388876667424, 10244.0, 10291.53688084038, 3520.8767693130617, 3570.839312230956, 3594.3530164570366, 3599.1182160370877, 3706.629337066299, 47254.2911856319, 48704.75647621739, 48824.023519529765, 48931.26603100956, 49104.75447622775, 9704.0, 9821.705348839547, 9847.45838978863, 9919.107280344659, 9946.254030947708, 16445.177741112897, 16576.336946522006, 16584.50246492607, 16597.170141492876, 16616.501504954627, 6515.641639709766, 6672.86654266912, 6697.799066028027, 6729.461643068543, 6866.0, 4053.4730485036757, 4072.165206132736, 4126.66986641074, 4174.457320548309, 4251.851185208565, 3012.051203870774, 3039.3921215756936, 3052.4810782167083, 3054.373853360056, 3087.505999040143, 543.3371287029818, 546.1998172677047, 547.0809040811396, 552.4889477233623, 577.1400613086471, 581.2588949089944, 624.8906441372833, 632.6141053957083, 656.5502630697891, 659.8350412396804, 8454.87317690235, 9167.404118732262, 9192.310576706774, 9294.72115836526, 9329.486878221764, 484.45740770336744, 525.1309083466869, 563.2902542796106, 591.6124938165508, 635.4662083849588, 3924.9018774530864, 3982.721209515364, 4063.9433747225935, 4083.3466645336603, 4092.6316631502714, 56382.0, 56726.86546269134, 56931.0, 57145.42854571484, 57187.0, 50726.0, 51817.48182518202, 51994.48005519896, 52256.73871630617, 52754.0, 44938.0, 45733.54266457293, 46182.76908615435, 46621.0, 47005.0, 7672.846543068996, 7783.221677832172, 7833.412494063082, 7844.254795794391, 7877.803054923673, 34701.0, 34836.82581587076, 35453.113672158404, 36353.81823090868, 36621.816890915376, 40723.59276407198, 42084.0, 42199.57800422079, 44532.0, 44600.33099503575, 10463.94768026155, 10516.316439431412, 10914.053205634593, 11083.445827708421, 11110.666679999613, 11742.941285293518, 11846.0, 11897.82153267719, 11985.520579176735, 12095.939520302341, 10677.839832402366, 10770.730731731455, 11158.888411115784, 11629.287763502558, 11696.415179241174, 10943.781124377309, 11109.666709998713, 11166.776664466503, 11180.720481988015, 11213.327200368005, 9218.539073046186, 10352.792944140925, 10848.511816968097, 11153.051990580567, 11162.162837787037, 8630.82738345217, 8974.282057435259, 8992.595333210153, 9043.638254469748, 9104.453732776055, 8848.513331766815, 8878.556072196494, 9176.908230917605, 9260.814783704423, 9474.857877131986], "unit": "score", "name": "yui.html", "value": 6103.314518402214}], "name": "dromaeo_css", "value": 6860.288013045764}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 110.0, 110.0, 110.0, 98.0, 109.0, 109.0, 121.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 148.0, 173.0, 136.0, 150.0, 147.0, 124.0, 165.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 160.0, 160.0, 159.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 82.0, 98.0, 72.0, 74.0, 71.0, 107.0, 88.0, 70.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 136.0, 95.0, 97.0, 95.0, 144.0, 96.0, 95.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 57.0, 57.0, 56.0, 58.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 94.0, 87.0, 88.0, 87.0, 85.0, 93.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 118.0, 127.0, 117.0, 126.0, 127.0, 124.0, 133.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [143.0, 153.0, 153.0, 158.0, 156.0, 146.0, 155.0, 145.0, 154.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1512.1000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.6944490748458], "unit": "score", "name": "Richards", "value": 211.77669800000004}, {"lowerIsBetter": false, "replicates": [192.0860545524395], "unit": "score", "name": "DeltaBlue", "value": 344.2103079999998}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1141.552511415525], "unit": "score", "name": "RayTrace", "value": 648.2303639999998}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [26102.5641025641], "unit": "score", "name": "RegExp", "value": 34.90021119842827}, {"lowerIsBetter": false, "replicates": [651.0416666666666], "unit": "score", "name": "Splay", "value": 125.17017600000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20720.42634891743}]} 07:13:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20720.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1512.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6860.29"}}} 07:13:40 INFO - Return code: 0 07:13:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:13:40 INFO - # TBPL SUCCESS # 07:13:40 INFO - Running post-action listener: _resource_record_post_action 07:13:40 INFO - Running post-run listener: _resource_record_post_run 07:13:41 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 10489856; Write bytes: 369594368; Read time: 2884; Write time: 388472 07:13:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 11264000; Read time: 0; Write time: 13396 07:13:41 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8728576; Write bytes: 358330368; Read time: 2840; Write time: 375076 07:13:41 INFO - Running post-run listener: _upload_blobber_files 07:13:41 INFO - Blob upload gear active. 07:13:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:13:41 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 07:13:41 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:13:41 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:13:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:42 INFO - (blobuploader) - INFO - Done attempting. 07:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:13:43 INFO - (blobuploader) - INFO - Done attempting. 07:13:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:13:43 INFO - Return code: 0 07:13:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:13:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:13:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c0efbbb70f1f127a43d1950042bf5f19c84eee558bfbe0f4e28e8af52b1d0048f76dd18fc8893d29c8aa9e49aefa00fa54fb379a00ea4cb4f8a0c5f527d40d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6090b98f1665d58632f1832cb534ab1af65a5f3437f246259228186e49f60df11ae1c4cb2f2ab6addb09b534791a5a7270edc325e79940b80dd282ea4ece8e2"} 07:13:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:13:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:13:43 INFO - Contents: 07:13:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c0efbbb70f1f127a43d1950042bf5f19c84eee558bfbe0f4e28e8af52b1d0048f76dd18fc8893d29c8aa9e49aefa00fa54fb379a00ea4cb4f8a0c5f527d40d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6090b98f1665d58632f1832cb534ab1af65a5f3437f246259228186e49f60df11ae1c4cb2f2ab6addb09b534791a5a7270edc325e79940b80dd282ea4ece8e2"} 07:13:43 INFO - Copying logs to upload dir... 07:13:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.343039 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-04 07:13:43.610792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 07:13:43.613823) ========= 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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c0efbbb70f1f127a43d1950042bf5f19c84eee558bfbe0f4e28e8af52b1d0048f76dd18fc8893d29c8aa9e49aefa00fa54fb379a00ea4cb4f8a0c5f527d40d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6090b98f1665d58632f1832cb534ab1af65a5f3437f246259228186e49f60df11ae1c4cb2f2ab6addb09b534791a5a7270edc325e79940b80dd282ea4ece8e2"} build_url:https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/W8OAu_kcSV-h1nxYCacZeA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c0efbbb70f1f127a43d1950042bf5f19c84eee558bfbe0f4e28e8af52b1d0048f76dd18fc8893d29c8aa9e49aefa00fa54fb379a00ea4cb4f8a0c5f527d40d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6090b98f1665d58632f1832cb534ab1af65a5f3437f246259228186e49f60df11ae1c4cb2f2ab6addb09b534791a5a7270edc325e79940b80dd282ea4ece8e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 07:13:43.637943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:13:43.638228) ========= 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=f919189b672bc2eeae365d21000001d6-1451918000.869157-1134303020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:13:43.721662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 07:13:43.721991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 07:13:43.722280) ========= ========= Total master_lag: 0.28 =========