builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1453391501.23 results: success (0) buildid: 20160120073402 builduid: f9f44c436add4a1d8910ad9c9d3d91ad revision: 6764bc656c1d146962d53710d734c2ac87c2306f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:41.232035) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:41.233673) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:41.234044) ========= 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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006417 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:41.291994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:41.292290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:41.974374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:41.974623) ========= 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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.040602) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.040953) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.041388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.041721) ========= 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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 07:51:42-- 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% 59.6M=0s 2016-01-21 07:51:42 (59.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168335 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.229246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.229613) ========= 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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014933 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.281060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.281477) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6764bc656c1d146962d53710d734c2ac87c2306f --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 6764bc656c1d146962d53710d734c2ac87c2306f --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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 07:51:42,512 truncating revision to first 12 chars 2016-01-21 07:51:42,512 Setting DEBUG logging. 2016-01-21 07:51:42,512 attempt 1/10 2016-01-21 07:51:42,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6764bc656c1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 07:51:42,768 unpacking tar archive at: mozilla-central-6764bc656c1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.915654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.916014) ========= echo 6764bc656c1d146962d53710d734c2ac87c2306f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6764bc656c1d146962d53710d734c2ac87c2306f'] 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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6764bc656c1d146962d53710d734c2ac87c2306f program finished with exit code 0 elapsedTime=0.003909 script_repo_revision: '6764bc656c1d146962d53710d734c2ac87c2306f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.965883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.966363) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.982844) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.983135) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/6764bc656c1d146962d53710d734c2ac87c2306f ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:42.983542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-21 07:51:42.983852) ========= /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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:43 INFO - MultiFileLogger online at 20160121 07:51:43 in /builds/slave/test-pgo 07:51:43 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 07:51:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:51:43 INFO - {'append_to_log': False, 07:51:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:51:43 INFO - 'blob_upload_branch': 'Firefox', 07:51:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:51:43 INFO - 'branch': 'Firefox', 07:51:43 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:43 INFO - 'config_files': ('talos/linux_config.py',), 07:51:43 INFO - 'default_actions': ('clobber', 07:51:43 INFO - 'read-buildbot-config', 07:51:43 INFO - 'download-and-extract', 07:51:43 INFO - 'populate-webroot', 07:51:43 INFO - 'create-virtualenv', 07:51:43 INFO - 'install', 07:51:43 INFO - 'run-tests'), 07:51:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:43 INFO - 'download_minidump_stackwalk': True, 07:51:43 INFO - 'download_symbols': 'ondemand', 07:51:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:43 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:43 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:43 INFO - 'installer_path': 'installer.exe', 07:51:43 INFO - 'log_level': 'info', 07:51:43 INFO - 'log_name': 'talos', 07:51:43 INFO - 'log_to_console': True, 07:51:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:43 INFO - 'opt_config_files': (), 07:51:43 INFO - 'pip_index': False, 07:51:43 INFO - 'sps_profile': False, 07:51:43 INFO - 'sps_profile_interval': 0, 07:51:43 INFO - 'suite': 'dromaeojs-e10s', 07:51:43 INFO - 'system_bits': '32', 07:51:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:43 INFO - 'title': 'talos-linux64-ix-008', 07:51:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:43 INFO - 'use_talos_json': True, 07:51:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:51:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:43 INFO - 'work_dir': 'build'} 07:51:43 INFO - ##### 07:51:43 INFO - ##### Running clobber step. 07:51:43 INFO - ##### 07:51:43 INFO - Running pre-action listener: _resource_record_pre_action 07:51:43 INFO - Running main action method: clobber 07:51:43 INFO - rmtree: /builds/slave/test-pgo/build 07:51:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:51:44 INFO - Running post-action listener: _resource_record_post_action 07:51:44 INFO - ##### 07:51:44 INFO - ##### Running read-buildbot-config step. 07:51:44 INFO - ##### 07:51:44 INFO - Running pre-action listener: _resource_record_pre_action 07:51:44 INFO - Running main action method: read_buildbot_config 07:51:44 INFO - Using buildbot properties: 07:51:44 INFO - { 07:51:44 INFO - "project": "", 07:51:44 INFO - "product": "firefox", 07:51:44 INFO - "script_repo_revision": "production", 07:51:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:51:44 INFO - "repository": "", 07:51:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:51:44 INFO - "buildid": "20160120073402", 07:51:44 INFO - "pgo_build": "True", 07:51:44 INFO - "basedir": "/builds/slave/test-pgo", 07:51:44 INFO - "buildnumber": 622, 07:51:44 INFO - "slavename": "talos-linux64-ix-008", 07:51:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:51:44 INFO - "platform": "ubuntu64_hw", 07:51:44 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:51:44 INFO - "branch": "mozilla-central", 07:51:44 INFO - "repo_path": "mozilla-central", 07:51:44 INFO - "revision": "6764bc656c1d146962d53710d734c2ac87c2306f", 07:51:44 INFO - "stage_platform": "linux64-pgo", 07:51:44 INFO - "builduid": "f9f44c436add4a1d8910ad9c9d3d91ad", 07:51:44 INFO - "slavebuilddir": "test" 07:51:44 INFO - } 07:51:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:51:44 INFO - Running post-action listener: _resource_record_post_action 07:51:44 INFO - ##### 07:51:44 INFO - ##### Running download-and-extract step. 07:51:44 INFO - ##### 07:51:44 INFO - Running pre-action listener: _resource_record_pre_action 07:51:44 INFO - Running main action method: download_and_extract 07:51:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:51: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')]} 07:51:44 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json 07:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json 07:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:51:51 INFO - Downloaded 1448 bytes. 07:51:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:51:51 INFO - Using the following test package requirements: 07:51:51 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:51 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:51 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:51:51 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'jsshell-linux-x86_64.zip'], 07:51:51 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:51 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:51 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:51:51 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:51:51 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:51 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:51 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:51 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51: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')]} 07:51:51 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:52:03 INFO - Downloaded 22485896 bytes. 07:52:03 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'] 07:52:03 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 07:52:04 INFO - Return code: 0 07:52:04 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 07:52:04 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')]} 07:52:04 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:52:06 INFO - Downloaded 22485896 bytes. 07:52:06 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'] 07:52:06 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 07:52:07 INFO - Return code: 0 07:52:07 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')]} 07:52:07 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:52:10 INFO - Downloaded 11132144 bytes. 07:52:10 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'] 07:52:10 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 07:52:10 INFO - Return code: 0 07:52: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')]} 07:52:10 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:52:12 INFO - Downloaded 55941556 bytes. 07:52:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:12 INFO - mkdir: /builds/slave/test-pgo/properties 07:52:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:52:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:52:12 INFO - Contents: 07:52:12 INFO - build_url:https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:12 INFO - Running post-action listener: _resource_record_post_action 07:52:12 INFO - Running post-action listener: set_extra_try_arguments 07:52:12 INFO - ##### 07:52:12 INFO - ##### Running populate-webroot step. 07:52:12 INFO - ##### 07:52:12 INFO - Running pre-action listener: _resource_record_pre_action 07:52:12 INFO - Running main action method: populate_webroot 07:52:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:12 INFO - '--tppagecycles', 07:52:12 INFO - '7'], 07:52:12 INFO - 'tests': ['tsvgm']}}, 07:52:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:52:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:52:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:52:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'tests': ['damp', 'tps']}, 07:52:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['damp', 'tps']}, 07:52:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:52:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:12 INFO - 'other': {'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore']}, 07:52:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore']}, 07:52:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore']}, 07:52:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore']}, 07:52:12 INFO - 'other_l64': {'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore']}, 07:52:12 INFO - 'other_nol64': {'tests': ['a11yr', 07:52:12 INFO - 'ts_paint', 07:52:12 INFO - 'tpaint', 07:52:12 INFO - 'sessionrestore', 07:52:12 INFO - 'sessionrestore_no_auto_restore']}, 07:52:12 INFO - 'svgr': {'tests': ['tsvgx', 07:52:12 INFO - 'tsvgr_opacity', 07:52:12 INFO - 'tart', 07:52:12 INFO - 'tscrollx', 07:52:12 INFO - 'cart']}, 07:52:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['tsvgx', 07:52:12 INFO - 'tsvgr_opacity', 07:52:12 INFO - 'tart', 07:52:12 INFO - 'tscrollx', 07:52:12 INFO - 'cart']}, 07:52:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'tests': ['tp5o']}, 07:52:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'talos_options': ['--e10s'], 07:52:12 INFO - 'tests': ['tp5o']}, 07:52:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'talos_options': ['--xperf_path', 07:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:12 INFO - 'tests': ['tp5n']}, 07:52:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:12 INFO - 'talos_options': ['--e10s', 07:52:12 INFO - '--xperf_path', 07:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:12 INFO - 'tests': ['tp5n']}}, 07:52:12 INFO - 'talos.zip': {'path': '', 07:52:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:12 INFO - Running post-action listener: _resource_record_post_action 07:52:12 INFO - ##### 07:52:12 INFO - ##### Running create-virtualenv step. 07:52:12 INFO - ##### 07:52:12 INFO - Running pre-action listener: _resource_record_pre_action 07:52:12 INFO - Running main action method: create_virtualenv 07:52:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:52:12 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 07:52:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:52:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:12 INFO - Using real prefix '/usr' 07:52:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:52:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:14 INFO - Installing pip.................done. 07:52:14 INFO - Return code: 0 07:52:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:52:14 INFO - Using env: {'DISPLAY': ':0', 07:52:14 INFO - 'HOME': '/home/cltbld', 07:52:14 INFO - 'LANG': 'en_US.UTF-8', 07:52:14 INFO - 'LANGUAGE': 'en_US:en', 07:52:14 INFO - 'LOGNAME': 'cltbld', 07:52:14 INFO - 'MAIL': '/var/mail/cltbld', 07:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:14 INFO - 'MOZ_NO_REMOTE': '1', 07:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:14 INFO - 'NO_EM_RESTART': '1', 07:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:14 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:14 INFO - 'SHELL': '/bin/bash', 07:52:14 INFO - 'SHLVL': '1', 07:52:14 INFO - 'TERM': 'linux', 07:52:14 INFO - 'TMOUT': '86400', 07:52:14 INFO - 'USER': 'cltbld', 07:52:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:14 INFO - '_': '/tools/buildbot/bin/python'} 07:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:15 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 07:52:15 INFO - Cleaning up... 07:52:15 INFO - Return code: 0 07:52:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:52:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:52:15 INFO - Using env: {'DISPLAY': ':0', 07:52:15 INFO - 'HOME': '/home/cltbld', 07:52:15 INFO - 'LANG': 'en_US.UTF-8', 07:52:15 INFO - 'LANGUAGE': 'en_US:en', 07:52:15 INFO - 'LOGNAME': 'cltbld', 07:52:15 INFO - 'MAIL': '/var/mail/cltbld', 07:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:15 INFO - 'MOZ_NO_REMOTE': '1', 07:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:15 INFO - 'NO_EM_RESTART': '1', 07:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:15 INFO - 'SHELL': '/bin/bash', 07:52:15 INFO - 'SHLVL': '1', 07:52:15 INFO - 'TERM': 'linux', 07:52:15 INFO - 'TMOUT': '86400', 07:52:15 INFO - 'USER': 'cltbld', 07:52:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:15 INFO - '_': '/tools/buildbot/bin/python'} 07:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:15 INFO - Downloading/unpacking psutil>=0.7.1 07:52:15 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 07:52:15 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 07:52:15 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 07:52:15 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 07:52:15 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 07:52:15 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 07:52:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:17 INFO - Installing collected packages: psutil 07:52:17 INFO - Running setup.py install for psutil 07:52:17 INFO - building 'psutil._psutil_linux' extension 07:52:17 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 07:52:17 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 07:52:17 INFO - building 'psutil._psutil_posix' extension 07:52:17 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 07:52:17 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 07:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:17 INFO - Successfully installed psutil 07:52:17 INFO - Cleaning up... 07:52:17 INFO - Return code: 0 07:52:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:52:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:52:17 INFO - Using env: {'DISPLAY': ':0', 07:52:17 INFO - 'HOME': '/home/cltbld', 07:52:17 INFO - 'LANG': 'en_US.UTF-8', 07:52:17 INFO - 'LANGUAGE': 'en_US:en', 07:52:17 INFO - 'LOGNAME': 'cltbld', 07:52:17 INFO - 'MAIL': '/var/mail/cltbld', 07:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:17 INFO - 'MOZ_NO_REMOTE': '1', 07:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:17 INFO - 'NO_EM_RESTART': '1', 07:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:17 INFO - 'SHELL': '/bin/bash', 07:52:17 INFO - 'SHLVL': '1', 07:52:17 INFO - 'TERM': 'linux', 07:52:17 INFO - 'TMOUT': '86400', 07:52:17 INFO - 'USER': 'cltbld', 07:52:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:17 INFO - '_': '/tools/buildbot/bin/python'} 07:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:52:17 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 07:52:17 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 07:52:17 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 07:52:17 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 07:52:17 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 07:52:17 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 07:52:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:52:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:52:19 INFO - Installing collected packages: mozsystemmonitor 07:52:19 INFO - Running setup.py install for mozsystemmonitor 07:52:19 INFO - Successfully installed mozsystemmonitor 07:52:19 INFO - Cleaning up... 07:52:19 INFO - Return code: 0 07:52:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:52:19 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')]} 07:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 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')]} 07:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:52:19 INFO - Using env: {'DISPLAY': ':0', 07:52:19 INFO - 'HOME': '/home/cltbld', 07:52:19 INFO - 'LANG': 'en_US.UTF-8', 07:52:19 INFO - 'LANGUAGE': 'en_US:en', 07:52:19 INFO - 'LOGNAME': 'cltbld', 07:52:19 INFO - 'MAIL': '/var/mail/cltbld', 07:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:19 INFO - 'MOZ_NO_REMOTE': '1', 07:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:19 INFO - 'NO_EM_RESTART': '1', 07:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:19 INFO - 'SHELL': '/bin/bash', 07:52:19 INFO - 'SHLVL': '1', 07:52:19 INFO - 'TERM': 'linux', 07:52:19 INFO - 'TMOUT': '86400', 07:52:19 INFO - 'USER': 'cltbld', 07:52:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:19 INFO - '_': '/tools/buildbot/bin/python'} 07:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:20 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 07:52:20 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 07:52:20 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 07:52:20 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 07:52:20 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 07:52:20 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 07:52:21 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:52:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:22 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 07:52:22 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 07:52:22 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 07:52:22 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 07:52:22 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 07:52:22 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 07:52:22 INFO - Downloading docopt-0.6.1.tar.gz 07:52:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:22 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:22 INFO - Running setup.py install for blobuploader 07:52:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:52:22 INFO - Running setup.py install for requests 07:52:22 INFO - Running setup.py install for docopt 07:52:23 INFO - Successfully installed blobuploader requests docopt 07:52:23 INFO - Cleaning up... 07:52:23 INFO - Return code: 0 07:52:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52: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')]} 07:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:52:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:23 INFO - Using env: {'DISPLAY': ':0', 07:52:23 INFO - 'HOME': '/home/cltbld', 07:52:23 INFO - 'LANG': 'en_US.UTF-8', 07:52:23 INFO - 'LANGUAGE': 'en_US:en', 07:52:23 INFO - 'LOGNAME': 'cltbld', 07:52:23 INFO - 'MAIL': '/var/mail/cltbld', 07:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:23 INFO - 'MOZ_NO_REMOTE': '1', 07:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:23 INFO - 'NO_EM_RESTART': '1', 07:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:23 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:23 INFO - 'SHELL': '/bin/bash', 07:52:23 INFO - 'SHLVL': '1', 07:52:23 INFO - 'TERM': 'linux', 07:52:23 INFO - 'TMOUT': '86400', 07:52:23 INFO - 'USER': 'cltbld', 07:52:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:23 INFO - '_': '/tools/buildbot/bin/python'} 07:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:23 INFO - Running setup.py (path:/tmp/pip-d86n2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:23 INFO - Running setup.py (path:/tmp/pip-mioMP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:23 INFO - Running setup.py (path:/tmp/pip-_zr7wd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:23 INFO - Running setup.py (path:/tmp/pip-RDec3X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:23 INFO - Running setup.py (path:/tmp/pip-uJQBhV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:23 INFO - Running setup.py (path:/tmp/pip-U3qXPK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:23 INFO - Running setup.py (path:/tmp/pip-g0ek33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:23 INFO - Running setup.py (path:/tmp/pip-aKbh4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:23 INFO - Running setup.py (path:/tmp/pip-y_3MaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:24 INFO - Running setup.py (path:/tmp/pip-EnXChU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:24 INFO - Running setup.py (path:/tmp/pip-eLbMFx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:24 INFO - Running setup.py (path:/tmp/pip-wJt2Bg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:24 INFO - Running setup.py (path:/tmp/pip-kAmQA6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:24 INFO - Running setup.py (path:/tmp/pip-_JJBdz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:24 INFO - Running setup.py (path:/tmp/pip-wutlw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:24 INFO - Running setup.py (path:/tmp/pip-8CZWw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:24 INFO - Running setup.py (path:/tmp/pip-COQ8op-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:24 INFO - Running setup.py install for manifestparser 07:52:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:52:24 INFO - Running setup.py install for mozcrash 07:52:24 INFO - Running setup.py install for mozdebug 07:52:24 INFO - Running setup.py install for mozdevice 07:52:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Running setup.py install for mozfile 07:52:25 INFO - Running setup.py install for mozhttpd 07:52:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Running setup.py install for mozinfo 07:52:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Running setup.py install for mozInstall 07:52:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Running setup.py install for mozleak 07:52:25 INFO - Running setup.py install for mozlog 07:52:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Running setup.py install for moznetwork 07:52:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Running setup.py install for mozprocess 07:52:25 INFO - Running setup.py install for mozprofile 07:52:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:52:25 INFO - Running setup.py install for mozrunner 07:52:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:52:26 INFO - Running setup.py install for mozscreenshot 07:52:26 INFO - Running setup.py install for moztest 07:52:26 INFO - Running setup.py install for mozversion 07:52:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:52:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:26 INFO - Cleaning up... 07:52:26 INFO - Return code: 0 07:52:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52: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')]} 07:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:52:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:26 INFO - Using env: {'DISPLAY': ':0', 07:52:26 INFO - 'HOME': '/home/cltbld', 07:52:26 INFO - 'LANG': 'en_US.UTF-8', 07:52:26 INFO - 'LANGUAGE': 'en_US:en', 07:52:26 INFO - 'LOGNAME': 'cltbld', 07:52:26 INFO - 'MAIL': '/var/mail/cltbld', 07:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:26 INFO - 'MOZ_NO_REMOTE': '1', 07:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:26 INFO - 'NO_EM_RESTART': '1', 07:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:26 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:26 INFO - 'SHELL': '/bin/bash', 07:52:26 INFO - 'SHLVL': '1', 07:52:26 INFO - 'TERM': 'linux', 07:52:26 INFO - 'TMOUT': '86400', 07:52:26 INFO - 'USER': 'cltbld', 07:52:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:26 INFO - '_': '/tools/buildbot/bin/python'} 07:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:26 INFO - Running setup.py (path:/tmp/pip-JmvyKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:26 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)) 07:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:26 INFO - Running setup.py (path:/tmp/pip-I9RZhw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:26 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)) 07:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:26 INFO - Running setup.py (path:/tmp/pip-dGtPGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:26 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)) 07:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:26 INFO - Running setup.py (path:/tmp/pip-6EAzUU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:26 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)) 07:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:26 INFO - Running setup.py (path:/tmp/pip-bPBlt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:26 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)) 07:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:26 INFO - Running setup.py (path:/tmp/pip-64C9m5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:27 INFO - Running setup.py (path:/tmp/pip-V7lkow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:27 INFO - Running setup.py (path:/tmp/pip-H6MSEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:27 INFO - Running setup.py (path:/tmp/pip-qCxXRq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:27 INFO - Running setup.py (path:/tmp/pip-w4xqDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:27 INFO - Running setup.py (path:/tmp/pip-NBAgxo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:27 INFO - Running setup.py (path:/tmp/pip-ZkO0we-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:27 INFO - Running setup.py (path:/tmp/pip-3ypPwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:27 INFO - Running setup.py (path:/tmp/pip-sG4E42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:27 INFO - Running setup.py (path:/tmp/pip-vBNQAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:27 INFO - Running setup.py (path:/tmp/pip-phkxxW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:27 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)) 07:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:27 INFO - Running setup.py (path:/tmp/pip-VRKxqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:27 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)) 07:52:27 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)) 07:52:27 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)) 07:52:27 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)) 07:52:27 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)) 07:52:27 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)) 07:52:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:27 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 07:52:27 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 07:52:27 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 07:52:27 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 07:52:27 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 07:52:27 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 07:52:29 INFO - Downloading blessings-1.6.tar.gz 07:52:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:29 INFO - Installing collected packages: blessings 07:52:29 INFO - Running setup.py install for blessings 07:52:29 INFO - Successfully installed blessings 07:52:29 INFO - Cleaning up... 07:52:29 INFO - Return code: 0 07:52:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:52:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:52:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:52:30 INFO - Reading from file tmpfile_stdout 07:52:30 INFO - Current package versions: 07:52:30 INFO - argparse == 1.2.1 07:52:30 INFO - blessings == 1.6 07:52:30 INFO - blobuploader == 1.2.4 07:52:30 INFO - docopt == 0.6.1 07:52:30 INFO - manifestparser == 1.1 07:52:30 INFO - mozInstall == 1.12 07:52:30 INFO - mozcrash == 0.16 07:52:30 INFO - mozdebug == 0.1 07:52:30 INFO - mozdevice == 0.48 07:52:30 INFO - mozfile == 1.2 07:52:30 INFO - mozhttpd == 0.7 07:52:30 INFO - mozinfo == 0.9 07:52:30 INFO - mozleak == 0.1 07:52:30 INFO - mozlog == 3.1 07:52:30 INFO - moznetwork == 0.27 07:52:30 INFO - mozprocess == 0.22 07:52:30 INFO - mozprofile == 0.28 07:52:30 INFO - mozrunner == 6.11 07:52:30 INFO - mozscreenshot == 0.1 07:52:30 INFO - mozsystemmonitor == 0.0 07:52:30 INFO - moztest == 0.7 07:52:30 INFO - mozversion == 1.4 07:52:30 INFO - psutil == 3.1.1 07:52:30 INFO - requests == 1.2.3 07:52:30 INFO - wsgiref == 0.1.2 07:52:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52:30 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')]} 07:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 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')]} 07:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:30 INFO - Using env: {'DISPLAY': ':0', 07:52:30 INFO - 'HOME': '/home/cltbld', 07:52:30 INFO - 'LANG': 'en_US.UTF-8', 07:52:30 INFO - 'LANGUAGE': 'en_US:en', 07:52:30 INFO - 'LOGNAME': 'cltbld', 07:52:30 INFO - 'MAIL': '/var/mail/cltbld', 07:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:30 INFO - 'MOZ_NO_REMOTE': '1', 07:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:30 INFO - 'NO_EM_RESTART': '1', 07:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:30 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:30 INFO - 'SHELL': '/bin/bash', 07:52:30 INFO - 'SHLVL': '1', 07:52:30 INFO - 'TERM': 'linux', 07:52:30 INFO - 'TMOUT': '86400', 07:52:30 INFO - 'USER': 'cltbld', 07:52:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:30 INFO - '_': '/tools/buildbot/bin/python'} 07:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 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)) 07:52:30 INFO - Cleaning up... 07:52:30 INFO - Return code: 0 07:52:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:52:30 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')]} 07:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 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')]} 07:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:52:30 INFO - Using env: {'DISPLAY': ':0', 07:52:30 INFO - 'HOME': '/home/cltbld', 07:52:30 INFO - 'LANG': 'en_US.UTF-8', 07:52:30 INFO - 'LANGUAGE': 'en_US:en', 07:52:30 INFO - 'LOGNAME': 'cltbld', 07:52:30 INFO - 'MAIL': '/var/mail/cltbld', 07:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:30 INFO - 'MOZ_NO_REMOTE': '1', 07:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:30 INFO - 'NO_EM_RESTART': '1', 07:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:30 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:30 INFO - 'SHELL': '/bin/bash', 07:52:30 INFO - 'SHLVL': '1', 07:52:30 INFO - 'TERM': 'linux', 07:52:30 INFO - 'TMOUT': '86400', 07:52:30 INFO - 'USER': 'cltbld', 07:52:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:30 INFO - '_': '/tools/buildbot/bin/python'} 07:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:30 INFO - Downloading/unpacking jsonschema 07:52:30 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 07:52:30 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 07:52:30 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 07:52:30 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 07:52:30 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 07:52:30 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 07:52:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:32 INFO - Downloading/unpacking functools32 (from jsonschema) 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:32 INFO - warning: no files found matching '*.txt' 07:52:32 INFO - no previously-included directories found matching 'build' 07:52:32 INFO - no previously-included directories found matching 'dist' 07:52:32 INFO - no previously-included directories found matching '.git*' 07:52:32 INFO - Installing collected packages: jsonschema, functools32 07:52:32 INFO - Running setup.py install for functools32 07:52:32 INFO - warning: no files found matching '*.txt' 07:52:32 INFO - no previously-included directories found matching 'build' 07:52:32 INFO - no previously-included directories found matching 'dist' 07:52:32 INFO - no previously-included directories found matching '.git*' 07:52:32 INFO - Successfully installed jsonschema functools32 07:52:32 INFO - Cleaning up... 07:52:32 INFO - Return code: 0 07:52:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:52:32 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')]} 07:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:32 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')]} 07:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f437ae73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, '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': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', '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 07:52:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:52:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:52:32 INFO - Using env: {'DISPLAY': ':0', 07:52:32 INFO - 'HOME': '/home/cltbld', 07:52:32 INFO - 'LANG': 'en_US.UTF-8', 07:52:32 INFO - 'LANGUAGE': 'en_US:en', 07:52:32 INFO - 'LOGNAME': 'cltbld', 07:52:32 INFO - 'MAIL': '/var/mail/cltbld', 07:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:32 INFO - 'MOZ_NO_REMOTE': '1', 07:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:32 INFO - 'NO_EM_RESTART': '1', 07:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:32 INFO - 'SHELL': '/bin/bash', 07:52:32 INFO - 'SHLVL': '1', 07:52:32 INFO - 'TERM': 'linux', 07:52:32 INFO - 'TMOUT': '86400', 07:52:32 INFO - 'USER': 'cltbld', 07:52:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:32 INFO - '_': '/tools/buildbot/bin/python'} 07:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:32 INFO - Downloading/unpacking flake8 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52:34 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 07:52:34 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 07:52:34 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 07:52:34 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 07:52:34 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 07:52:34 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 07:52:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52:34 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 07:52:34 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 07:52:34 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 07:52:34 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 07:52:34 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 07:52:34 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 07:52:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52:35 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 07:52:35 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 07:52:35 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 07:52:35 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 07:52:35 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 07:52:35 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 07:52:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:35 INFO - no previously-included directories found matching 'docs/_build' 07:52:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:35 INFO - Running setup.py install for pep8 07:52:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:35 INFO - no previously-included directories found matching 'docs/_build' 07:52:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:52:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:35 INFO - Cleaning up... 07:52:35 INFO - Return code: 0 07:52:35 INFO - Running post-action listener: _resource_record_post_action 07:52:35 INFO - Running post-action listener: _start_resource_monitoring 07:52:35 INFO - Starting resource monitoring. 07:52:35 INFO - ##### 07:52:35 INFO - ##### Running install step. 07:52:35 INFO - ##### 07:52:35 INFO - Running pre-action listener: _resource_record_pre_action 07:52:35 INFO - Running main action method: install 07:52:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:52:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:52:35 INFO - Reading from file tmpfile_stdout 07:52:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:52:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:52:35 INFO - Reading from file tmpfile_stdout 07:52:35 INFO - Output received: 07:52:35 INFO - Usage: mozinstall [options] installer 07:52:35 INFO - Options: 07:52:35 INFO - -h, --help show this help message and exit 07:52:35 INFO - -d DEST, --destination=DEST 07:52:35 INFO - Directory to install application into. [default: 07:52:35 INFO - "/builds/slave/test-pgo"] 07:52:35 INFO - --app=APP Application being installed. [default: firefox] 07:52:35 INFO - mkdir: /builds/slave/test-pgo/build/application 07:52:35 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'] 07:52:35 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 07:52:51 INFO - Reading from file tmpfile_stdout 07:52:51 INFO - Output received: 07:52:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:52:51 INFO - Running post-action listener: _resource_record_post_action 07:52:51 INFO - ##### 07:52:51 INFO - ##### Running run-tests step. 07:52:51 INFO - ##### 07:52:51 INFO - Running pre-action listener: _resource_record_pre_action 07:52:51 INFO - Running main action method: run_tests 07:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:52:51 INFO - Python 2.7.3 07:52:51 INFO - Return code: 0 07:52:51 INFO - grabbing minidump binary from tooltool 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:51 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 0xfc2660>, '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 0xfc3560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:52:51 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 07:52:51 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 07:52:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:52 INFO - Return code: 0 07:52:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:52:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:52:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:52:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:52:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:52:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:52:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:52:53 INFO - Return code: 0 07:52:53 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/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 07:52:53 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/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 07:52:53 INFO - Using env: {'DISPLAY': ':0', 07:52:53 INFO - 'HOME': '/home/cltbld', 07:52:53 INFO - 'LANG': 'en_US.UTF-8', 07:52:53 INFO - 'LANGUAGE': 'en_US:en', 07:52:53 INFO - 'LOGNAME': 'cltbld', 07:52:53 INFO - 'MAIL': '/var/mail/cltbld', 07:52:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:52:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:53 INFO - 'MOZ_NO_REMOTE': '1', 07:52:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:53 INFO - 'NO_EM_RESTART': '1', 07:52:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:52:53 INFO - 'SHELL': '/bin/bash', 07:52:53 INFO - 'SHLVL': '1', 07:52:53 INFO - 'TERM': 'linux', 07:52:53 INFO - 'TMOUT': '86400', 07:52:53 INFO - 'USER': 'cltbld', 07:52:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891', 07:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:53 INFO - '_': '/tools/buildbot/bin/python'} 07:52:53 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/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 07:52:53 INFO - mozversion application_buildid: 20160120073402 07:52:53 INFO - mozversion application_changeset: 6764bc656c1d146962d53710d734c2ac87c2306f 07:52:53 INFO - mozversion application_display_name: Nightly 07:52:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:53 INFO - mozversion application_name: Firefox 07:52:53 INFO - mozversion application_remotingname: firefox 07:52:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:52:53 INFO - mozversion application_vendor: Mozilla 07:52:53 INFO - mozversion application_version: 46.0a1 07:52:53 INFO - mozversion platform_buildid: 20160120073402 07:52:53 INFO - mozversion platform_changeset: 6764bc656c1d146962d53710d734c2ac87c2306f 07:52:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:52:53 INFO - mozversion platform_version: 46.0a1 07:52:53 INFO - using testdate: 1453391573 07:52:53 INFO - actual date: 1453391573 07:52:54 INFO - starting webserver on 'localhost:59335' 07:52:54 INFO - SUITE-START | Running 3 tests 07:52:54 INFO - TEST-START | dromaeo_css 07:52:54 INFO - operating with platform_type : linux_ 07:52:54 INFO - Initialising browser for dromaeo_css test... 07:52:54 INFO - TEST-INFO | started process 22730 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOWXVLH/profile http://localhost:59335/getInfo.html) 07:52:57 INFO - PROCESS | 22730 | 07:52:57 INFO - PROCESS | 22730 | (process:22810): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:52:58 INFO - PROCESS | 22730 | __metrics Screen width/height:1600/1200 07:52:58 INFO - PROCESS | 22730 | colorDepth:24 07:52:58 INFO - PROCESS | 22730 | Browser inner width/height: 1024/697 07:52:58 INFO - PROCESS | 22730 | __metrics 07:52:59 INFO - PROCESS | 22730 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:52:59 INFO - TEST-INFO | 22730: exit 0 07:52:59 INFO - Browser initialized. 07:52:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:59 INFO - TEST-INFO | started process 22860 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOWXVLH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:00 INFO - PROCESS | 22860 | -- checkerboarding starts below -- 07:53:00 INFO - PROCESS | 22860 | RENDERTRACE 0.041234 rect red 0 0 10 10 // viewport 07:53:00 INFO - PROCESS | 22860 | RENDERTRACE 37.8412 rect brown 0 0 10 10 // page 07:53:00 INFO - PROCESS | 22860 | RENDERTRACE 37.8637 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 07:53:00 INFO - PROCESS | 22860 | Checkerboarded for 1 frames (38.1641 ms), 100 peak, 1 severity. 07:53:01 INFO - PROCESS | 22860 | 07:53:01 INFO - PROCESS | 22860 | (process:22914): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:53:11 INFO - PROCESS | 22860 | RSS: Main: 150454272 07:53:11 INFO - PROCESS | 22860 | 07:54:01 INFO - PROCESS | 22860 | 1453391641361 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] 07:56:10 INFO - PROCESS | 22860 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59335/tests/dromaeo/cssquery-ext.html) 07:56:11 INFO - PROCESS | 22860 | RSS: Main: 156364800 07:56:11 INFO - PROCESS | 22860 | 07:59:13 INFO - PROCESS | 22860 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-ext.html (next: http://localhost:59335/tests/dromaeo/cssquery-jquery.html) 07:59:14 INFO - PROCESS | 22860 | RSS: Main: 153354240 07:59:14 INFO - PROCESS | 22860 | 08:02:16 INFO - PROCESS | 22860 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59335/tests/dromaeo/cssquery-mootools.html) 08:02:16 INFO - PROCESS | 22860 | RSS: Main: 152072192 08:02:16 INFO - PROCESS | 22860 | 08:05:18 INFO - PROCESS | 22860 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59335/tests/dromaeo/cssquery-prototype.html) 08:05:18 INFO - PROCESS | 22860 | RSS: Main: 150622208 08:05:18 INFO - PROCESS | 22860 | 08:08:21 INFO - PROCESS | 22860 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59335/tests/dromaeo/cssquery-yui.html) 08:08:21 INFO - PROCESS | 22860 | RSS: Main: 151322624 08:08:21 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | Cycle 1(1): loaded http://localhost:59335/tests/dromaeo/cssquery-yui.html (next: http://localhost:59335/tests/dromaeo/cssquery-dojo.html) 08:11:24 INFO - PROCESS | 22860 | RSS: Main: 153088000 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | __start_tp_report 08:11:24 INFO - PROCESS | 22860 | _x_x_mozilla_page_load 08:11:24 INFO - PROCESS | 22860 | _x_x_mozilla_page_load_details 08:11:24 INFO - PROCESS | 22860 | |i|pagename|runs| 08:11:24 INFO - PROCESS | 22860 | |0;dojo.html;3209.117492689511;3241.643419223885;3257.381097591456;3276.7378609711227;3277.88527401541;5303.071962406573;5419.566434685225;5424.538914192293;5426.213199086125;5438.2114593383985;5356.4107948125775;5369.48989845964;5375.139977603584;5453.400125986138;5469.15228139638;4894.363732714742;4977.402711674604;5019.64862459628;5033.672811267256;5038.59691224703;4920.753962301888;4977.50224977503;4980.6015518758595;4982.128127577677;5039.647224694273;4834.323194752737;4871.8782030449165;4903.53416425439;4981.576565991895;4984.675996060245;4961.603071754251;4961.751912404366;4964.900701985976;4976.800927962913;4979.701217926936;4947.158982972904;4950.603951683856;4952.034353301107;4968.478309777457;4993.1262029144755;5187.403448603422;5286.656367336111;5326.840194794124;5376.838694839122;5409.756560954727;5877.970610146922;5882.382349853289;5884.117382392633;5887.735051922631;5891.057430811093;5890.528757699374;5906.586538942276;5911.793087241926;5914.940850591482;5923.970380148115;5327.9733601331745;5432.891342173134;5457.017736807413;5500.50495455411;5551;6025;6029.728662210211;6033.456988871023;6058.515318774487;6061.848453788691;5754.712264386764;5780.88438231233;5789.942100579025;5795.768169273182;5798.565107616945;5715.771369145271;5765;5809.738561764731;5861.296644402613;5892.469677729025;5774.191613174159;5836.620619659709;5842.006858834008;5884.0585506318785;5890.646561206341;5824.271966004249;5847.239858818326;5857.7656893724625;5860.824175274749;5862.530997520188;4483.103379324149;4492.528284530143;4541.205289074399;4556;4566.452025756864;3986.242613903407;3990.06233535119;3993.1414745829784;4003.3302921982095;4027.3958906163725;5386.569074474111;5393.514583687487;5393.6763794172475;5402.91895621566;5436.347638283352;5754.0505816540635;5851.561132915049;5854.5901786875365;5905.675187864708;5948.196993405922;5320.068987927098;5352.982933242672;5374.596905232123;5377.7311134443125;5411.107167317427;4868.829590964299;4987.750612469362;5005.474425185376;5015.097282489187;5047.545720885138;5968.522518198533;6003.339632640406;6026.397360264026;6065.272167339859;6101.877962440726;5731.083026715705;5732.942670573408;5764.13537969308;5768.221290125779;5769.07694768835;5963.731632076654;6002.729877155626;6005.6396616203165;6015.849603759941;6069.848253793514;5743.282089738783;5748.511376532874;5756.884862302647;5771.3651498335985;5836.678982655994;5830.125481177857;5841.853953651193;5855.707214639337;5880.8235752927485;5918.940810592011;5671.092625179951;5743.4543718346695;5751.712414379348;5752.942470575408;5753.539716822728;5723.284589426322;5781.768729250783;5790;5793.478586927196;5794.797182098607;5654.208410822406;5674;5684.403137670485;5689.516391106637;5690.174924635822;5568.387477377566;5671.461211184931;5687.203791469115;5692.203091567267;5750.6837123958585;5623.100303951348;5631.8592035199445;5640.943590564042;5654.2649455572155;5666.688332141607 08:11:24 INFO - PROCESS | 22860 | |1;ext.html;521.2520033751567;546.8325125856297;563.3408911573458;566.7024811973713;577.1141298107406;34513.203547609744;35281.47077793829;35322.64677353229;35337.823310883476;35367.2926541469;38973.22053558927;39010.43958241667;39032.60967390325;39320.60679393205;39353.803230983875;8413.242808147266;8522.57387130644;8571.271441927413;8577.142285771435;8593.097724738906;8171.468854524437;8329.541875196861;8352.665893364288;8473.279771219453;8521.744347669579;8505.447145935494;8517.318614510825;8560.571971401436;8590.613422395976;8593.570321483932;8491.915080849205;8509.914900850974;8545.145485451436;8548.316134709208;8554.016288126883;8439.957800211021;8582;8583.356248281403;8598.613062412143;8622.870656940151;39399.21201575953;39749;39807;39995.600043999475;40071.599284007076;3124.140861263148;3306.6032076150777;3537.9739875436094;3712.313222053902;3971.947433930011;29140.562891556645;29316.41367172666;29434;30549.541756873663;30617.693823061705;3876.5348158221195;3893.1240470894104;3933.6853051755793;4002.639762421367;4062.6343629073526;265187;267352;267409;268245;269566;40512.392314115314;41099.7945010279;41188.176236475105;54152.45847541553;55601.439856014076;40083.39874901879;40246.39630405546;40416.39375409371;40481.59518404778;40554.594454055674;13273.800892986614;13423.664408389868;13448.91541811021;13476.191428514321;13477.056606037679;10576.259661823598;10632.30889992148;10642.733931651615;10644.414557199429;10660.573577056986;14123.64690882736;14203.573892783234;14220.075695079786;14341.498047568493;14351.928240358731;5679.460451257124;5808.82573522795;5834.708264586754;5844.327902291291;5858.970705146447;910.9225715814098;925.2644147902433;939.9718008459757;948.1798244518442;1059.1368035051407;28925;28955.71044289572;29037.41925161485;29117.70882291192;29395.85302073476;1008.7125169326854;1052.310736467615;1060.0194819791661;1070.2668671959732;1147.3460127727114;14634.121952682874;14802.851971480362;14833.406663733545;15018.774718379233;15123.243837808066;342285;348519;352520;353971;355654;50605.49394506008;51357.48642513527;51516.227256591184;51725.48274517282;51766.74116629468;1276.9489220431265;1327.6415367850627;1343.1068339554088;1345.2466618693563;1347.1647578501393;27011;27898.860505697343;27989;28179.859100704365;28664;45622.31566526438;45982.7700861507;46029;46046.76976615095;46052.539474604826;315031;316572;316800;316948;318406;32531.51202732008;42356.36465452959;42755;42890;42957.57042429536;45422.77288613668;46157;46584.767076164404;46685;47206.527934720216;32920.67079329272;33141.50287745734;33406;33434;35767.13862891014;35543.64456355404;35597.28805423929;36221.27557448889;36247;36461.27077458383;33361.332773343915;33546.832265838515;33572;37832.62167378401;38323.23353532858;29035.854820725763;30289.394212115192;30409.327486988426;30712;30921;23335.18326858552;23415.243856711157;23433.648495272926;23591.882040589688;23895.880520597286 08:11:24 INFO - PROCESS | 22860 | |2;jquery.html;360.3801461486244;360.5187075254535;367.1317334503899;368.13855577947595;370.1541976583507;15265.542033738991;16380.754288685679;16648.66702665949;17352.045637489933;17645.647087058267;15201.695966080671;15268;15514;15652.0608763474;15711.842881571181;4737.739424331652;4942.579880710144;4945.480724523927;4950.826721064764;4968.056069346831;4846.369971903648;4873.366462359888;4904.5831104356175;4907.82822601209;5237.502437268472;4878.97541516282;5044.520770526812;5193.039287731782;5200.245964335169;5200.583953283728;5019.071471777733;5033.697978121324;5058.0895438821;5061.291419201315;5343.625946183769;5346.117890548055;5349.331333583302;5350.625456218067;5359.3032905722;5372.274742909696;12209.816852747215;16013.359465621477;19019.33432329862;19770.308039218704;19903.40289791294;2130.8614940028847;2144.438019659846;2152.1283880028614;2174.7390313162523;2225.4547635829163;12118.939405303005;12332.630021099292;12394.31831249281;12559.434825432878;12750.322432289231;1608.3727346334938;1626.3169468823005;1660.377358490566;1661.0531996761852;1857.452051644768;54274.72862635701;54521.45478545243;55383.723081384735;55723;55879.44120558783;9087.273018158532;9216.400933939272;9267.907320926839;9280.350375473652;9371.203447706885;11879.762404751857;11887.10846686502;11932.22440541362;11953.103517236243;11968.521259149536;6457.192850893638;6700.564463309966;6798.966005169942;6866.210385805596;6977.058097156819;6622.1722284714415;6648.0360347750275;6668;6670.332966703388;6697.866042679119;4048.0487085534874;4152.252594532953;4301.763403012865;4344.761038142932;4359.760213188241;1592.2038980509744;1647.3492970276673;1674.6650669866076;1683.3434960365466;1692.3146125818816;428.21850123524695;434.36148861174024;438.64250635731776;443.70050216104;446.7297285142442;10467.633632822815;10737.355758654505;10862.348259104321;10895.564177432972;10910.454477276264;441.697437255481;449.86953783402447;460.3623980786635;470.3438703009351;883.4875772052194;8604.48373097616;8757.168069033432;8860.335474839412;8996.010438851721;9046.547672616343;587213;587402;590430;614791;616897;69058.61882762317;71565;71899;73814.63092684503;74013.62993185;1114.3481063577897;1118.5637601335486;1124.8987591116838;1124.943752812356;1125.1954852280494;13752.65618359549;13955.37200825945;14684.632884177981;15278.847211528187;15754.448594299145;29718.851405742833;30668.539971899994;31202.843985780833;32860.67139328576;33638;37782.2443551133;40027;41755.373669395594;42350.788246059805;44972.55027449683;6987.9301206987275;7121;7138.428925686037;7179.569225846466;7254.854902902018;9096.499692516974;11101.500432480396;11128.554857805597;11580.710482237675;11675.241109327866;2919.2701824543865;2959.8816047358728;7011.719531218694;7935.166807485131;9335.346525743133;6846.486513511407;7584.924150758422;7661.885071723817;7694.961525192338;9689.352810022454;7029.789106326613;7059.541129826544;7216.71133154689;7252.4560657949805;7355.264473552602;8814.338924580554;9200.95399522998;9215.67745128944;10022.448765317977;10222.795544088927;8647;8648.740537783877;8709.608067636846;8731.301495880442;8834.469931803855 08:11:24 INFO - PROCESS | 22860 | |3;mootools.html;1448.645081954921;1451.6443471349517;1604.6870860182269;1741.4775567329798;1771.9911400443004;7858.921410785891;7963.323117535002;8090.6763729450895;8107;8135.755927322175;8141.38939579531;8168.836623267531;8174.550399728013;8236.588170591462;8254.463459875118;2342.3792694935814;2356.7289761677457;2364.4561750797325;2368.12379419615;2373.9287821365388;2347.9178228762;2370.3718514593647;2374.4776149247136;2376.7979721723673;2389.6654468374354;1963.9607207855834;2016.737824082867;2299.8505097168713;2350.095213342858;2355.752645972174;2273.9994402462944;2322.1756276521846;2332.3702600297993;2335.6730057791838;2342.297310806768;2283.086765293896;2321.605327094398;2365.597848365782;2370.6799582056374;2374.964375534368;8050.355971522265;8087.919120808834;8096.10942796292;8108.797280067986;8131.959340203321;4880.658353915227;4938.703677779345;4978.203487442028;4979.053979743837;4992.950070499285;3071.4010767900268;3076.6000419945262;3145.2923092304277;3149.370125974814;3166.60417447819;963.2919803944095;1014.8782146142437;1021.4586269277295;1035.1666908138945;1041.7656027393853;11202.159838012181;11282.830757538644;11295.717607059807;11337.659870203906;11361.375124368156;4346.174226896879;4367.344898265285;4383.649308055348;4413.492448368479;4433.246348120827;8967.372283940062;9032.548372581345;9052.456852588866;9056.04911484298;9060.365774395728;4862.708237505761;4867.367242258484;4887.584555312767;4902.681325713817;4917.409910810654;4518.209313370147;4536.228841097021;4538.228501154812;4558.042811009659;4567.977160114245;3568.2685049564775;3636.581793093775;3650.0509867434657;3650.10572409756;3661.5423072115987;1108.8835672254459;1119.054399032816;1121.5962253588702;1149.3563604381573;1149.7183190118474;961.8845738511424;975.7511834482303;1035.0374152038676;1083.6586475260267;1284.4476874943864;7330.853382932311;7335.743248986367;7345.632718364061;7354.669039893218;7366.96316518414;1028.6091285311684;1032.210359075308;1079.1420820447763;1088.3252383522267;1112.0603090388609;5815.360310365856;5886.61736987103;5887.2052272943465;5899.967505686488;5903.881922361615;9370.85943710845;9535.47554884474;9651.131398174199;9738.90261097394;9780.902190977999;9530;9582.520873956275;9591;9606.039396060338;9647.71056868295;7431.554106753612;7501.324880760649;7677.731279405194;7747.30274275318;7790.143084260727;7366.337029667356;7375.188729239887;7448.068991376078;7448.8882666758955;7469.066366704162;8547.316214702932;8654.48073115615;8942.73171804847;8969.955150224207;9076;8925.464472131693;8988.46069235848;9017.143371379709;9052.592633331384;9182.862257066283;6692.631905245258;6822.556533825285;6863.142107236596;6897.55165914214;6898;7634.732784352521;7649.847003060019;7653.846923061396;7655.617219139132;7657.88513172314;7271;7365.9631701841145;7407.740729074457;7435.256474352522;7585.355244804254;6344.841378965562;6670.633115178518;6966.825829354307;7078.752243671447;7123.358897699232;7090.822729431599;7177.820554485971;7195.46034047438;7210.89183662256;7255.709771609077;6335.429811317003;6507.381798729113;6511.34886511364;6524.347565243438;6525;6575.473962083118;6587.670616469061;6632.204135503771;6649.002649602405;6656.201255849329 08:11:24 INFO - PROCESS | 22860 | |4;prototype.html;321.56428040005807;324.8116092666252;334.6352475801376;342.0985702673456;345.8841288168463;6149.538784591156;6210.09953556734;6261.123442718023;6277;6426.518011149159;6170.197874276338;6230.065490176476;6246.968765156168;6264.467520260783;6271.4669253113425;4766.332713420124;4766.404199475066;4766.976165119187;4768.117898188846;4771.475137734864;4761.571458568728;4770.952290477103;4775.068861571995;4780.928286075712;4787.425508938933;4652.767361631905;4734.502877197896;4737;4739.73931433771;4748.976255118737;4726.338312636217;4731.243001119821;4731.503192164808;4738.455077666078;4757.310190022427;4109.321961876287;4115.794210289503;4116.115035267402;4131.35963925592;4135.8966025849295;5927.673977931212;5977.402259774031;5982.581219314649;5983.910241346383;5995.760169593211;5424.105022671254;5517.586181036399;5519.889602207933;5522.66863988162;5527.143292789624;6591.868162636768;6600.372964568358;6612.93387066128;6617.139771829679;6619.834504137387;4538.341940418621;4547.727136371828;4554.362389265505;4554.63562914966;4567.840125595588;6712.899306510406;6830.59016459014;6902.723891044352;6916.23921368649;6923.411510021604;4554.4990051094355;4568.109218702321;4568.611668008257;4573.108243892409;4575.5424457554645;4624.352590637313;4638.304254361873;4639.814407423665;4640.86077417678;4644.140833945731;5369.033573956725;5405.432429594836;5407.594430417735;5413.431589683027;5413.729313534386;6398.232212134573;6577.835554111186;6588.4729221662155;6620.073189753439;6669.7665581704405;1570.9135997520018;1590.109538658355;1590.300267882128;1593.8167110782408;1636.0674415583003;1081.4808891731855;1097.9505922233518;1107.2304748199924;1109.2180013090751;1128.7911736328806;6139.693015349215;6183.258009038944;6198.256209254918;6217.036359364306;6219.782307619212;6678.031685405589;6683.198016238082;6697.028930805103;6726.327367263332;6774.356436138559;6014.6391216527145;6205.348438413992;6208.689565521706;6211.192544969125;6215.968920155461;3649.434337677664;3663.5603727552866;3672.8163591820835;3676.540432445944;3680.4847321375028;7074.469414793911;7082.327178917994;7093.184283807325;7125.501214914906;7127.572345659173;6724.865502689919;6875.278095799969;6875.690593923286;6900.689468973908;6910.412614927787;7079.82300442493;7084.716611335489;7091.787246382617;7092.9645351772915;7117.466190035768;6723.655268946328;6731.730730770911;6737.461003119836;6742.6291553965;6744.426723728342;6540.869182616416;6665.566738162004;6673.566218195801;6682.231543372574;6682.866342673216;7061.646917653994;7089.220185779457;7101.715931362688;7118.430525558047;7118.430525558047;4642.605378542727;4644.790984405642;4646.86059418218;4647.814087436464;4665.650076244227;6710.966445167743;6791.89812152828;6800.081988931431;6804.149481314836;6969.4424446045205;6654.83362915931;6669.032990216295;6695.732170713117;6717.697703603252;6729.596224226562;6674.9332506676255;6721.563098398588;6736;6747.595144291358;6749.595024298558;6446.742130314922;6561.80314590563;6571.145751052332;6582.308857569887;6588.341165883373;6738.528303018742;6776.491763117688;6780.898286525608;6785.185777706707;6800.727970881109;6528.118703974903;6563.737450502117;6578.440832529289;6592.472602191718;6599.53803233769 08:11:24 INFO - PROCESS | 22860 | |5;yui.html;728.5446595877577;775.7401270574358;839.1189251286148;849.329030066248;865.238590040764;10684.572617095317;10744.516496757646;10832.295900766454;10884.183686223545;10944.3980581068;12536.874631253684;12568.748625027494;12578.496860125608;12592.118551701384;12593.118481706284;653.3988730368072;663.4692246203042;751.7181057103586;782.4327362662082;798.8641930871737;785.1206648553627;787.9606019699021;790.0401012769483;791.3708601661664;792.5918152151646;824.2952275804191;827.1893544326564;828.2835347424465;829.3986859526855;832.7002279179491;817.9100298967109;822.3914303415489;822.7161629237903;824.2499325613693;824.5135370131621;606.472369038939;607.025723713438;609.2141137932107;609.6860117039683;611.574955405993;12945.61163165097;12970.740585188338;12978.675533111653;12993.675158121028;13004.284764337957;12803;13013.154144980546;13210.00924930634;13361.331933403291;13370.532031378854;10133;10252.846207306822;10302.433366164858;10526;10643.893561064446;3539.982300088509;3588.4617307404096;3611.747177697562;3676.209614932802;3679.3929001714687;43855.34216986748;44246;44276.3358549622;44445;44671.55328446674;9257.722268331827;9524.952375238217;9552.092551207625;9830.459324737065;9921;17816.287348506175;17956;17972.910135449238;17974.281028758964;17999.64000719978;7048.295170482911;7326.706931722778;7359.190489046201;7407.333339999318;7416.7774966751085;4208.705390622688;4239.788010599519;4240.385144154142;4287.206866729665;4294.74231546102;3064.8927287545275;3081.9691803082133;3089.2894634233803;3090.026641607886;3104.286014216743;544.8093167391461;567.9261695979496;572.4161355417534;581.3198557687516;589.6462122726416;590.421387040694;597.4652685846144;627.6547898655813;643.6813777180325;720.9396113498129;8315.584220789058;8334.958325208456;8337;8444.24001839825;8495.1080136586;499.5354320481914;626.4080443980395;691.515938842812;695.4714417042983;735.4116706634671;3915.1190982029384;4026.6577340925764;4028.536718277377;4040.8585699500377;4082.6937979651643;48666.270005949234;48831.116888310884;49059;58176;59505.10742338868;46933.29600056002;46941.765291173324;47024.76487617609;47057.29414058792;47097;40754.38868416976;40779.59220407758;41048.794756026626;42430.78784606057;42536;8349.499030057974;8370;8433.367497437594;8475.32197424217;8704.303655707656;31825.204369890937;32418;32661.673383265865;33588.832055839564;33664.49503257404;37829.24341513209;38274.42588361121;40761.184776303715;42452.787736061124;42638.36042459303;10922;11100.944495277472;11194.608188713355;11201.775964480828;11512.30926144434;11738.178327516991;11942.402879856147;12165.391730413621;12190.51237950472;12542;10741.355518668905;11158.330500170016;11206;11234.438278086227;11705.261476089274;11181.298184531212;11183.664490065312;11571.421428928352;11697.532098715956;11909.583164589198;9986.101250887456;10274.22943279272;11426.657200284004;11432.885671143182;11624.88375116238;9758.365706229357;9875.358101723365;9958.502074896081;10116.544755486168;10184.541695623566;8707.695230666895;9050.185483306534;9320.440773553608;9482.634385358131;9681.177099946302 08:11:24 INFO - PROCESS | 22860 | __end_tp_report 08:11:24 INFO - PROCESS | 22860 | __start_cc_report 08:11:24 INFO - PROCESS | 22860 | _x_x_mozilla_cycle_collect,300 08:11:24 INFO - PROCESS | 22860 | __end_cc_report 08:11:24 INFO - PROCESS | 22860 | __startTimestamp1453392684789__endTimestamp 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | ------- Summary: start ------- 08:11:24 INFO - PROCESS | 22860 | Number of tests: 6 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | [#0] dojo.html Cycles:165 Average:5420.07 Median:5671.09 stddev:606.53 (10.7%) stddev-sans-first:583.07 08:11:24 INFO - PROCESS | 22860 | Values: 3209.1 3241.6 3257.4 3276.7 3277.9 5303.1 5419.6 5424.5 5426.2 5438.2 5356.4 5369.5 5375.1 5453.4 5469.2 4894.4 4977.4 5019.6 5033.7 5038.6 4920.8 4977.5 4980.6 4982.1 5039.6 4834.3 4871.9 4903.5 4981.6 4984.7 4961.6 4961.8 4964.9 4976.8 4979.7 4947.2 4950.6 4952.0 4968.5 4993.1 5187.4 5286.7 5326.8 5376.8 5409.8 5878.0 5882.4 5884.1 5887.7 5891.1 5890.5 5906.6 5911.8 5914.9 5924.0 5328.0 5432.9 5457.0 5500.5 5551.0 6025.0 6029.7 6033.5 6058.5 6061.8 5754.7 5780.9 5789.9 5795.8 5798.6 5715.8 5765.0 5809.7 5861.3 5892.5 5774.2 5836.6 5842.0 5884.1 5890.6 5824.3 5847.2 5857.8 5860.8 5862.5 4483.1 4492.5 4541.2 4556.0 4566.5 3986.2 3990.1 3993.1 4003.3 4027.4 5386.6 5393.5 5393.7 5402.9 5436.3 5754.1 5851.6 5854.6 5905.7 5948.2 5320.1 5353.0 5374.6 5377.7 5411.1 4868.8 4987.8 5005.5 5015.1 5047.5 5968.5 6003.3 6026.4 6065.3 6101.9 5731.1 5732.9 5764.1 5768.2 5769.1 5963.7 6002.7 6005.6 6015.8 6069.8 5743.3 5748.5 5756.9 5771.4 5836.7 5830.1 5841.9 5855.7 5880.8 5918.9 5671.1 5743.5 5751.7 5752.9 5753.5 5723.3 5781.8 5790.0 5793.5 5794.8 5654.2 5674.0 5684.4 5689.5 5690.2 5568.4 5671.5 5687.2 5692.2 5750.7 5623.1 5631.9 5640.9 5654.3 5666.7 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | [#1] ext.html Cycles:180 Average:46638.34 Median:36234.14 stddev:82242.36 (227.0%) stddev-sans-first:82400.18 08:11:24 INFO - PROCESS | 22860 | Values: 521.3 546.8 563.3 566.7 577.1 34513.2 35281.5 35322.6 35337.8 35367.3 38973.2 39010.4 39032.6 39320.6 39353.8 8413.2 8522.6 8571.3 8577.1 8593.1 8171.5 8329.5 8352.7 8473.3 8521.7 8505.4 8517.3 8560.6 8590.6 8593.6 8491.9 8509.9 8545.1 8548.3 8554.0 8440.0 8582.0 8583.4 8598.6 8622.9 39399.2 39749.0 39807.0 39995.6 40071.6 3124.1 3306.6 3538.0 3712.3 3971.9 29140.6 29316.4 29434.0 30549.5 30617.7 3876.5 3893.1 3933.7 4002.6 4062.6 265187.0 267352.0 267409.0 268245.0 269566.0 40512.4 41099.8 41188.2 54152.5 55601.4 40083.4 40246.4 40416.4 40481.6 40554.6 13273.8 13423.7 13448.9 13476.2 13477.1 10576.3 10632.3 10642.7 10644.4 10660.6 14123.6 14203.6 14220.1 14341.5 14351.9 5679.5 5808.8 5834.7 5844.3 5859.0 910.9 925.3 940.0 948.2 1059.1 28925.0 28955.7 29037.4 29117.7 29395.9 1008.7 1052.3 1060.0 1070.3 1147.3 14634.1 14802.9 14833.4 15018.8 15123.2 342285.0 348519.0 352520.0 353971.0 355654.0 50605.5 51357.5 51516.2 51725.5 51766.7 1276.9 1327.6 1343.1 1345.2 1347.2 27011.0 27898.9 27989.0 28179.9 28664.0 45622.3 45982.8 46029.0 46046.8 46052.5 315031.0 316572.0 316800.0 316948.0 318406.0 32531.5 42356.4 42755.0 42890.0 42957.6 45422.8 46157.0 46584.8 46685.0 47206.5 32920.7 33141.5 33406.0 33434.0 35767.1 35543.6 35597.3 36221.3 36247.0 36461.3 33361.3 33546.8 33572.0 37832.6 38323.2 29035.9 30289.4 30409.3 30712.0 30921.0 23335.2 23415.2 23433.6 23591.9 23895.9 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | [#2] jquery.html Cycles:180 Average:28484.05 Median:465.35 stddev:97956.43 (21049.9%) stddev-sans-first:98208.46 08:11:24 INFO - PROCESS | 22860 | Values: 360.4 360.5 367.1 368.1 370.2 15265.5 16380.8 16648.7 17352.0 17645.6 15201.7 15268.0 15514.0 15652.1 15711.8 4737.7 4942.6 4945.5 4950.8 4968.1 4846.4 4873.4 4904.6 4907.8 5237.5 4879.0 5044.5 5193.0 5200.2 5200.6 5019.1 5033.7 5058.1 5061.3 5343.6 5346.1 5349.3 5350.6 5359.3 5372.3 12209.8 16013.4 19019.3 19770.3 19903.4 2130.9 2144.4 2152.1 2174.7 2225.5 12118.9 12332.6 12394.3 12559.4 12750.3 1608.4 1626.3 1660.4 1661.1 1857.5 54274.7 54521.5 55383.7 55723.0 55879.4 9087.3 9216.4 9267.9 9280.4 9371.2 11879.8 11887.1 11932.2 11953.1 11968.5 6457.2 6700.6 6799.0 6866.2 6977.1 6622.2 6648.0 6668.0 6670.3 6697.9 4048.0 4152.3 4301.8 4344.8 4359.8 1592.2 1647.3 1674.7 1683.3 1692.3 428.2 434.4 438.6 443.7 446.7 10467.6 10737.4 10862.3 10895.6 10910.5 441.7 449.9 460.4 470.3 883.5 8604.5 8757.2 8860.3 8996.0 9046.5 587213.0 587402.0 590430.0 614791.0 616897.0 69058.6 71565.0 71899.0 73814.6 74013.6 1114.3 1118.6 1124.9 1124.9 1125.2 13752.7 13955.4 14684.6 15278.8 15754.4 29718.9 30668.5 31202.8 32860.7 33638.0 37782.2 40027.0 41755.4 42350.8 44972.6 6987.9 7121.0 7138.4 7179.6 7254.9 9096.5 11101.5 11128.6 11580.7 11675.2 2919.3 2959.9 7011.7 7935.2 9335.3 6846.5 7584.9 7661.9 7695.0 9689.4 7029.8 7059.5 7216.7 7252.5 7355.3 8814.3 9201.0 9215.7 10022.4 10222.8 8647.0 8648.7 8709.6 8731.3 8834.5 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | [#3] mootools.html Cycles:180 Average:5612.13 Median:6517.85 stddev:2935.91 (45.0%) stddev-sans-first:2927.46 08:11:24 INFO - PROCESS | 22860 | Values: 1448.6 1451.6 1604.7 1741.5 1772.0 7858.9 7963.3 8090.7 8107.0 8135.8 8141.4 8168.8 8174.6 8236.6 8254.5 2342.4 2356.7 2364.5 2368.1 2373.9 2347.9 2370.4 2374.5 2376.8 2389.7 1964.0 2016.7 2299.9 2350.1 2355.8 2274.0 2322.2 2332.4 2335.7 2342.3 2283.1 2321.6 2365.6 2370.7 2375.0 8050.4 8087.9 8096.1 8108.8 8132.0 4880.7 4938.7 4978.2 4979.1 4993.0 3071.4 3076.6 3145.3 3149.4 3166.6 963.3 1014.9 1021.5 1035.2 1041.8 11202.2 11282.8 11295.7 11337.7 11361.4 4346.2 4367.3 4383.6 4413.5 4433.2 8967.4 9032.5 9052.5 9056.0 9060.4 4862.7 4867.4 4887.6 4902.7 4917.4 4518.2 4536.2 4538.2 4558.0 4568.0 3568.3 3636.6 3650.1 3650.1 3661.5 1108.9 1119.1 1121.6 1149.4 1149.7 961.9 975.8 1035.0 1083.7 1284.4 7330.9 7335.7 7345.6 7354.7 7367.0 1028.6 1032.2 1079.1 1088.3 1112.1 5815.4 5886.6 5887.2 5900.0 5903.9 9370.9 9535.5 9651.1 9738.9 9780.9 9530.0 9582.5 9591.0 9606.0 9647.7 7431.6 7501.3 7677.7 7747.3 7790.1 7366.3 7375.2 7448.1 7448.9 7469.1 8547.3 8654.5 8942.7 8970.0 9076.0 8925.5 8988.5 9017.1 9052.6 9182.9 6692.6 6822.6 6863.1 6897.6 6898.0 7634.7 7649.8 7653.8 7655.6 7657.9 7271.0 7366.0 7407.7 7435.3 7585.4 6344.8 6670.6 6966.8 7078.8 7123.4 7090.8 7177.8 7195.5 7210.9 7255.7 6335.4 6507.4 6511.3 6524.3 6525.0 6575.5 6587.7 6632.2 6649.0 6656.2 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | [#4] prototype.html Cycles:180 Average:5510.93 Median:6216.50 stddev:1678.78 (27.0%) stddev-sans-first:1637.68 08:11:24 INFO - PROCESS | 22860 | Values: 321.6 324.8 334.6 342.1 345.9 6149.5 6210.1 6261.1 6277.0 6426.5 6170.2 6230.1 6247.0 6264.5 6271.5 4766.3 4766.4 4767.0 4768.1 4771.5 4761.6 4771.0 4775.1 4780.9 4787.4 4652.8 4734.5 4737.0 4739.7 4749.0 4726.3 4731.2 4731.5 4738.5 4757.3 4109.3 4115.8 4116.1 4131.4 4135.9 5927.7 5977.4 5982.6 5983.9 5995.8 5424.1 5517.6 5519.9 5522.7 5527.1 6591.9 6600.4 6612.9 6617.1 6619.8 4538.3 4547.7 4554.4 4554.6 4567.8 6712.9 6830.6 6902.7 6916.2 6923.4 4554.5 4568.1 4568.6 4573.1 4575.5 4624.4 4638.3 4639.8 4640.9 4644.1 5369.0 5405.4 5407.6 5413.4 5413.7 6398.2 6577.8 6588.5 6620.1 6669.8 1570.9 1590.1 1590.3 1593.8 1636.1 1081.5 1098.0 1107.2 1109.2 1128.8 6139.7 6183.3 6198.3 6217.0 6219.8 6678.0 6683.2 6697.0 6726.3 6774.4 6014.6 6205.3 6208.7 6211.2 6216.0 3649.4 3663.6 3672.8 3676.5 3680.5 7074.5 7082.3 7093.2 7125.5 7127.6 6724.9 6875.3 6875.7 6900.7 6910.4 7079.8 7084.7 7091.8 7093.0 7117.5 6723.7 6731.7 6737.5 6742.6 6744.4 6540.9 6665.6 6673.6 6682.2 6682.9 7061.6 7089.2 7101.7 7118.4 7118.4 4642.6 4644.8 4646.9 4647.8 4665.7 6711.0 6791.9 6800.1 6804.1 6969.4 6654.8 6669.0 6695.7 6717.7 6729.6 6674.9 6721.6 6736.0 6747.6 6749.6 6446.7 6561.8 6571.1 6582.3 6588.3 6738.5 6776.5 6780.9 6785.2 6800.7 6528.1 6563.7 6578.4 6592.5 6599.5 08:11:24 INFO - PROCESS | 22860 | 08:11:24 INFO - PROCESS | 22860 | [#5] yui.html Cycles:180 Average:13003.60 Median:24075.04 stddev:14542.84 (60.4%) stddev-sans-first:14554.42 08:11:24 INFO - PROCESS | 22860 | Values: 728.5 775.7 839.1 849.3 865.2 10684.6 10744.5 10832.3 10884.2 10944.4 12536.9 12568.7 12578.5 12592.1 12593.1 653.4 663.5 751.7 782.4 798.9 785.1 788.0 790.0 791.4 792.6 824.3 827.2 828.3 829.4 832.7 817.9 822.4 822.7 824.2 824.5 606.5 607.0 609.2 609.7 611.6 12945.6 12970.7 12978.7 12993.7 13004.3 12803.0 13013.2 13210.0 13361.3 13370.5 10133.0 10252.8 10302.4 10526.0 10643.9 3540.0 3588.5 3611.7 3676.2 3679.4 43855.3 44246.0 44276.3 44445.0 44671.6 9257.7 9525.0 9552.1 9830.5 9921.0 17816.3 17956.0 17972.9 17974.3 17999.6 7048.3 7326.7 7359.2 7407.3 7416.8 4208.7 4239.8 4240.4 4287.2 4294.7 3064.9 3082.0 3089.3 3090.0 3104.3 544.8 567.9 572.4 581.3 589.6 590.4 597.5 627.7 643.7 720.9 8315.6 8335.0 8337.0 8444.2 8495.1 499.5 626.4 691.5 695.5 735.4 3915.1 4026.7 4028.5 4040.9 4082.7 48666.3 48831.1 49059.0 58176.0 59505.1 46933.3 46941.8 47024.8 47057.3 47097.0 40754.4 40779.6 41048.8 42430.8 42536.0 8349.5 8370.0 8433.4 8475.3 8704.3 31825.2 32418.0 32661.7 33588.8 33664.5 37829.2 38274.4 40761.2 42452.8 42638.4 10922.0 11100.9 11194.6 11201.8 11512.3 11738.2 11942.4 12165.4 12190.5 12542.0 10741.4 11158.3 11206.0 11234.4 11705.3 11181.3 11183.7 11571.4 11697.5 11909.6 9986.1 10274.2 11426.7 11432.9 11624.9 9758.4 9875.4 9958.5 10116.5 10184.5 8707.7 9050.2 9320.4 9482.6 9681.2 08:11:24 INFO - PROCESS | 22860 | -------- Summary: end -------- 08:11:24 INFO - PROCESS | 22860 | 08:11:25 INFO - TEST-INFO | 22860: exit 0 08:11:25 INFO - TEST-OK | dromaeo_css | took 1111136ms 08:11:25 INFO - TEST-START | kraken 08:11:25 INFO - operating with platform_type : linux_ 08:11:25 INFO - Initialising browser for kraken test... 08:11:25 INFO - TEST-INFO | started process 23096 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxuvJkb/profile http://localhost:59335/getInfo.html) 08:11:29 INFO - PROCESS | 23096 | 08:11:29 INFO - PROCESS | 23096 | (process:23169): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:11:29 INFO - PROCESS | 23096 | __metrics Screen width/height:1600/1200 08:11:29 INFO - PROCESS | 23096 | colorDepth:24 08:11:29 INFO - PROCESS | 23096 | Browser inner width/height: 1024/697 08:11:29 INFO - PROCESS | 23096 | __metrics 08:11:30 INFO - PROCESS | 23096 | 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:11:30 INFO - TEST-INFO | 23096: exit 0 08:11:30 INFO - Browser initialized. 08:11:30 INFO - Running cycle 1/1 for kraken test... 08:11:30 INFO - TEST-INFO | started process 23218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxuvJkb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:31 INFO - PROCESS | 23218 | -- checkerboarding starts below -- 08:11:31 INFO - PROCESS | 23218 | RENDERTRACE 0.055489 rect red 0 0 10 10 // viewport 08:11:31 INFO - PROCESS | 23218 | RENDERTRACE 17.4616 rect brown 0 0 10 10 // page 08:11:31 INFO - PROCESS | 23218 | RENDERTRACE 17.4858 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:11:31 INFO - PROCESS | 23218 | Checkerboarded for 1 frames (33.0711 ms), 100 peak, 1 severity. 08:11:32 INFO - PROCESS | 23218 | 08:11:32 INFO - PROCESS | 23218 | (process:23275): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:11:42 INFO - PROCESS | 23218 | RSS: Main: 150167552 08:11:42 INFO - PROCESS | 23218 | 08:11:45 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:45 INFO - PROCESS | 23218 | RSS: Main: 151511040 08:11:45 INFO - PROCESS | 23218 | 08:11:48 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-dft) 08:11:49 INFO - PROCESS | 23218 | RSS: Main: 154230784 08:11:49 INFO - PROCESS | 23218 | 08:11:51 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-fft) 08:11:52 INFO - PROCESS | 23218 | RSS: Main: 147308544 08:11:52 INFO - PROCESS | 23218 | 08:11:54 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59335/tests/kraken/driver.html?testName=audio-oscillator) 08:11:55 INFO - PROCESS | 23218 | RSS: Main: 147361792 08:11:55 INFO - PROCESS | 23218 | 08:11:57 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:58 INFO - PROCESS | 23218 | RSS: Main: 147779584 08:11:58 INFO - PROCESS | 23218 | 08:12:01 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59335/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:01 INFO - PROCESS | 23218 | RSS: Main: 149245952 08:12:01 INFO - PROCESS | 23218 | 08:12:05 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59335/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:05 INFO - PROCESS | 23218 | RSS: Main: 149504000 08:12:05 INFO - PROCESS | 23218 | 08:12:08 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59335/tests/kraken/driver.html?testName=json-parse-financial) 08:12:09 INFO - PROCESS | 23218 | RSS: Main: 149753856 08:12:09 INFO - PROCESS | 23218 | 08:12:10 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:11 INFO - PROCESS | 23218 | RSS: Main: 148500480 08:12:11 INFO - PROCESS | 23218 | 08:12:13 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:13 INFO - PROCESS | 23218 | RSS: Main: 147832832 08:12:13 INFO - PROCESS | 23218 | 08:12:15 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:16 INFO - PROCESS | 23218 | RSS: Main: 148697088 08:12:16 INFO - PROCESS | 23218 | 08:12:18 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:19 INFO - PROCESS | 23218 | RSS: Main: 150347776 08:12:19 INFO - PROCESS | 23218 | 08:12:22 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:22 INFO - PROCESS | 23218 | RSS: Main: 149323776 08:12:22 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:59335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59335/tests/kraken/driver.html?testName=ai-astar) 08:12:24 INFO - PROCESS | 23218 | RSS: Main: 149327872 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | __start_tp_report 08:12:24 INFO - PROCESS | 23218 | _x_x_mozilla_page_load 08:12:24 INFO - PROCESS | 23218 | _x_x_mozilla_page_load_details 08:12:24 INFO - PROCESS | 23218 | |i|pagename|runs| 08:12:24 INFO - PROCESS | 23218 | |0;ai-astar;110;106;109;111;111;125;110;110;110;110 08:12:24 INFO - PROCESS | 23218 | |1;audio-beat-detection;153;137;151;168;126;150;156;132;173;128 08:12:24 INFO - PROCESS | 23218 | |2;audio-dft;162;162;161;164;166;164;162;170;167;160 08:12:24 INFO - PROCESS | 23218 | |3;audio-fft;74;79;74;74;74;144;73;74;73;74 08:12:24 INFO - PROCESS | 23218 | |4;audio-oscillator;97;96;138;97;96;97;141;95;97;145 08:12:24 INFO - PROCESS | 23218 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;109;109;109 08:12:24 INFO - PROCESS | 23218 | |6;imaging-darkroom;146;146;147;147;146;146;148;147;147;146 08:12:24 INFO - PROCESS | 23218 | |7;imaging-desaturate;97;97;101;96;97;96;96;97;96;97 08:12:24 INFO - PROCESS | 23218 | |8;json-parse-financial;60;60;62;62;60;60;62;61;61;57 08:12:24 INFO - PROCESS | 23218 | |9;json-stringify-tinderbox;67;69;67;67;79;67;67;67;72;67 08:12:24 INFO - PROCESS | 23218 | |10;stanford-crypto-aes;85;83;86;102;83;84;85;84;84;93 08:12:24 INFO - PROCESS | 23218 | |11;stanford-crypto-ccm;121;119;129;126;117;136;129;128;132;122 08:12:24 INFO - PROCESS | 23218 | |12;stanford-crypto-pbkdf2;141;155;151;149;152;139;150;153;150;139 08:12:24 INFO - PROCESS | 23218 | |13;stanford-crypto-sha256-iterative;70;68;74;69;69;68;67;68;66;71 08:12:24 INFO - PROCESS | 23218 | __end_tp_report 08:12:24 INFO - PROCESS | 23218 | __start_cc_report 08:12:24 INFO - PROCESS | 23218 | _x_x_mozilla_cycle_collect,745 08:12:24 INFO - PROCESS | 23218 | __end_cc_report 08:12:24 INFO - PROCESS | 23218 | __startTimestamp1453392744566__endTimestamp 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | ------- Summary: start ------- 08:12:24 INFO - PROCESS | 23218 | Number of tests: 14 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#0] ai-astar Cycles:10 Average:111.20 Median:110.00 stddev:5.05 (4.6%) stddev-sans-first:5.34 08:12:24 INFO - PROCESS | 23218 | Values: 110.0 106.0 109.0 111.0 111.0 125.0 110.0 110.0 110.0 110.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:152.00 stddev:16.28 (10.7%) stddev-sans-first:17.14 08:12:24 INFO - PROCESS | 23218 | Values: 153.0 137.0 151.0 168.0 126.0 150.0 156.0 132.0 173.0 128.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:3.08 (1.9%) stddev-sans-first:3.20 08:12:24 INFO - PROCESS | 23218 | Values: 162.0 162.0 161.0 164.0 166.0 164.0 162.0 170.0 167.0 160.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:22.10 (29.9%) stddev-sans-first:23.28 08:12:24 INFO - PROCESS | 23218 | Values: 74.0 79.0 74.0 74.0 74.0 144.0 73.0 74.0 73.0 74.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.50 stddev:21.76 (22.6%) stddev-sans-first:22.58 08:12:24 INFO - PROCESS | 23218 | Values: 97.0 96.0 138.0 97.0 96.0 97.0 141.0 95.0 97.0 145.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:12:24 INFO - PROCESS | 23218 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 08:12:24 INFO - PROCESS | 23218 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 148.0 147.0 147.0 146.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.49 (1.5%) stddev-sans-first:1.58 08:12:24 INFO - PROCESS | 23218 | Values: 97.0 97.0 101.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:1.51 (2.5%) stddev-sans-first:1.59 08:12:24 INFO - PROCESS | 23218 | Values: 60.0 60.0 62.0 62.0 60.0 60.0 62.0 61.0 61.0 57.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:67.00 stddev:3.90 (5.8%) stddev-sans-first:4.08 08:12:24 INFO - PROCESS | 23218 | Values: 67.0 69.0 67.0 67.0 79.0 67.0 67.0 67.0 72.0 67.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:84.50 stddev:6.05 (7.2%) stddev-sans-first:6.37 08:12:24 INFO - PROCESS | 23218 | Values: 85.0 83.0 86.0 102.0 83.0 84.0 85.0 84.0 84.0 93.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:128.50 stddev:6.05 (4.7%) stddev-sans-first:6.15 08:12:24 INFO - PROCESS | 23218 | Values: 121.0 119.0 129.0 126.0 117.0 136.0 129.0 128.0 132.0 122.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.50 stddev:5.95 (4.0%) stddev-sans-first:5.77 08:12:24 INFO - PROCESS | 23218 | Values: 141.0 155.0 151.0 149.0 152.0 139.0 150.0 153.0 150.0 139.0 08:12:24 INFO - PROCESS | 23218 | 08:12:24 INFO - PROCESS | 23218 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.26 (3.3%) stddev-sans-first:2.37 08:12:24 INFO - PROCESS | 23218 | Values: 70.0 68.0 74.0 69.0 69.0 68.0 67.0 68.0 66.0 71.0 08:12:24 INFO - PROCESS | 23218 | -------- Summary: end -------- 08:12:24 INFO - PROCESS | 23218 | 08:12:25 INFO - TEST-INFO | 23218: exit 0 08:12:25 INFO - TEST-OK | kraken | took 59987ms 08:12:25 INFO - TEST-START | v8_7 08:12:25 INFO - operating with platform_type : linux_ 08:12:25 INFO - Initialising browser for v8_7 test... 08:12:25 INFO - TEST-INFO | started process 23503 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKj1Rh8/profile http://localhost:59335/getInfo.html) 08:12:28 INFO - PROCESS | 23503 | 08:12:28 INFO - PROCESS | 23503 | (process:23575): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:12:29 INFO - PROCESS | 23503 | __metrics Screen width/height:1600/1200 08:12:29 INFO - PROCESS | 23503 | colorDepth:24 08:12:29 INFO - PROCESS | 23503 | Browser inner width/height: 1024/697 08:12:29 INFO - PROCESS | 23503 | __metrics 08:12:29 INFO - PROCESS | 23503 | 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:12:30 INFO - TEST-INFO | 23503: exit 0 08:12:30 INFO - Browser initialized. 08:12:30 INFO - Running cycle 1/1 for v8_7 test... 08:12:30 INFO - TEST-INFO | started process 23625 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKj1Rh8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:31 INFO - PROCESS | 23625 | -- checkerboarding starts below -- 08:12:31 INFO - PROCESS | 23625 | RENDERTRACE 0.043166 rect red 0 0 10 10 // viewport 08:12:31 INFO - PROCESS | 23625 | RENDERTRACE 66.978 rect brown 0 0 10 10 // page 08:12:31 INFO - PROCESS | 23625 | RENDERTRACE 67.0016 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:12:31 INFO - PROCESS | 23625 | Checkerboarded for 1 frames (68.5054 ms), 100 peak, 1 severity. 08:12:31 INFO - PROCESS | 23625 | 08:12:31 INFO - PROCESS | 23625 | (process:23683): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:12:42 INFO - PROCESS | 23625 | RSS: Main: 149389312 08:12:42 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | Cycle 1(1): loaded http://localhost:59335/tests/v8_7/run.html (next: http://localhost:59335/tests/v8_7/run.html) 08:13:04 INFO - PROCESS | 23625 | RSS: Main: 145408000 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | __start_tp_report 08:13:04 INFO - PROCESS | 23625 | _x_x_mozilla_page_load 08:13:04 INFO - PROCESS | 23625 | _x_x_mozilla_page_load_details 08:13:04 INFO - PROCESS | 23625 | |i|pagename|runs| 08:13:04 INFO - PROCESS | 23625 | |0;Richards;167.47613465081227 08:13:04 INFO - PROCESS | 23625 | |1;DeltaBlue;186.1850679575498 08:13:04 INFO - PROCESS | 23625 | |2;Encrypt;278.8622420524261 08:13:04 INFO - PROCESS | 23625 | |3;Decrypt;5186.5284974093265 08:13:04 INFO - PROCESS | 23625 | |4;RayTrace;1059.322033898305 08:13:04 INFO - PROCESS | 23625 | |5;Earley;713.7758743754462 08:13:04 INFO - PROCESS | 23625 | |6;Boyer;12407.407407407407 08:13:04 INFO - PROCESS | 23625 | |7;RegExp;41591.836734693876 08:13:04 INFO - PROCESS | 23625 | |8;Splay;613.8735420503376 08:13:04 INFO - PROCESS | 23625 | |9;NavierStokes;4817.307692307692 08:13:04 INFO - PROCESS | 23625 | __end_tp_report 08:13:04 INFO - PROCESS | 23625 | __startTimestamp1453392784981__endTimestamp 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | ------- Summary: start ------- 08:13:04 INFO - PROCESS | 23625 | Number of tests: 10 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 167.5 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#1] DeltaBlue Cycles:1 Average:186.19 Median:186.19 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 186.2 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 278.9 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 5186.5 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 1059.3 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 713.8 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 12407.4 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#7] RegExp Cycles:1 Average:41591.84 Median:41591.84 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 41591.8 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#8] Splay Cycles:1 Average:613.87 Median:613.87 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 613.9 08:13:04 INFO - PROCESS | 23625 | 08:13:04 INFO - PROCESS | 23625 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 08:13:04 INFO - PROCESS | 23625 | Values: 4817.3 08:13:04 INFO - PROCESS | 23625 | -------- Summary: end -------- 08:13:04 INFO - PROCESS | 23625 | 08:13:05 INFO - TEST-INFO | 23625: exit 0 08:13:05 INFO - TEST-OK | v8_7 | took 40390ms 08:13:05 INFO - SUITE-END | took 1211s 08:13:06 INFO - Completed test suite (00:20:11) 08:13:06 INFO - Working with test: dromaeo_css 08:13:06 INFO - Generating results file: dromaeo_css 08:13:06 INFO - Working with test: kraken 08:13:06 INFO - Generating results file: kraken 08:13:06 INFO - javascript benchmark 08:13:06 INFO - Working with test: v8_7 08:13:06 INFO - Generating results file: v8_7 08:13:06 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 08:13:06 INFO - process_Request line: dromaeo_css 6792.12 graph.html#tests=[[72,1,43]] 08:13:06 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:06 INFO - process_Request line: kraken 1525.90 graph.html#tests=[[232,1,43]] 08:13:06 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:06 INFO - process_Request line: v8_7 20346.75 graph.html#tests=[[230,1,43]] 08:13:06 INFO - RETURN: dromaeo_css: 6792.12 08:13:06 INFO - RETURN: kraken: 1525.90 08:13:06 INFO - RETURN: v8_7: 20346.75 08:13:06 INFO - javascript benchmark 08:13:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3209.117492689511, 3241.643419223885, 3257.381097591456, 3276.7378609711227, 3277.88527401541, 5303.071962406573, 5419.566434685225, 5424.538914192293, 5426.213199086125, 5438.2114593383985, 5356.4107948125775, 5369.48989845964, 5375.139977603584, 5453.400125986138, 5469.15228139638, 4894.363732714742, 4977.402711674604, 5019.64862459628, 5033.672811267256, 5038.59691224703, 4920.753962301888, 4977.50224977503, 4980.6015518758595, 4982.128127577677, 5039.647224694273, 4834.323194752737, 4871.8782030449165, 4903.53416425439, 4981.576565991895, 4984.675996060245, 4961.603071754251, 4961.751912404366, 4964.900701985976, 4976.800927962913, 4979.701217926936, 4947.158982972904, 4950.603951683856, 4952.034353301107, 4968.478309777457, 4993.1262029144755, 5187.403448603422, 5286.656367336111, 5326.840194794124, 5376.838694839122, 5409.756560954727, 5877.970610146922, 5882.382349853289, 5884.117382392633, 5887.735051922631, 5891.057430811093, 5890.528757699374, 5906.586538942276, 5911.793087241926, 5914.940850591482, 5923.970380148115, 5327.9733601331745, 5432.891342173134, 5457.017736807413, 5500.50495455411, 5551.0, 6025.0, 6029.728662210211, 6033.456988871023, 6058.515318774487, 6061.848453788691, 5754.712264386764, 5780.88438231233, 5789.942100579025, 5795.768169273182, 5798.565107616945, 5715.771369145271, 5765.0, 5809.738561764731, 5861.296644402613, 5892.469677729025, 5774.191613174159, 5836.620619659709, 5842.006858834008, 5884.0585506318785, 5890.646561206341, 5824.271966004249, 5847.239858818326, 5857.7656893724625, 5860.824175274749, 5862.530997520188, 4483.103379324149, 4492.528284530143, 4541.205289074399, 4556.0, 4566.452025756864, 3986.242613903407, 3990.06233535119, 3993.1414745829784, 4003.3302921982095, 4027.3958906163725, 5386.569074474111, 5393.514583687487, 5393.6763794172475, 5402.91895621566, 5436.347638283352, 5754.0505816540635, 5851.561132915049, 5854.5901786875365, 5905.675187864708, 5948.196993405922, 5320.068987927098, 5352.982933242672, 5374.596905232123, 5377.7311134443125, 5411.107167317427, 4868.829590964299, 4987.750612469362, 5005.474425185376, 5015.097282489187, 5047.545720885138, 5968.522518198533, 6003.339632640406, 6026.397360264026, 6065.272167339859, 6101.877962440726, 5731.083026715705, 5732.942670573408, 5764.13537969308, 5768.221290125779, 5769.07694768835, 5963.731632076654, 6002.729877155626, 6005.6396616203165, 6015.849603759941, 6069.848253793514, 5743.282089738783, 5748.511376532874, 5756.884862302647, 5771.3651498335985, 5836.678982655994, 5830.125481177857, 5841.853953651193, 5855.707214639337, 5880.8235752927485, 5918.940810592011, 5671.092625179951, 5743.4543718346695, 5751.712414379348, 5752.942470575408, 5753.539716822728, 5723.284589426322, 5781.768729250783, 5790.0, 5793.478586927196, 5794.797182098607, 5654.208410822406, 5674.0, 5684.403137670485, 5689.516391106637, 5690.174924635822, 5568.387477377566, 5671.461211184931, 5687.203791469115, 5692.203091567267, 5750.6837123958585, 5623.100303951348, 5631.8592035199445, 5640.943590564042, 5654.2649455572155, 5666.688332141607], "unit": "score", "name": "dojo.html", "value": 5380.360397251391}, {"lowerIsBetter": false, "replicates": [521.2520033751567, 546.8325125856297, 563.3408911573458, 566.7024811973713, 577.1141298107406, 34513.203547609744, 35281.47077793829, 35322.64677353229, 35337.823310883476, 35367.2926541469, 38973.22053558927, 39010.43958241667, 39032.60967390325, 39320.60679393205, 39353.803230983875, 8413.242808147266, 8522.57387130644, 8571.271441927413, 8577.142285771435, 8593.097724738906, 8171.468854524437, 8329.541875196861, 8352.665893364288, 8473.279771219453, 8521.744347669579, 8505.447145935494, 8517.318614510825, 8560.571971401436, 8590.613422395976, 8593.570321483932, 8491.915080849205, 8509.914900850974, 8545.145485451436, 8548.316134709208, 8554.016288126883, 8439.957800211021, 8582.0, 8583.356248281403, 8598.613062412143, 8622.870656940151, 39399.21201575953, 39749.0, 39807.0, 39995.600043999475, 40071.599284007076, 3124.140861263148, 3306.6032076150777, 3537.9739875436094, 3712.313222053902, 3971.947433930011, 29140.562891556645, 29316.41367172666, 29434.0, 30549.541756873663, 30617.693823061705, 3876.5348158221195, 3893.1240470894104, 3933.6853051755793, 4002.639762421367, 4062.6343629073526, 265187.0, 267352.0, 267409.0, 268245.0, 269566.0, 40512.392314115314, 41099.7945010279, 41188.176236475105, 54152.45847541553, 55601.439856014076, 40083.39874901879, 40246.39630405546, 40416.39375409371, 40481.59518404778, 40554.594454055674, 13273.800892986614, 13423.664408389868, 13448.91541811021, 13476.191428514321, 13477.056606037679, 10576.259661823598, 10632.30889992148, 10642.733931651615, 10644.414557199429, 10660.573577056986, 14123.64690882736, 14203.573892783234, 14220.075695079786, 14341.498047568493, 14351.928240358731, 5679.460451257124, 5808.82573522795, 5834.708264586754, 5844.327902291291, 5858.970705146447, 910.9225715814098, 925.2644147902433, 939.9718008459757, 948.1798244518442, 1059.1368035051407, 28925.0, 28955.71044289572, 29037.41925161485, 29117.70882291192, 29395.85302073476, 1008.7125169326854, 1052.310736467615, 1060.0194819791661, 1070.2668671959732, 1147.3460127727114, 14634.121952682874, 14802.851971480362, 14833.406663733545, 15018.774718379233, 15123.243837808066, 342285.0, 348519.0, 352520.0, 353971.0, 355654.0, 50605.49394506008, 51357.48642513527, 51516.227256591184, 51725.48274517282, 51766.74116629468, 1276.9489220431265, 1327.6415367850627, 1343.1068339554088, 1345.2466618693563, 1347.1647578501393, 27011.0, 27898.860505697343, 27989.0, 28179.859100704365, 28664.0, 45622.31566526438, 45982.7700861507, 46029.0, 46046.76976615095, 46052.539474604826, 315031.0, 316572.0, 316800.0, 316948.0, 318406.0, 32531.51202732008, 42356.36465452959, 42755.0, 42890.0, 42957.57042429536, 45422.77288613668, 46157.0, 46584.767076164404, 46685.0, 47206.527934720216, 32920.67079329272, 33141.50287745734, 33406.0, 33434.0, 35767.13862891014, 35543.64456355404, 35597.28805423929, 36221.27557448889, 36247.0, 36461.27077458383, 33361.332773343915, 33546.832265838515, 33572.0, 37832.62167378401, 38323.23353532858, 29035.854820725763, 30289.394212115192, 30409.327486988426, 30712.0, 30921.0, 23335.18326858552, 23415.243856711157, 23433.648495272926, 23591.882040589688, 23895.880520597286], "unit": "score", "name": "ext.html", "value": 17694.549330748556}, {"lowerIsBetter": false, "replicates": [360.3801461486244, 360.5187075254535, 367.1317334503899, 368.13855577947595, 370.1541976583507, 15265.542033738991, 16380.754288685679, 16648.66702665949, 17352.045637489933, 17645.647087058267, 15201.695966080671, 15268.0, 15514.0, 15652.0608763474, 15711.842881571181, 4737.739424331652, 4942.579880710144, 4945.480724523927, 4950.826721064764, 4968.056069346831, 4846.369971903648, 4873.366462359888, 4904.5831104356175, 4907.82822601209, 5237.502437268472, 4878.97541516282, 5044.520770526812, 5193.039287731782, 5200.245964335169, 5200.583953283728, 5019.071471777733, 5033.697978121324, 5058.0895438821, 5061.291419201315, 5343.625946183769, 5346.117890548055, 5349.331333583302, 5350.625456218067, 5359.3032905722, 5372.274742909696, 12209.816852747215, 16013.359465621477, 19019.33432329862, 19770.308039218704, 19903.40289791294, 2130.8614940028847, 2144.438019659846, 2152.1283880028614, 2174.7390313162523, 2225.4547635829163, 12118.939405303005, 12332.630021099292, 12394.31831249281, 12559.434825432878, 12750.322432289231, 1608.3727346334938, 1626.3169468823005, 1660.377358490566, 1661.0531996761852, 1857.452051644768, 54274.72862635701, 54521.45478545243, 55383.723081384735, 55723.0, 55879.44120558783, 9087.273018158532, 9216.400933939272, 9267.907320926839, 9280.350375473652, 9371.203447706885, 11879.762404751857, 11887.10846686502, 11932.22440541362, 11953.103517236243, 11968.521259149536, 6457.192850893638, 6700.564463309966, 6798.966005169942, 6866.210385805596, 6977.058097156819, 6622.1722284714415, 6648.0360347750275, 6668.0, 6670.332966703388, 6697.866042679119, 4048.0487085534874, 4152.252594532953, 4301.763403012865, 4344.761038142932, 4359.760213188241, 1592.2038980509744, 1647.3492970276673, 1674.6650669866076, 1683.3434960365466, 1692.3146125818816, 428.21850123524695, 434.36148861174024, 438.64250635731776, 443.70050216104, 446.7297285142442, 10467.633632822815, 10737.355758654505, 10862.348259104321, 10895.564177432972, 10910.454477276264, 441.697437255481, 449.86953783402447, 460.3623980786635, 470.3438703009351, 883.4875772052194, 8604.48373097616, 8757.168069033432, 8860.335474839412, 8996.010438851721, 9046.547672616343, 587213.0, 587402.0, 590430.0, 614791.0, 616897.0, 69058.61882762317, 71565.0, 71899.0, 73814.63092684503, 74013.62993185, 1114.3481063577897, 1118.5637601335486, 1124.8987591116838, 1124.943752812356, 1125.1954852280494, 13752.65618359549, 13955.37200825945, 14684.632884177981, 15278.847211528187, 15754.448594299145, 29718.851405742833, 30668.539971899994, 31202.843985780833, 32860.67139328576, 33638.0, 37782.2443551133, 40027.0, 41755.373669395594, 42350.788246059805, 44972.55027449683, 6987.9301206987275, 7121.0, 7138.428925686037, 7179.569225846466, 7254.854902902018, 9096.499692516974, 11101.500432480396, 11128.554857805597, 11580.710482237675, 11675.241109327866, 2919.2701824543865, 2959.8816047358728, 7011.719531218694, 7935.166807485131, 9335.346525743133, 6846.486513511407, 7584.924150758422, 7661.885071723817, 7694.961525192338, 9689.352810022454, 7029.789106326613, 7059.541129826544, 7216.71133154689, 7252.4560657949805, 7355.264473552602, 8814.338924580554, 9200.95399522998, 9215.67745128944, 10022.448765317977, 10222.795544088927, 8647.0, 8648.740537783877, 8709.608067636846, 8731.301495880442, 8834.469931803855], "unit": "score", "name": "jquery.html", "value": 7429.792134021225}, {"lowerIsBetter": false, "replicates": [1448.645081954921, 1451.6443471349517, 1604.6870860182269, 1741.4775567329798, 1771.9911400443004, 7858.921410785891, 7963.323117535002, 8090.6763729450895, 8107.0, 8135.755927322175, 8141.38939579531, 8168.836623267531, 8174.550399728013, 8236.588170591462, 8254.463459875118, 2342.3792694935814, 2356.7289761677457, 2364.4561750797325, 2368.12379419615, 2373.9287821365388, 2347.9178228762, 2370.3718514593647, 2374.4776149247136, 2376.7979721723673, 2389.6654468374354, 1963.9607207855834, 2016.737824082867, 2299.8505097168713, 2350.095213342858, 2355.752645972174, 2273.9994402462944, 2322.1756276521846, 2332.3702600297993, 2335.6730057791838, 2342.297310806768, 2283.086765293896, 2321.605327094398, 2365.597848365782, 2370.6799582056374, 2374.964375534368, 8050.355971522265, 8087.919120808834, 8096.10942796292, 8108.797280067986, 8131.959340203321, 4880.658353915227, 4938.703677779345, 4978.203487442028, 4979.053979743837, 4992.950070499285, 3071.4010767900268, 3076.6000419945262, 3145.2923092304277, 3149.370125974814, 3166.60417447819, 963.2919803944095, 1014.8782146142437, 1021.4586269277295, 1035.1666908138945, 1041.7656027393853, 11202.159838012181, 11282.830757538644, 11295.717607059807, 11337.659870203906, 11361.375124368156, 4346.174226896879, 4367.344898265285, 4383.649308055348, 4413.492448368479, 4433.246348120827, 8967.372283940062, 9032.548372581345, 9052.456852588866, 9056.04911484298, 9060.365774395728, 4862.708237505761, 4867.367242258484, 4887.584555312767, 4902.681325713817, 4917.409910810654, 4518.209313370147, 4536.228841097021, 4538.228501154812, 4558.042811009659, 4567.977160114245, 3568.2685049564775, 3636.581793093775, 3650.0509867434657, 3650.10572409756, 3661.5423072115987, 1108.8835672254459, 1119.054399032816, 1121.5962253588702, 1149.3563604381573, 1149.7183190118474, 961.8845738511424, 975.7511834482303, 1035.0374152038676, 1083.6586475260267, 1284.4476874943864, 7330.853382932311, 7335.743248986367, 7345.632718364061, 7354.669039893218, 7366.96316518414, 1028.6091285311684, 1032.210359075308, 1079.1420820447763, 1088.3252383522267, 1112.0603090388609, 5815.360310365856, 5886.61736987103, 5887.2052272943465, 5899.967505686488, 5903.881922361615, 9370.85943710845, 9535.47554884474, 9651.131398174199, 9738.90261097394, 9780.902190977999, 9530.0, 9582.520873956275, 9591.0, 9606.039396060338, 9647.71056868295, 7431.554106753612, 7501.324880760649, 7677.731279405194, 7747.30274275318, 7790.143084260727, 7366.337029667356, 7375.188729239887, 7448.068991376078, 7448.8882666758955, 7469.066366704162, 8547.316214702932, 8654.48073115615, 8942.73171804847, 8969.955150224207, 9076.0, 8925.464472131693, 8988.46069235848, 9017.143371379709, 9052.592633331384, 9182.862257066283, 6692.631905245258, 6822.556533825285, 6863.142107236596, 6897.55165914214, 6898.0, 7634.732784352521, 7649.847003060019, 7653.846923061396, 7655.617219139132, 7657.88513172314, 7271.0, 7365.9631701841145, 7407.740729074457, 7435.256474352522, 7585.355244804254, 6344.841378965562, 6670.633115178518, 6966.825829354307, 7078.752243671447, 7123.358897699232, 7090.822729431599, 7177.820554485971, 7195.46034047438, 7210.89183662256, 7255.709771609077, 6335.429811317003, 6507.381798729113, 6511.34886511364, 6524.347565243438, 6525.0, 6575.473962083118, 6587.670616469061, 6632.204135503771, 6649.002649602405, 6656.201255849329], "unit": "score", "name": "mootools.html", "value": 4579.734136571224}, {"lowerIsBetter": false, "replicates": [321.56428040005807, 324.8116092666252, 334.6352475801376, 342.0985702673456, 345.8841288168463, 6149.538784591156, 6210.09953556734, 6261.123442718023, 6277.0, 6426.518011149159, 6170.197874276338, 6230.065490176476, 6246.968765156168, 6264.467520260783, 6271.4669253113425, 4766.332713420124, 4766.404199475066, 4766.976165119187, 4768.117898188846, 4771.475137734864, 4761.571458568728, 4770.952290477103, 4775.068861571995, 4780.928286075712, 4787.425508938933, 4652.767361631905, 4734.502877197896, 4737.0, 4739.73931433771, 4748.976255118737, 4726.338312636217, 4731.243001119821, 4731.503192164808, 4738.455077666078, 4757.310190022427, 4109.321961876287, 4115.794210289503, 4116.115035267402, 4131.35963925592, 4135.8966025849295, 5927.673977931212, 5977.402259774031, 5982.581219314649, 5983.910241346383, 5995.760169593211, 5424.105022671254, 5517.586181036399, 5519.889602207933, 5522.66863988162, 5527.143292789624, 6591.868162636768, 6600.372964568358, 6612.93387066128, 6617.139771829679, 6619.834504137387, 4538.341940418621, 4547.727136371828, 4554.362389265505, 4554.63562914966, 4567.840125595588, 6712.899306510406, 6830.59016459014, 6902.723891044352, 6916.23921368649, 6923.411510021604, 4554.4990051094355, 4568.109218702321, 4568.611668008257, 4573.108243892409, 4575.5424457554645, 4624.352590637313, 4638.304254361873, 4639.814407423665, 4640.86077417678, 4644.140833945731, 5369.033573956725, 5405.432429594836, 5407.594430417735, 5413.431589683027, 5413.729313534386, 6398.232212134573, 6577.835554111186, 6588.4729221662155, 6620.073189753439, 6669.7665581704405, 1570.9135997520018, 1590.109538658355, 1590.300267882128, 1593.8167110782408, 1636.0674415583003, 1081.4808891731855, 1097.9505922233518, 1107.2304748199924, 1109.2180013090751, 1128.7911736328806, 6139.693015349215, 6183.258009038944, 6198.256209254918, 6217.036359364306, 6219.782307619212, 6678.031685405589, 6683.198016238082, 6697.028930805103, 6726.327367263332, 6774.356436138559, 6014.6391216527145, 6205.348438413992, 6208.689565521706, 6211.192544969125, 6215.968920155461, 3649.434337677664, 3663.5603727552866, 3672.8163591820835, 3676.540432445944, 3680.4847321375028, 7074.469414793911, 7082.327178917994, 7093.184283807325, 7125.501214914906, 7127.572345659173, 6724.865502689919, 6875.278095799969, 6875.690593923286, 6900.689468973908, 6910.412614927787, 7079.82300442493, 7084.716611335489, 7091.787246382617, 7092.9645351772915, 7117.466190035768, 6723.655268946328, 6731.730730770911, 6737.461003119836, 6742.6291553965, 6744.426723728342, 6540.869182616416, 6665.566738162004, 6673.566218195801, 6682.231543372574, 6682.866342673216, 7061.646917653994, 7089.220185779457, 7101.715931362688, 7118.430525558047, 7118.430525558047, 4642.605378542727, 4644.790984405642, 4646.86059418218, 4647.814087436464, 4665.650076244227, 6710.966445167743, 6791.89812152828, 6800.081988931431, 6804.149481314836, 6969.4424446045205, 6654.83362915931, 6669.032990216295, 6695.732170713117, 6717.697703603252, 6729.596224226562, 6674.9332506676255, 6721.563098398588, 6736.0, 6747.595144291358, 6749.595024298558, 6446.742130314922, 6561.80314590563, 6571.145751052332, 6582.308857569887, 6588.341165883373, 6738.528303018742, 6776.491763117688, 6780.898286525608, 6785.185777706707, 6800.727970881109, 6528.118703974903, 6563.737450502117, 6578.440832529289, 6592.472602191718, 6599.53803233769], "unit": "score", "name": "prototype.html", "value": 4956.395174668561}, {"lowerIsBetter": false, "replicates": [728.5446595877577, 775.7401270574358, 839.1189251286148, 849.329030066248, 865.238590040764, 10684.572617095317, 10744.516496757646, 10832.295900766454, 10884.183686223545, 10944.3980581068, 12536.874631253684, 12568.748625027494, 12578.496860125608, 12592.118551701384, 12593.118481706284, 653.3988730368072, 663.4692246203042, 751.7181057103586, 782.4327362662082, 798.8641930871737, 785.1206648553627, 787.9606019699021, 790.0401012769483, 791.3708601661664, 792.5918152151646, 824.2952275804191, 827.1893544326564, 828.2835347424465, 829.3986859526855, 832.7002279179491, 817.9100298967109, 822.3914303415489, 822.7161629237903, 824.2499325613693, 824.5135370131621, 606.472369038939, 607.025723713438, 609.2141137932107, 609.6860117039683, 611.574955405993, 12945.61163165097, 12970.740585188338, 12978.675533111653, 12993.675158121028, 13004.284764337957, 12803.0, 13013.154144980546, 13210.00924930634, 13361.331933403291, 13370.532031378854, 10133.0, 10252.846207306822, 10302.433366164858, 10526.0, 10643.893561064446, 3539.982300088509, 3588.4617307404096, 3611.747177697562, 3676.209614932802, 3679.3929001714687, 43855.34216986748, 44246.0, 44276.3358549622, 44445.0, 44671.55328446674, 9257.722268331827, 9524.952375238217, 9552.092551207625, 9830.459324737065, 9921.0, 17816.287348506175, 17956.0, 17972.910135449238, 17974.281028758964, 17999.64000719978, 7048.295170482911, 7326.706931722778, 7359.190489046201, 7407.333339999318, 7416.7774966751085, 4208.705390622688, 4239.788010599519, 4240.385144154142, 4287.206866729665, 4294.74231546102, 3064.8927287545275, 3081.9691803082133, 3089.2894634233803, 3090.026641607886, 3104.286014216743, 544.8093167391461, 567.9261695979496, 572.4161355417534, 581.3198557687516, 589.6462122726416, 590.421387040694, 597.4652685846144, 627.6547898655813, 643.6813777180325, 720.9396113498129, 8315.584220789058, 8334.958325208456, 8337.0, 8444.24001839825, 8495.1080136586, 499.5354320481914, 626.4080443980395, 691.515938842812, 695.4714417042983, 735.4116706634671, 3915.1190982029384, 4026.6577340925764, 4028.536718277377, 4040.8585699500377, 4082.6937979651643, 48666.270005949234, 48831.116888310884, 49059.0, 58176.0, 59505.10742338868, 46933.29600056002, 46941.765291173324, 47024.76487617609, 47057.29414058792, 47097.0, 40754.38868416976, 40779.59220407758, 41048.794756026626, 42430.78784606057, 42536.0, 8349.499030057974, 8370.0, 8433.367497437594, 8475.32197424217, 8704.303655707656, 31825.204369890937, 32418.0, 32661.673383265865, 33588.832055839564, 33664.49503257404, 37829.24341513209, 38274.42588361121, 40761.184776303715, 42452.787736061124, 42638.36042459303, 10922.0, 11100.944495277472, 11194.608188713355, 11201.775964480828, 11512.30926144434, 11738.178327516991, 11942.402879856147, 12165.391730413621, 12190.51237950472, 12542.0, 10741.355518668905, 11158.330500170016, 11206.0, 11234.438278086227, 11705.261476089274, 11181.298184531212, 11183.664490065312, 11571.421428928352, 11697.532098715956, 11909.583164589198, 9986.101250887456, 10274.22943279272, 11426.657200284004, 11432.885671143182, 11624.88375116238, 9758.365706229357, 9875.358101723365, 9958.502074896081, 10116.544755486168, 10184.541695623566, 8707.695230666895, 9050.185483306534, 9320.440773553608, 9482.634385358131, 9681.177099946302], "unit": "score", "name": "yui.html", "value": 6114.583133419914}], "name": "dromaeo_css", "value": 6792.125270673819}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 109.0, 111.0, 111.0, 125.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [153.0, 137.0, 151.0, 168.0, 126.0, 150.0, 156.0, 132.0, 173.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 164.0, 166.0, 164.0, 162.0, 170.0, 167.0, 160.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [74.0, 79.0, 74.0, 74.0, 74.0, 144.0, 73.0, 74.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 138.0, 97.0, 96.0, 97.0, 141.0, 95.0, 97.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 101.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 62.0, 62.0, 60.0, 60.0, 62.0, 61.0, 61.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 67.0, 79.0, 67.0, 67.0, 67.0, 72.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 86.0, 102.0, 83.0, 84.0, 85.0, 84.0, 84.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 129.0, 126.0, 117.0, 136.0, 129.0, 128.0, 132.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [141.0, 155.0, 151.0, 149.0, 152.0, 139.0, 150.0, 153.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 74.0, 69.0, 69.0, 68.0, 67.0, 68.0, 66.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1525.9000000000005}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [186.1850679575498], "unit": "score", "name": "DeltaBlue", "value": 355.1197780000001}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [41591.836734693876], "unit": "score", "name": "RegExp", "value": 21.902975956820406}, {"lowerIsBetter": false, "replicates": [613.8735420503376], "unit": "score", "name": "Splay", "value": 132.748839}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20346.7530049834}]} 08:13:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20346.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1525.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6792.12"}}} 08:13:06 INFO - Return code: 0 08:13:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:13:06 INFO - # TBPL SUCCESS # 08:13:06 INFO - Running post-action listener: _resource_record_post_action 08:13:06 INFO - Running post-run listener: _resource_record_post_run 08:13:07 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 551817216; Read time: 0; Write time: 528772 08:13:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 210931712; Read time: 0; Write time: 248504 08:13:07 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 314519552; Read time: 0; Write time: 264516 08:13:07 INFO - Running post-run listener: _upload_blobber_files 08:13:07 INFO - Blob upload gear active. 08:13:07 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:13:07 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 08:13:07 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'] 08:13:07 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 08:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:08 INFO - (blobuploader) - INFO - Done attempting. 08:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:09 INFO - (blobuploader) - INFO - Done attempting. 08:13:09 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:09 INFO - Return code: 0 08:13:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:13:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2f24f35e685198dedb827667fdfb489af6536b0cf4143e1dff013877ad8a31090cdf40517bd1e65d058de2fdabcbf0cef4d4a20d2841e27afac24168afc2216", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2506ccdafaf14a2b94ee36f8502d15f93a3debc10e0aa8c068fd6d4997abcd4b3a4bb362c8cfeb40a49e296fe6f38f9635ee5db7c40348d1218188f007cb6380"} 08:13:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:13:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:13:09 INFO - Contents: 08:13:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2f24f35e685198dedb827667fdfb489af6536b0cf4143e1dff013877ad8a31090cdf40517bd1e65d058de2fdabcbf0cef4d4a20d2841e27afac24168afc2216", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2506ccdafaf14a2b94ee36f8502d15f93a3debc10e0aa8c068fd6d4997abcd4b3a4bb362c8cfeb40a49e296fe6f38f9635ee5db7c40348d1218188f007cb6380"} 08:13:09 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:09 INFO - Copying logs to upload dir... 08:13:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:13:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.532755 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-21 08:13:09.565369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 08:13:09.572554) ========= 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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 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/f2f24f35e685198dedb827667fdfb489af6536b0cf4143e1dff013877ad8a31090cdf40517bd1e65d058de2fdabcbf0cef4d4a20d2841e27afac24168afc2216", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2506ccdafaf14a2b94ee36f8502d15f93a3debc10e0aa8c068fd6d4997abcd4b3a4bb362c8cfeb40a49e296fe6f38f9635ee5db7c40348d1218188f007cb6380"} build_url:https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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/f2f24f35e685198dedb827667fdfb489af6536b0cf4143e1dff013877ad8a31090cdf40517bd1e65d058de2fdabcbf0cef4d4a20d2841e27afac24168afc2216", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2506ccdafaf14a2b94ee36f8502d15f93a3debc10e0aa8c068fd6d4997abcd4b3a4bb362c8cfeb40a49e296fe6f38f9635ee5db7c40348d1218188f007cb6380"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 08:13:09.599251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:13:09.599601) ========= 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=32c5991c409366f7fec8a718000001d2-1453390243.463470-1712678891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:13:09.649374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:13:09.649679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:13:09.649967) ========= ========= Total master_lag: 0.34 =========