builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1452790689.47 results: success (0) buildid: 20160114060719 builduid: bcc34891ba2d4ed5a054dd5e69bc73b0 revision: 27eb5e90eeee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.470356) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.470831) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.471151) ========= 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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004417 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.488347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.488635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.500563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.500881) ========= 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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004696 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.550655) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.550940) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.551318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.551595) ========= 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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 08:58:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-14 08:58:10 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.649878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.650214) ========= 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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021096 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.701901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:09.702264) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee --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 27eb5e90eeee --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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 08:58:10,344 Setting DEBUG logging. 2016-01-14 08:58:10,344 attempt 1/10 2016-01-14 08:58:10,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27eb5e90eeee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 08:58:10,611 unpacking tar archive at: mozilla-central-27eb5e90eeee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:10.317411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:10.317709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:10.327527) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:10.327808) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 08:58:10.328224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-14 08:58:10.328517) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:58:11 INFO - MultiFileLogger online at 20160114 08:58:11 in /builds/slave/test-pgo 08:58:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:58:11 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:58:11 INFO - {'append_to_log': False, 08:58:11 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:58:11 INFO - 'blob_upload_branch': 'Firefox', 08:58:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:58:11 INFO - 'branch': 'Firefox', 08:58:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:11 INFO - 'config_files': ('talos/linux_config.py',), 08:58:11 INFO - 'default_actions': ('clobber', 08:58:11 INFO - 'read-buildbot-config', 08:58:11 INFO - 'download-and-extract', 08:58:11 INFO - 'populate-webroot', 08:58:11 INFO - 'create-virtualenv', 08:58:11 INFO - 'install', 08:58:11 INFO - 'run-tests'), 08:58:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:11 INFO - 'download_minidump_stackwalk': True, 08:58:11 INFO - 'download_symbols': 'ondemand', 08:58:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:11 INFO - 'installer_path': 'installer.exe', 08:58:11 INFO - 'log_level': 'info', 08:58:11 INFO - 'log_name': 'talos', 08:58:11 INFO - 'log_to_console': True, 08:58:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:58:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:58:11 INFO - 'opt_config_files': (), 08:58:11 INFO - 'pip_index': False, 08:58:11 INFO - 'sps_profile': False, 08:58:11 INFO - 'sps_profile_interval': 0, 08:58:11 INFO - 'suite': 'dromaeojs-e10s', 08:58:11 INFO - 'system_bits': '32', 08:58:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:11 INFO - 'title': 'talos-linux64-ix-056', 08:58:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:11 INFO - 'use_talos_json': True, 08:58:11 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:58:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:11 INFO - 'work_dir': 'build'} 08:58:11 INFO - ##### 08:58:11 INFO - ##### Running clobber step. 08:58:11 INFO - ##### 08:58:11 INFO - Running pre-action listener: _resource_record_pre_action 08:58:11 INFO - Running main action method: clobber 08:58:11 INFO - rmtree: /builds/slave/test-pgo/build 08:58:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:58:12 INFO - Running post-action listener: _resource_record_post_action 08:58:12 INFO - ##### 08:58:12 INFO - ##### Running read-buildbot-config step. 08:58:12 INFO - ##### 08:58:12 INFO - Running pre-action listener: _resource_record_pre_action 08:58:12 INFO - Running main action method: read_buildbot_config 08:58:12 INFO - Using buildbot properties: 08:58:12 INFO - { 08:58:12 INFO - "project": "", 08:58:12 INFO - "product": "firefox", 08:58:12 INFO - "script_repo_revision": "production", 08:58:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:58:12 INFO - "repository": "", 08:58:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:58:12 INFO - "buildid": "20160114060719", 08:58:12 INFO - "stage_platform": "linux64-pgo", 08:58:12 INFO - "basedir": "/builds/slave/test-pgo", 08:58:12 INFO - "nightly_build": "True", 08:58:12 INFO - "buildnumber": 619, 08:58:12 INFO - "slavename": "talos-linux64-ix-056", 08:58:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:58:12 INFO - "platform": "ubuntu64_hw", 08:58:12 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:58:12 INFO - "branch": "mozilla-central", 08:58:12 INFO - "repo_path": "mozilla-central", 08:58:12 INFO - "revision": "27eb5e90eeee", 08:58:12 INFO - "pgo_build": "True", 08:58:12 INFO - "builduid": "bcc34891ba2d4ed5a054dd5e69bc73b0", 08:58:12 INFO - "slavebuilddir": "test" 08:58:12 INFO - } 08:58:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:58:12 INFO - Running post-action listener: _resource_record_post_action 08:58:12 INFO - ##### 08:58:12 INFO - ##### Running download-and-extract step. 08:58:12 INFO - ##### 08:58:12 INFO - Running pre-action listener: _resource_record_pre_action 08:58:12 INFO - Running main action method: download_and_extract 08:58:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:58:12 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')]} 08:58:12 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:58:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json 08:58:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json 08:58:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:58:12 INFO - Downloaded 1448 bytes. 08:58:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:58:12 INFO - Using the following test package requirements: 08:58:12 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:58:12 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:58:12 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:58:12 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'jsshell-linux-x86_64.zip'], 08:58:12 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:58:12 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:58:12 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:58:12 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:58:12 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:58:12 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:58:12 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:58:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:58:12 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:58:12 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')]} 08:58:12 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:58:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:58:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:58:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:15 INFO - Downloaded 24030841 bytes. 08:58:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:58:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:58:16 INFO - Return code: 0 08:58:16 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 08:58:16 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')]} 08:58:16 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:58:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:58:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:58:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:21 INFO - Downloaded 24030841 bytes. 08:58:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:58:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:58:23 INFO - Return code: 0 08:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:23 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:25 INFO - Downloaded 11132144 bytes. 08:58:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:58:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:58:26 INFO - Return code: 0 08:58:26 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')]} 08:58:26 INFO - https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/al17RE2WSju46MYDDMLwhg/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 08:58:30 INFO - Downloaded 55848868 bytes. 08:58:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:58:30 INFO - mkdir: /builds/slave/test-pgo/properties 08:58:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:58:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:58:30 INFO - Contents: 08:58:30 INFO - build_url:https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:58:30 INFO - Running post-action listener: _resource_record_post_action 08:58:30 INFO - Running post-action listener: set_extra_try_arguments 08:58:30 INFO - ##### 08:58:30 INFO - ##### Running populate-webroot step. 08:58:30 INFO - ##### 08:58:30 INFO - Running pre-action listener: _resource_record_pre_action 08:58:30 INFO - Running main action method: populate_webroot 08:58:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:58:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:58:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:58:30 INFO - '--tppagecycles', 08:58:30 INFO - '7'], 08:58:30 INFO - 'tests': ['tsvgm']}}, 08:58:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:58:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:58:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:58:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:58:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'tests': ['damp', 'tps']}, 08:58:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['damp', 'tps']}, 08:58:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:58:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:58:30 INFO - 'other': {'tests': ['a11yr', 08:58:30 INFO - 'ts_paint', 08:58:30 INFO - 'tpaint', 08:58:30 INFO - 'sessionrestore', 08:58:30 INFO - 'sessionrestore_no_auto_restore']}, 08:58:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['a11yr', 08:58:30 INFO - 'ts_paint', 08:58:30 INFO - 'tpaint', 08:58:30 INFO - 'sessionrestore', 08:58:30 INFO - 'sessionrestore_no_auto_restore']}, 08:58:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['a11yr', 08:58:30 INFO - 'ts_paint', 08:58:30 INFO - 'tpaint', 08:58:30 INFO - 'sessionrestore', 08:58:30 INFO - 'sessionrestore_no_auto_restore']}, 08:58:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['a11yr', 08:58:30 INFO - 'ts_paint', 08:58:30 INFO - 'tpaint', 08:58:30 INFO - 'sessionrestore', 08:58:30 INFO - 'sessionrestore_no_auto_restore']}, 08:58:30 INFO - 'other_l64': {'tests': ['a11yr', 08:58:30 INFO - 'ts_paint', 08:58:30 INFO - 'tpaint', 08:58:30 INFO - 'sessionrestore', 08:58:30 INFO - 'sessionrestore_no_auto_restore']}, 08:58:30 INFO - 'other_nol64': {'tests': ['a11yr', 08:58:30 INFO - 'ts_paint', 08:58:30 INFO - 'tpaint', 08:58:30 INFO - 'sessionrestore', 08:58:30 INFO - 'sessionrestore_no_auto_restore']}, 08:58:30 INFO - 'svgr': {'tests': ['tsvgx', 08:58:30 INFO - 'tsvgr_opacity', 08:58:30 INFO - 'tart', 08:58:30 INFO - 'tscrollx', 08:58:30 INFO - 'cart']}, 08:58:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['tsvgx', 08:58:30 INFO - 'tsvgr_opacity', 08:58:30 INFO - 'tart', 08:58:30 INFO - 'tscrollx', 08:58:30 INFO - 'cart']}, 08:58:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'tests': ['tp5o']}, 08:58:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'talos_options': ['--e10s'], 08:58:30 INFO - 'tests': ['tp5o']}, 08:58:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'talos_options': ['--xperf_path', 08:58:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:30 INFO - 'tests': ['tp5n']}, 08:58:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:58:30 INFO - 'talos_options': ['--e10s', 08:58:30 INFO - '--xperf_path', 08:58:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:30 INFO - 'tests': ['tp5n']}}, 08:58:30 INFO - 'talos.zip': {'path': '', 08:58:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:58:30 INFO - Running post-action listener: _resource_record_post_action 08:58:30 INFO - ##### 08:58:30 INFO - ##### Running create-virtualenv step. 08:58:30 INFO - ##### 08:58:30 INFO - Running pre-action listener: _resource_record_pre_action 08:58:30 INFO - Running main action method: create_virtualenv 08:58:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:58:30 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 08:58:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:58:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:58:30 INFO - Using real prefix '/usr' 08:58:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:58:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:58:33 INFO - Installing pip.................done. 08:58:33 INFO - Return code: 0 08:58:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:33 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 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58:33 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 08:58:33 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 08:58:33 INFO - Using env: {'DISPLAY': ':0', 08:58:33 INFO - 'HOME': '/home/cltbld', 08:58:33 INFO - 'LANG': 'en_US.UTF-8', 08:58:33 INFO - 'LANGUAGE': 'en_US:en', 08:58:33 INFO - 'LOGNAME': 'cltbld', 08:58:33 INFO - 'MAIL': '/var/mail/cltbld', 08:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:33 INFO - 'MOZ_NO_REMOTE': '1', 08:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:33 INFO - 'NO_EM_RESTART': '1', 08:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:33 INFO - 'SHELL': '/bin/bash', 08:58:33 INFO - 'SHLVL': '1', 08:58:33 INFO - 'TERM': 'linux', 08:58:33 INFO - 'TMOUT': '86400', 08:58:33 INFO - 'USER': 'cltbld', 08:58:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:33 INFO - '_': '/tools/buildbot/bin/python'} 08:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:33 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 08:58:33 INFO - Cleaning up... 08:58:33 INFO - Return code: 0 08:58:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:33 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 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58:33 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 08:58:33 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 08:58:33 INFO - Using env: {'DISPLAY': ':0', 08:58:33 INFO - 'HOME': '/home/cltbld', 08:58:33 INFO - 'LANG': 'en_US.UTF-8', 08:58:33 INFO - 'LANGUAGE': 'en_US:en', 08:58:33 INFO - 'LOGNAME': 'cltbld', 08:58:33 INFO - 'MAIL': '/var/mail/cltbld', 08:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:33 INFO - 'MOZ_NO_REMOTE': '1', 08:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:33 INFO - 'NO_EM_RESTART': '1', 08:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:33 INFO - 'SHELL': '/bin/bash', 08:58:33 INFO - 'SHLVL': '1', 08:58:33 INFO - 'TERM': 'linux', 08:58:33 INFO - 'TMOUT': '86400', 08:58:33 INFO - 'USER': 'cltbld', 08:58:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:33 INFO - '_': '/tools/buildbot/bin/python'} 08:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:33 INFO - Downloading/unpacking psutil>=0.7.1 08:58:33 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 08:58:33 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 08:58:33 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 08:58:33 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 08:58:33 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 08:58:33 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 08:58:35 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:58:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:58:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:58:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:35 INFO - Installing collected packages: psutil 08:58:35 INFO - Running setup.py install for psutil 08:58:35 INFO - building 'psutil._psutil_linux' extension 08:58:35 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 08:58:35 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 08:58:35 INFO - building 'psutil._psutil_posix' extension 08:58:35 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 08:58:36 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 08:58:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:36 INFO - Successfully installed psutil 08:58:36 INFO - Cleaning up... 08:58:36 INFO - Return code: 0 08:58:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:58:36 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')]} 08:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:36 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')]} 08:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:36 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 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58:36 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 08:58:36 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 08:58:36 INFO - Using env: {'DISPLAY': ':0', 08:58:36 INFO - 'HOME': '/home/cltbld', 08:58:36 INFO - 'LANG': 'en_US.UTF-8', 08:58:36 INFO - 'LANGUAGE': 'en_US:en', 08:58:36 INFO - 'LOGNAME': 'cltbld', 08:58:36 INFO - 'MAIL': '/var/mail/cltbld', 08:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:36 INFO - 'MOZ_NO_REMOTE': '1', 08:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:36 INFO - 'NO_EM_RESTART': '1', 08:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:36 INFO - 'SHELL': '/bin/bash', 08:58:36 INFO - 'SHLVL': '1', 08:58:36 INFO - 'TERM': 'linux', 08:58:36 INFO - 'TMOUT': '86400', 08:58:36 INFO - 'USER': 'cltbld', 08:58:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:36 INFO - '_': '/tools/buildbot/bin/python'} 08:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:58:36 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 08:58:36 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 08:58:36 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 08:58:36 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 08:58:36 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 08:58:36 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 08:58:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:58:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:58:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:58:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:58:38 INFO - Installing collected packages: mozsystemmonitor 08:58:38 INFO - Running setup.py install for mozsystemmonitor 08:58:38 INFO - Successfully installed mozsystemmonitor 08:58:38 INFO - Cleaning up... 08:58:38 INFO - Return code: 0 08:58:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:58: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')]} 08:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:38 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 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58:38 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 08:58:38 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 08:58:38 INFO - Using env: {'DISPLAY': ':0', 08:58:38 INFO - 'HOME': '/home/cltbld', 08:58:38 INFO - 'LANG': 'en_US.UTF-8', 08:58:38 INFO - 'LANGUAGE': 'en_US:en', 08:58:38 INFO - 'LOGNAME': 'cltbld', 08:58:38 INFO - 'MAIL': '/var/mail/cltbld', 08:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:38 INFO - 'MOZ_NO_REMOTE': '1', 08:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:38 INFO - 'NO_EM_RESTART': '1', 08:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:38 INFO - 'SHELL': '/bin/bash', 08:58:38 INFO - 'SHLVL': '1', 08:58:38 INFO - 'TERM': 'linux', 08:58:38 INFO - 'TMOUT': '86400', 08:58:38 INFO - 'USER': 'cltbld', 08:58:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:38 INFO - '_': '/tools/buildbot/bin/python'} 08:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:58:38 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 08:58:38 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 08:58:38 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 08:58:38 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 08:58:38 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 08:58:38 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 08:58:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:58:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:58:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:58:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 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 08:58:40 INFO - Downloading docopt-0.6.1.tar.gz 08:58:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:58:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:58:40 INFO - Running setup.py install for blobuploader 08:58:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:58:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:58:41 INFO - Running setup.py install for requests 08:58:41 INFO - Running setup.py install for docopt 08:58:41 INFO - Successfully installed blobuploader requests docopt 08:58:41 INFO - Cleaning up... 08:58:41 INFO - Return code: 0 08:58:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:41 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 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58:41 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 08:58:41 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 08:58:41 INFO - Using env: {'DISPLAY': ':0', 08:58:41 INFO - 'HOME': '/home/cltbld', 08:58:41 INFO - 'LANG': 'en_US.UTF-8', 08:58:41 INFO - 'LANGUAGE': 'en_US:en', 08:58:41 INFO - 'LOGNAME': 'cltbld', 08:58:41 INFO - 'MAIL': '/var/mail/cltbld', 08:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:41 INFO - 'MOZ_NO_REMOTE': '1', 08:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:41 INFO - 'NO_EM_RESTART': '1', 08:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:41 INFO - 'SHELL': '/bin/bash', 08:58:41 INFO - 'SHLVL': '1', 08:58:41 INFO - 'TERM': 'linux', 08:58:41 INFO - 'TMOUT': '86400', 08:58:41 INFO - 'USER': 'cltbld', 08:58:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:41 INFO - '_': '/tools/buildbot/bin/python'} 08:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:58:41 INFO - Running setup.py (path:/tmp/pip-18GlvC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:58:41 INFO - Running setup.py (path:/tmp/pip-pcMjRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:58:41 INFO - Running setup.py (path:/tmp/pip-DQcCzx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:58:42 INFO - Running setup.py (path:/tmp/pip-tJLHV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:58:42 INFO - Running setup.py (path:/tmp/pip-ArlaLs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:58:42 INFO - Running setup.py (path:/tmp/pip-fziXrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:58:42 INFO - Running setup.py (path:/tmp/pip-zNAfEi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:58:42 INFO - Running setup.py (path:/tmp/pip-6pGa9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:58:42 INFO - Running setup.py (path:/tmp/pip-M5z1lA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:58:42 INFO - Running setup.py (path:/tmp/pip-HFRAOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:58:42 INFO - Running setup.py (path:/tmp/pip-7Q10_V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:58:42 INFO - Running setup.py (path:/tmp/pip-UO5CG2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:58:42 INFO - Running setup.py (path:/tmp/pip-EWMNM9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:58:42 INFO - Running setup.py (path:/tmp/pip-i5uq_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:58:42 INFO - Running setup.py (path:/tmp/pip-wklsLr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:58:42 INFO - Running setup.py (path:/tmp/pip-f0GZKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:58:42 INFO - Running setup.py (path:/tmp/pip-TUJwMN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:58:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:58:43 INFO - Running setup.py install for manifestparser 08:58:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Running setup.py install for mozcrash 08:58:43 INFO - Running setup.py install for mozdebug 08:58:43 INFO - Running setup.py install for mozdevice 08:58:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Running setup.py install for mozfile 08:58:43 INFO - Running setup.py install for mozhttpd 08:58:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Running setup.py install for mozinfo 08:58:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Running setup.py install for mozInstall 08:58:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:58:43 INFO - Running setup.py install for mozleak 08:58:43 INFO - Running setup.py install for mozlog 08:58:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:58:44 INFO - Running setup.py install for moznetwork 08:58:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:58:44 INFO - Running setup.py install for mozprocess 08:58:44 INFO - Running setup.py install for mozprofile 08:58:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:58:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:58:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:58:44 INFO - Running setup.py install for mozrunner 08:58:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:58:44 INFO - Running setup.py install for mozscreenshot 08:58:44 INFO - Running setup.py install for moztest 08:58:44 INFO - Running setup.py install for mozversion 08:58:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:58:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:58:44 INFO - Cleaning up... 08:58:44 INFO - Return code: 0 08:58:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:58: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')]} 08:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', '-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 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58:44 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 08:58:44 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 08:58:44 INFO - Using env: {'DISPLAY': ':0', 08:58:44 INFO - 'HOME': '/home/cltbld', 08:58:44 INFO - 'LANG': 'en_US.UTF-8', 08:58:44 INFO - 'LANGUAGE': 'en_US:en', 08:58:44 INFO - 'LOGNAME': 'cltbld', 08:58:44 INFO - 'MAIL': '/var/mail/cltbld', 08:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:44 INFO - 'MOZ_NO_REMOTE': '1', 08:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:44 INFO - 'NO_EM_RESTART': '1', 08:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:44 INFO - 'SHELL': '/bin/bash', 08:58:44 INFO - 'SHLVL': '1', 08:58:44 INFO - 'TERM': 'linux', 08:58:44 INFO - 'TMOUT': '86400', 08:58:44 INFO - 'USER': 'cltbld', 08:58:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:44 INFO - '_': '/tools/buildbot/bin/python'} 08:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:58:45 INFO - Running setup.py (path:/tmp/pip-9eMq2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:58:45 INFO - Running setup.py (path:/tmp/pip-F4373o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:58:45 INFO - Running setup.py (path:/tmp/pip-4y5uIO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:58:45 INFO - Running setup.py (path:/tmp/pip-jGIuCL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:58:45 INFO - Running setup.py (path:/tmp/pip-gbzUWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:58:45 INFO - Running setup.py (path:/tmp/pip-ANfNA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:58:45 INFO - Running setup.py (path:/tmp/pip-VSjZP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:58:45 INFO - Running setup.py (path:/tmp/pip-h0FARz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:58:45 INFO - Running setup.py (path:/tmp/pip-JYq1gF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:58:45 INFO - Running setup.py (path:/tmp/pip-6gCOhd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:58:45 INFO - Running setup.py (path:/tmp/pip-UCDv0_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:58:45 INFO - Running setup.py (path:/tmp/pip-v9IjYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:58:45 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)) 08:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:58:45 INFO - Running setup.py (path:/tmp/pip-f2TdKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:58:46 INFO - Running setup.py (path:/tmp/pip-uYRfCU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:58:46 INFO - Running setup.py (path:/tmp/pip-2TYy6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:58:46 INFO - Running setup.py (path:/tmp/pip-HgtSF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:58:46 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)) 08:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:58:46 INFO - Running setup.py (path:/tmp/pip-ynRzi4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:58:46 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)) 08:58:46 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)) 08:58:46 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)) 08:58:46 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)) 08:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:58:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:48 INFO - Downloading blessings-1.5.1.tar.gz 08:58:48 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 08:58:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:58:48 INFO - Installing collected packages: blessings 08:58:48 INFO - Running setup.py install for blessings 08:58:48 INFO - Successfully installed blessings 08:58:48 INFO - Cleaning up... 08:58:48 INFO - Return code: 0 08:58:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:58:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:58:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:58:48 INFO - Reading from file tmpfile_stdout 08:58:48 INFO - Current package versions: 08:58:48 INFO - argparse == 1.2.1 08:58:48 INFO - blessings == 1.5.1 08:58:48 INFO - blobuploader == 1.2.4 08:58:48 INFO - docopt == 0.6.1 08:58:48 INFO - manifestparser == 1.1 08:58:48 INFO - mozInstall == 1.12 08:58:48 INFO - mozcrash == 0.16 08:58:48 INFO - mozdebug == 0.1 08:58:48 INFO - mozdevice == 0.48 08:58:48 INFO - mozfile == 1.2 08:58:48 INFO - mozhttpd == 0.7 08:58:48 INFO - mozinfo == 0.9 08:58:48 INFO - mozleak == 0.1 08:58:48 INFO - mozlog == 3.1 08:58:48 INFO - moznetwork == 0.27 08:58:48 INFO - mozprocess == 0.22 08:58:48 INFO - mozprofile == 0.28 08:58:48 INFO - mozrunner == 6.11 08:58:48 INFO - mozscreenshot == 0.1 08:58:48 INFO - mozsystemmonitor == 0.0 08:58:48 INFO - moztest == 0.7 08:58:48 INFO - mozversion == 1.4 08:58:48 INFO - psutil == 3.1.1 08:58:48 INFO - requests == 1.2.3 08:58:48 INFO - wsgiref == 0.1.2 08:58:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 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 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58:48 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 08:58:48 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 08:58:48 INFO - Using env: {'DISPLAY': ':0', 08:58:48 INFO - 'HOME': '/home/cltbld', 08:58:48 INFO - 'LANG': 'en_US.UTF-8', 08:58:48 INFO - 'LANGUAGE': 'en_US:en', 08:58:48 INFO - 'LOGNAME': 'cltbld', 08:58:48 INFO - 'MAIL': '/var/mail/cltbld', 08:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:48 INFO - 'MOZ_NO_REMOTE': '1', 08:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:48 INFO - 'NO_EM_RESTART': '1', 08:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:48 INFO - 'SHELL': '/bin/bash', 08:58:48 INFO - 'SHLVL': '1', 08:58:48 INFO - 'TERM': 'linux', 08:58:48 INFO - 'TMOUT': '86400', 08:58:48 INFO - 'USER': 'cltbld', 08:58:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:48 INFO - '_': '/tools/buildbot/bin/python'} 08:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 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)) 08:58:48 INFO - Cleaning up... 08:58:49 INFO - Return code: 0 08:58:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:58: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')]} 08:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58: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', 'jsonschema'] in /builds/slave/test-pgo/build 08:58: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 jsonschema 08:58:49 INFO - Using env: {'DISPLAY': ':0', 08:58:49 INFO - 'HOME': '/home/cltbld', 08:58:49 INFO - 'LANG': 'en_US.UTF-8', 08:58:49 INFO - 'LANGUAGE': 'en_US:en', 08:58:49 INFO - 'LOGNAME': 'cltbld', 08:58:49 INFO - 'MAIL': '/var/mail/cltbld', 08:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:49 INFO - 'MOZ_NO_REMOTE': '1', 08:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:49 INFO - 'NO_EM_RESTART': '1', 08:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:49 INFO - 'SHELL': '/bin/bash', 08:58:49 INFO - 'SHLVL': '1', 08:58:49 INFO - 'TERM': 'linux', 08:58:49 INFO - 'TMOUT': '86400', 08:58:49 INFO - 'USER': 'cltbld', 08:58:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:49 INFO - '_': '/tools/buildbot/bin/python'} 08:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:49 INFO - Downloading/unpacking jsonschema 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:58:50 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 08:58:50 INFO - Downloading/unpacking functools32 (from jsonschema) 08:58:50 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 08:58:50 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 08:58:50 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 08:58:50 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 08:58:50 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 08:58:50 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 08:58:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:58:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:58:51 INFO - warning: no files found matching '*.txt' 08:58:51 INFO - no previously-included directories found matching 'build' 08:58:51 INFO - no previously-included directories found matching 'dist' 08:58:51 INFO - no previously-included directories found matching '.git*' 08:58:51 INFO - Installing collected packages: jsonschema, functools32 08:58:51 INFO - Running setup.py install for functools32 08:58:51 INFO - warning: no files found matching '*.txt' 08:58:51 INFO - no previously-included directories found matching 'build' 08:58:51 INFO - no previously-included directories found matching 'dist' 08:58:51 INFO - no previously-included directories found matching '.git*' 08:58:51 INFO - Successfully installed jsonschema functools32 08:58:51 INFO - Cleaning up... 08:58:51 INFO - Return code: 0 08:58:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:58: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')]} 08:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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')]} 08:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0281972f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, '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': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', '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 08:58: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', 'flake8'] in /builds/slave/test-pgo/build 08:58: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 flake8 08:58:51 INFO - Using env: {'DISPLAY': ':0', 08:58:51 INFO - 'HOME': '/home/cltbld', 08:58:51 INFO - 'LANG': 'en_US.UTF-8', 08:58:51 INFO - 'LANGUAGE': 'en_US:en', 08:58:51 INFO - 'LOGNAME': 'cltbld', 08:58:51 INFO - 'MAIL': '/var/mail/cltbld', 08:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:51 INFO - 'MOZ_NO_REMOTE': '1', 08:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:51 INFO - 'NO_EM_RESTART': '1', 08:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:58:51 INFO - 'SHELL': '/bin/bash', 08:58:51 INFO - 'SHLVL': '1', 08:58:51 INFO - 'TERM': 'linux', 08:58:51 INFO - 'TMOUT': '86400', 08:58:51 INFO - 'USER': 'cltbld', 08:58:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:51 INFO - '_': '/tools/buildbot/bin/python'} 08:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:51 INFO - Downloading/unpacking flake8 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:58:53 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 08:58:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:58:53 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 08:58:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:53 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 08:58:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58: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 08:58:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:58:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:58:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:58:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:58:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:58:53 INFO - no previously-included directories found matching 'docs/_build' 08:58:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:58:54 INFO - Running setup.py install for pep8 08:58:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:58:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:58:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:58:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:58:54 INFO - no previously-included directories found matching 'docs/_build' 08:58:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:58:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:58:54 INFO - Cleaning up... 08:58:54 INFO - Return code: 0 08:58:54 INFO - Running post-action listener: _resource_record_post_action 08:58:54 INFO - Running post-action listener: _start_resource_monitoring 08:58:54 INFO - Starting resource monitoring. 08:58:54 INFO - ##### 08:58:54 INFO - ##### Running install step. 08:58:54 INFO - ##### 08:58:54 INFO - Running pre-action listener: _resource_record_pre_action 08:58:54 INFO - Running main action method: install 08:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:58:54 INFO - Reading from file tmpfile_stdout 08:58:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:58:54 INFO - Reading from file tmpfile_stdout 08:58:54 INFO - Output received: 08:58:54 INFO - Usage: mozinstall [options] installer 08:58:54 INFO - Options: 08:58:54 INFO - -h, --help show this help message and exit 08:58:54 INFO - -d DEST, --destination=DEST 08:58:54 INFO - Directory to install application into. [default: 08:58:54 INFO - "/builds/slave/test-pgo"] 08:58:54 INFO - --app=APP Application being installed. [default: firefox] 08:58:54 INFO - mkdir: /builds/slave/test-pgo/build/application 08:58:54 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'] 08:58:54 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 08:59:10 INFO - Reading from file tmpfile_stdout 08:59:10 INFO - Output received: 08:59:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:59:10 INFO - Running post-action listener: _resource_record_post_action 08:59:10 INFO - ##### 08:59:10 INFO - ##### Running run-tests step. 08:59:10 INFO - ##### 08:59:10 INFO - Running pre-action listener: _resource_record_pre_action 08:59:10 INFO - Running main action method: run_tests 08:59:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:59:10 INFO - Python 2.7.3 08:59:10 INFO - Return code: 0 08:59:10 INFO - grabbing minidump binary from tooltool 08:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:10 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 0x20a8660>, '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 0x20a9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:59:10 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 08:59:10 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 08:59:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:59:10 INFO - Return code: 0 08:59:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:59:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:59:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:59:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:59:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:59:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:59:11 INFO - Return code: 0 08:59:11 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 08:59:11 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:59:11 INFO - Using env: {'DISPLAY': ':0', 08:59:11 INFO - 'HOME': '/home/cltbld', 08:59:11 INFO - 'LANG': 'en_US.UTF-8', 08:59:11 INFO - 'LANGUAGE': 'en_US:en', 08:59:11 INFO - 'LOGNAME': 'cltbld', 08:59:11 INFO - 'MAIL': '/var/mail/cltbld', 08:59:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:59:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:11 INFO - 'MOZ_NO_REMOTE': '1', 08:59:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:11 INFO - 'NO_EM_RESTART': '1', 08:59:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:59:11 INFO - 'PWD': '/builds/slave/test-pgo', 08:59:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:59:11 INFO - 'SHELL': '/bin/bash', 08:59:11 INFO - 'SHLVL': '1', 08:59:11 INFO - 'TERM': 'linux', 08:59:11 INFO - 'TMOUT': '86400', 08:59:11 INFO - 'USER': 'cltbld', 08:59:11 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915', 08:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:11 INFO - '_': '/tools/buildbot/bin/python'} 08:59:11 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:59:11 INFO - mozversion application_buildid: 20160114060719 08:59:11 INFO - mozversion application_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 08:59:11 INFO - mozversion application_display_name: Nightly 08:59:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:59:11 INFO - mozversion application_name: Firefox 08:59:11 INFO - mozversion application_remotingname: firefox 08:59:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:59:11 INFO - mozversion application_vendor: Mozilla 08:59:11 INFO - mozversion application_version: 46.0a1 08:59:11 INFO - mozversion platform_buildid: 20160114060719 08:59:11 INFO - mozversion platform_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 08:59:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:59:11 INFO - mozversion platform_version: 46.0a1 08:59:11 INFO - using testdate: 1452790751 08:59:11 INFO - actual date: 1452790751 08:59:11 INFO - starting webserver on 'localhost:51122' 08:59:11 INFO - SUITE-START | Running 3 tests 08:59:11 INFO - TEST-START | dromaeo_css 08:59:11 INFO - operating with platform_type : linux_ 08:59:11 INFO - Initialising browser for dromaeo_css test... 08:59:11 INFO - TEST-INFO | started process 355 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9kgwtS/profile http://localhost:51122/getInfo.html) 08:59:15 INFO - PROCESS | 355 | 08:59:15 INFO - PROCESS | 355 | (process:441): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:59:16 INFO - PROCESS | 355 | __metrics Screen width/height:1600/1200 08:59:16 INFO - PROCESS | 355 | colorDepth:24 08:59:16 INFO - PROCESS | 355 | Browser inner width/height: 1024/670 08:59:16 INFO - PROCESS | 355 | __metrics 08:59:16 INFO - PROCESS | 355 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:59:17 INFO - TEST-INFO | 355: exit 0 08:59:17 INFO - Browser initialized. 08:59:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:59:17 INFO - TEST-INFO | started process 490 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9kgwtS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:19 INFO - PROCESS | 490 | 08:59:19 INFO - PROCESS | 490 | (process:549): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:59:29 INFO - PROCESS | 490 | RSS: Main: 150892544 08:59:29 INFO - PROCESS | 490 | 09:00:19 INFO - PROCESS | 490 | 1452790819173 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:02:28 INFO - PROCESS | 490 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51122/tests/dromaeo/cssquery-ext.html) 09:02:29 INFO - PROCESS | 490 | RSS: Main: 155435008 09:02:29 INFO - PROCESS | 490 | 09:05:31 INFO - PROCESS | 490 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-ext.html (next: http://localhost:51122/tests/dromaeo/cssquery-jquery.html) 09:05:32 INFO - PROCESS | 490 | RSS: Main: 153227264 09:05:32 INFO - PROCESS | 490 | 09:08:33 INFO - PROCESS | 490 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51122/tests/dromaeo/cssquery-mootools.html) 09:08:34 INFO - PROCESS | 490 | RSS: Main: 151195648 09:08:34 INFO - PROCESS | 490 | 09:11:36 INFO - PROCESS | 490 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51122/tests/dromaeo/cssquery-prototype.html) 09:11:36 INFO - PROCESS | 490 | RSS: Main: 150851584 09:11:36 INFO - PROCESS | 490 | 09:14:39 INFO - PROCESS | 490 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51122/tests/dromaeo/cssquery-yui.html) 09:14:39 INFO - PROCESS | 490 | RSS: Main: 151842816 09:14:39 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | Cycle 1(1): loaded http://localhost:51122/tests/dromaeo/cssquery-yui.html (next: http://localhost:51122/tests/dromaeo/cssquery-dojo.html) 09:17:42 INFO - PROCESS | 490 | RSS: Main: 153886720 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | __start_tp_report 09:17:42 INFO - PROCESS | 490 | _x_x_mozilla_page_load 09:17:42 INFO - PROCESS | 490 | _x_x_mozilla_page_load_details 09:17:42 INFO - PROCESS | 490 | |i|pagename|runs| 09:17:42 INFO - PROCESS | 490 | |0;dojo.html;3150.4329220740265;3166.2559298564834;3184.633767116782;3204.1028512016637;3217.2117831131377;5080.745962701869;5098.031374038935;5118.9488105118935;5162.974185129074;5224.190250511177;5044.974775126128;5117.437081920985;5204.817831375903;5255.579553635709;5264.657797243186;4612.677112602119;4644.628429725613;4682.601978831786;4716.339712440261;4758.928616070744;4664.4402671679445;4717.363155973934;4726.527347265281;4774.212254977924;4780.067886762083;4608.884777880547;4621.65337599678;4723.3859598252175;4752.40594925636;4753.33453316536;4738.857834264943;4775.713457192544;4787.8563643090765;4799.472058073609;4830.686005409672;4730.511851119536;4742.193827049376;4746.596539294164;4784.162771514971;4790.257510085942;4954.777035033432;4963.578095861856;5028.698278103326;5098.4646612105935;5177.456367081478;5605.803796867131;5618.438156184389;5622.606417550773;5631.915521267184;5663.575231857586;5606.24315717377;5629.662220266756;5689.971550142222;5696.23100881384;5716;5102.617303702237;5166.9224961625605;5174.197999310113;5243.659162154448;5333.973330133402;5686;5697.259356283656;5700.942990570041;5716.1997320375185;5716.942830571724;5490.6431081979545;5505.339359276913;5514.255575497336;5519.558435325244;5529.1349371034485;5496.395396506381;5562.137868630369;5571.9442805572235;5646.407127251661;5699.401562835926;5489;5537.612367134262;5561.555075593943;5568.443155684399;5574.358948720868;5401.351837779492;5537.446255374431;5551.333839939233;5551.500364967173;5559.471850174227;4276.957230427656;4282.850100246476;4298.527162012176;4299.14017196562;4344.913101737948;3855.9614403855603;3868.5507592018175;3887.494625698641;3897.57126716061;3914.393269043303;5085.415177254663;5174.7930082796265;5188.662736922088;5225.294585230945;5285.68285902847;5489.478499542537;5523.337199536081;5536.529395001389;5554.389017208104;5570.944290557123;5179.637425380187;5203.8178663746585;5230.08473517133;5236.162214045735;5326.36083669962;4700.741459219776;4763.166445871959;4824.300476430898;4828.275758636232;4838.564529192389;5653.745581448845;5705.058665320259;5713.114467257582;5716.628419152742;5758.1650660654805;5439.102548079681;5533.142362933751;5534.695591742332;5537.473939975695;5541.639793413416;5604.3835178131185;5614.63504872182;5664.773409063591;5685.260916080883;5724.771009159587;5344.679319240858;5384.596155288291;5390.865228369322;5409.215663728816;5437.293151890229;5414.972925135349;5449.6185267032515;5454.263674404064;5461.781528738806;5505.6696598204235;5174.689518628894;5214.270002199619;5261.053010458154;5290.523852853262;5321.6540924839765;5375.274337964324;5434.2935418395355;5444.6188766785945;5446.782128714807;5473.480019398151;5362.249285100167;5412.134058550613;5424;5432.755526001419;5465.562754979672;5379.892402151857;5466.508014278734;5476.780928762805;5477.808276710296;5494.642848214853;5222.216667499905;5268.1044222481505;5291.365036195682;5301.867453313698;5327.413984461628 09:17:42 INFO - PROCESS | 490 | |1;ext.html;525.5952916254487;526.4814158054317;526.5839986410735;547.1191381875179;553.6318348298382;35736.10659733505;36742.63257367426;36751.26497470049;36872;36873.44689829655;39718.801405993;40352.192956140934;40362;40380.59619403805;40523.189536209335;8510.702125425596;8543.700970466034;8635.740927772145;8741.912580874205;8766;8432.789180270482;8483.618237179342;8498.702545410912;8550.444221125637;8592.742217733477;8750.124987501262;8788.912110878873;8836.160564746371;8851.911480885205;8868.113188681113;8689.391742578022;8710.433821801595;8712.172343627408;8753;8776.473411595325;8589.828203435896;8700.173483519056;8714.25928796053;8714.912850871473;8715.520646364448;39452.40821387653;39630.80184599059;39961;39988.40017399741;40023.39964900529;3039.3313471036336;3174.571432856581;3241.692039256267;3502.159481724393;3961.1285517186175;29728.056864467686;30179.69820301791;30188.396232075454;30250.54624180639;30550.54174187389;3721.162738383869;3867.16855875988;4038.737482063686;4055.5538890721996;4070.4504891839815;255756;257499;257598;257979;259593.9999999981;43782.56217437849;44253.336199957026;58559.707201464575;58866.41133588609;59114.11328830071;42099;42194.15611687749;42229.78885105555;42354.57645423568;42362.57637423648;12519.812202816966;12520.561780337644;12526.81209781854;12534.937325313314;12550.246985180918;9636.903630963741;9650.227981761442;9732.805343893082;9754.0733630305;9758.609655613838;14337.56987290383;14627;14632.707345853023;14781.630459238606;14820.851791481948;5743.425657434307;5835.387284335168;5863.618864773776;5875.559333050039;5953.047512397996;881.6693739847557;906.8911730592371;961.8701475300885;962.2734835199519;962.3119469579144;28661.28346791347;28687.56968645472;28938.421231575252;28942.710572894423;29163.270918227216;958.6596758150896;1008.9154159278804;1071.9663352711807;1078.3044936016227;1100.9815920273716;14835.777463337843;14847.70304593902;14955.700885982436;15064.397424102914;15078;323778;326167;327121;327337;328719;51208.719782005006;51850.740746296025;51933.22100168501;52334;52473.7376313116;1296.9546065887837;1299.8310219671382;1318.6241921052454;1334.0461569977513;1335.5859683498147;27374;28344.858275709314;28498.57252141261;28508.287292817844;28759.424811504072;46543.301850471595;46715.766421167675;46742.532574673816;47017;47219;289936;293493;293637;293677;293863;33162.336753265285;43489.34765978449;43571.56428435675;43716.34425483557;44533.77733111314;41023.179536408505;42266;42549.5745042558;42740.14519709526;43025;36149.65027273324;36158.819205903805;36161.45757813582;36686.816565917;36709.26581468409;36437;36733.26533469262;37258.44112338263;37375.252494950495;37382;35226.47160292649;35333.64666353406;35457.64542354544;35625.82187089048;35953.28093438169;31234.21914452066;31673.683263167073;32743.836280818443;33023.834880825445;33320.66679333176;25052;25148.49703005893;25287;25529.361765956;25749.3562660935 09:17:42 INFO - PROCESS | 490 | |2;jquery.html;365.87560229521955;367.7756568493219;367.98344074516643;370.32046195231754;375.80458161755905;11136.944315278412;11684.649460516177;15434.845651543481;16946.661066778655;17932.28270869165;16668.83331166688;16865;17604.119794010312;17660.82339176608;17732.734008989843;5399.541039011679;5716.1711551824965;5721.056025755766;5731.054376027951;5734.311882574097;5496.560275177996;5907.852303692399;5926.170336152942;5975.372585878486;6005.309389420229;5969.791057312973;5976.4919981801595;6172.814815555518;6456.644884531349;6468.094466774655;6345.682715864212;6401;6470.967645161768;6751.729930802762;6808.183018037817;6294.622322660609;6502.089707440962;6507.349265073455;6516.1203237562795;6524.673766311713;19291.4212573623;19580.804191958185;20124.396268111832;21944.670829937564;22457.55084898293;2152.2897443843494;2172.1528603844513;2200.9119635214574;2285.063124119103;2356.5286942611374;12559.183653062613;12998.610041698765;13219.272939988297;13396.665083372896;13485.258310792902;1860.5720684242565;1904.1621686458052;1926.7784204816485;1978.910949007298;2015.203994422195;60504.39495605075;61118.388816111714;62628.68685656588;63254.36745632531;63695.363046369406;14747.18890461035;14778.408863645334;14900.552983410515;14925.552233433014;15037;23119.24410955611;23237.88381058084;23253.76746232516;23358.883205584203;23502.177423790086;7915.366770658334;8103.797405064803;8193.549354785544;8209.671613135408;8249.752507424786;6678.565893216925;6680;6703.095082163845;6745.325467453215;6780.355866192704;7525.4355923305975;7534.886976695354;7598.620068996528;7626;7668.578228197391;1718.4672751446842;1760.4649305000758;1772.1139430284857;2978.776591755627;3060.938781224363;394.5699187885219;852.8123812761182;898.4878619187001;987.6493844685177;994.4182653147844;9849.852252216222;10694.197935154894;10877.728056798485;15647.843521564866;15739;907.8774365460711;920.6271460058553;924.4776701163821;934.6261495401758;1011.6560369474267;8988.55057247135;9001.729948101567;9009.819803603892;9432.19826314771;9548.713538593853;519380;523044;526755;536045;538882;64029.35970640234;71016;72413.27586724171;72429;72442.63778681072;1141.14414189358;1149.1611123879447;1175.5121624525725;1176.2413243458093;1178.1811640909486;14254.857451425352;14346.641333966318;14399.640008999859;14422.134671919719;14721.92639036798;29473.263168420963;29593;30219.69780302257;30307.393852123274;31131.844340778152;38149.61850381461;38979.2204155921;39891.80054099711;42222;44290.77854610706;7265.782026539212;7327.267273272843;7332.41340692754;7431.516951398142;7529.435292353205;10071.899281007389;10444.634437794944;10489.947550262199;11153.72115697114;11175.976668273332;9245.352825302165;9308;9358.578863951274;9705.951470242604;9710.951445242728;3102.8293443860803;3386.881459148918;9043.23132533742;9235.722928312161;9678.516074196403;9735.561899714672;10003.849942251018;10127.088562029452;10336.793264134825;10345.63790267337;6757.45940324763;7246.4202863771825;7247.057882475245;7518.28576285252;7663.1570527243075;9285.582148803185;9405.905940940776;9504.382215156269;9664.613415463302;9902.257330700082 09:17:42 INFO - PROCESS | 490 | |3;mootools.html;1502.1137528857976;1514.4775052606851;1645.2596331650752;1739.3129713763071;1761.1458442655319;7471.589062601554;7539.359154471869;7676.501027433213;7681.961590192048;7783.727569535067;7701.730439434621;7770.68917243311;7827.882581761264;7839.4512384132995;7860.960695196516;2266.0595852721144;2277.464795772992;2293.174457195408;2296.6555016747457;2302.0791683326634;2296.2537175417974;2305.965410518844;2320.582295186866;2325.2907863101746;2330.545543618995;2205.7353117625908;2241.226776762023;2261.0955617752866;2285.314405678298;2288.1533832482005;2291.324059402472;2294.7819957104048;2297.3911913342977;2312.953740925189;2323.53529294141;2305.9769402306097;2329.6389059695775;2331.3588763090115;2332.346942856003;2339.2982105368324;7778.727744528971;7807.102183248942;7899.644515996736;7900.091489478726;7918.960405197937;4677.18149323867;4782.689125206851;4844.442889067767;4844.709317440965;4854.466008739036;2978.166113488227;3017.698230176965;3048.2684155802667;3057.801242919203;3073.861676224575;967.8171063656835;983.2625530851861;988.619381538113;990.5641517732247;1017.6641708236265;10640.680779576625;10663.84004239937;10675;10680.038796508274;10728.195385346053;4011.6590089842107;4052.2503336882182;4129.855455059059;4133.194027164674;4180;8661.913380866237;8671.869921951176;8701;8734.519601421856;8748.343874209333;4629.120467111238;4661.463931647836;4662.557057079572;4668.743219122913;4675.392199014174;4234.216669916075;4257.978710106429;4264.402983582301;4271.124419493996;4292.12011537634;3428.468587368962;3436.7766095203733;3467.8612855486003;3472.5659292588425;3491.6857482826667;1024.0578667625803;1032.932859364154;1036.3315661398356;1038.8182068138046;1045.5713157605346;921.8571121476182;921.9769505762409;926.1063074133493;947.9194268487256;1281.5002149161835;6975.651217439107;7089.291070892869;7100.076989991268;7114.14630244374;7121.501494895308;1057.8942105789513;1077.5366592365358;1079.8920107989138;1083.3283364314018;1123.9887601124049;5123.180291153398;5176.430592634807;5239.187925871496;5252.632315737938;5289.444608316148;8998.370114092082;9079.18287354128;9433.575489103006;9485.952570237105;9559.091886270931;9276.257899368034;9287;9342.299327550461;9359.906400935903;9468.337216394924;7275.4179665626625;7447.962760186165;7453.925460745323;7457.254274572608;7513.910482980046;7005.194402643761;7006.6846991886505;7019.227884932551;7045.612491313027;7056.576605403692;8242.505449673039;8263.504189748634;8536.103709110454;8560;8668.219860212612;8508.404411691123;8516.361272904433;8581.95709021451;8620.482771033758;8691.087435819149;6525.347465253437;6841.315868413119;6841.93158068413;6842.726290948306;6855.520113592001;7420.443466739908;7491.9625401872645;7508.549487030796;7513.812154696177;7531.8117047074265;6907;6952.130983627047;7081.327273908971;7182.497225194186;7218;6853.86911159673;6892.793216203522;6919.273476284918;6950.8609827804175;6966.12923384577;7005.859882802417;7010.439164866901;7039.718411263492;7042.859142817218;7091.361777440055;6462.095306657166;6497.382748638872;6519.73921043172;6530.412262896362;6541.70562324687;6395.776147834804;6447.871042579216;6456;6457.418832305115;6557.377049180321 09:17:42 INFO - PROCESS | 490 | |4;prototype.html;312.99217519562023;318.980861148331;323.7733586489457;329.1278113000548;333.5180663940606;6173.228346456693;6302.653354065525;6303.054541818729;6342.14381058557;6352.047192921064;6109.14471973924;6235.220597425322;6240.31356550779;6241.687915604224;6245.9063114053215;4735.834245801398;4775.570198682118;4776.90446191076;4780.163471392492;4792.856214313559;4752.263399173134;4759.048190361924;4769.18923782956;4781.0676918001;4785.90428191436;4664.883377915546;4720.457147428038;4741.881452963687;4747.311639812225;4753.382060332152;4703.43558772946;4724.078804633098;4735.976320118394;4749;4749.050189962021;4146.295129827937;4152.709310348277;4157.771322577257;4160.729552579103;4164.479440069991;5872.706364681749;5891.499222566087;5898.174255604219;5918;5927.170196172539;5400.243965844785;5508.20131080991;5510.586705997066;5536.667799932017;5547.944520554824;6623.3045530219115;6633.2040155181685;6635.601863888182;6644.202695676501;6656.93343066568;4585.95414045862;4597.195490789132;4599.540045995407;4606.332081848113;4608.009278005212;6779.2881747416795;6880.69036893341;6900.171979362459;6933.826654333631;6940.618265995368;4700.835470758507;4703;4712.198926182557;4713.363695901078;4715.74063426508;4762.309465127537;4767.308740232716;4767.904641907143;4771.880702982453;4776.761161941889;5505.678637127061;5510.448955104457;5510.504054635102;5533.03171944908;5534.667919924817;6506.284308726036;6664.166979127609;6669.4330981866115;6672.933270667231;6691.732330706717;1609.316040682705;1621.8621417179436;1638.0826737027303;1642.7043132236074;1660.062064933333;1057.8095942730383;1074.4735079810837;1086.8043752124536;1089.7112265249716;1100.0539535999035;6218.533609979179;6220.813375598739;6224.564280500412;6269.8746025079245;6269.993602047392;6793.796186114425;6839.863202735917;6853.657317134123;6855.760048398282;6857.25140089284;6140.846478838065;6163.445289923839;6175.505959523227;6205.782797602153;6240.188775459252;3698.3158115748674;3701.5188025556504;3712.6101759314884;3724.7020238380865;3725.832337544817;7082.362587367059;7109;7110.857782844314;7130;7162.247963963813;6823.147106611674;6976.395429051245;6983.546069505466;6993.160820701447;7008.229094799568;7108.218096009435;7116.217216106224;7127.679254433563;7133.785986420519;7134.179569349488;6765.42493888025;6788.422984046411;6815.93184068153;6818.079559259437;6835.829104272433;6631.303713110247;6728.831779205559;6742.561733487308;6754.696038678173;6822.249552549315;7189.1013623297085;7232.674529646073;7244.239354867663;7246;7252;4592.931106033479;4620.445546534437;4640.767961601839;4655.604273636779;4663.370444989883;6860.2453730088655;6926.792196234121;6957.721691132298;6969.16370035599;7040.577565346096;6811.591304521745;6833.487488438288;6841;6852.725890964306;6863.485238607024;6809.182898052265;6817.216020157745;6831.521793474409;6832.453403727789;6850.280720524273;6521.413072823469;6667.599944003376;6690.13028306317;6693;6698.866022679616;6822.3859852613505;6828.795136145924;6834.316568343126;6838.829029274308;6865.656717164022;6576.967115164393;6603.537752357481;6620.649669367498;6664.733410663519;6692.795296846614 09:17:42 INFO - PROCESS | 490 | |5;yui.html;683.8563901580668;777.6928113395207;812.1553584272357;826.29764700005;856.4818284937613;13091.869081309183;13100.29696139503;13156.934215328922;13218;13275.734485310288;12780.233186008823;12794.424250908709;12907.096503244753;12916.418761155746;12961.092723509359;659.5844617890734;667.5660820466687;802.2258520527689;826.7767702720262;830.1988581019315;809.2716555100427;811.342812322021;816.4529765057425;819.2708489444399;825.0347093900151;844.3962566764762;845.1421806866036;849.3247867944998;850.6512329944724;852.799592095857;831.2269589281965;839.3369238301734;841.3899922556159;842.2209456253003;843.1231519219973;628.7830698409042;628.9622622642656;629.527854109418;629.7512482569405;629.8456878064858;12899;13015.15401498909;13062.412191451407;13115.344232788419;13144.934275328658;12649.683757906034;12862.485500579965;13070.542531011464;13236.338183090807;13444.596662100153;10888.61889833852;10970.286931349438;11095.119457651332;11322.49048792798;11462.82805757906;3589.2283159120916;3609.386404311247;3619.2218672985173;3621.9094522636883;3639.7998110103936;45899.54100458986;45984;46199.76900115512;46455.53544464546;47578.5242147581;9799.853002204973;9865.457399842933;9872.605095796087;9895.752606184902;9900.900990989998;18148.274069037092;18317.450476485727;18321.7251741224;18405.447836564923;18434.170462329228;7303.671334789948;7335.339819416278;7422.369098626677;7509.962450187823;7644.694212231449;4129.236091323115;4136.841684328393;4173.853915112956;4194.266003449445;4227.6406505447385;2961.4373269078806;3024.107888172994;3032.1358412852233;3033.9836154888358;3044;523.500057445139;525.0549011778783;527.2618334331966;528.408182835227;555.0342404216634;475.86675730795434;508.74054232341774;560.9411011843779;597.3190562758459;625.7309356976543;8025.678972841138;8619.267362274277;8917.598708058153;8960.283177345797;9059.123010330957;504.67700671570225;550.9256250406224;563.1130968724276;567.3447168520365;572.4904834697123;4069.4302797608357;4103.5997274214515;4170.562090980464;4290.935635965463;4417.757023363746;54073.1889021665;54924.73545630698;55014.449855500934;55021.724891375285;55329;47711.28433073506;48870.26694599584;49016.5098349012;49559.256611150864;49578.25632615513;44382;45162.09675806531;45308.09383812305;45542.08915821731;45554.54445455503;8753.25619735909;8832.205101540892;8886.644534218818;8915.866262005946;9010.86483702758;32971.50542741813;34399.65600344064;34873.82563087168;35379.646203538665;37057.81471092627;42441.787791060844;42717;43884.341734873364;44098;44697.55302446934;9930.354526955725;10057.748556286151;10107.89892101099;10110.140638045848;10166.390016599027;10447.58209671635;10497.632582859564;10557.313774604627;10762.569497220336;11096.167787415814;10327.431991240554;10514.26400151982;10812.891871081189;10885.836712449478;10905.34567925927;10453.68638940833;10525.684229473129;10746.785064298514;10799.244052916221;10827.24209305341;10672.786544268916;10778.29941053829;10934.507947142556;10975.945120274348;11232.255304756009;9220.953895230481;9255.53722313895;9329.953350233205;9418.62325506972;9478.810423791623;9324;9558.426494410358;9581.712548623553;9621.9037809621;9631.566579503798 09:17:42 INFO - PROCESS | 490 | __end_tp_report 09:17:42 INFO - PROCESS | 490 | __start_cc_report 09:17:42 INFO - PROCESS | 490 | _x_x_mozilla_cycle_collect,309 09:17:42 INFO - PROCESS | 490 | __end_cc_report 09:17:42 INFO - PROCESS | 490 | __startTimestamp1452791862414__endTimestamp 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | ------- Summary: start ------- 09:17:42 INFO - PROCESS | 490 | Number of tests: 6 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | [#0] dojo.html Cycles:165 Average:5154.42 Median:5326.36 stddev:552.39 (10.4%) stddev-sans-first:531.24 09:17:42 INFO - PROCESS | 490 | Values: 3150.4 3166.3 3184.6 3204.1 3217.2 5080.7 5098.0 5118.9 5163.0 5224.2 5045.0 5117.4 5204.8 5255.6 5264.7 4612.7 4644.6 4682.6 4716.3 4758.9 4664.4 4717.4 4726.5 4774.2 4780.1 4608.9 4621.7 4723.4 4752.4 4753.3 4738.9 4775.7 4787.9 4799.5 4830.7 4730.5 4742.2 4746.6 4784.2 4790.3 4954.8 4963.6 5028.7 5098.5 5177.5 5605.8 5618.4 5622.6 5631.9 5663.6 5606.2 5629.7 5690.0 5696.2 5716.0 5102.6 5166.9 5174.2 5243.7 5334.0 5686.0 5697.3 5700.9 5716.2 5716.9 5490.6 5505.3 5514.3 5519.6 5529.1 5496.4 5562.1 5571.9 5646.4 5699.4 5489.0 5537.6 5561.6 5568.4 5574.4 5401.4 5537.4 5551.3 5551.5 5559.5 4277.0 4282.9 4298.5 4299.1 4344.9 3856.0 3868.6 3887.5 3897.6 3914.4 5085.4 5174.8 5188.7 5225.3 5285.7 5489.5 5523.3 5536.5 5554.4 5570.9 5179.6 5203.8 5230.1 5236.2 5326.4 4700.7 4763.2 4824.3 4828.3 4838.6 5653.7 5705.1 5713.1 5716.6 5758.2 5439.1 5533.1 5534.7 5537.5 5541.6 5604.4 5614.6 5664.8 5685.3 5724.8 5344.7 5384.6 5390.9 5409.2 5437.3 5415.0 5449.6 5454.3 5461.8 5505.7 5174.7 5214.3 5261.1 5290.5 5321.7 5375.3 5434.3 5444.6 5446.8 5473.5 5362.2 5412.1 5424.0 5432.8 5465.6 5379.9 5466.5 5476.8 5477.8 5494.6 5222.2 5268.1 5291.4 5301.9 5327.4 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | [#1] ext.html Cycles:180 Average:45504.64 Median:21659.79 stddev:76826.72 (354.7%) stddev-sans-first:76968.01 09:17:42 INFO - PROCESS | 490 | Values: 525.6 526.5 526.6 547.1 553.6 35736.1 36742.6 36751.3 36872.0 36873.4 39718.8 40352.2 40362.0 40380.6 40523.2 8510.7 8543.7 8635.7 8741.9 8766.0 8432.8 8483.6 8498.7 8550.4 8592.7 8750.1 8788.9 8836.2 8851.9 8868.1 8689.4 8710.4 8712.2 8753.0 8776.5 8589.8 8700.2 8714.3 8714.9 8715.5 39452.4 39630.8 39961.0 39988.4 40023.4 3039.3 3174.6 3241.7 3502.2 3961.1 29728.1 30179.7 30188.4 30250.5 30550.5 3721.2 3867.2 4038.7 4055.6 4070.5 255756.0 257499.0 257598.0 257979.0 259594.0 43782.6 44253.3 58559.7 58866.4 59114.1 42099.0 42194.2 42229.8 42354.6 42362.6 12519.8 12520.6 12526.8 12534.9 12550.2 9636.9 9650.2 9732.8 9754.1 9758.6 14337.6 14627.0 14632.7 14781.6 14820.9 5743.4 5835.4 5863.6 5875.6 5953.0 881.7 906.9 961.9 962.3 962.3 28661.3 28687.6 28938.4 28942.7 29163.3 958.7 1008.9 1072.0 1078.3 1101.0 14835.8 14847.7 14955.7 15064.4 15078.0 323778.0 326167.0 327121.0 327337.0 328719.0 51208.7 51850.7 51933.2 52334.0 52473.7 1297.0 1299.8 1318.6 1334.0 1335.6 27374.0 28344.9 28498.6 28508.3 28759.4 46543.3 46715.8 46742.5 47017.0 47219.0 289936.0 293493.0 293637.0 293677.0 293863.0 33162.3 43489.3 43571.6 43716.3 44533.8 41023.2 42266.0 42549.6 42740.1 43025.0 36149.7 36158.8 36161.5 36686.8 36709.3 36437.0 36733.3 37258.4 37375.3 37382.0 35226.5 35333.6 35457.6 35625.8 35953.3 31234.2 31673.7 32743.8 33023.8 33320.7 25052.0 25148.5 25287.0 25529.4 25749.4 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | [#2] jquery.html Cycles:180 Average:27687.72 Median:537463.50 stddev:86330.26 (16.1%) stddev-sans-first:86548.06 09:17:42 INFO - PROCESS | 490 | Values: 365.9 367.8 368.0 370.3 375.8 11136.9 11684.6 15434.8 16946.7 17932.3 16668.8 16865.0 17604.1 17660.8 17732.7 5399.5 5716.2 5721.1 5731.1 5734.3 5496.6 5907.9 5926.2 5975.4 6005.3 5969.8 5976.5 6172.8 6456.6 6468.1 6345.7 6401.0 6471.0 6751.7 6808.2 6294.6 6502.1 6507.3 6516.1 6524.7 19291.4 19580.8 20124.4 21944.7 22457.6 2152.3 2172.2 2200.9 2285.1 2356.5 12559.2 12998.6 13219.3 13396.7 13485.3 1860.6 1904.2 1926.8 1978.9 2015.2 60504.4 61118.4 62628.7 63254.4 63695.4 14747.2 14778.4 14900.6 14925.6 15037.0 23119.2 23237.9 23253.8 23358.9 23502.2 7915.4 8103.8 8193.5 8209.7 8249.8 6678.6 6680.0 6703.1 6745.3 6780.4 7525.4 7534.9 7598.6 7626.0 7668.6 1718.5 1760.5 1772.1 2978.8 3060.9 394.6 852.8 898.5 987.6 994.4 9849.9 10694.2 10877.7 15647.8 15739.0 907.9 920.6 924.5 934.6 1011.7 8988.6 9001.7 9009.8 9432.2 9548.7 519380.0 523044.0 526755.0 536045.0 538882.0 64029.4 71016.0 72413.3 72429.0 72442.6 1141.1 1149.2 1175.5 1176.2 1178.2 14254.9 14346.6 14399.6 14422.1 14721.9 29473.3 29593.0 30219.7 30307.4 31131.8 38149.6 38979.2 39891.8 42222.0 44290.8 7265.8 7327.3 7332.4 7431.5 7529.4 10071.9 10444.6 10489.9 11153.7 11176.0 9245.4 9308.0 9358.6 9706.0 9711.0 3102.8 3386.9 9043.2 9235.7 9678.5 9735.6 10003.8 10127.1 10336.8 10345.6 6757.5 7246.4 7247.1 7518.3 7663.2 9285.6 9405.9 9504.4 9664.6 9902.3 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | [#3] mootools.html Cycles:180 Average:5415.13 Median:6536.06 stddev:2817.38 (43.1%) stddev-sans-first:2809.94 09:17:42 INFO - PROCESS | 490 | Values: 1502.1 1514.5 1645.3 1739.3 1761.1 7471.6 7539.4 7676.5 7682.0 7783.7 7701.7 7770.7 7827.9 7839.5 7861.0 2266.1 2277.5 2293.2 2296.7 2302.1 2296.3 2306.0 2320.6 2325.3 2330.5 2205.7 2241.2 2261.1 2285.3 2288.2 2291.3 2294.8 2297.4 2313.0 2323.5 2306.0 2329.6 2331.4 2332.3 2339.3 7778.7 7807.1 7899.6 7900.1 7919.0 4677.2 4782.7 4844.4 4844.7 4854.5 2978.2 3017.7 3048.3 3057.8 3073.9 967.8 983.3 988.6 990.6 1017.7 10640.7 10663.8 10675.0 10680.0 10728.2 4011.7 4052.3 4129.9 4133.2 4180.0 8661.9 8671.9 8701.0 8734.5 8748.3 4629.1 4661.5 4662.6 4668.7 4675.4 4234.2 4258.0 4264.4 4271.1 4292.1 3428.5 3436.8 3467.9 3472.6 3491.7 1024.1 1032.9 1036.3 1038.8 1045.6 921.9 922.0 926.1 947.9 1281.5 6975.7 7089.3 7100.1 7114.1 7121.5 1057.9 1077.5 1079.9 1083.3 1124.0 5123.2 5176.4 5239.2 5252.6 5289.4 8998.4 9079.2 9433.6 9486.0 9559.1 9276.3 9287.0 9342.3 9359.9 9468.3 7275.4 7448.0 7453.9 7457.3 7513.9 7005.2 7006.7 7019.2 7045.6 7056.6 8242.5 8263.5 8536.1 8560.0 8668.2 8508.4 8516.4 8582.0 8620.5 8691.1 6525.3 6841.3 6841.9 6842.7 6855.5 7420.4 7492.0 7508.5 7513.8 7531.8 6907.0 6952.1 7081.3 7182.5 7218.0 6853.9 6892.8 6919.3 6950.9 6966.1 7005.9 7010.4 7039.7 7042.9 7091.4 6462.1 6497.4 6519.7 6530.4 6541.7 6395.8 6447.9 6456.0 6457.4 6557.4 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | [#4] prototype.html Cycles:180 Average:5561.11 Median:6240.25 stddev:1700.00 (27.2%) stddev-sans-first:1658.50 09:17:42 INFO - PROCESS | 490 | Values: 313.0 319.0 323.8 329.1 333.5 6173.2 6302.7 6303.1 6342.1 6352.0 6109.1 6235.2 6240.3 6241.7 6245.9 4735.8 4775.6 4776.9 4780.2 4792.9 4752.3 4759.0 4769.2 4781.1 4785.9 4664.9 4720.5 4741.9 4747.3 4753.4 4703.4 4724.1 4736.0 4749.0 4749.1 4146.3 4152.7 4157.8 4160.7 4164.5 5872.7 5891.5 5898.2 5918.0 5927.2 5400.2 5508.2 5510.6 5536.7 5547.9 6623.3 6633.2 6635.6 6644.2 6656.9 4586.0 4597.2 4599.5 4606.3 4608.0 6779.3 6880.7 6900.2 6933.8 6940.6 4700.8 4703.0 4712.2 4713.4 4715.7 4762.3 4767.3 4767.9 4771.9 4776.8 5505.7 5510.4 5510.5 5533.0 5534.7 6506.3 6664.2 6669.4 6672.9 6691.7 1609.3 1621.9 1638.1 1642.7 1660.1 1057.8 1074.5 1086.8 1089.7 1100.1 6218.5 6220.8 6224.6 6269.9 6270.0 6793.8 6839.9 6853.7 6855.8 6857.3 6140.8 6163.4 6175.5 6205.8 6240.2 3698.3 3701.5 3712.6 3724.7 3725.8 7082.4 7109.0 7110.9 7130.0 7162.2 6823.1 6976.4 6983.5 6993.2 7008.2 7108.2 7116.2 7127.7 7133.8 7134.2 6765.4 6788.4 6815.9 6818.1 6835.8 6631.3 6728.8 6742.6 6754.7 6822.2 7189.1 7232.7 7244.2 7246.0 7252.0 4592.9 4620.4 4640.8 4655.6 4663.4 6860.2 6926.8 6957.7 6969.2 7040.6 6811.6 6833.5 6841.0 6852.7 6863.5 6809.2 6817.2 6831.5 6832.5 6850.3 6521.4 6667.6 6690.1 6693.0 6698.9 6822.4 6828.8 6834.3 6838.8 6865.7 6577.0 6603.5 6620.6 6664.7 6692.8 09:17:42 INFO - PROCESS | 490 | 09:17:42 INFO - PROCESS | 490 | [#5] yui.html Cycles:180 Average:13436.22 Median:46091.88 stddev:15389.01 (33.4%) stddev-sans-first:15402.38 09:17:42 INFO - PROCESS | 490 | Values: 683.9 777.7 812.2 826.3 856.5 13091.9 13100.3 13156.9 13218.0 13275.7 12780.2 12794.4 12907.1 12916.4 12961.1 659.6 667.6 802.2 826.8 830.2 809.3 811.3 816.5 819.3 825.0 844.4 845.1 849.3 850.7 852.8 831.2 839.3 841.4 842.2 843.1 628.8 629.0 629.5 629.8 629.8 12899.0 13015.2 13062.4 13115.3 13144.9 12649.7 12862.5 13070.5 13236.3 13444.6 10888.6 10970.3 11095.1 11322.5 11462.8 3589.2 3609.4 3619.2 3621.9 3639.8 45899.5 45984.0 46199.8 46455.5 47578.5 9799.9 9865.5 9872.6 9895.8 9900.9 18148.3 18317.5 18321.7 18405.4 18434.2 7303.7 7335.3 7422.4 7510.0 7644.7 4129.2 4136.8 4173.9 4194.3 4227.6 2961.4 3024.1 3032.1 3034.0 3044.0 523.5 525.1 527.3 528.4 555.0 475.9 508.7 560.9 597.3 625.7 8025.7 8619.3 8917.6 8960.3 9059.1 504.7 550.9 563.1 567.3 572.5 4069.4 4103.6 4170.6 4290.9 4417.8 54073.2 54924.7 55014.4 55021.7 55329.0 47711.3 48870.3 49016.5 49559.3 49578.3 44382.0 45162.1 45308.1 45542.1 45554.5 8753.3 8832.2 8886.6 8915.9 9010.9 32971.5 34399.7 34873.8 35379.6 37057.8 42441.8 42717.0 43884.3 44098.0 44697.6 9930.4 10057.7 10107.9 10110.1 10166.4 10447.6 10497.6 10557.3 10762.6 11096.2 10327.4 10514.3 10812.9 10885.8 10905.3 10453.7 10525.7 10746.8 10799.2 10827.2 10672.8 10778.3 10934.5 10975.9 11232.3 9221.0 9255.5 9330.0 9418.6 9478.8 9324.0 9558.4 9581.7 9621.9 9631.6 09:17:42 INFO - PROCESS | 490 | -------- Summary: end -------- 09:17:42 INFO - PROCESS | 490 | 09:17:43 INFO - TEST-INFO | 490: exit 0 09:17:43 INFO - TEST-OK | dromaeo_css | took 1111290ms 09:17:43 INFO - TEST-START | kraken 09:17:43 INFO - operating with platform_type : linux_ 09:17:43 INFO - Initialising browser for kraken test... 09:17:43 INFO - TEST-INFO | started process 733 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjJ8Xnf/profile http://localhost:51122/getInfo.html) 09:17:47 INFO - PROCESS | 733 | 09:17:47 INFO - PROCESS | 733 | (process:805): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:17:47 INFO - PROCESS | 733 | __metrics Screen width/height:1600/1200 09:17:47 INFO - PROCESS | 733 | colorDepth:24 09:17:47 INFO - PROCESS | 733 | Browser inner width/height: 1024/670 09:17:47 INFO - PROCESS | 733 | __metrics 09:17:48 INFO - PROCESS | 733 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:17:49 INFO - TEST-INFO | 733: exit 0 09:17:49 INFO - Browser initialized. 09:17:49 INFO - Running cycle 1/1 for kraken test... 09:17:49 INFO - TEST-INFO | started process 860 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjJ8Xnf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:50 INFO - PROCESS | 860 | 09:17:50 INFO - PROCESS | 860 | (process:920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:00 INFO - PROCESS | 860 | RSS: Main: 150937600 09:18:00 INFO - PROCESS | 860 | 09:18:03 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-beat-detection) 09:18:03 INFO - PROCESS | 860 | RSS: Main: 151707648 09:18:03 INFO - PROCESS | 860 | 09:18:06 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-dft) 09:18:07 INFO - PROCESS | 860 | RSS: Main: 153579520 09:18:07 INFO - PROCESS | 860 | 09:18:10 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-fft) 09:18:10 INFO - PROCESS | 860 | RSS: Main: 148893696 09:18:10 INFO - PROCESS | 860 | 09:18:12 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51122/tests/kraken/driver.html?testName=audio-oscillator) 09:18:13 INFO - PROCESS | 860 | RSS: Main: 150249472 09:18:13 INFO - PROCESS | 860 | 09:18:15 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51122/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:18:16 INFO - PROCESS | 860 | RSS: Main: 150417408 09:18:16 INFO - PROCESS | 860 | 09:18:19 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51122/tests/kraken/driver.html?testName=imaging-darkroom) 09:18:19 INFO - PROCESS | 860 | RSS: Main: 148946944 09:18:19 INFO - PROCESS | 860 | 09:18:23 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51122/tests/kraken/driver.html?testName=imaging-desaturate) 09:18:23 INFO - PROCESS | 860 | RSS: Main: 150568960 09:18:23 INFO - PROCESS | 860 | 09:18:26 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51122/tests/kraken/driver.html?testName=json-parse-financial) 09:18:27 INFO - PROCESS | 860 | RSS: Main: 150020096 09:18:27 INFO - PROCESS | 860 | 09:18:28 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51122/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:18:29 INFO - PROCESS | 860 | RSS: Main: 151126016 09:18:29 INFO - PROCESS | 860 | 09:18:31 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:18:31 INFO - PROCESS | 860 | RSS: Main: 150900736 09:18:31 INFO - PROCESS | 860 | 09:18:34 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:18:34 INFO - PROCESS | 860 | RSS: Main: 151240704 09:18:34 INFO - PROCESS | 860 | 09:18:37 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:18:37 INFO - PROCESS | 860 | RSS: Main: 151449600 09:18:37 INFO - PROCESS | 860 | 09:18:40 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:18:40 INFO - PROCESS | 860 | RSS: Main: 150953984 09:18:40 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:51122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51122/tests/kraken/driver.html?testName=ai-astar) 09:18:42 INFO - PROCESS | 860 | RSS: Main: 150777856 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | __start_tp_report 09:18:42 INFO - PROCESS | 860 | _x_x_mozilla_page_load 09:18:42 INFO - PROCESS | 860 | _x_x_mozilla_page_load_details 09:18:42 INFO - PROCESS | 860 | |i|pagename|runs| 09:18:42 INFO - PROCESS | 860 | |0;ai-astar;113;107;111;115;114;124;112;112;113;113 09:18:42 INFO - PROCESS | 860 | |1;audio-beat-detection;147;147;154;161;130;156;149;125;168;126 09:18:42 INFO - PROCESS | 860 | |2;audio-dft;164;164;163;164;164;166;166;174;164;166 09:18:42 INFO - PROCESS | 860 | |3;audio-fft;75;74;75;72;74;75;144;73;71;72 09:18:42 INFO - PROCESS | 860 | |4;audio-oscillator;96;97;147;97;98;97;140;96;97;137 09:18:42 INFO - PROCESS | 860 | |5;imaging-gaussian-blur;110;110;110;111;110;110;110;110;110;110 09:18:42 INFO - PROCESS | 860 | |6;imaging-darkroom;147;147;147;146;146;147;146;146;146;146 09:18:42 INFO - PROCESS | 860 | |7;imaging-desaturate;97;96;96;98;97;97;96;97;97;96 09:18:42 INFO - PROCESS | 860 | |8;json-parse-financial;60;60;59;60;59;66;62;60;58;58 09:18:42 INFO - PROCESS | 860 | |9;json-stringify-tinderbox;68;73;68;69;67;68;76;68;68;69 09:18:42 INFO - PROCESS | 860 | |10;stanford-crypto-aes;82;83;84;85;91;92;85;84;86;83 09:18:42 INFO - PROCESS | 860 | |11;stanford-crypto-ccm;122;132;128;128;119;117;119;132;117;118 09:18:42 INFO - PROCESS | 860 | |12;stanford-crypto-pbkdf2;152;154;152;155;156;142;165;152;151;142 09:18:42 INFO - PROCESS | 860 | |13;stanford-crypto-sha256-iterative;69;72;69;68;69;68;70;70;71;69 09:18:42 INFO - PROCESS | 860 | __end_tp_report 09:18:42 INFO - PROCESS | 860 | __start_cc_report 09:18:42 INFO - PROCESS | 860 | _x_x_mozilla_cycle_collect,726 09:18:42 INFO - PROCESS | 860 | __end_cc_report 09:18:42 INFO - PROCESS | 860 | __startTimestamp1452791922872__endTimestamp 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | ------- Summary: start ------- 09:18:42 INFO - PROCESS | 860 | Number of tests: 14 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:4.30 (3.8%) stddev-sans-first:4.56 09:18:42 INFO - PROCESS | 860 | Values: 113.0 107.0 111.0 115.0 114.0 124.0 112.0 112.0 113.0 113.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:151.50 stddev:14.83 (9.8%) stddev-sans-first:15.73 09:18:42 INFO - PROCESS | 860 | Values: 147.0 147.0 154.0 161.0 130.0 156.0 149.0 125.0 168.0 126.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:3.17 (1.9%) stddev-sans-first:3.32 09:18:42 INFO - PROCESS | 860 | Values: 164.0 164.0 163.0 164.0 164.0 166.0 166.0 174.0 164.0 166.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:22.36 (30.2%) stddev-sans-first:23.62 09:18:42 INFO - PROCESS | 860 | Values: 75.0 74.0 75.0 72.0 74.0 75.0 144.0 73.0 71.0 72.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:97.00 stddev:21.63 (22.3%) stddev-sans-first:22.32 09:18:42 INFO - PROCESS | 860 | Values: 96.0 97.0 147.0 97.0 98.0 97.0 140.0 96.0 97.0 137.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:18:42 INFO - PROCESS | 860 | Values: 110.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:18:42 INFO - PROCESS | 860 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:18:42 INFO - PROCESS | 860 | Values: 97.0 96.0 96.0 98.0 97.0 97.0 96.0 97.0 97.0 96.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:2.35 (3.9%) stddev-sans-first:2.49 09:18:42 INFO - PROCESS | 860 | Values: 60.0 60.0 59.0 60.0 59.0 66.0 62.0 60.0 58.0 58.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:68.50 stddev:2.84 (4.1%) stddev-sans-first:2.96 09:18:42 INFO - PROCESS | 860 | Values: 68.0 73.0 68.0 69.0 67.0 68.0 76.0 68.0 68.0 69.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:3.37 (4.0%) stddev-sans-first:3.33 09:18:42 INFO - PROCESS | 860 | Values: 82.0 83.0 84.0 85.0 91.0 92.0 85.0 84.0 86.0 83.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:125.00 stddev:6.16 (4.9%) stddev-sans-first:6.52 09:18:42 INFO - PROCESS | 860 | Values: 122.0 132.0 128.0 128.0 119.0 117.0 119.0 132.0 117.0 118.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:153.00 stddev:6.66 (4.4%) stddev-sans-first:7.06 09:18:42 INFO - PROCESS | 860 | Values: 152.0 154.0 152.0 155.0 156.0 142.0 165.0 152.0 151.0 142.0 09:18:42 INFO - PROCESS | 860 | 09:18:42 INFO - PROCESS | 860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.27 (1.8%) stddev-sans-first:1.33 09:18:42 INFO - PROCESS | 860 | Values: 69.0 72.0 69.0 68.0 69.0 68.0 70.0 70.0 71.0 69.0 09:18:42 INFO - PROCESS | 860 | -------- Summary: end -------- 09:18:42 INFO - PROCESS | 860 | 09:18:43 INFO - TEST-INFO | 860: exit 0 09:18:43 INFO - TEST-OK | kraken | took 60656ms 09:18:43 INFO - TEST-START | v8_7 09:18:43 INFO - operating with platform_type : linux_ 09:18:43 INFO - Initialising browser for v8_7 test... 09:18:43 INFO - TEST-INFO | started process 1216 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBw_g41/profile http://localhost:51122/getInfo.html) 09:18:47 INFO - PROCESS | 1216 | 09:18:47 INFO - PROCESS | 1216 | (process:1304): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:48 INFO - PROCESS | 1216 | __metrics Screen width/height:1600/1200 09:18:48 INFO - PROCESS | 1216 | colorDepth:24 09:18:48 INFO - PROCESS | 1216 | Browser inner width/height: 1024/670 09:18:48 INFO - PROCESS | 1216 | __metrics 09:18:48 INFO - PROCESS | 1216 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:18:49 INFO - TEST-INFO | 1216: exit 0 09:18:49 INFO - Browser initialized. 09:18:49 INFO - Running cycle 1/1 for v8_7 test... 09:18:49 INFO - TEST-INFO | started process 1353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBw_g41/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:50 INFO - PROCESS | 1353 | 09:18:50 INFO - PROCESS | 1353 | (process:1411): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:19:01 INFO - PROCESS | 1353 | RSS: Main: 151052288 09:19:01 INFO - PROCESS | 1353 | 09:19:23 INFO - PROCESS | 1353 | Cycle 1(1): loaded http://localhost:51122/tests/v8_7/run.html (next: http://localhost:51122/tests/v8_7/run.html) 09:19:24 INFO - PROCESS | 1353 | RSS: Main: 146927616 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | __start_tp_report 09:19:24 INFO - PROCESS | 1353 | _x_x_mozilla_page_load 09:19:24 INFO - PROCESS | 1353 | _x_x_mozilla_page_load_details 09:19:24 INFO - PROCESS | 1353 | |i|pagename|runs| 09:19:24 INFO - PROCESS | 1353 | |0;Richards;168.32183134152498 09:19:24 INFO - PROCESS | 1353 | |1;DeltaBlue;187.89928598271325 09:19:24 INFO - PROCESS | 1353 | |2;Encrypt;279.6420581655481 09:19:24 INFO - PROCESS | 1353 | |3;Decrypt;5196.891191709845 09:19:24 INFO - PROCESS | 1353 | |4;RayTrace;1064.9627263045793 09:19:24 INFO - PROCESS | 1353 | |5;Earley;724.112961622013 09:19:24 INFO - PROCESS | 1353 | |6;Boyer;12419.753086419752 09:19:24 INFO - PROCESS | 1353 | |7;RegExp;40725.490196078434 09:19:24 INFO - PROCESS | 1353 | |8;Splay;624.2197253433209 09:19:24 INFO - PROCESS | 1353 | |9;NavierStokes;4830.917874396136 09:19:24 INFO - PROCESS | 1353 | __end_tp_report 09:19:24 INFO - PROCESS | 1353 | __startTimestamp1452791964029__endTimestamp 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | ------- Summary: start ------- 09:19:24 INFO - PROCESS | 1353 | Number of tests: 10 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#0] Richards Cycles:1 Average:168.32 Median:168.32 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 168.3 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#1] DeltaBlue Cycles:1 Average:187.90 Median:187.90 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 187.9 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 279.6 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 5196.9 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 1065.0 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#5] Earley Cycles:1 Average:724.11 Median:724.11 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 724.1 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 12419.8 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#7] RegExp Cycles:1 Average:40725.49 Median:40725.49 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 40725.5 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#8] Splay Cycles:1 Average:624.22 Median:624.22 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 624.2 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - PROCESS | 1353 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:19:24 INFO - PROCESS | 1353 | Values: 4830.9 09:19:24 INFO - PROCESS | 1353 | -------- Summary: end -------- 09:19:24 INFO - PROCESS | 1353 | 09:19:24 INFO - TEST-INFO | 1353: exit 0 09:19:24 INFO - TEST-OK | v8_7 | took 41149ms 09:19:24 INFO - SUITE-END | took 1213s 09:19:25 INFO - Completed test suite (00:20:13) 09:19:25 INFO - Working with test: dromaeo_css 09:19:25 INFO - Generating results file: dromaeo_css 09:19:25 INFO - Working with test: kraken 09:19:25 INFO - Generating results file: kraken 09:19:25 INFO - javascript benchmark 09:19:25 INFO - Working with test: v8_7 09:19:25 INFO - Generating results file: v8_7 09:19:25 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:19:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 09:19:25 INFO - process_Request line: dromaeo_css 6885.18 graph.html#tests=[[72,1,43]] 09:19:25 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:19:25 INFO - process_Request line: kraken 1529.00 graph.html#tests=[[232,1,43]] 09:19:25 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:19:25 INFO - process_Request line: v8_7 20267.57 graph.html#tests=[[230,1,43]] 09:19:25 INFO - RETURN: dromaeo_css: 6885.18 09:19:25 INFO - RETURN: kraken: 1529.00 09:19:25 INFO - RETURN: v8_7: 20267.57 09:19:25 INFO - javascript benchmark 09:19:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3150.4329220740265, 3166.2559298564834, 3184.633767116782, 3204.1028512016637, 3217.2117831131377, 5080.745962701869, 5098.031374038935, 5118.9488105118935, 5162.974185129074, 5224.190250511177, 5044.974775126128, 5117.437081920985, 5204.817831375903, 5255.579553635709, 5264.657797243186, 4612.677112602119, 4644.628429725613, 4682.601978831786, 4716.339712440261, 4758.928616070744, 4664.4402671679445, 4717.363155973934, 4726.527347265281, 4774.212254977924, 4780.067886762083, 4608.884777880547, 4621.65337599678, 4723.3859598252175, 4752.40594925636, 4753.33453316536, 4738.857834264943, 4775.713457192544, 4787.8563643090765, 4799.472058073609, 4830.686005409672, 4730.511851119536, 4742.193827049376, 4746.596539294164, 4784.162771514971, 4790.257510085942, 4954.777035033432, 4963.578095861856, 5028.698278103326, 5098.4646612105935, 5177.456367081478, 5605.803796867131, 5618.438156184389, 5622.606417550773, 5631.915521267184, 5663.575231857586, 5606.24315717377, 5629.662220266756, 5689.971550142222, 5696.23100881384, 5716.0, 5102.617303702237, 5166.9224961625605, 5174.197999310113, 5243.659162154448, 5333.973330133402, 5686.0, 5697.259356283656, 5700.942990570041, 5716.1997320375185, 5716.942830571724, 5490.6431081979545, 5505.339359276913, 5514.255575497336, 5519.558435325244, 5529.1349371034485, 5496.395396506381, 5562.137868630369, 5571.9442805572235, 5646.407127251661, 5699.401562835926, 5489.0, 5537.612367134262, 5561.555075593943, 5568.443155684399, 5574.358948720868, 5401.351837779492, 5537.446255374431, 5551.333839939233, 5551.500364967173, 5559.471850174227, 4276.957230427656, 4282.850100246476, 4298.527162012176, 4299.14017196562, 4344.913101737948, 3855.9614403855603, 3868.5507592018175, 3887.494625698641, 3897.57126716061, 3914.393269043303, 5085.415177254663, 5174.7930082796265, 5188.662736922088, 5225.294585230945, 5285.68285902847, 5489.478499542537, 5523.337199536081, 5536.529395001389, 5554.389017208104, 5570.944290557123, 5179.637425380187, 5203.8178663746585, 5230.08473517133, 5236.162214045735, 5326.36083669962, 4700.741459219776, 4763.166445871959, 4824.300476430898, 4828.275758636232, 4838.564529192389, 5653.745581448845, 5705.058665320259, 5713.114467257582, 5716.628419152742, 5758.1650660654805, 5439.102548079681, 5533.142362933751, 5534.695591742332, 5537.473939975695, 5541.639793413416, 5604.3835178131185, 5614.63504872182, 5664.773409063591, 5685.260916080883, 5724.771009159587, 5344.679319240858, 5384.596155288291, 5390.865228369322, 5409.215663728816, 5437.293151890229, 5414.972925135349, 5449.6185267032515, 5454.263674404064, 5461.781528738806, 5505.6696598204235, 5174.689518628894, 5214.270002199619, 5261.053010458154, 5290.523852853262, 5321.6540924839765, 5375.274337964324, 5434.2935418395355, 5444.6188766785945, 5446.782128714807, 5473.480019398151, 5362.249285100167, 5412.134058550613, 5424.0, 5432.755526001419, 5465.562754979672, 5379.892402151857, 5466.508014278734, 5476.780928762805, 5477.808276710296, 5494.642848214853, 5222.216667499905, 5268.1044222481505, 5291.365036195682, 5301.867453313698, 5327.413984461628], "unit": "score", "name": "dojo.html", "value": 5120.2271026080225}, {"lowerIsBetter": false, "replicates": [525.5952916254487, 526.4814158054317, 526.5839986410735, 547.1191381875179, 553.6318348298382, 35736.10659733505, 36742.63257367426, 36751.26497470049, 36872.0, 36873.44689829655, 39718.801405993, 40352.192956140934, 40362.0, 40380.59619403805, 40523.189536209335, 8510.702125425596, 8543.700970466034, 8635.740927772145, 8741.912580874205, 8766.0, 8432.789180270482, 8483.618237179342, 8498.702545410912, 8550.444221125637, 8592.742217733477, 8750.124987501262, 8788.912110878873, 8836.160564746371, 8851.911480885205, 8868.113188681113, 8689.391742578022, 8710.433821801595, 8712.172343627408, 8753.0, 8776.473411595325, 8589.828203435896, 8700.173483519056, 8714.25928796053, 8714.912850871473, 8715.520646364448, 39452.40821387653, 39630.80184599059, 39961.0, 39988.40017399741, 40023.39964900529, 3039.3313471036336, 3174.571432856581, 3241.692039256267, 3502.159481724393, 3961.1285517186175, 29728.056864467686, 30179.69820301791, 30188.396232075454, 30250.54624180639, 30550.54174187389, 3721.162738383869, 3867.16855875988, 4038.737482063686, 4055.5538890721996, 4070.4504891839815, 255756.0, 257499.0, 257598.0, 257979.0, 259593.9999999981, 43782.56217437849, 44253.336199957026, 58559.707201464575, 58866.41133588609, 59114.11328830071, 42099.0, 42194.15611687749, 42229.78885105555, 42354.57645423568, 42362.57637423648, 12519.812202816966, 12520.561780337644, 12526.81209781854, 12534.937325313314, 12550.246985180918, 9636.903630963741, 9650.227981761442, 9732.805343893082, 9754.0733630305, 9758.609655613838, 14337.56987290383, 14627.0, 14632.707345853023, 14781.630459238606, 14820.851791481948, 5743.425657434307, 5835.387284335168, 5863.618864773776, 5875.559333050039, 5953.047512397996, 881.6693739847557, 906.8911730592371, 961.8701475300885, 962.2734835199519, 962.3119469579144, 28661.28346791347, 28687.56968645472, 28938.421231575252, 28942.710572894423, 29163.270918227216, 958.6596758150896, 1008.9154159278804, 1071.9663352711807, 1078.3044936016227, 1100.9815920273716, 14835.777463337843, 14847.70304593902, 14955.700885982436, 15064.397424102914, 15078.0, 323778.0, 326167.0, 327121.0, 327337.0, 328719.0, 51208.719782005006, 51850.740746296025, 51933.22100168501, 52334.0, 52473.7376313116, 1296.9546065887837, 1299.8310219671382, 1318.6241921052454, 1334.0461569977513, 1335.5859683498147, 27374.0, 28344.858275709314, 28498.57252141261, 28508.287292817844, 28759.424811504072, 46543.301850471595, 46715.766421167675, 46742.532574673816, 47017.0, 47219.0, 289936.0, 293493.0, 293637.0, 293677.0, 293863.0, 33162.336753265285, 43489.34765978449, 43571.56428435675, 43716.34425483557, 44533.77733111314, 41023.179536408505, 42266.0, 42549.5745042558, 42740.14519709526, 43025.0, 36149.65027273324, 36158.819205903805, 36161.45757813582, 36686.816565917, 36709.26581468409, 36437.0, 36733.26533469262, 37258.44112338263, 37375.252494950495, 37382.0, 35226.47160292649, 35333.64666353406, 35457.64542354544, 35625.82187089048, 35953.28093438169, 31234.21914452066, 31673.683263167073, 32743.836280818443, 33023.834880825445, 33320.66679333176, 25052.0, 25148.49703005893, 25287.0, 25529.361765956, 25749.3562660935], "unit": "score", "name": "ext.html", "value": 17759.95420537095}, {"lowerIsBetter": false, "replicates": [365.87560229521955, 367.7756568493219, 367.98344074516643, 370.32046195231754, 375.80458161755905, 11136.944315278412, 11684.649460516177, 15434.845651543481, 16946.661066778655, 17932.28270869165, 16668.83331166688, 16865.0, 17604.119794010312, 17660.82339176608, 17732.734008989843, 5399.541039011679, 5716.1711551824965, 5721.056025755766, 5731.054376027951, 5734.311882574097, 5496.560275177996, 5907.852303692399, 5926.170336152942, 5975.372585878486, 6005.309389420229, 5969.791057312973, 5976.4919981801595, 6172.814815555518, 6456.644884531349, 6468.094466774655, 6345.682715864212, 6401.0, 6470.967645161768, 6751.729930802762, 6808.183018037817, 6294.622322660609, 6502.089707440962, 6507.349265073455, 6516.1203237562795, 6524.673766311713, 19291.4212573623, 19580.804191958185, 20124.396268111832, 21944.670829937564, 22457.55084898293, 2152.2897443843494, 2172.1528603844513, 2200.9119635214574, 2285.063124119103, 2356.5286942611374, 12559.183653062613, 12998.610041698765, 13219.272939988297, 13396.665083372896, 13485.258310792902, 1860.5720684242565, 1904.1621686458052, 1926.7784204816485, 1978.910949007298, 2015.203994422195, 60504.39495605075, 61118.388816111714, 62628.68685656588, 63254.36745632531, 63695.363046369406, 14747.18890461035, 14778.408863645334, 14900.552983410515, 14925.552233433014, 15037.0, 23119.24410955611, 23237.88381058084, 23253.76746232516, 23358.883205584203, 23502.177423790086, 7915.366770658334, 8103.797405064803, 8193.549354785544, 8209.671613135408, 8249.752507424786, 6678.565893216925, 6680.0, 6703.095082163845, 6745.325467453215, 6780.355866192704, 7525.4355923305975, 7534.886976695354, 7598.620068996528, 7626.0, 7668.578228197391, 1718.4672751446842, 1760.4649305000758, 1772.1139430284857, 2978.776591755627, 3060.938781224363, 394.5699187885219, 852.8123812761182, 898.4878619187001, 987.6493844685177, 994.4182653147844, 9849.852252216222, 10694.197935154894, 10877.728056798485, 15647.843521564866, 15739.0, 907.8774365460711, 920.6271460058553, 924.4776701163821, 934.6261495401758, 1011.6560369474267, 8988.55057247135, 9001.729948101567, 9009.819803603892, 9432.19826314771, 9548.713538593853, 519380.0, 523044.0, 526755.0, 536045.0, 538882.0, 64029.35970640234, 71016.0, 72413.27586724171, 72429.0, 72442.63778681072, 1141.14414189358, 1149.1611123879447, 1175.5121624525725, 1176.2413243458093, 1178.1811640909486, 14254.857451425352, 14346.641333966318, 14399.640008999859, 14422.134671919719, 14721.92639036798, 29473.263168420963, 29593.0, 30219.69780302257, 30307.393852123274, 31131.844340778152, 38149.61850381461, 38979.2204155921, 39891.80054099711, 42222.0, 44290.77854610706, 7265.782026539212, 7327.267273272843, 7332.41340692754, 7431.516951398142, 7529.435292353205, 10071.899281007389, 10444.634437794944, 10489.947550262199, 11153.72115697114, 11175.976668273332, 9245.352825302165, 9308.0, 9358.578863951274, 9705.951470242604, 9710.951445242728, 3102.8293443860803, 3386.881459148918, 9043.23132533742, 9235.722928312161, 9678.516074196403, 9735.561899714672, 10003.849942251018, 10127.088562029452, 10336.793264134825, 10345.63790267337, 6757.45940324763, 7246.4202863771825, 7247.057882475245, 7518.28576285252, 7663.1570527243075, 9285.582148803185, 9405.905940940776, 9504.382215156269, 9664.613415463302, 9902.257330700082], "unit": "score", "name": "jquery.html", "value": 8624.195671685955}, {"lowerIsBetter": false, "replicates": [1502.1137528857976, 1514.4775052606851, 1645.2596331650752, 1739.3129713763071, 1761.1458442655319, 7471.589062601554, 7539.359154471869, 7676.501027433213, 7681.961590192048, 7783.727569535067, 7701.730439434621, 7770.68917243311, 7827.882581761264, 7839.4512384132995, 7860.960695196516, 2266.0595852721144, 2277.464795772992, 2293.174457195408, 2296.6555016747457, 2302.0791683326634, 2296.2537175417974, 2305.965410518844, 2320.582295186866, 2325.2907863101746, 2330.545543618995, 2205.7353117625908, 2241.226776762023, 2261.0955617752866, 2285.314405678298, 2288.1533832482005, 2291.324059402472, 2294.7819957104048, 2297.3911913342977, 2312.953740925189, 2323.53529294141, 2305.9769402306097, 2329.6389059695775, 2331.3588763090115, 2332.346942856003, 2339.2982105368324, 7778.727744528971, 7807.102183248942, 7899.644515996736, 7900.091489478726, 7918.960405197937, 4677.18149323867, 4782.689125206851, 4844.442889067767, 4844.709317440965, 4854.466008739036, 2978.166113488227, 3017.698230176965, 3048.2684155802667, 3057.801242919203, 3073.861676224575, 967.8171063656835, 983.2625530851861, 988.619381538113, 990.5641517732247, 1017.6641708236265, 10640.680779576625, 10663.84004239937, 10675.0, 10680.038796508274, 10728.195385346053, 4011.6590089842107, 4052.2503336882182, 4129.855455059059, 4133.194027164674, 4180.0, 8661.913380866237, 8671.869921951176, 8701.0, 8734.519601421856, 8748.343874209333, 4629.120467111238, 4661.463931647836, 4662.557057079572, 4668.743219122913, 4675.392199014174, 4234.216669916075, 4257.978710106429, 4264.402983582301, 4271.124419493996, 4292.12011537634, 3428.468587368962, 3436.7766095203733, 3467.8612855486003, 3472.5659292588425, 3491.6857482826667, 1024.0578667625803, 1032.932859364154, 1036.3315661398356, 1038.8182068138046, 1045.5713157605346, 921.8571121476182, 921.9769505762409, 926.1063074133493, 947.9194268487256, 1281.5002149161835, 6975.651217439107, 7089.291070892869, 7100.076989991268, 7114.14630244374, 7121.501494895308, 1057.8942105789513, 1077.5366592365358, 1079.8920107989138, 1083.3283364314018, 1123.9887601124049, 5123.180291153398, 5176.430592634807, 5239.187925871496, 5252.632315737938, 5289.444608316148, 8998.370114092082, 9079.18287354128, 9433.575489103006, 9485.952570237105, 9559.091886270931, 9276.257899368034, 9287.0, 9342.299327550461, 9359.906400935903, 9468.337216394924, 7275.4179665626625, 7447.962760186165, 7453.925460745323, 7457.254274572608, 7513.910482980046, 7005.194402643761, 7006.6846991886505, 7019.227884932551, 7045.612491313027, 7056.576605403692, 8242.505449673039, 8263.504189748634, 8536.103709110454, 8560.0, 8668.219860212612, 8508.404411691123, 8516.361272904433, 8581.95709021451, 8620.482771033758, 8691.087435819149, 6525.347465253437, 6841.315868413119, 6841.93158068413, 6842.726290948306, 6855.520113592001, 7420.443466739908, 7491.9625401872645, 7508.549487030796, 7513.812154696177, 7531.8117047074265, 6907.0, 6952.130983627047, 7081.327273908971, 7182.497225194186, 7218.0, 6853.86911159673, 6892.793216203522, 6919.273476284918, 6950.8609827804175, 6966.12923384577, 7005.859882802417, 7010.439164866901, 7039.718411263492, 7042.859142817218, 7091.361777440055, 6462.095306657166, 6497.382748638872, 6519.73921043172, 6530.412262896362, 6541.70562324687, 6395.776147834804, 6447.871042579216, 6456.0, 6457.418832305115, 6557.377049180321], "unit": "score", "name": "mootools.html", "value": 4430.044838220066}, {"lowerIsBetter": false, "replicates": [312.99217519562023, 318.980861148331, 323.7733586489457, 329.1278113000548, 333.5180663940606, 6173.228346456693, 6302.653354065525, 6303.054541818729, 6342.14381058557, 6352.047192921064, 6109.14471973924, 6235.220597425322, 6240.31356550779, 6241.687915604224, 6245.9063114053215, 4735.834245801398, 4775.570198682118, 4776.90446191076, 4780.163471392492, 4792.856214313559, 4752.263399173134, 4759.048190361924, 4769.18923782956, 4781.0676918001, 4785.90428191436, 4664.883377915546, 4720.457147428038, 4741.881452963687, 4747.311639812225, 4753.382060332152, 4703.43558772946, 4724.078804633098, 4735.976320118394, 4749.0, 4749.050189962021, 4146.295129827937, 4152.709310348277, 4157.771322577257, 4160.729552579103, 4164.479440069991, 5872.706364681749, 5891.499222566087, 5898.174255604219, 5918.0, 5927.170196172539, 5400.243965844785, 5508.20131080991, 5510.586705997066, 5536.667799932017, 5547.944520554824, 6623.3045530219115, 6633.2040155181685, 6635.601863888182, 6644.202695676501, 6656.93343066568, 4585.95414045862, 4597.195490789132, 4599.540045995407, 4606.332081848113, 4608.009278005212, 6779.2881747416795, 6880.69036893341, 6900.171979362459, 6933.826654333631, 6940.618265995368, 4700.835470758507, 4703.0, 4712.198926182557, 4713.363695901078, 4715.74063426508, 4762.309465127537, 4767.308740232716, 4767.904641907143, 4771.880702982453, 4776.761161941889, 5505.678637127061, 5510.448955104457, 5510.504054635102, 5533.03171944908, 5534.667919924817, 6506.284308726036, 6664.166979127609, 6669.4330981866115, 6672.933270667231, 6691.732330706717, 1609.316040682705, 1621.8621417179436, 1638.0826737027303, 1642.7043132236074, 1660.062064933333, 1057.8095942730383, 1074.4735079810837, 1086.8043752124536, 1089.7112265249716, 1100.0539535999035, 6218.533609979179, 6220.813375598739, 6224.564280500412, 6269.8746025079245, 6269.993602047392, 6793.796186114425, 6839.863202735917, 6853.657317134123, 6855.760048398282, 6857.25140089284, 6140.846478838065, 6163.445289923839, 6175.505959523227, 6205.782797602153, 6240.188775459252, 3698.3158115748674, 3701.5188025556504, 3712.6101759314884, 3724.7020238380865, 3725.832337544817, 7082.362587367059, 7109.0, 7110.857782844314, 7130.0, 7162.247963963813, 6823.147106611674, 6976.395429051245, 6983.546069505466, 6993.160820701447, 7008.229094799568, 7108.218096009435, 7116.217216106224, 7127.679254433563, 7133.785986420519, 7134.179569349488, 6765.42493888025, 6788.422984046411, 6815.93184068153, 6818.079559259437, 6835.829104272433, 6631.303713110247, 6728.831779205559, 6742.561733487308, 6754.696038678173, 6822.249552549315, 7189.1013623297085, 7232.674529646073, 7244.239354867663, 7246.0, 7252.0, 4592.931106033479, 4620.445546534437, 4640.767961601839, 4655.604273636779, 4663.370444989883, 6860.2453730088655, 6926.792196234121, 6957.721691132298, 6969.16370035599, 7040.577565346096, 6811.591304521745, 6833.487488438288, 6841.0, 6852.725890964306, 6863.485238607024, 6809.182898052265, 6817.216020157745, 6831.521793474409, 6832.453403727789, 6850.280720524273, 6521.413072823469, 6667.599944003376, 6690.13028306317, 6693.0, 6698.866022679616, 6822.3859852613505, 6828.795136145924, 6834.316568343126, 6838.829029274308, 6865.656717164022, 6576.967115164393, 6603.537752357481, 6620.649669367498, 6664.733410663519, 6692.795296846614], "unit": "score", "name": "prototype.html", "value": 4993.607381025269}, {"lowerIsBetter": false, "replicates": [683.8563901580668, 777.6928113395207, 812.1553584272357, 826.29764700005, 856.4818284937613, 13091.869081309183, 13100.29696139503, 13156.934215328922, 13218.0, 13275.734485310288, 12780.233186008823, 12794.424250908709, 12907.096503244753, 12916.418761155746, 12961.092723509359, 659.5844617890734, 667.5660820466687, 802.2258520527689, 826.7767702720262, 830.1988581019315, 809.2716555100427, 811.342812322021, 816.4529765057425, 819.2708489444399, 825.0347093900151, 844.3962566764762, 845.1421806866036, 849.3247867944998, 850.6512329944724, 852.799592095857, 831.2269589281965, 839.3369238301734, 841.3899922556159, 842.2209456253003, 843.1231519219973, 628.7830698409042, 628.9622622642656, 629.527854109418, 629.7512482569405, 629.8456878064858, 12899.0, 13015.15401498909, 13062.412191451407, 13115.344232788419, 13144.934275328658, 12649.683757906034, 12862.485500579965, 13070.542531011464, 13236.338183090807, 13444.596662100153, 10888.61889833852, 10970.286931349438, 11095.119457651332, 11322.49048792798, 11462.82805757906, 3589.2283159120916, 3609.386404311247, 3619.2218672985173, 3621.9094522636883, 3639.7998110103936, 45899.54100458986, 45984.0, 46199.76900115512, 46455.53544464546, 47578.5242147581, 9799.853002204973, 9865.457399842933, 9872.605095796087, 9895.752606184902, 9900.900990989998, 18148.274069037092, 18317.450476485727, 18321.7251741224, 18405.447836564923, 18434.170462329228, 7303.671334789948, 7335.339819416278, 7422.369098626677, 7509.962450187823, 7644.694212231449, 4129.236091323115, 4136.841684328393, 4173.853915112956, 4194.266003449445, 4227.6406505447385, 2961.4373269078806, 3024.107888172994, 3032.1358412852233, 3033.9836154888358, 3044.0, 523.500057445139, 525.0549011778783, 527.2618334331966, 528.408182835227, 555.0342404216634, 475.86675730795434, 508.74054232341774, 560.9411011843779, 597.3190562758459, 625.7309356976543, 8025.678972841138, 8619.267362274277, 8917.598708058153, 8960.283177345797, 9059.123010330957, 504.67700671570225, 550.9256250406224, 563.1130968724276, 567.3447168520365, 572.4904834697123, 4069.4302797608357, 4103.5997274214515, 4170.562090980464, 4290.935635965463, 4417.757023363746, 54073.1889021665, 54924.73545630698, 55014.449855500934, 55021.724891375285, 55329.0, 47711.28433073506, 48870.26694599584, 49016.5098349012, 49559.256611150864, 49578.25632615513, 44382.0, 45162.09675806531, 45308.09383812305, 45542.08915821731, 45554.54445455503, 8753.25619735909, 8832.205101540892, 8886.644534218818, 8915.866262005946, 9010.86483702758, 32971.50542741813, 34399.65600344064, 34873.82563087168, 35379.646203538665, 37057.81471092627, 42441.787791060844, 42717.0, 43884.341734873364, 44098.0, 44697.55302446934, 9930.354526955725, 10057.748556286151, 10107.89892101099, 10110.140638045848, 10166.390016599027, 10447.58209671635, 10497.632582859564, 10557.313774604627, 10762.569497220336, 11096.167787415814, 10327.431991240554, 10514.26400151982, 10812.891871081189, 10885.836712449478, 10905.34567925927, 10453.68638940833, 10525.684229473129, 10746.785064298514, 10799.244052916221, 10827.24209305341, 10672.786544268916, 10778.29941053829, 10934.507947142556, 10975.945120274348, 11232.255304756009, 9220.953895230481, 9255.53722313895, 9329.953350233205, 9418.62325506972, 9478.810423791623, 9324.0, 9558.426494410358, 9581.712548623553, 9621.9037809621, 9631.566579503798], "unit": "score", "name": "yui.html", "value": 6140.177659200183}], "name": "dromaeo_css", "value": 6885.175303011357}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 115.0, 114.0, 124.0, 112.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 154.0, 161.0, 130.0, 156.0, 149.0, 125.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 164.0, 164.0, 166.0, 166.0, 174.0, 164.0, 166.0], "unit": "score", "name": "audio-dft", "value": 165.5}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 75.0, 72.0, 74.0, 75.0, 144.0, 73.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 147.0, 97.0, 98.0, 97.0, 140.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 98.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 60.0, 59.0, 66.0, 62.0, 60.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [68.0, 73.0, 68.0, 69.0, 67.0, 68.0, 76.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 85.0, 91.0, 92.0, 85.0, 84.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [122.0, 132.0, 128.0, 128.0, 119.0, 117.0, 119.0, 132.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [152.0, 154.0, 152.0, 155.0, 156.0, 142.0, 165.0, 152.0, 151.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 69.0, 68.0, 69.0, 68.0, 70.0, 70.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1529.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.32183134152498], "unit": "score", "name": "Richards", "value": 209.72918199999998}, {"lowerIsBetter": false, "replicates": [187.89928598271325], "unit": "score", "name": "DeltaBlue", "value": 351.879996}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1064.9627263045793], "unit": "score", "name": "RayTrace", "value": 694.8496709999997}, {"lowerIsBetter": false, "replicates": [724.112961622013], "unit": "score", "name": "Earley", "value": 920.3854029999999}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [40725.490196078434], "unit": "score", "name": "RegExp", "value": 22.368914299470404}, {"lowerIsBetter": false, "replicates": [624.2197253433209], "unit": "score", "name": "Splay", "value": 130.54858199999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20267.56983099408}]} 09:19:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20267.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1529.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6885.18"}}} 09:19:25 INFO - Return code: 0 09:19:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:19:25 INFO - # TBPL SUCCESS # 09:19:25 INFO - Running post-action listener: _resource_record_post_action 09:19:25 INFO - Running post-run listener: _resource_record_post_run 09:19:26 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 20480; Write bytes: 550895616; Read time: 24; Write time: 520984 09:19:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 199065600; Read time: 0; Write time: 238520 09:19:26 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 20480; Write bytes: 311078912; Read time: 24; Write time: 258196 09:19:26 INFO - Running post-run listener: _upload_blobber_files 09:19:26 INFO - Blob upload gear active. 09:19:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:19:26 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:19:26 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'] 09:19:26 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 09:19:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:27 INFO - (blobuploader) - INFO - Done attempting. 09:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:28 INFO - (blobuploader) - INFO - Done attempting. 09:19:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:28 INFO - Return code: 0 09:19:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:19:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e173e00c32b2e3a4a9e9b519ece079535c30083a2225c548655b02b3e0f1d4a58ab5d4c7d0af687e2f201726b234b0b211785fc83ac7539d80bb92832f3f457", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/445e9dc1773bb94e1852f1baca6ccd21df71ca152d6a1fce5dbb7517dc20ac7a68aa93d9a1633a84f16fedf9fba7a8bf3fbf44f17dda71c368a7e0042e364f1a"} 09:19:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:19:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:19:28 INFO - Contents: 09:19:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e173e00c32b2e3a4a9e9b519ece079535c30083a2225c548655b02b3e0f1d4a58ab5d4c7d0af687e2f201726b234b0b211785fc83ac7539d80bb92832f3f457", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/445e9dc1773bb94e1852f1baca6ccd21df71ca152d6a1fce5dbb7517dc20ac7a68aa93d9a1633a84f16fedf9fba7a8bf3fbf44f17dda71c368a7e0042e364f1a"} 09:19:28 INFO - Copying logs to upload dir... 09:19:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.688125 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-14 09:19:28.012313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 09:19:28.015635) ========= 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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e173e00c32b2e3a4a9e9b519ece079535c30083a2225c548655b02b3e0f1d4a58ab5d4c7d0af687e2f201726b234b0b211785fc83ac7539d80bb92832f3f457", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/445e9dc1773bb94e1852f1baca6ccd21df71ca152d6a1fce5dbb7517dc20ac7a68aa93d9a1633a84f16fedf9fba7a8bf3fbf44f17dda71c368a7e0042e364f1a"} build_url:https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/al17RE2WSju46MYDDMLwhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e173e00c32b2e3a4a9e9b519ece079535c30083a2225c548655b02b3e0f1d4a58ab5d4c7d0af687e2f201726b234b0b211785fc83ac7539d80bb92832f3f457", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/445e9dc1773bb94e1852f1baca6ccd21df71ca152d6a1fce5dbb7517dc20ac7a68aa93d9a1633a84f16fedf9fba7a8bf3fbf44f17dda71c368a7e0042e364f1a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 09:19:28.040217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:19:28.040529) ========= 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=52faae308a556c440401f8e5000001e8-1452790689.142117-1576790915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:19:28.123108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 09:19:28.123412) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 09:19:28.123714) ========= ========= Total master_lag: 0.20 =========