builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1452085404.72 results: success (0) buildid: 20160106023011 builduid: 4650683aa9ec4810bd902957b8b630b0 revision: 444097473d1a78553a360b82a2d123cfad306492 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.716516) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.717011) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.717306) ========= 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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.750601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.750913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.770357) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.770717) ========= 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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.822950) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.823316) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.823746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.824045) ========= 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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 05:03:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 43.5M=0s 2016-01-06 05:03:25 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146116 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.982505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.982868) ========= 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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.032642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.033032) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 444097473d1a78553a360b82a2d123cfad306492 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 444097473d1a78553a360b82a2d123cfad306492 --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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 05:03:26,022 truncating revision to first 12 chars 2016-01-06 05:03:26,022 Setting DEBUG logging. 2016-01-06 05:03:26,022 attempt 1/10 2016-01-06 05:03:26,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/444097473d1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 05:03:26,261 unpacking tar archive at: fx-team-444097473d1a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.577253) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.577521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.587289) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.587537) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.587907) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-06 05:03:25.588203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:26 INFO - MultiFileLogger online at 20160106 05:03:26 in /builds/slave/test-pgo 05:03:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:03:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:03:26 INFO - {'append_to_log': False, 05:03:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:03:26 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:03:26 INFO - 'branch': 'Fx-Team', 05:03:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:26 INFO - 'config_files': ('talos/linux_config.py',), 05:03:26 INFO - 'default_actions': ('clobber', 05:03:26 INFO - 'read-buildbot-config', 05:03:26 INFO - 'download-and-extract', 05:03:26 INFO - 'populate-webroot', 05:03:26 INFO - 'create-virtualenv', 05:03:26 INFO - 'install', 05:03:26 INFO - 'run-tests'), 05:03:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:26 INFO - 'download_minidump_stackwalk': True, 05:03:26 INFO - 'download_symbols': 'ondemand', 05:03:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:26 INFO - 'installer_path': 'installer.exe', 05:03:26 INFO - 'log_level': 'info', 05:03:26 INFO - 'log_name': 'talos', 05:03:26 INFO - 'log_to_console': True, 05:03:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:26 INFO - 'opt_config_files': (), 05:03:26 INFO - 'pip_index': False, 05:03:26 INFO - 'sps_profile': False, 05:03:26 INFO - 'sps_profile_interval': 0, 05:03:26 INFO - 'suite': 'dromaeojs-e10s', 05:03:26 INFO - 'system_bits': '32', 05:03:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:26 INFO - 'title': 'talos-linux64-ix-050', 05:03:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:26 INFO - 'use_talos_json': True, 05:03:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:03:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:26 INFO - 'work_dir': 'build'} 05:03:26 INFO - ##### 05:03:26 INFO - ##### Running clobber step. 05:03:26 INFO - ##### 05:03:26 INFO - Running pre-action listener: _resource_record_pre_action 05:03:26 INFO - Running main action method: clobber 05:03:26 INFO - rmtree: /builds/slave/test-pgo/build 05:03:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:03:27 INFO - Running post-action listener: _resource_record_post_action 05:03:27 INFO - ##### 05:03:27 INFO - ##### Running read-buildbot-config step. 05:03:27 INFO - ##### 05:03:27 INFO - Running pre-action listener: _resource_record_pre_action 05:03:27 INFO - Running main action method: read_buildbot_config 05:03:27 INFO - Using buildbot properties: 05:03:27 INFO - { 05:03:27 INFO - "project": "", 05:03:27 INFO - "product": "firefox", 05:03:27 INFO - "script_repo_revision": "production", 05:03:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:03:27 INFO - "repository": "", 05:03:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:03:27 INFO - "buildid": "20160106023011", 05:03:27 INFO - "pgo_build": "True", 05:03:27 INFO - "basedir": "/builds/slave/test-pgo", 05:03:27 INFO - "buildnumber": 426, 05:03:27 INFO - "slavename": "talos-linux64-ix-050", 05:03:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:03:27 INFO - "platform": "ubuntu64_hw", 05:03:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:03:27 INFO - "branch": "fx-team", 05:03:27 INFO - "repo_path": "integration/fx-team", 05:03:27 INFO - "revision": "444097473d1a78553a360b82a2d123cfad306492", 05:03:27 INFO - "stage_platform": "linux64-pgo", 05:03:27 INFO - "builduid": "4650683aa9ec4810bd902957b8b630b0", 05:03:27 INFO - "slavebuilddir": "test" 05:03:27 INFO - } 05:03:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:03:27 INFO - Running post-action listener: _resource_record_post_action 05:03:27 INFO - ##### 05:03:27 INFO - ##### Running download-and-extract step. 05:03:27 INFO - ##### 05:03:27 INFO - Running pre-action listener: _resource_record_pre_action 05:03:27 INFO - Running main action method: download_and_extract 05:03:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:27 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:03:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json 05:03:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json 05:03:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:03:31 INFO - Downloaded 1302 bytes. 05:03:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:03:31 INFO - Using the following test package requirements: 05:03:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:03:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:31 INFO - u'jsshell-linux-x86_64.zip'], 05:03:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:03:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:03:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:03:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:03:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:03:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:31 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:33 INFO - Downloaded 24097761 bytes. 05:03:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:03:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:03:34 INFO - Return code: 0 05:03:34 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 05:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:34 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:38 INFO - Downloaded 24097761 bytes. 05:03:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:03:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:03:39 INFO - Return code: 0 05:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:39 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:40 INFO - Downloaded 11132285 bytes. 05:03:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:03:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:03:40 INFO - Return code: 0 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:40 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/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 05:03:42 INFO - Downloaded 55073732 bytes. 05:03:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:42 INFO - mkdir: /builds/slave/test-pgo/properties 05:03:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:03:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:03:42 INFO - Contents: 05:03:42 INFO - build_url:https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:42 INFO - Running post-action listener: _resource_record_post_action 05:03:42 INFO - Running post-action listener: set_extra_try_arguments 05:03:42 INFO - ##### 05:03:42 INFO - ##### Running populate-webroot step. 05:03:42 INFO - ##### 05:03:42 INFO - Running pre-action listener: _resource_record_pre_action 05:03:42 INFO - Running main action method: populate_webroot 05:03:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:42 INFO - '--tppagecycles', 05:03:42 INFO - '7'], 05:03:42 INFO - 'tests': ['tsvgm']}}, 05:03:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:03:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:03:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:03:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'tests': ['damp', 'tps']}, 05:03:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['damp', 'tps']}, 05:03:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:03:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:42 INFO - 'other': {'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore']}, 05:03:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore']}, 05:03:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore']}, 05:03:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore']}, 05:03:42 INFO - 'other_l64': {'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore']}, 05:03:42 INFO - 'other_nol64': {'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore']}, 05:03:42 INFO - 'svgr': {'tests': ['tsvgx', 05:03:42 INFO - 'tsvgr_opacity', 05:03:42 INFO - 'tart', 05:03:42 INFO - 'tscrollx', 05:03:42 INFO - 'cart']}, 05:03:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['tsvgx', 05:03:42 INFO - 'tsvgr_opacity', 05:03:42 INFO - 'tart', 05:03:42 INFO - 'tscrollx', 05:03:42 INFO - 'cart']}, 05:03:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'tests': ['tp5o']}, 05:03:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'talos_options': ['--e10s'], 05:03:42 INFO - 'tests': ['tp5o']}, 05:03:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'talos_options': ['--xperf_path', 05:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:42 INFO - 'tests': ['tp5n']}, 05:03:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:42 INFO - 'talos_options': ['--e10s', 05:03:42 INFO - '--xperf_path', 05:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:42 INFO - 'tests': ['tp5n']}}, 05:03:42 INFO - 'talos.zip': {'path': '', 05:03:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:42 INFO - Running post-action listener: _resource_record_post_action 05:03:42 INFO - ##### 05:03:42 INFO - ##### Running create-virtualenv step. 05:03:42 INFO - ##### 05:03:42 INFO - Running pre-action listener: _resource_record_pre_action 05:03:42 INFO - Running main action method: create_virtualenv 05:03:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:03:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:03:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:03:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:42 INFO - Using real prefix '/usr' 05:03:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:03:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:44 INFO - Installing pip.................done. 05:03:44 INFO - Return code: 0 05:03:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:03: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')]} 05:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:03:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:03:44 INFO - Using env: {'DISPLAY': ':0', 05:03:44 INFO - 'HOME': '/home/cltbld', 05:03:44 INFO - 'LANG': 'en_US.UTF-8', 05:03:44 INFO - 'LANGUAGE': 'en_US:en', 05:03:44 INFO - 'LOGNAME': 'cltbld', 05:03:44 INFO - 'MAIL': '/var/mail/cltbld', 05:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:44 INFO - 'MOZ_NO_REMOTE': '1', 05:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:44 INFO - 'NO_EM_RESTART': '1', 05:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:44 INFO - 'SHELL': '/bin/bash', 05:03:44 INFO - 'SHLVL': '1', 05:03:44 INFO - 'TERM': 'linux', 05:03:44 INFO - 'TMOUT': '86400', 05:03:44 INFO - 'USER': 'cltbld', 05:03:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:44 INFO - '_': '/tools/buildbot/bin/python'} 05:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:03:45 INFO - Cleaning up... 05:03:45 INFO - Return code: 0 05:03:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:03:45 INFO - Using env: {'DISPLAY': ':0', 05:03:45 INFO - 'HOME': '/home/cltbld', 05:03:45 INFO - 'LANG': 'en_US.UTF-8', 05:03:45 INFO - 'LANGUAGE': 'en_US:en', 05:03:45 INFO - 'LOGNAME': 'cltbld', 05:03:45 INFO - 'MAIL': '/var/mail/cltbld', 05:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:45 INFO - 'MOZ_NO_REMOTE': '1', 05:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:45 INFO - 'NO_EM_RESTART': '1', 05:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:45 INFO - 'SHELL': '/bin/bash', 05:03:45 INFO - 'SHLVL': '1', 05:03:45 INFO - 'TERM': 'linux', 05:03:45 INFO - 'TMOUT': '86400', 05:03:45 INFO - 'USER': 'cltbld', 05:03:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:45 INFO - '_': '/tools/buildbot/bin/python'} 05:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:45 INFO - Downloading/unpacking psutil>=0.7.1 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:03:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:03:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:47 INFO - Installing collected packages: psutil 05:03:47 INFO - Running setup.py install for psutil 05:03:47 INFO - building 'psutil._psutil_linux' extension 05:03:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:03:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:03:47 INFO - building 'psutil._psutil_posix' extension 05:03:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:03:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:47 INFO - Successfully installed psutil 05:03:47 INFO - Cleaning up... 05:03:47 INFO - Return code: 0 05:03:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:03:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:03:47 INFO - Using env: {'DISPLAY': ':0', 05:03:47 INFO - 'HOME': '/home/cltbld', 05:03:47 INFO - 'LANG': 'en_US.UTF-8', 05:03:47 INFO - 'LANGUAGE': 'en_US:en', 05:03:47 INFO - 'LOGNAME': 'cltbld', 05:03:47 INFO - 'MAIL': '/var/mail/cltbld', 05:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:47 INFO - 'MOZ_NO_REMOTE': '1', 05:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:47 INFO - 'NO_EM_RESTART': '1', 05:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:47 INFO - 'SHELL': '/bin/bash', 05:03:47 INFO - 'SHLVL': '1', 05:03:47 INFO - 'TERM': 'linux', 05:03:47 INFO - 'TMOUT': '86400', 05:03:47 INFO - 'USER': 'cltbld', 05:03:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:47 INFO - '_': '/tools/buildbot/bin/python'} 05:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:03:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:03:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:03:49 INFO - Installing collected packages: mozsystemmonitor 05:03:49 INFO - Running setup.py install for mozsystemmonitor 05:03:49 INFO - Successfully installed mozsystemmonitor 05:03:49 INFO - Cleaning up... 05:03:49 INFO - Return code: 0 05:03:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:03:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:03:49 INFO - Using env: {'DISPLAY': ':0', 05:03:49 INFO - 'HOME': '/home/cltbld', 05:03:49 INFO - 'LANG': 'en_US.UTF-8', 05:03:49 INFO - 'LANGUAGE': 'en_US:en', 05:03:49 INFO - 'LOGNAME': 'cltbld', 05:03:49 INFO - 'MAIL': '/var/mail/cltbld', 05:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:49 INFO - 'MOZ_NO_REMOTE': '1', 05:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:49 INFO - 'NO_EM_RESTART': '1', 05:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:49 INFO - 'SHELL': '/bin/bash', 05:03:49 INFO - 'SHLVL': '1', 05:03:49 INFO - 'TERM': 'linux', 05:03:49 INFO - 'TMOUT': '86400', 05:03:49 INFO - 'USER': 'cltbld', 05:03:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:49 INFO - '_': '/tools/buildbot/bin/python'} 05:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:03:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:03:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:03:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:52 INFO - Downloading docopt-0.6.1.tar.gz 05:03:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:03:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:52 INFO - Running setup.py install for blobuploader 05:03:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:03:52 INFO - Running setup.py install for requests 05:03:52 INFO - Running setup.py install for docopt 05:03:52 INFO - Successfully installed blobuploader requests docopt 05:03:52 INFO - Cleaning up... 05:03:52 INFO - Return code: 0 05:03:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:03:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:52 INFO - Using env: {'DISPLAY': ':0', 05:03:52 INFO - 'HOME': '/home/cltbld', 05:03:52 INFO - 'LANG': 'en_US.UTF-8', 05:03:52 INFO - 'LANGUAGE': 'en_US:en', 05:03:52 INFO - 'LOGNAME': 'cltbld', 05:03:52 INFO - 'MAIL': '/var/mail/cltbld', 05:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:52 INFO - 'MOZ_NO_REMOTE': '1', 05:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:52 INFO - 'NO_EM_RESTART': '1', 05:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:52 INFO - 'SHELL': '/bin/bash', 05:03:52 INFO - 'SHLVL': '1', 05:03:52 INFO - 'TERM': 'linux', 05:03:52 INFO - 'TMOUT': '86400', 05:03:52 INFO - 'USER': 'cltbld', 05:03:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:52 INFO - '_': '/tools/buildbot/bin/python'} 05:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:53 INFO - Running setup.py (path:/tmp/pip-81VgXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:53 INFO - Running setup.py (path:/tmp/pip-KH8Evw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:53 INFO - Running setup.py (path:/tmp/pip-c1TSxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:53 INFO - Running setup.py (path:/tmp/pip-QAmxPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:53 INFO - Running setup.py (path:/tmp/pip-Wk0MnQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:53 INFO - Running setup.py (path:/tmp/pip-vIT1oX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:53 INFO - Running setup.py (path:/tmp/pip-mIhFgY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:53 INFO - Running setup.py (path:/tmp/pip-wgtfBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:53 INFO - Running setup.py (path:/tmp/pip-NYfhdP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:53 INFO - Running setup.py (path:/tmp/pip-3tAIEE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:53 INFO - Running setup.py (path:/tmp/pip-wVCrWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:53 INFO - Running setup.py (path:/tmp/pip-wSWxfV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:54 INFO - Running setup.py (path:/tmp/pip-ocDL16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:54 INFO - Running setup.py (path:/tmp/pip-9tC9Ew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:54 INFO - Running setup.py (path:/tmp/pip-TQFIcp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:54 INFO - Running setup.py (path:/tmp/pip-qPXvaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:54 INFO - Running setup.py (path:/tmp/pip-mn1WoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:54 INFO - Running setup.py install for manifestparser 05:03:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:03:54 INFO - Running setup.py install for mozcrash 05:03:54 INFO - Running setup.py install for mozdebug 05:03:54 INFO - Running setup.py install for mozdevice 05:03:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:03:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:03:54 INFO - Running setup.py install for mozfile 05:03:54 INFO - Running setup.py install for mozhttpd 05:03:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Running setup.py install for mozinfo 05:03:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Running setup.py install for mozInstall 05:03:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Running setup.py install for mozleak 05:03:55 INFO - Running setup.py install for mozlog 05:03:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Running setup.py install for moznetwork 05:03:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Running setup.py install for mozprocess 05:03:55 INFO - Running setup.py install for mozprofile 05:03:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Running setup.py install for mozrunner 05:03:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:03:55 INFO - Running setup.py install for mozscreenshot 05:03:55 INFO - Running setup.py install for moztest 05:03:56 INFO - Running setup.py install for mozversion 05:03:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:03:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:56 INFO - Cleaning up... 05:03:56 INFO - Return code: 0 05:03:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:03:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:56 INFO - Using env: {'DISPLAY': ':0', 05:03:56 INFO - 'HOME': '/home/cltbld', 05:03:56 INFO - 'LANG': 'en_US.UTF-8', 05:03:56 INFO - 'LANGUAGE': 'en_US:en', 05:03:56 INFO - 'LOGNAME': 'cltbld', 05:03:56 INFO - 'MAIL': '/var/mail/cltbld', 05:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:56 INFO - 'MOZ_NO_REMOTE': '1', 05:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:56 INFO - 'NO_EM_RESTART': '1', 05:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:56 INFO - 'SHELL': '/bin/bash', 05:03:56 INFO - 'SHLVL': '1', 05:03:56 INFO - 'TERM': 'linux', 05:03:56 INFO - 'TMOUT': '86400', 05:03:56 INFO - 'USER': 'cltbld', 05:03:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:56 INFO - '_': '/tools/buildbot/bin/python'} 05:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:56 INFO - Running setup.py (path:/tmp/pip-z2DdaJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:56 INFO - Running setup.py (path:/tmp/pip-YXTzRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:56 INFO - Running setup.py (path:/tmp/pip-LcuT9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:56 INFO - Running setup.py (path:/tmp/pip-ONoXKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:56 INFO - Running setup.py (path:/tmp/pip-LMgCA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:56 INFO - Running setup.py (path:/tmp/pip-GfDRxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:56 INFO - Running setup.py (path:/tmp/pip-Cude2G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:56 INFO - Running setup.py (path:/tmp/pip-rXH1Rc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:56 INFO - Running setup.py (path:/tmp/pip-NR_PHK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:57 INFO - Running setup.py (path:/tmp/pip-fbgzJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:57 INFO - Running setup.py (path:/tmp/pip-5ya2VR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:57 INFO - Running setup.py (path:/tmp/pip-4CPoY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:57 INFO - Running setup.py (path:/tmp/pip-QjKlav-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:57 INFO - Running setup.py (path:/tmp/pip-J8UbHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:57 INFO - Running setup.py (path:/tmp/pip-_ITe3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:57 INFO - Running setup.py (path:/tmp/pip-OeefGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:57 INFO - Running setup.py (path:/tmp/pip-nIkph0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:59 INFO - Downloading blessings-1.5.1.tar.gz 05:03:59 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:03:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:59 INFO - Installing collected packages: blessings 05:03:59 INFO - Running setup.py install for blessings 05:03:59 INFO - Successfully installed blessings 05:03:59 INFO - Cleaning up... 05:03:59 INFO - Return code: 0 05:03:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:03:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:03:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:03:59 INFO - Reading from file tmpfile_stdout 05:03:59 INFO - Current package versions: 05:03:59 INFO - argparse == 1.2.1 05:03:59 INFO - blessings == 1.5.1 05:03:59 INFO - blobuploader == 1.2.4 05:03:59 INFO - docopt == 0.6.1 05:03:59 INFO - manifestparser == 1.1 05:03:59 INFO - mozInstall == 1.12 05:03:59 INFO - mozcrash == 0.16 05:03:59 INFO - mozdebug == 0.1 05:03:59 INFO - mozdevice == 0.47 05:03:59 INFO - mozfile == 1.2 05:03:59 INFO - mozhttpd == 0.7 05:03:59 INFO - mozinfo == 0.9 05:03:59 INFO - mozleak == 0.1 05:03:59 INFO - mozlog == 3.1 05:03:59 INFO - moznetwork == 0.27 05:03:59 INFO - mozprocess == 0.22 05:03:59 INFO - mozprofile == 0.28 05:03:59 INFO - mozrunner == 6.11 05:03:59 INFO - mozscreenshot == 0.1 05:03:59 INFO - mozsystemmonitor == 0.0 05:03:59 INFO - moztest == 0.7 05:03:59 INFO - mozversion == 1.4 05:03:59 INFO - psutil == 3.1.1 05:03:59 INFO - requests == 1.2.3 05:03:59 INFO - wsgiref == 0.1.2 05:03:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:03:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:59 INFO - Using env: {'DISPLAY': ':0', 05:03:59 INFO - 'HOME': '/home/cltbld', 05:03:59 INFO - 'LANG': 'en_US.UTF-8', 05:03:59 INFO - 'LANGUAGE': 'en_US:en', 05:03:59 INFO - 'LOGNAME': 'cltbld', 05:03:59 INFO - 'MAIL': '/var/mail/cltbld', 05:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:59 INFO - 'MOZ_NO_REMOTE': '1', 05:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:59 INFO - 'NO_EM_RESTART': '1', 05:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:59 INFO - 'SHELL': '/bin/bash', 05:03:59 INFO - 'SHLVL': '1', 05:03:59 INFO - 'TERM': 'linux', 05:03:59 INFO - 'TMOUT': '86400', 05:03:59 INFO - 'USER': 'cltbld', 05:03:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:59 INFO - '_': '/tools/buildbot/bin/python'} 05:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:04:00 INFO - Cleaning up... 05:04:00 INFO - Return code: 0 05:04:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:04:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:04:00 INFO - Using env: {'DISPLAY': ':0', 05:04:00 INFO - 'HOME': '/home/cltbld', 05:04:00 INFO - 'LANG': 'en_US.UTF-8', 05:04:00 INFO - 'LANGUAGE': 'en_US:en', 05:04:00 INFO - 'LOGNAME': 'cltbld', 05:04:00 INFO - 'MAIL': '/var/mail/cltbld', 05:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:00 INFO - 'MOZ_NO_REMOTE': '1', 05:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:00 INFO - 'NO_EM_RESTART': '1', 05:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:00 INFO - 'SHELL': '/bin/bash', 05:04:00 INFO - 'SHLVL': '1', 05:04:00 INFO - 'TERM': 'linux', 05:04:00 INFO - 'TMOUT': '86400', 05:04:00 INFO - 'USER': 'cltbld', 05:04:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:00 INFO - '_': '/tools/buildbot/bin/python'} 05:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:00 INFO - Downloading/unpacking jsonschema 05:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:04:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:04:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:02 INFO - warning: no files found matching '*.txt' 05:04:02 INFO - no previously-included directories found matching 'build' 05:04:02 INFO - no previously-included directories found matching 'dist' 05:04:02 INFO - no previously-included directories found matching '.git*' 05:04:02 INFO - Installing collected packages: jsonschema, functools32 05:04:02 INFO - Running setup.py install for functools32 05:04:02 INFO - warning: no files found matching '*.txt' 05:04:02 INFO - no previously-included directories found matching 'build' 05:04:02 INFO - no previously-included directories found matching 'dist' 05:04:02 INFO - no previously-included directories found matching '.git*' 05:04:02 INFO - Successfully installed jsonschema functools32 05:04:02 INFO - Cleaning up... 05:04:02 INFO - Return code: 0 05:04:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2283b05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, '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': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:04:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:04:02 INFO - Using env: {'DISPLAY': ':0', 05:04:02 INFO - 'HOME': '/home/cltbld', 05:04:02 INFO - 'LANG': 'en_US.UTF-8', 05:04:02 INFO - 'LANGUAGE': 'en_US:en', 05:04:02 INFO - 'LOGNAME': 'cltbld', 05:04:02 INFO - 'MAIL': '/var/mail/cltbld', 05:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:02 INFO - 'MOZ_NO_REMOTE': '1', 05:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:02 INFO - 'NO_EM_RESTART': '1', 05:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:02 INFO - 'SHELL': '/bin/bash', 05:04:02 INFO - 'SHLVL': '1', 05:04:02 INFO - 'TERM': 'linux', 05:04:02 INFO - 'TMOUT': '86400', 05:04:02 INFO - 'USER': 'cltbld', 05:04:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:02 INFO - '_': '/tools/buildbot/bin/python'} 05:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:02 INFO - Downloading/unpacking flake8 05:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:04:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:04:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:04:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:04:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:04:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:04:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:04 INFO - no previously-included directories found matching 'docs/_build' 05:04:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:05 INFO - Running setup.py install for pep8 05:04:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:05 INFO - no previously-included directories found matching 'docs/_build' 05:04:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:04:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:05 INFO - Cleaning up... 05:04:05 INFO - Return code: 0 05:04:05 INFO - Running post-action listener: _resource_record_post_action 05:04:05 INFO - Running post-action listener: _start_resource_monitoring 05:04:05 INFO - Starting resource monitoring. 05:04:05 INFO - ##### 05:04:05 INFO - ##### Running install step. 05:04:05 INFO - ##### 05:04:05 INFO - Running pre-action listener: _resource_record_pre_action 05:04:05 INFO - Running main action method: install 05:04:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:05 INFO - Reading from file tmpfile_stdout 05:04:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:04:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:04:05 INFO - Reading from file tmpfile_stdout 05:04:05 INFO - Output received: 05:04:05 INFO - Usage: mozinstall [options] installer 05:04:05 INFO - Options: 05:04:05 INFO - -h, --help show this help message and exit 05:04:05 INFO - -d DEST, --destination=DEST 05:04:05 INFO - Directory to install application into. [default: 05:04:05 INFO - "/builds/slave/test-pgo"] 05:04:05 INFO - --app=APP Application being installed. [default: firefox] 05:04:05 INFO - mkdir: /builds/slave/test-pgo/build/application 05:04:05 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'] 05:04:05 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 05:04:21 INFO - Reading from file tmpfile_stdout 05:04:21 INFO - Output received: 05:04:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:04:21 INFO - Running post-action listener: _resource_record_post_action 05:04:21 INFO - ##### 05:04:21 INFO - ##### Running run-tests step. 05:04:21 INFO - ##### 05:04:21 INFO - Running pre-action listener: _resource_record_pre_action 05:04:21 INFO - Running main action method: run_tests 05:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:04:21 INFO - Python 2.7.3 05:04:21 INFO - Return code: 0 05:04:21 INFO - grabbing minidump binary from tooltool 05:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:21 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 0x2843660>, '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 0x2844560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2844a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:04:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:04:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:04:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:21 INFO - Return code: 0 05:04:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:04:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:04:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:04:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:04:22 INFO - Return code: 0 05:04:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:04:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:04:22 INFO - Using env: {'DISPLAY': ':0', 05:04:22 INFO - 'HOME': '/home/cltbld', 05:04:22 INFO - 'LANG': 'en_US.UTF-8', 05:04:22 INFO - 'LANGUAGE': 'en_US:en', 05:04:22 INFO - 'LOGNAME': 'cltbld', 05:04:22 INFO - 'MAIL': '/var/mail/cltbld', 05:04:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:22 INFO - 'MOZ_NO_REMOTE': '1', 05:04:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:22 INFO - 'NO_EM_RESTART': '1', 05:04:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:04:22 INFO - 'SHELL': '/bin/bash', 05:04:22 INFO - 'SHLVL': '1', 05:04:22 INFO - 'TERM': 'linux', 05:04:22 INFO - 'TMOUT': '86400', 05:04:22 INFO - 'USER': 'cltbld', 05:04:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925', 05:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:22 INFO - '_': '/tools/buildbot/bin/python'} 05:04:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:04:22 INFO - mozversion application_buildid: 20160106023011 05:04:22 INFO - mozversion application_changeset: 444097473d1a78553a360b82a2d123cfad306492 05:04:22 INFO - mozversion application_display_name: Nightly 05:04:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:22 INFO - mozversion application_name: Firefox 05:04:22 INFO - mozversion application_remotingname: firefox 05:04:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:22 INFO - mozversion application_vendor: Mozilla 05:04:22 INFO - mozversion application_version: 46.0a1 05:04:22 INFO - mozversion platform_buildid: 20160106023011 05:04:22 INFO - mozversion platform_changeset: 444097473d1a78553a360b82a2d123cfad306492 05:04:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:22 INFO - mozversion platform_version: 46.0a1 05:04:22 INFO - using testdate: 1452085462 05:04:22 INFO - actual date: 1452085462 05:04:22 INFO - starting webserver on 'localhost:57790' 05:04:22 INFO - SUITE-START | Running 3 tests 05:04:22 INFO - TEST-START | dromaeo_css 05:04:22 INFO - operating with platform_type : linux_ 05:04:22 INFO - Initialising browser for dromaeo_css test... 05:04:22 INFO - TEST-INFO | started process 1868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxz4Mb6/profile http://localhost:57790/getInfo.html) 05:04:26 INFO - PROCESS | 1868 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:04:27 INFO - PROCESS | 1868 | __metrics Screen width/height:1600/1200 05:04:27 INFO - PROCESS | 1868 | colorDepth:24 05:04:27 INFO - PROCESS | 1868 | Browser inner width/height: 1024/697 05:04:27 INFO - PROCESS | 1868 | __metrics 05:04:27 INFO - PROCESS | 1868 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:04:28 INFO - TEST-INFO | 1868: exit 0 05:04:28 INFO - Browser initialized. 05:04:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:28 INFO - TEST-INFO | started process 2000 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxz4Mb6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:39 INFO - PROCESS | 2000 | RSS: Main: 150437888 05:04:39 INFO - PROCESS | 2000 | 05:05:29 INFO - PROCESS | 2000 | 1452085529407 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:07:37 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:57790/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57790/tests/dromaeo/cssquery-ext.html) 05:07:38 INFO - PROCESS | 2000 | RSS: Main: 158511104 05:07:38 INFO - PROCESS | 2000 | 05:10:40 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:57790/tests/dromaeo/cssquery-ext.html (next: http://localhost:57790/tests/dromaeo/cssquery-jquery.html) 05:10:41 INFO - PROCESS | 2000 | RSS: Main: 153157632 05:10:41 INFO - PROCESS | 2000 | 05:13:43 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:57790/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57790/tests/dromaeo/cssquery-mootools.html) 05:13:43 INFO - PROCESS | 2000 | RSS: Main: 153141248 05:13:43 INFO - PROCESS | 2000 | 05:16:45 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:57790/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57790/tests/dromaeo/cssquery-prototype.html) 05:16:45 INFO - PROCESS | 2000 | RSS: Main: 152240128 05:16:45 INFO - PROCESS | 2000 | 05:19:48 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:57790/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57790/tests/dromaeo/cssquery-yui.html) 05:19:48 INFO - PROCESS | 2000 | RSS: Main: 152109056 05:19:48 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:57790/tests/dromaeo/cssquery-yui.html (next: http://localhost:57790/tests/dromaeo/cssquery-dojo.html) 05:22:51 INFO - PROCESS | 2000 | RSS: Main: 155389952 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | __start_tp_report 05:22:51 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 05:22:51 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 05:22:51 INFO - PROCESS | 2000 | |i|pagename|runs| 05:22:51 INFO - PROCESS | 2000 | |0;dojo.html;3168.7940283881544;3238.8542515586796;3268.0032590060023;3275.9508607370894;3299.8185099819502;5083.974580127104;5291.55021823145;5298.364196296445;5308.071087559676;5313.601479889005;5223.138182199942;5224.242484839696;5236.895262094756;5245.973770131153;5249.343832020997;4837.371141751576;4855.150348688983;4861.756912154396;4954.405471343443;4961.826336078238;573.356342210407;4868.756562171895;4886.071646387175;4887.853364399074;4897.265410188483;4825.493323201066;4841.8547443576745;4845.927311090337;4863.53796389346;4906.264060390934;4857.6599638025355;4864.659473836833;4873.634477414208;4882.048000639877;4933.087378834927;4695.976520117378;4916.115099282128;4924.409070911478;4941.827036053721;4946.87632809179;4925.802967881281;4926.655134140611;5020.472850350734;5033.345665063555;5070.3915530136255;5732.455416735404;5750.309962804448;5751.05107657236;5764.913526297109;5771.076627739583;5556.277683901108;5774.88450230993;5780.653160810322;5789.681567513785;5809.564282678773;5199.090159222121;5308.681479111266;5372.865678358073;5391.16436952273;5437.945620543784;5806.767729290781;5820.650760954356;5822.039363505059;5822.970885145632;5831.416858314219;5424.213489044067;5577.637453565505;5584.162375643686;5610.046292130348;5611.298587676541;5600.551955843523;5615.438456154352;5620.241267428844;5633.802816901471;5677;5583.4137415571595;5662.886742265132;5667.546596272288;5673.290838645169;5679;5653.180288858092;5655.575831812631;5674.716264186774;5691.345495268014;5694.772209111589;4308.482982042175;4389.648828093745;4400.185965596375;4434.512203657595;4493.303537951622;3880.9223815523533;3906.882793516142;3909.706771992112;3925.0972276376024;3939.5666476687543;5226.189940559219;5240.528352448298;5245.501677340723;5259.868503287448;5274.393444753826;5511.283533140666;5573.832785016456;5586.13414920688;5628.915566266509;5730.025895597759;5252.1596544552685;5266.868328291824;5270.209468579667;5275.551578115903;5276.709780962007;4770.904581908412;4829.589484893753;4832.613390928787;4835.588974937099;4880.194767863334;5837.795677151279;5856.531477481792;5916.083007133901;5947.078202878561;5978.103284507359;5674.120511320752;5685.033544297479;5685.573581981285;5691.4877661010705;5698.25922630072;5756.913646295393;5913.172155898092;5922.940770592239;5928.170056192051;5948.643081415129;5584.972075139598;5611.551075913835;5643.407442218508;5655.236543066633;5677.205191273142;5728.3412407572;5755.913661295168;5761.135829625589;5764.567657425626;5771.134329850556;5409.5672346213;5547.472990065938;5549.306336707911;5613.382527922007;5617.522510586646;5621.915671264853;5625.549956003591;5630.23991761107;5631.239782629456;5636.070048442125;5499.5325397340075;5511.090670039399;5513.228148059355;5528.143137813645;5560.304961879765;5434.239206511171;5543.972280138573;5548.639338442988;5647.875211882362;5674.716264186856;5312.654677445954;5326.9200961984825;5358.7856485741695;5367.087595108919;5367.355917289794 05:22:51 INFO - PROCESS | 2000 | |1;ext.html;522.3522831688707;526.8656492594388;530.9256704061431;552.8507303028185;556.7244214114013;35577.46633800492;36132.81933590328;36377;36445.63554364456;36483.4527482088;39392.80303598485;39820.402693959615;39918.20163596726;39991.40012899809;40075.39886901691;8379.413441059112;8534.829303413928;8541.95729021354;8558.957205213965;8560.357973152039;8236.62935167916;8377.078521362646;8386.412951093425;8387.454815437008;8392.118827523114;8644.222020018196;8699;8705.129487051308;8721.040685524587;8734.51960142192;8580.141985801401;8602.18279263469;8655.870161947576;8671.13288671134;8684;8465.619047142893;8601;8610.225079742853;8637.568121593895;8668.913310866874;38595.1053670973;38899.416508752394;39098.804505977285;39102.21795564101;39166.21667566633;2996.4905965985836;3010.5333673280675;3049.603551538308;3293.2096296888813;3346.882859099944;28833.855830720713;29180.8540957296;29235.70764292351;29243.268918277;29451.41097178066;3676.5036720042717;3741.7754934704003;3782.167923056923;3786.6970642348547;3798.3352913240074;269679;269939;270130;270516;270753;50602.240966385536;51837.222441663405;57195;57525.71237143871;57666.7116664414;61389.69305153446;63516.36483635197;63521;63569.36430635634;63631;13368.39842207103;13448.1258718183;13550.051496395157;13553.728925421634;13686.04197706171;10319.329243599143;10367.377957322586;10379.84430233547;10409.42748148859;10437.634682786218;18637.627247454973;18732.719009214874;18922.810771892106;18968.241270349306;19510;7300;7347.08161479815;7521.586312752851;7541.698332066766;7567.772966811004;854.3976496569903;908.2234689340651;940.7459985803795;945.9290553208536;957.9664711735056;24600.876995614908;25207.74792252054;25306.240812775646;25369;25847.61228581535;1049.627382279295;1089.1430111659602;1141.868685101224;1195.7967145585271;1206.1074804644675;14029.649258768612;14053.648658783612;14079.507217247346;14196.929015354857;14272.785908211385;340258;342675;343446;343897;344032;51918;52261;52588.47411525912;52602.73698631483;52808;1291.761024210524;1311.3639884655934;1324.7681655710212;1336.8262125923761;1343.6708006538265;25034.37414064663;26112.60831087573;26150.215493535223;26164.34589135287;26487;40606.593934061464;41070;41464.1707165861;41580;41675.16649667051;326626;327621;327718;328261;329638;30020.048696834638;30594;30693;30716;30850;43446.56553434425;43895.78052109719;44404.55595444133;44757.776211120035;45054.77472612616;36514.63485365112;36868.81565592155;37139.81430092832;37365.43951840779;38356.808215959856;36747.44878826766;36780.26439471249;36817.815910920275;36953.26093478169;37085.629143709295;35754;36254.45618315675;36415.63584364228;36471.63528364682;36994.630053700195;28100;28243.15270541887;29717.554236686035;30166.396672065996;30345.544816827325;23627.64558531658;25170.49659006773;25354.492910142064;25773.613395799453;26014.86992565025 05:22:51 INFO - PROCESS | 2000 | |2;jquery.html;356.90363601827505;360.1949642548903;360.96209897960716;365.37703216016695;368.57061523325325;16412.75380869288;17421.825781742195;17523.474295771117;18204.726929096076;18303.17635706395;11360.488778004988;11365.829512557319;11464.48409821558;11538.076953843693;11602.709932251677;4938.975305123469;4941.382327209099;5011.824586139486;5054.393472783271;5063.84808455745;5004.249362595603;5034.723090230036;5038.370203724535;5044.344235249412;5058.342415485981;5020.447750747415;5035.521625445577;6248.875022499547;6561.245456772461;6565.34346565342;6431.903521447182;6440.452561532252;6516.446102081329;6918.965405172992;6921.930780692179;6693.397594216495;6741.359570840762;6752.797416077526;6760.932390676079;6764.289749576273;21889.233876814393;22374.2169024085;22696.77303226963;23890;23909.282721518382;2002.4593359792775;2024.129624261567;2091.2366986049983;2189.748178959408;2225.2322948582714;14196.787048194285;14522.636934076627;14537.709245815131;14548.1998490083;14807.0375425597;1973.3093417303828;2000.9699854502194;2033.2273735980232;2033.4712974626555;2079.0540304161723;63475.365246347406;70718.64640676815;70831;70970;71011.64494177495;15555.922220388826;15590.220488975507;15604.141772202638;15671.843281567266;15798.842011579967;23941.52116957686;24047.158349457684;24165.879170604036;24330.270091896917;24338.63492047621;8437.704680336281;8461.365397595082;8466.280366168945;8500.10748871372;8522.65909363631;6931.722731090801;6993.545419547713;7002.194747603989;7011.474139439562;7012.5792452453015;7857.685692572348;7878.566678832719;7944.761657150295;7957.3634109271115;8029.397795165386;1653.5287443078664;1694.8135705072432;3011.849407529615;3038.6961303869434;3175.4919212926284;805.5529181304432;860.9354298427643;1001.9649312274036;1027.1577306608658;1030.6392762533053;15792.447264345692;15885.364585416453;15886.443974460839;16288.918555407146;17278.308867645406;910.5947853205261;912.2838571721167;961.9422834629945;976.4531862157214;991.5587563534302;9548.37935534188;9654.469004204837;9921.603135874484;9935.80128397428;10027.197824174049;405009;413157;417443;422502;424512;74770.25229747742;78723.60638196772;79394;79573;82622.58688706518;1147.649966760146;1148.6152139033518;1199.1905463812066;1206.849143857018;1219.2136072233536;15689.372425102869;15870.285837137588;15962.920185398998;16001.359945602046;16141.75787363167;34995.65004349924;35093.824530878206;35355.116122097155;35487;36426.635733642324;44834;44981.55018449773;45621;47813.760931195124;50326.49673503218;9208.401453905475;9734.36726612768;9804.26468014916;9858.605655773688;9867.358621689567;11471.139664525028;11523.711907202387;11578.71053223676;11672.708182295171;13359.799603006157;14266.286685665467;14316.284185790877;14379.712405751618;14528.636784080483;14734.452882447189;13882.861171388156;13969;14081.295935203403;14469;14521.636959075686;14269.500567480089;14370.928145359207;14643.19462429534;14652.70694586081;14722.558323249892;9351.438913665203;9423.057694230522;9500.572474238537;9657.372270802376;9934.20526357904;10590.629327973484;11089.667309980714;14520.491782787552;14544.127352358892;14927.776083358542 05:22:51 INFO - PROCESS | 2000 | |3;mootools.html;1440.351841671248;1447.2618964328192;1599.3202888772269;1743.9389621363255;1751.7372394140884;6489.318621544729;6569.8686026279565;7368.815779605513;7395.445341599381;7444.29279218474;6933.895991560118;7082.539634923726;7126.714931402737;7131.786046418616;7145.285471452852;2195.703580016693;2219.8345868419046;2232.174095584636;2237.910483580663;2241.4956634757214;2153.440105572555;2166.7616562178146;2218.8114010309064;2233.419310979149;2248.6289762189217;2232.285668586053;2262.9321120366417;2267.4444761033487;2303.1363238785457;2310.8151347892212;2199.2412617646887;2214.5792299463133;2239.8992045358;2241.383619504633;2241.8654880707127;2229.710137682107;2253.9774602254097;2254.1321591187348;2255.5827171973237;2256.3343813575034;7452.366548843354;7461.515001524937;7495.138059123216;7573.621318934086;7590.6963721451075;4412.117576484684;4449.7330160190495;4461.330800379969;4475.440569928759;4480.462344518679;2988.118505041018;3032.924176895573;3035.9544606830914;3040.6503252126067;3055.419470300658;943.9008904065112;946.2950102173855;966.7583104223944;1021.3208216535994;1066.402814423925;10190.133838623726;10212.846807297896;10223.284370094096;10231.6418925338;10237.283390162616;4115.753054816721;4122.649574786176;4163.604457576525;4169.291220492523;4171.0823618803815;8761.299096072298;8853.15894989975;8854.114588541095;8871.512066836385;8895.199432051146;4419.624331931757;4438.578335058164;4448.377227188196;4459.9331010034875;4485.0805584855025;4001.6198461146146;4042.717009809285;4055.7769322687536;4168.437260969791;4172.4993000840095;3502.3345564342694;3516.226430185406;3518.2611651552947;3522.6653467920505;3561.1453251219523;1070.1224995503767;1076.971492224939;1085.766560189563;1086.1310951238977;1098.8241881298954;968.7287559483356;969.9127078562963;975.2831668723483;1062.8724553053682;1284.319310765296;6886.070380498669;6896.586204827727;6897.3447522486285;6915.688794004282;6926.515143939977;455.6309389394601;1175.3653027365299;1205.4033253539553;1212.8241404996227;1235.4131787400913;5274.604404669665;5311.256424100629;5321.866953326198;5329.094054010828;5352.625316227826;8415.621297041647;8420;8439.071702112762;8494.895663563697;8572.399932004824;8363.581820909052;8432.072472028072;8433.451825631437;8433.662653493791;8446.113158118309;6621.635810030398;6977.058097156921;7021.1574611047;7094.290570942968;7095.254998225215;6831.795046148623;6890.345417185359;6899.482538809509;6900.137482814648;6916.446684265146;7834.294913457816;7925.762227133196;7928.960355198418;8069.636866340911;8095.7166499172245;8034.598270086355;8042.517448953082;8285.254327110348;8408.117147699404;8428.367872409717;6504.414602685781;6571.835704107436;6578.8355291118105;6607.636579988147;6657.73369065232;7023.33278338557;7060.505764596429;7076.858462830817;7139.107611548557;7143.2499587544635;6504.276366762717;6551.377619126175;6575.638339891352;6579.769708060387;6689.565178263398;6461.903071454026;6515.0553169791065;6586.901196481961;6646.435053020354;6676.9332306676315;6727.899081513683;6766.898496522457;6780.627065511444;6796.796096117125;6800.251972282946;6055.061465472859;6064.696765161812;6067.939320606737;6070.878582428415;6106.45041946227;6131.448169664752;6132.632042077311;6155.384461553988;6161.599496032743;6168.0439531872635 05:22:51 INFO - PROCESS | 2000 | |4;prototype.html;338.296343605301;342.4828508951483;349.8128501251831;350.1543771791124;354.8935319404178;6171.660558669271;6195.845103872394;6251.781187658433;6252.531060170489;6323.936760632392;6135.9079613805825;6175.444210021097;6177.660228687431;6180.289266734327;6182.041783523561;4715.221988371914;4717.622590192794;4733;4737.218358970766;4738.194506933813;4716.080364328957;4718.079974404993;4718.57532822046;4720.221163508034;4745.145873742725;4513.097380523892;4547.136044151617;4664.626829853621;4668.883277918046;4672.836450724225;4622.121796858586;4651.1162879053045;4653.255479123358;4657.999999999983;4687.718736875764;4076.755394676299;4078.898027549335;4083.7549747014978;4090.447789548403;4096.09885825118;5796.681182534959;5807.0998995155815;5821.67980761058;5882.705864706748;5887.528997680175;5340.759665815048;5469.179623056533;5491.643043202179;5498.752556134984;5504;6542.93457065428;6548.6725663716625;6548.70530826114;6549.803505894831;6552.115464412339;4482.260427029536;4527.162474942146;4534.433195850519;4541.114482675879;4542.091581683643;6734.292899245606;6781.11845460087;6848.6918088686125;6864.691088901011;6867.931320686829;4536.88657783558;4550.590446859798;4567.223571992769;4583.816647334069;4588.518205588365;4617.607503362185;4625.676202665781;4627.375304333872;4636.211843986531;4638.095571363552;5356.491133342404;5379.300690910157;5393.973030134903;5394.865128371744;5399.433059528693;6427.017424801874;6593;6594.340565943367;6595.175603049619;6603.900941485882;1638.0908595729484;1658.2620733773356;1658.5439004273921;1662.4680102367126;1668.0908904646997;1078.487718333785;1078.8813230544633;1081.1566977757204;1097.780443911221;1098.1763677242068;6286.05709143623;6295.779647712399;6302.1177035215105;6303.747850086037;6312.116303717483;6712.865742685119;6750.1562304711915;6769.458443324621;6793.72825086991;6825;6176.81469555914;6311.715972781236;6317.305096439388;6350.460210882126;6359.077933699587;3682.760620559655;3694.242680250542;3711.109333759878;3711.202091550276;3712.276106159327;7172.103487064117;7173.856522869513;7183.964080179566;7187.31720486553;7194.316539928698;6892.517523773388;6968.512204145661;7020.262872398427;7024.5434046786795;7052.682629281695;7113.92886071143;7152.964235178895;7161.319674630901;7177.210506844243;7186.173590037108;6757.628330441873;6770.898436523357;6795.796126116026;6806.727730890709;6850.109485766819;6561.770338038145;6681.465482761465;6764.2559318475915;6794.42247408956;6805.659717014229;7161.427085833225;7170.462215333767;7180.676869540987;7184.676689549087;7202;4567.954320456753;4586.747728874944;4591.403117594691;4595.264757638762;4598.678092533491;6665.40011398957;6822.181338239443;6828;6843.589384636938;6845.828854278683;6634.203895532567;6638.103855979574;6642.634655094016;6647.700853461509;6651.767188148391;6594.868102638016;6609.20689517261;6627.237867645283;6630.60216386999;6642.269350371359;6333.303336633059;6498.577592456475;6501.2198536175965;6501.544891857714;6514.57655252407;6642.202935647753;6654.13496245485;6661.733530658719;6669.633170175687;6675.299093595103;6368.490520758235;6411.743530258737;6450.451711604566;6477.643729594917;6489.415952564292 05:22:51 INFO - PROCESS | 2000 | |5;yui.html;828.6027288118714;829.5064436660189;839.404023143568;849.3672214200419;850.2517784349772;12773.872261277384;12997.415116319764;13018.609441716751;13060.542880999143;13103.410346534405;12188.817167742469;12280.078994075458;12541.561045363414;12633.747325053517;12640.115191936546;827.2843989948681;838.9035260945009;842.4776638484149;842.7766641839918;843.1779015459908;826.5371392020458;831.5343407691712;836.2181360428019;837.844998675247;838.2748922182329;869.3349587565517;870.24723614074;874.7419511244199;875.3172525430175;878.4773060029272;867.0765634599131;868.2923417414787;871.8561437362828;874.5321253129545;875.2560323724847;633.7908490198223;635.0759644716971;636.0300541673938;637.7353398339684;640.5068097564849;11154;11181.83227251592;11234.3259404436;11254.818244084336;11292.604758833402;10028;10099.747506312327;10246.590136394536;10361;10474.47627618616;8248.958755206246;8286.792830179233;8961.507117108556;9119.635214591408;9226.53867306632;3531.876384326536;3583.3191693578137;3593.317269718745;3596.3886139356373;3597.2625611749527;42240;42287.57712422867;45285.547144528464;45323.54676453259;51620.48379516232;8011.719589814328;8923.286137109015;9273.814523709489;9318.86021709675;9491.620335186515;17598.38405655796;17611.471655850088;17675;17680.646387072185;17700.380486683163;6749.358810912955;7113.253108423541;7253.238409966983;7388.113426388868;7424.888626670604;4126.711130220916;4137.482814648169;4170.020045289354;4178.561251068594;4183.811728472226;3078.98460507696;3095.9226019349244;3195.6804319568323;3268.444364458;3269.9509507357407;577.8295402856168;578.320473443702;586.1881294407276;587.1427715535281;589.4017572164257;489.7012822178468;521.9743204602973;633.7274971762095;669.7019826177304;670.0418401685539;7914.564698941498;8158.632861521246;8253.463524870864;8537.957310213533;8631.270342120251;491.8275640709087;596.7195418153461;667.889798183304;676.9695363708645;681.189384632286;3785.8674946376746;3788.753731007476;3835.4246862970776;3845.057960799622;3939.212157568498;56256.437435625936;56535.71732141313;56680.71659641758;56842.715786420806;56987.430125699044;45297.09405811865;48678.51321486811;51530.74234628878;52203.47796521986;52319.476805232225;43858.780706096906;45137.09725805466;46204.5379546207;46238;47187.528124718316;7332.523385980107;7622.123455802432;7631.1987241341085;7656.272654097852;7696.961515192612;35451.82274088613;35566.64433355633;35824.46263306105;35971.100722482144;36235.818820905726;39973.40039899346;44741.77629111834;45745.54254457546;46480.53519464762;46684;10268.794624107326;10770.246082774443;10960.780784384428;11000;11380.54477820878;12051.33717645538;12154.149209555246;12182.208156469802;12230.205036672587;12511.311877846805;9494.765680461496;9603.711888643353;9655.468949207861;9915.157211637092;10056;10277.280590358603;10315.17478601695;10405.21960852924;10424.895751042695;10907.181961352771;9905.950470247892;9942.701718948443;10197.337173084023;10351.896481035094;10363.222758293008;9357.53212339394;9742.853857192289;9890;10219.897801021894;10345.482725863527;8331.708390206313;8376.539290338846;8390.874136888073;8443.83112337762;8507.95746021266 05:22:51 INFO - PROCESS | 2000 | __end_tp_report 05:22:51 INFO - PROCESS | 2000 | __start_cc_report 05:22:51 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,309 05:22:51 INFO - PROCESS | 2000 | __end_cc_report 05:22:51 INFO - PROCESS | 2000 | __startTimestamp1452086571391__endTimestamp 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | ------- Summary: start ------- 05:22:51 INFO - PROCESS | 2000 | Number of tests: 6 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5249.19 Median:5499.53 stddev:682.04 (12.4%) stddev-sans-first:664.32 05:22:51 INFO - PROCESS | 2000 | Values: 3168.8 3238.9 3268.0 3276.0 3299.8 5084.0 5291.6 5298.4 5308.1 5313.6 5223.1 5224.2 5236.9 5246.0 5249.3 4837.4 4855.2 4861.8 4954.4 4961.8 573.4 4868.8 4886.1 4887.9 4897.3 4825.5 4841.9 4845.9 4863.5 4906.3 4857.7 4864.7 4873.6 4882.0 4933.1 4696.0 4916.1 4924.4 4941.8 4946.9 4925.8 4926.7 5020.5 5033.3 5070.4 5732.5 5750.3 5751.1 5764.9 5771.1 5556.3 5774.9 5780.7 5789.7 5809.6 5199.1 5308.7 5372.9 5391.2 5437.9 5806.8 5820.7 5822.0 5823.0 5831.4 5424.2 5577.6 5584.2 5610.0 5611.3 5600.6 5615.4 5620.2 5633.8 5677.0 5583.4 5662.9 5667.5 5673.3 5679.0 5653.2 5655.6 5674.7 5691.3 5694.8 4308.5 4389.6 4400.2 4434.5 4493.3 3880.9 3906.9 3909.7 3925.1 3939.6 5226.2 5240.5 5245.5 5259.9 5274.4 5511.3 5573.8 5586.1 5628.9 5730.0 5252.2 5266.9 5270.2 5275.6 5276.7 4770.9 4829.6 4832.6 4835.6 4880.2 5837.8 5856.5 5916.1 5947.1 5978.1 5674.1 5685.0 5685.6 5691.5 5698.3 5756.9 5913.2 5922.9 5928.2 5948.6 5585.0 5611.6 5643.4 5655.2 5677.2 5728.3 5755.9 5761.1 5764.6 5771.1 5409.6 5547.5 5549.3 5613.4 5617.5 5621.9 5625.5 5630.2 5631.2 5636.1 5499.5 5511.1 5513.2 5528.1 5560.3 5434.2 5544.0 5548.6 5647.9 5674.7 5312.7 5326.9 5358.8 5367.1 5367.4 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:47396.07 Median:20211.98 stddev:82739.72 (409.4%) stddev-sans-first:82896.98 05:22:51 INFO - PROCESS | 2000 | Values: 522.4 526.9 530.9 552.9 556.7 35577.5 36132.8 36377.0 36445.6 36483.5 39392.8 39820.4 39918.2 39991.4 40075.4 8379.4 8534.8 8542.0 8559.0 8560.4 8236.6 8377.1 8386.4 8387.5 8392.1 8644.2 8699.0 8705.1 8721.0 8734.5 8580.1 8602.2 8655.9 8671.1 8684.0 8465.6 8601.0 8610.2 8637.6 8668.9 38595.1 38899.4 39098.8 39102.2 39166.2 2996.5 3010.5 3049.6 3293.2 3346.9 28833.9 29180.9 29235.7 29243.3 29451.4 3676.5 3741.8 3782.2 3786.7 3798.3 269679.0 269939.0 270130.0 270516.0 270753.0 50602.2 51837.2 57195.0 57525.7 57666.7 61389.7 63516.4 63521.0 63569.4 63631.0 13368.4 13448.1 13550.1 13553.7 13686.0 10319.3 10367.4 10379.8 10409.4 10437.6 18637.6 18732.7 18922.8 18968.2 19510.0 7300.0 7347.1 7521.6 7541.7 7567.8 854.4 908.2 940.7 945.9 958.0 24600.9 25207.7 25306.2 25369.0 25847.6 1049.6 1089.1 1141.9 1195.8 1206.1 14029.6 14053.6 14079.5 14196.9 14272.8 340258.0 342675.0 343446.0 343897.0 344032.0 51918.0 52261.0 52588.5 52602.7 52808.0 1291.8 1311.4 1324.8 1336.8 1343.7 25034.4 26112.6 26150.2 26164.3 26487.0 40606.6 41070.0 41464.2 41580.0 41675.2 326626.0 327621.0 327718.0 328261.0 329638.0 30020.0 30594.0 30693.0 30716.0 30850.0 43446.6 43895.8 44404.6 44757.8 45054.8 36514.6 36868.8 37139.8 37365.4 38356.8 36747.4 36780.3 36817.8 36953.3 37085.6 35754.0 36254.5 36415.6 36471.6 36994.6 28100.0 28243.2 29717.6 30166.4 30345.5 23627.6 25170.5 25354.5 25773.6 26014.9 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:26269.91 Median:35224.47 stddev:68369.51 (194.1%) stddev-sans-first:68533.62 05:22:51 INFO - PROCESS | 2000 | Values: 356.9 360.2 361.0 365.4 368.6 16412.8 17421.8 17523.5 18204.7 18303.2 11360.5 11365.8 11464.5 11538.1 11602.7 4939.0 4941.4 5011.8 5054.4 5063.8 5004.2 5034.7 5038.4 5044.3 5058.3 5020.4 5035.5 6248.9 6561.2 6565.3 6431.9 6440.5 6516.4 6919.0 6921.9 6693.4 6741.4 6752.8 6760.9 6764.3 21889.2 22374.2 22696.8 23890.0 23909.3 2002.5 2024.1 2091.2 2189.7 2225.2 14196.8 14522.6 14537.7 14548.2 14807.0 1973.3 2001.0 2033.2 2033.5 2079.1 63475.4 70718.6 70831.0 70970.0 71011.6 15555.9 15590.2 15604.1 15671.8 15798.8 23941.5 24047.2 24165.9 24330.3 24338.6 8437.7 8461.4 8466.3 8500.1 8522.7 6931.7 6993.5 7002.2 7011.5 7012.6 7857.7 7878.6 7944.8 7957.4 8029.4 1653.5 1694.8 3011.8 3038.7 3175.5 805.6 860.9 1002.0 1027.2 1030.6 15792.4 15885.4 15886.4 16288.9 17278.3 910.6 912.3 961.9 976.5 991.6 9548.4 9654.5 9921.6 9935.8 10027.2 405009.0 413157.0 417443.0 422502.0 424512.0 74770.3 78723.6 79394.0 79573.0 82622.6 1147.6 1148.6 1199.2 1206.8 1219.2 15689.4 15870.3 15962.9 16001.4 16141.8 34995.7 35093.8 35355.1 35487.0 36426.6 44834.0 44981.6 45621.0 47813.8 50326.5 9208.4 9734.4 9804.3 9858.6 9867.4 11471.1 11523.7 11578.7 11672.7 13359.8 14266.3 14316.3 14379.7 14528.6 14734.5 13882.9 13969.0 14081.3 14469.0 14521.6 14269.5 14370.9 14643.2 14652.7 14722.6 9351.4 9423.1 9500.6 9657.4 9934.2 10590.6 11089.7 14520.5 14544.1 14927.8 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5177.13 Median:6144.01 stddev:2634.33 (42.9%) stddev-sans-first:2626.74 05:22:51 INFO - PROCESS | 2000 | Values: 1440.4 1447.3 1599.3 1743.9 1751.7 6489.3 6569.9 7368.8 7395.4 7444.3 6933.9 7082.5 7126.7 7131.8 7145.3 2195.7 2219.8 2232.2 2237.9 2241.5 2153.4 2166.8 2218.8 2233.4 2248.6 2232.3 2262.9 2267.4 2303.1 2310.8 2199.2 2214.6 2239.9 2241.4 2241.9 2229.7 2254.0 2254.1 2255.6 2256.3 7452.4 7461.5 7495.1 7573.6 7590.7 4412.1 4449.7 4461.3 4475.4 4480.5 2988.1 3032.9 3036.0 3040.7 3055.4 943.9 946.3 966.8 1021.3 1066.4 10190.1 10212.8 10223.3 10231.6 10237.3 4115.8 4122.6 4163.6 4169.3 4171.1 8761.3 8853.2 8854.1 8871.5 8895.2 4419.6 4438.6 4448.4 4459.9 4485.1 4001.6 4042.7 4055.8 4168.4 4172.5 3502.3 3516.2 3518.3 3522.7 3561.1 1070.1 1077.0 1085.8 1086.1 1098.8 968.7 969.9 975.3 1062.9 1284.3 6886.1 6896.6 6897.3 6915.7 6926.5 455.6 1175.4 1205.4 1212.8 1235.4 5274.6 5311.3 5321.9 5329.1 5352.6 8415.6 8420.0 8439.1 8494.9 8572.4 8363.6 8432.1 8433.5 8433.7 8446.1 6621.6 6977.1 7021.2 7094.3 7095.3 6831.8 6890.3 6899.5 6900.1 6916.4 7834.3 7925.8 7929.0 8069.6 8095.7 8034.6 8042.5 8285.3 8408.1 8428.4 6504.4 6571.8 6578.8 6607.6 6657.7 7023.3 7060.5 7076.9 7139.1 7143.2 6504.3 6551.4 6575.6 6579.8 6689.6 6461.9 6515.1 6586.9 6646.4 6676.9 6727.9 6766.9 6780.6 6796.8 6800.3 6055.1 6064.7 6067.9 6070.9 6106.5 6131.4 6132.6 6155.4 6161.6 6168.0 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:5499.13 Median:6290.92 stddev:1683.09 (26.8%) stddev-sans-first:1642.63 05:22:51 INFO - PROCESS | 2000 | Values: 338.3 342.5 349.8 350.2 354.9 6171.7 6195.8 6251.8 6252.5 6323.9 6135.9 6175.4 6177.7 6180.3 6182.0 4715.2 4717.6 4733.0 4737.2 4738.2 4716.1 4718.1 4718.6 4720.2 4745.1 4513.1 4547.1 4664.6 4668.9 4672.8 4622.1 4651.1 4653.3 4658.0 4687.7 4076.8 4078.9 4083.8 4090.4 4096.1 5796.7 5807.1 5821.7 5882.7 5887.5 5340.8 5469.2 5491.6 5498.8 5504.0 6542.9 6548.7 6548.7 6549.8 6552.1 4482.3 4527.2 4534.4 4541.1 4542.1 6734.3 6781.1 6848.7 6864.7 6867.9 4536.9 4550.6 4567.2 4583.8 4588.5 4617.6 4625.7 4627.4 4636.2 4638.1 5356.5 5379.3 5394.0 5394.9 5399.4 6427.0 6593.0 6594.3 6595.2 6603.9 1638.1 1658.3 1658.5 1662.5 1668.1 1078.5 1078.9 1081.2 1097.8 1098.2 6286.1 6295.8 6302.1 6303.7 6312.1 6712.9 6750.2 6769.5 6793.7 6825.0 6176.8 6311.7 6317.3 6350.5 6359.1 3682.8 3694.2 3711.1 3711.2 3712.3 7172.1 7173.9 7184.0 7187.3 7194.3 6892.5 6968.5 7020.3 7024.5 7052.7 7113.9 7153.0 7161.3 7177.2 7186.2 6757.6 6770.9 6795.8 6806.7 6850.1 6561.8 6681.5 6764.3 6794.4 6805.7 7161.4 7170.5 7180.7 7184.7 7202.0 4568.0 4586.7 4591.4 4595.3 4598.7 6665.4 6822.2 6828.0 6843.6 6845.8 6634.2 6638.1 6642.6 6647.7 6651.8 6594.9 6609.2 6627.2 6630.6 6642.3 6333.3 6498.6 6501.2 6501.5 6514.6 6642.2 6654.1 6661.7 6669.6 6675.3 6368.5 6411.7 6450.5 6477.6 6489.4 05:22:51 INFO - PROCESS | 2000 | 05:22:51 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:13248.18 Median:26071.23 stddev:15729.22 (60.3%) stddev-sans-first:15745.69 05:22:51 INFO - PROCESS | 2000 | Values: 828.6 829.5 839.4 849.4 850.3 12773.9 12997.4 13018.6 13060.5 13103.4 12188.8 12280.1 12541.6 12633.7 12640.1 827.3 838.9 842.5 842.8 843.2 826.5 831.5 836.2 837.8 838.3 869.3 870.2 874.7 875.3 878.5 867.1 868.3 871.9 874.5 875.3 633.8 635.1 636.0 637.7 640.5 11154.0 11181.8 11234.3 11254.8 11292.6 10028.0 10099.7 10246.6 10361.0 10474.5 8249.0 8286.8 8961.5 9119.6 9226.5 3531.9 3583.3 3593.3 3596.4 3597.3 42240.0 42287.6 45285.5 45323.5 51620.5 8011.7 8923.3 9273.8 9318.9 9491.6 17598.4 17611.5 17675.0 17680.6 17700.4 6749.4 7113.3 7253.2 7388.1 7424.9 4126.7 4137.5 4170.0 4178.6 4183.8 3079.0 3095.9 3195.7 3268.4 3270.0 577.8 578.3 586.2 587.1 589.4 489.7 522.0 633.7 669.7 670.0 7914.6 8158.6 8253.5 8538.0 8631.3 491.8 596.7 667.9 677.0 681.2 3785.9 3788.8 3835.4 3845.1 3939.2 56256.4 56535.7 56680.7 56842.7 56987.4 45297.1 48678.5 51530.7 52203.5 52319.5 43858.8 45137.1 46204.5 46238.0 47187.5 7332.5 7622.1 7631.2 7656.3 7697.0 35451.8 35566.6 35824.5 35971.1 36235.8 39973.4 44741.8 45745.5 46480.5 46684.0 10268.8 10770.2 10960.8 11000.0 11380.5 12051.3 12154.1 12182.2 12230.2 12511.3 9494.8 9603.7 9655.5 9915.2 10056.0 10277.3 10315.2 10405.2 10424.9 10907.2 9906.0 9942.7 10197.3 10351.9 10363.2 9357.5 9742.9 9890.0 10219.9 10345.5 8331.7 8376.5 8390.9 8443.8 8508.0 05:22:51 INFO - PROCESS | 2000 | -------- Summary: end -------- 05:22:51 INFO - PROCESS | 2000 | 05:22:52 INFO - TEST-INFO | 2000: exit 0 05:22:52 INFO - TEST-OK | dromaeo_css | took 1109460ms 05:22:52 INFO - TEST-START | kraken 05:22:52 INFO - operating with platform_type : linux_ 05:22:52 INFO - Initialising browser for kraken test... 05:22:52 INFO - TEST-INFO | started process 2246 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQzvDom/profile http://localhost:57790/getInfo.html) 05:22:55 INFO - PROCESS | 2246 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:22:56 INFO - PROCESS | 2246 | __metrics Screen width/height:1600/1200 05:22:56 INFO - PROCESS | 2246 | colorDepth:24 05:22:56 INFO - PROCESS | 2246 | Browser inner width/height: 1024/697 05:22:56 INFO - PROCESS | 2246 | __metrics 05:22:56 INFO - PROCESS | 2246 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:22:57 INFO - TEST-INFO | 2246: exit 0 05:22:57 INFO - Browser initialized. 05:22:57 INFO - Running cycle 1/1 for kraken test... 05:22:57 INFO - TEST-INFO | started process 2442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQzvDom/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:09 INFO - PROCESS | 2442 | RSS: Main: 150151168 05:23:09 INFO - PROCESS | 2442 | 05:23:11 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57790/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:12 INFO - PROCESS | 2442 | RSS: Main: 150441984 05:23:12 INFO - PROCESS | 2442 | 05:23:14 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57790/tests/kraken/driver.html?testName=audio-dft) 05:23:15 INFO - PROCESS | 2442 | RSS: Main: 151527424 05:23:15 INFO - PROCESS | 2442 | 05:23:18 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57790/tests/kraken/driver.html?testName=audio-fft) 05:23:18 INFO - PROCESS | 2442 | RSS: Main: 145788928 05:23:18 INFO - PROCESS | 2442 | 05:23:20 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57790/tests/kraken/driver.html?testName=audio-oscillator) 05:23:21 INFO - PROCESS | 2442 | RSS: Main: 145604608 05:23:21 INFO - PROCESS | 2442 | 05:23:23 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57790/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:24 INFO - PROCESS | 2442 | RSS: Main: 146345984 05:23:24 INFO - PROCESS | 2442 | 05:23:27 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57790/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:27 INFO - PROCESS | 2442 | RSS: Main: 146137088 05:23:27 INFO - PROCESS | 2442 | 05:23:31 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57790/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:31 INFO - PROCESS | 2442 | RSS: Main: 146771968 05:23:31 INFO - PROCESS | 2442 | 05:23:34 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57790/tests/kraken/driver.html?testName=json-parse-financial) 05:23:35 INFO - PROCESS | 2442 | RSS: Main: 148094976 05:23:35 INFO - PROCESS | 2442 | 05:23:36 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57790/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:37 INFO - PROCESS | 2442 | RSS: Main: 148226048 05:23:37 INFO - PROCESS | 2442 | 05:23:39 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:39 INFO - PROCESS | 2442 | RSS: Main: 148938752 05:23:39 INFO - PROCESS | 2442 | 05:23:41 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:42 INFO - PROCESS | 2442 | RSS: Main: 148234240 05:23:42 INFO - PROCESS | 2442 | 05:23:44 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:45 INFO - PROCESS | 2442 | RSS: Main: 148537344 05:23:45 INFO - PROCESS | 2442 | 05:23:48 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:48 INFO - PROCESS | 2442 | RSS: Main: 148926464 05:23:48 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | Cycle 1(1): loaded http://localhost:57790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57790/tests/kraken/driver.html?testName=ai-astar) 05:23:50 INFO - PROCESS | 2442 | RSS: Main: 148107264 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | __start_tp_report 05:23:50 INFO - PROCESS | 2442 | _x_x_mozilla_page_load 05:23:50 INFO - PROCESS | 2442 | _x_x_mozilla_page_load_details 05:23:50 INFO - PROCESS | 2442 | |i|pagename|runs| 05:23:50 INFO - PROCESS | 2442 | |0;ai-astar;111;108;111;112;110;122;112;111;113;111 05:23:50 INFO - PROCESS | 2442 | |1;audio-beat-detection;152;132;154;162;125;153;149;132;171;128 05:23:50 INFO - PROCESS | 2442 | |2;audio-dft;166;162;163;161;162;163;162;170;167;163 05:23:50 INFO - PROCESS | 2442 | |3;audio-fft;73;73;76;76;72;73;132;76;72;74 05:23:50 INFO - PROCESS | 2442 | |4;audio-oscillator;96;97;139;97;97;98;139;96;97;137 05:23:50 INFO - PROCESS | 2442 | |5;imaging-gaussian-blur;110;109;109;110;109;111;110;110;110;111 05:23:50 INFO - PROCESS | 2442 | |6;imaging-darkroom;148;148;147;147;145;148;146;148;146;147 05:23:50 INFO - PROCESS | 2442 | |7;imaging-desaturate;96;97;97;97;97;97;96;96;97;97 05:23:50 INFO - PROCESS | 2442 | |8;json-parse-financial;60;64;60;59;63;61;65;59;60;59 05:23:50 INFO - PROCESS | 2442 | |9;json-stringify-tinderbox;68;67;68;67;67;68;69;68;68;68 05:23:50 INFO - PROCESS | 2442 | |10;stanford-crypto-aes;87;87;86;87;88;86;90;87;87;95 05:23:50 INFO - PROCESS | 2442 | |11;stanford-crypto-ccm;117;126;120;133;120;128;121;129;123;125 05:23:50 INFO - PROCESS | 2442 | |12;stanford-crypto-pbkdf2;147;155;151;150;155;138;155;150;154;141 05:23:50 INFO - PROCESS | 2442 | |13;stanford-crypto-sha256-iterative;69;71;71;74;77;69;67;71;68;69 05:23:50 INFO - PROCESS | 2442 | __end_tp_report 05:23:50 INFO - PROCESS | 2442 | __start_cc_report 05:23:50 INFO - PROCESS | 2442 | _x_x_mozilla_cycle_collect,736 05:23:50 INFO - PROCESS | 2442 | __end_cc_report 05:23:50 INFO - PROCESS | 2442 | __startTimestamp1452086630707__endTimestamp 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | ------- Summary: start ------- 05:23:50 INFO - PROCESS | 2442 | Number of tests: 14 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.73 (3.3%) stddev-sans-first:3.93 05:23:50 INFO - PROCESS | 2442 | Values: 111.0 108.0 111.0 112.0 110.0 122.0 112.0 111.0 113.0 111.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:152.50 stddev:15.62 (10.2%) stddev-sans-first:16.40 05:23:50 INFO - PROCESS | 2442 | Values: 152.0 132.0 154.0 162.0 125.0 153.0 149.0 132.0 171.0 128.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.85 (1.7%) stddev-sans-first:2.92 05:23:50 INFO - PROCESS | 2442 | Values: 166.0 162.0 163.0 161.0 162.0 163.0 162.0 170.0 167.0 163.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#3] audio-fft Cycles:10 Average:79.70 Median:73.50 stddev:18.45 (25.1%) stddev-sans-first:19.40 05:23:50 INFO - PROCESS | 2442 | Values: 73.0 73.0 76.0 76.0 72.0 73.0 132.0 76.0 72.0 74.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:97.00 stddev:20.05 (20.7%) stddev-sans-first:20.68 05:23:50 INFO - PROCESS | 2442 | Values: 96.0 97.0 139.0 97.0 97.0 98.0 139.0 96.0 97.0 137.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 05:23:50 INFO - PROCESS | 2442 | Values: 110.0 109.0 109.0 110.0 109.0 111.0 110.0 110.0 110.0 111.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 05:23:50 INFO - PROCESS | 2442 | Values: 148.0 148.0 147.0 147.0 145.0 148.0 146.0 148.0 146.0 147.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:23:50 INFO - PROCESS | 2442 | Values: 96.0 97.0 97.0 97.0 97.0 97.0 96.0 96.0 97.0 97.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:60.50 stddev:2.21 (3.7%) stddev-sans-first:2.32 05:23:50 INFO - PROCESS | 2442 | Values: 60.0 64.0 60.0 59.0 63.0 61.0 65.0 59.0 60.0 59.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 05:23:50 INFO - PROCESS | 2442 | Values: 68.0 67.0 68.0 67.0 67.0 68.0 69.0 68.0 68.0 68.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.00 stddev:2.71 (3.1%) stddev-sans-first:2.85 05:23:50 INFO - PROCESS | 2442 | Values: 87.0 87.0 86.0 87.0 88.0 86.0 90.0 87.0 87.0 95.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.50 stddev:4.92 (3.9%) stddev-sans-first:4.47 05:23:50 INFO - PROCESS | 2442 | Values: 117.0 126.0 120.0 133.0 120.0 128.0 121.0 129.0 123.0 125.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.50 stddev:6.00 (3.9%) stddev-sans-first:6.29 05:23:50 INFO - PROCESS | 2442 | Values: 147.0 155.0 151.0 150.0 155.0 138.0 155.0 150.0 154.0 141.0 05:23:50 INFO - PROCESS | 2442 | 05:23:50 INFO - PROCESS | 2442 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:2.99 (4.2%) stddev-sans-first:3.11 05:23:50 INFO - PROCESS | 2442 | Values: 69.0 71.0 71.0 74.0 77.0 69.0 67.0 71.0 68.0 69.0 05:23:50 INFO - PROCESS | 2442 | -------- Summary: end -------- 05:23:50 INFO - PROCESS | 2442 | 05:23:51 INFO - TEST-INFO | 2442: exit 0 05:23:51 INFO - TEST-OK | kraken | took 59479ms 05:23:51 INFO - TEST-START | v8_7 05:23:51 INFO - operating with platform_type : linux_ 05:23:51 INFO - Initialising browser for v8_7 test... 05:23:51 INFO - TEST-INFO | started process 2831 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdo32Y7/profile http://localhost:57790/getInfo.html) 05:23:55 INFO - PROCESS | 2831 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 05:23:55 INFO - PROCESS | 2831 | __metrics Screen width/height:1600/1200 05:23:55 INFO - PROCESS | 2831 | colorDepth:24 05:23:55 INFO - PROCESS | 2831 | Browser inner width/height: 1024/697 05:23:55 INFO - PROCESS | 2831 | __metrics 05:23:56 INFO - PROCESS | 2831 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:23:56 INFO - TEST-INFO | 2831: exit 0 05:23:56 INFO - Browser initialized. 05:23:56 INFO - Running cycle 1/1 for v8_7 test... 05:23:56 INFO - TEST-INFO | started process 2976 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdo32Y7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:08 INFO - PROCESS | 2976 | RSS: Main: 150028288 05:24:08 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | Cycle 1(1): loaded http://localhost:57790/tests/v8_7/run.html (next: http://localhost:57790/tests/v8_7/run.html) 05:24:30 INFO - PROCESS | 2976 | RSS: Main: 146804736 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | __start_tp_report 05:24:30 INFO - PROCESS | 2976 | _x_x_mozilla_page_load 05:24:30 INFO - PROCESS | 2976 | _x_x_mozilla_page_load_details 05:24:30 INFO - PROCESS | 2976 | |i|pagename|runs| 05:24:30 INFO - PROCESS | 2976 | |0;Richards;169.86580601324954 05:24:30 INFO - PROCESS | 2976 | |1;DeltaBlue;201.6942315449778 05:24:30 INFO - PROCESS | 2976 | |2;Encrypt;283.4467120181406 05:24:30 INFO - PROCESS | 2976 | |3;Decrypt;5284.210526315789 05:24:30 INFO - PROCESS | 2976 | |4;RayTrace;1081.081081081081 05:24:30 INFO - PROCESS | 2976 | |5;Earley;711.2375533428165 05:24:30 INFO - PROCESS | 2976 | |6;Boyer;12407.407407407407 05:24:30 INFO - PROCESS | 2976 | |7;RegExp;25275 05:24:30 INFO - PROCESS | 2976 | |8;Splay;687.8850102669404 05:24:30 INFO - PROCESS | 2976 | |9;NavierStokes;4850.241545893719 05:24:30 INFO - PROCESS | 2976 | __end_tp_report 05:24:30 INFO - PROCESS | 2976 | __startTimestamp1452086670354__endTimestamp 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | ------- Summary: start ------- 05:24:30 INFO - PROCESS | 2976 | Number of tests: 10 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#0] Richards Cycles:1 Average:169.87 Median:169.87 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 169.9 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#1] DeltaBlue Cycles:1 Average:201.69 Median:201.69 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 201.7 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#2] Encrypt Cycles:1 Average:283.45 Median:283.45 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 283.4 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 5284.2 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 1081.1 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#5] Earley Cycles:1 Average:711.24 Median:711.24 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 711.2 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 12407.4 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#7] RegExp Cycles:1 Average:25275.00 Median:25275.00 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 25275.0 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#8] Splay Cycles:1 Average:687.89 Median:687.89 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 687.9 05:24:30 INFO - PROCESS | 2976 | 05:24:30 INFO - PROCESS | 2976 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 05:24:30 INFO - PROCESS | 2976 | Values: 4850.2 05:24:30 INFO - PROCESS | 2976 | -------- Summary: end -------- 05:24:30 INFO - PROCESS | 2976 | 05:24:31 INFO - TEST-INFO | 2976: exit 0 05:24:31 INFO - TEST-OK | v8_7 | took 39684ms 05:24:31 INFO - SUITE-END | took 1208s 05:24:31 INFO - Completed test suite (00:20:08) 05:24:31 INFO - Working with test: dromaeo_css 05:24:31 INFO - Generating results file: dromaeo_css 05:24:31 INFO - Working with test: kraken 05:24:31 INFO - Generating results file: kraken 05:24:31 INFO - javascript benchmark 05:24:31 INFO - Working with test: v8_7 05:24:31 INFO - Generating results file: v8_7 05:24:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:24:31 INFO - process_Request line: dromaeo_css 6958.92 graph.html#tests=[[72,64,43]] 05:24:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:31 INFO - process_Request line: kraken 1525.60 graph.html#tests=[[232,64,43]] 05:24:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:31 INFO - process_Request line: v8_7 20792.95 graph.html#tests=[[230,64,43]] 05:24:31 INFO - RETURN: dromaeo_css: 6958.92 05:24:31 INFO - RETURN: kraken: 1525.60 05:24:31 INFO - RETURN: v8_7: 20792.95 05:24:31 INFO - javascript benchmark 05:24:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3168.7940283881544, 3238.8542515586796, 3268.0032590060023, 3275.9508607370894, 3299.8185099819502, 5083.974580127104, 5291.55021823145, 5298.364196296445, 5308.071087559676, 5313.601479889005, 5223.138182199942, 5224.242484839696, 5236.895262094756, 5245.973770131153, 5249.343832020997, 4837.371141751576, 4855.150348688983, 4861.756912154396, 4954.405471343443, 4961.826336078238, 573.356342210407, 4868.756562171895, 4886.071646387175, 4887.853364399074, 4897.265410188483, 4825.493323201066, 4841.8547443576745, 4845.927311090337, 4863.53796389346, 4906.264060390934, 4857.6599638025355, 4864.659473836833, 4873.634477414208, 4882.048000639877, 4933.087378834927, 4695.976520117378, 4916.115099282128, 4924.409070911478, 4941.827036053721, 4946.87632809179, 4925.802967881281, 4926.655134140611, 5020.472850350734, 5033.345665063555, 5070.3915530136255, 5732.455416735404, 5750.309962804448, 5751.05107657236, 5764.913526297109, 5771.076627739583, 5556.277683901108, 5774.88450230993, 5780.653160810322, 5789.681567513785, 5809.564282678773, 5199.090159222121, 5308.681479111266, 5372.865678358073, 5391.16436952273, 5437.945620543784, 5806.767729290781, 5820.650760954356, 5822.039363505059, 5822.970885145632, 5831.416858314219, 5424.213489044067, 5577.637453565505, 5584.162375643686, 5610.046292130348, 5611.298587676541, 5600.551955843523, 5615.438456154352, 5620.241267428844, 5633.802816901471, 5677.0, 5583.4137415571595, 5662.886742265132, 5667.546596272288, 5673.290838645169, 5679.0, 5653.180288858092, 5655.575831812631, 5674.716264186774, 5691.345495268014, 5694.772209111589, 4308.482982042175, 4389.648828093745, 4400.185965596375, 4434.512203657595, 4493.303537951622, 3880.9223815523533, 3906.882793516142, 3909.706771992112, 3925.0972276376024, 3939.5666476687543, 5226.189940559219, 5240.528352448298, 5245.501677340723, 5259.868503287448, 5274.393444753826, 5511.283533140666, 5573.832785016456, 5586.13414920688, 5628.915566266509, 5730.025895597759, 5252.1596544552685, 5266.868328291824, 5270.209468579667, 5275.551578115903, 5276.709780962007, 4770.904581908412, 4829.589484893753, 4832.613390928787, 4835.588974937099, 4880.194767863334, 5837.795677151279, 5856.531477481792, 5916.083007133901, 5947.078202878561, 5978.103284507359, 5674.120511320752, 5685.033544297479, 5685.573581981285, 5691.4877661010705, 5698.25922630072, 5756.913646295393, 5913.172155898092, 5922.940770592239, 5928.170056192051, 5948.643081415129, 5584.972075139598, 5611.551075913835, 5643.407442218508, 5655.236543066633, 5677.205191273142, 5728.3412407572, 5755.913661295168, 5761.135829625589, 5764.567657425626, 5771.134329850556, 5409.5672346213, 5547.472990065938, 5549.306336707911, 5613.382527922007, 5617.522510586646, 5621.915671264853, 5625.549956003591, 5630.23991761107, 5631.239782629456, 5636.070048442125, 5499.5325397340075, 5511.090670039399, 5513.228148059355, 5528.143137813645, 5560.304961879765, 5434.239206511171, 5543.972280138573, 5548.639338442988, 5647.875211882362, 5674.716264186856, 5312.654677445954, 5326.9200961984825, 5358.7856485741695, 5367.087595108919, 5367.355917289794], "unit": "score", "name": "dojo.html", "value": 5208.303895297537}, {"lowerIsBetter": false, "replicates": [522.3522831688707, 526.8656492594388, 530.9256704061431, 552.8507303028185, 556.7244214114013, 35577.46633800492, 36132.81933590328, 36377.0, 36445.63554364456, 36483.4527482088, 39392.80303598485, 39820.402693959615, 39918.20163596726, 39991.40012899809, 40075.39886901691, 8379.413441059112, 8534.829303413928, 8541.95729021354, 8558.957205213965, 8560.357973152039, 8236.62935167916, 8377.078521362646, 8386.412951093425, 8387.454815437008, 8392.118827523114, 8644.222020018196, 8699.0, 8705.129487051308, 8721.040685524587, 8734.51960142192, 8580.141985801401, 8602.18279263469, 8655.870161947576, 8671.13288671134, 8684.0, 8465.619047142893, 8601.0, 8610.225079742853, 8637.568121593895, 8668.913310866874, 38595.1053670973, 38899.416508752394, 39098.804505977285, 39102.21795564101, 39166.21667566633, 2996.4905965985836, 3010.5333673280675, 3049.603551538308, 3293.2096296888813, 3346.882859099944, 28833.855830720713, 29180.8540957296, 29235.70764292351, 29243.268918277, 29451.41097178066, 3676.5036720042717, 3741.7754934704003, 3782.167923056923, 3786.6970642348547, 3798.3352913240074, 269679.0, 269939.0, 270130.0, 270516.0, 270753.0, 50602.240966385536, 51837.222441663405, 57195.0, 57525.71237143871, 57666.7116664414, 61389.69305153446, 63516.36483635197, 63521.0, 63569.36430635634, 63631.0, 13368.39842207103, 13448.1258718183, 13550.051496395157, 13553.728925421634, 13686.04197706171, 10319.329243599143, 10367.377957322586, 10379.84430233547, 10409.42748148859, 10437.634682786218, 18637.627247454973, 18732.719009214874, 18922.810771892106, 18968.241270349306, 19510.0, 7300.0, 7347.08161479815, 7521.586312752851, 7541.698332066766, 7567.772966811004, 854.3976496569903, 908.2234689340651, 940.7459985803795, 945.9290553208536, 957.9664711735056, 24600.876995614908, 25207.74792252054, 25306.240812775646, 25369.0, 25847.61228581535, 1049.627382279295, 1089.1430111659602, 1141.868685101224, 1195.7967145585271, 1206.1074804644675, 14029.649258768612, 14053.648658783612, 14079.507217247346, 14196.929015354857, 14272.785908211385, 340258.0, 342675.0, 343446.0, 343897.0, 344032.0, 51918.0, 52261.0, 52588.47411525912, 52602.73698631483, 52808.0, 1291.761024210524, 1311.3639884655934, 1324.7681655710212, 1336.8262125923761, 1343.6708006538265, 25034.37414064663, 26112.60831087573, 26150.215493535223, 26164.34589135287, 26487.0, 40606.593934061464, 41070.0, 41464.1707165861, 41580.0, 41675.16649667051, 326626.0, 327621.0, 327718.0, 328261.0, 329638.0, 30020.048696834638, 30594.0, 30693.0, 30716.0, 30850.0, 43446.56553434425, 43895.78052109719, 44404.55595444133, 44757.776211120035, 45054.77472612616, 36514.63485365112, 36868.81565592155, 37139.81430092832, 37365.43951840779, 38356.808215959856, 36747.44878826766, 36780.26439471249, 36817.815910920275, 36953.26093478169, 37085.629143709295, 35754.0, 36254.45618315675, 36415.63584364228, 36471.63528364682, 36994.630053700195, 28100.0, 28243.15270541887, 29717.554236686035, 30166.396672065996, 30345.544816827325, 23627.64558531658, 25170.49659006773, 25354.492910142064, 25773.613395799453, 26014.86992565025], "unit": "score", "name": "ext.html", "value": 17948.771082917174}, {"lowerIsBetter": false, "replicates": [356.90363601827505, 360.1949642548903, 360.96209897960716, 365.37703216016695, 368.57061523325325, 16412.75380869288, 17421.825781742195, 17523.474295771117, 18204.726929096076, 18303.17635706395, 11360.488778004988, 11365.829512557319, 11464.48409821558, 11538.076953843693, 11602.709932251677, 4938.975305123469, 4941.382327209099, 5011.824586139486, 5054.393472783271, 5063.84808455745, 5004.249362595603, 5034.723090230036, 5038.370203724535, 5044.344235249412, 5058.342415485981, 5020.447750747415, 5035.521625445577, 6248.875022499547, 6561.245456772461, 6565.34346565342, 6431.903521447182, 6440.452561532252, 6516.446102081329, 6918.965405172992, 6921.930780692179, 6693.397594216495, 6741.359570840762, 6752.797416077526, 6760.932390676079, 6764.289749576273, 21889.233876814393, 22374.2169024085, 22696.77303226963, 23890.0, 23909.282721518382, 2002.4593359792775, 2024.129624261567, 2091.2366986049983, 2189.748178959408, 2225.2322948582714, 14196.787048194285, 14522.636934076627, 14537.709245815131, 14548.1998490083, 14807.0375425597, 1973.3093417303828, 2000.9699854502194, 2033.2273735980232, 2033.4712974626555, 2079.0540304161723, 63475.365246347406, 70718.64640676815, 70831.0, 70970.0, 71011.64494177495, 15555.922220388826, 15590.220488975507, 15604.141772202638, 15671.843281567266, 15798.842011579967, 23941.52116957686, 24047.158349457684, 24165.879170604036, 24330.270091896917, 24338.63492047621, 8437.704680336281, 8461.365397595082, 8466.280366168945, 8500.10748871372, 8522.65909363631, 6931.722731090801, 6993.545419547713, 7002.194747603989, 7011.474139439562, 7012.5792452453015, 7857.685692572348, 7878.566678832719, 7944.761657150295, 7957.3634109271115, 8029.397795165386, 1653.5287443078664, 1694.8135705072432, 3011.849407529615, 3038.6961303869434, 3175.4919212926284, 805.5529181304432, 860.9354298427643, 1001.9649312274036, 1027.1577306608658, 1030.6392762533053, 15792.447264345692, 15885.364585416453, 15886.443974460839, 16288.918555407146, 17278.308867645406, 910.5947853205261, 912.2838571721167, 961.9422834629945, 976.4531862157214, 991.5587563534302, 9548.37935534188, 9654.469004204837, 9921.603135874484, 9935.80128397428, 10027.197824174049, 405009.0, 413157.0, 417443.0, 422502.0, 424512.0, 74770.25229747742, 78723.60638196772, 79394.0, 79573.0, 82622.58688706518, 1147.649966760146, 1148.6152139033518, 1199.1905463812066, 1206.849143857018, 1219.2136072233536, 15689.372425102869, 15870.285837137588, 15962.920185398998, 16001.359945602046, 16141.75787363167, 34995.65004349924, 35093.824530878206, 35355.116122097155, 35487.0, 36426.635733642324, 44834.0, 44981.55018449773, 45621.0, 47813.760931195124, 50326.49673503218, 9208.401453905475, 9734.36726612768, 9804.26468014916, 9858.605655773688, 9867.358621689567, 11471.139664525028, 11523.711907202387, 11578.71053223676, 11672.708182295171, 13359.799603006157, 14266.286685665467, 14316.284185790877, 14379.712405751618, 14528.636784080483, 14734.452882447189, 13882.861171388156, 13969.0, 14081.295935203403, 14469.0, 14521.636959075686, 14269.500567480089, 14370.928145359207, 14643.19462429534, 14652.70694586081, 14722.558323249892, 9351.438913665203, 9423.057694230522, 9500.572474238537, 9657.372270802376, 9934.20526357904, 10590.629327973484, 11089.667309980714, 14520.491782787552, 14544.127352358892, 14927.776083358542], "unit": "score", "name": "jquery.html", "value": 9463.058058595037}, {"lowerIsBetter": false, "replicates": [1440.351841671248, 1447.2618964328192, 1599.3202888772269, 1743.9389621363255, 1751.7372394140884, 6489.318621544729, 6569.8686026279565, 7368.815779605513, 7395.445341599381, 7444.29279218474, 6933.895991560118, 7082.539634923726, 7126.714931402737, 7131.786046418616, 7145.285471452852, 2195.703580016693, 2219.8345868419046, 2232.174095584636, 2237.910483580663, 2241.4956634757214, 2153.440105572555, 2166.7616562178146, 2218.8114010309064, 2233.419310979149, 2248.6289762189217, 2232.285668586053, 2262.9321120366417, 2267.4444761033487, 2303.1363238785457, 2310.8151347892212, 2199.2412617646887, 2214.5792299463133, 2239.8992045358, 2241.383619504633, 2241.8654880707127, 2229.710137682107, 2253.9774602254097, 2254.1321591187348, 2255.5827171973237, 2256.3343813575034, 7452.366548843354, 7461.515001524937, 7495.138059123216, 7573.621318934086, 7590.6963721451075, 4412.117576484684, 4449.7330160190495, 4461.330800379969, 4475.440569928759, 4480.462344518679, 2988.118505041018, 3032.924176895573, 3035.9544606830914, 3040.6503252126067, 3055.419470300658, 943.9008904065112, 946.2950102173855, 966.7583104223944, 1021.3208216535994, 1066.402814423925, 10190.133838623726, 10212.846807297896, 10223.284370094096, 10231.6418925338, 10237.283390162616, 4115.753054816721, 4122.649574786176, 4163.604457576525, 4169.291220492523, 4171.0823618803815, 8761.299096072298, 8853.15894989975, 8854.114588541095, 8871.512066836385, 8895.199432051146, 4419.624331931757, 4438.578335058164, 4448.377227188196, 4459.9331010034875, 4485.0805584855025, 4001.6198461146146, 4042.717009809285, 4055.7769322687536, 4168.437260969791, 4172.4993000840095, 3502.3345564342694, 3516.226430185406, 3518.2611651552947, 3522.6653467920505, 3561.1453251219523, 1070.1224995503767, 1076.971492224939, 1085.766560189563, 1086.1310951238977, 1098.8241881298954, 968.7287559483356, 969.9127078562963, 975.2831668723483, 1062.8724553053682, 1284.319310765296, 6886.070380498669, 6896.586204827727, 6897.3447522486285, 6915.688794004282, 6926.515143939977, 455.6309389394601, 1175.3653027365299, 1205.4033253539553, 1212.8241404996227, 1235.4131787400913, 5274.604404669665, 5311.256424100629, 5321.866953326198, 5329.094054010828, 5352.625316227826, 8415.621297041647, 8420.0, 8439.071702112762, 8494.895663563697, 8572.399932004824, 8363.581820909052, 8432.072472028072, 8433.451825631437, 8433.662653493791, 8446.113158118309, 6621.635810030398, 6977.058097156921, 7021.1574611047, 7094.290570942968, 7095.254998225215, 6831.795046148623, 6890.345417185359, 6899.482538809509, 6900.137482814648, 6916.446684265146, 7834.294913457816, 7925.762227133196, 7928.960355198418, 8069.636866340911, 8095.7166499172245, 8034.598270086355, 8042.517448953082, 8285.254327110348, 8408.117147699404, 8428.367872409717, 6504.414602685781, 6571.835704107436, 6578.8355291118105, 6607.636579988147, 6657.73369065232, 7023.33278338557, 7060.505764596429, 7076.858462830817, 7139.107611548557, 7143.2499587544635, 6504.276366762717, 6551.377619126175, 6575.638339891352, 6579.769708060387, 6689.565178263398, 6461.903071454026, 6515.0553169791065, 6586.901196481961, 6646.435053020354, 6676.9332306676315, 6727.899081513683, 6766.898496522457, 6780.627065511444, 6796.796096117125, 6800.251972282946, 6055.061465472859, 6064.696765161812, 6067.939320606737, 6070.878582428415, 6106.45041946227, 6131.448169664752, 6132.632042077311, 6155.384461553988, 6161.599496032743, 6168.0439531872635], "unit": "score", "name": "mootools.html", "value": 4281.946834914374}, {"lowerIsBetter": false, "replicates": [338.296343605301, 342.4828508951483, 349.8128501251831, 350.1543771791124, 354.8935319404178, 6171.660558669271, 6195.845103872394, 6251.781187658433, 6252.531060170489, 6323.936760632392, 6135.9079613805825, 6175.444210021097, 6177.660228687431, 6180.289266734327, 6182.041783523561, 4715.221988371914, 4717.622590192794, 4733.0, 4737.218358970766, 4738.194506933813, 4716.080364328957, 4718.079974404993, 4718.57532822046, 4720.221163508034, 4745.145873742725, 4513.097380523892, 4547.136044151617, 4664.626829853621, 4668.883277918046, 4672.836450724225, 4622.121796858586, 4651.1162879053045, 4653.255479123358, 4657.999999999983, 4687.718736875764, 4076.755394676299, 4078.898027549335, 4083.7549747014978, 4090.447789548403, 4096.09885825118, 5796.681182534959, 5807.0998995155815, 5821.67980761058, 5882.705864706748, 5887.528997680175, 5340.759665815048, 5469.179623056533, 5491.643043202179, 5498.752556134984, 5504.0, 6542.93457065428, 6548.6725663716625, 6548.70530826114, 6549.803505894831, 6552.115464412339, 4482.260427029536, 4527.162474942146, 4534.433195850519, 4541.114482675879, 4542.091581683643, 6734.292899245606, 6781.11845460087, 6848.6918088686125, 6864.691088901011, 6867.931320686829, 4536.88657783558, 4550.590446859798, 4567.223571992769, 4583.816647334069, 4588.518205588365, 4617.607503362185, 4625.676202665781, 4627.375304333872, 4636.211843986531, 4638.095571363552, 5356.491133342404, 5379.300690910157, 5393.973030134903, 5394.865128371744, 5399.433059528693, 6427.017424801874, 6593.0, 6594.340565943367, 6595.175603049619, 6603.900941485882, 1638.0908595729484, 1658.2620733773356, 1658.5439004273921, 1662.4680102367126, 1668.0908904646997, 1078.487718333785, 1078.8813230544633, 1081.1566977757204, 1097.780443911221, 1098.1763677242068, 6286.05709143623, 6295.779647712399, 6302.1177035215105, 6303.747850086037, 6312.116303717483, 6712.865742685119, 6750.1562304711915, 6769.458443324621, 6793.72825086991, 6825.0, 6176.81469555914, 6311.715972781236, 6317.305096439388, 6350.460210882126, 6359.077933699587, 3682.760620559655, 3694.242680250542, 3711.109333759878, 3711.202091550276, 3712.276106159327, 7172.103487064117, 7173.856522869513, 7183.964080179566, 7187.31720486553, 7194.316539928698, 6892.517523773388, 6968.512204145661, 7020.262872398427, 7024.5434046786795, 7052.682629281695, 7113.92886071143, 7152.964235178895, 7161.319674630901, 7177.210506844243, 7186.173590037108, 6757.628330441873, 6770.898436523357, 6795.796126116026, 6806.727730890709, 6850.109485766819, 6561.770338038145, 6681.465482761465, 6764.2559318475915, 6794.42247408956, 6805.659717014229, 7161.427085833225, 7170.462215333767, 7180.676869540987, 7184.676689549087, 7202.0, 4567.954320456753, 4586.747728874944, 4591.403117594691, 4595.264757638762, 4598.678092533491, 6665.40011398957, 6822.181338239443, 6828.0, 6843.589384636938, 6845.828854278683, 6634.203895532567, 6638.103855979574, 6642.634655094016, 6647.700853461509, 6651.767188148391, 6594.868102638016, 6609.20689517261, 6627.237867645283, 6630.60216386999, 6642.269350371359, 6333.303336633059, 6498.577592456475, 6501.2198536175965, 6501.544891857714, 6514.57655252407, 6642.202935647753, 6654.13496245485, 6661.733530658719, 6669.633170175687, 6675.299093595103, 6368.490520758235, 6411.743530258737, 6450.451711604566, 6477.643729594917, 6489.415952564292], "unit": "score", "name": "prototype.html", "value": 4950.49916028625}, {"lowerIsBetter": false, "replicates": [828.6027288118714, 829.5064436660189, 839.404023143568, 849.3672214200419, 850.2517784349772, 12773.872261277384, 12997.415116319764, 13018.609441716751, 13060.542880999143, 13103.410346534405, 12188.817167742469, 12280.078994075458, 12541.561045363414, 12633.747325053517, 12640.115191936546, 827.2843989948681, 838.9035260945009, 842.4776638484149, 842.7766641839918, 843.1779015459908, 826.5371392020458, 831.5343407691712, 836.2181360428019, 837.844998675247, 838.2748922182329, 869.3349587565517, 870.24723614074, 874.7419511244199, 875.3172525430175, 878.4773060029272, 867.0765634599131, 868.2923417414787, 871.8561437362828, 874.5321253129545, 875.2560323724847, 633.7908490198223, 635.0759644716971, 636.0300541673938, 637.7353398339684, 640.5068097564849, 11154.0, 11181.83227251592, 11234.3259404436, 11254.818244084336, 11292.604758833402, 10028.0, 10099.747506312327, 10246.590136394536, 10361.0, 10474.47627618616, 8248.958755206246, 8286.792830179233, 8961.507117108556, 9119.635214591408, 9226.53867306632, 3531.876384326536, 3583.3191693578137, 3593.317269718745, 3596.3886139356373, 3597.2625611749527, 42240.0, 42287.57712422867, 45285.547144528464, 45323.54676453259, 51620.48379516232, 8011.719589814328, 8923.286137109015, 9273.814523709489, 9318.86021709675, 9491.620335186515, 17598.38405655796, 17611.471655850088, 17675.0, 17680.646387072185, 17700.380486683163, 6749.358810912955, 7113.253108423541, 7253.238409966983, 7388.113426388868, 7424.888626670604, 4126.711130220916, 4137.482814648169, 4170.020045289354, 4178.561251068594, 4183.811728472226, 3078.98460507696, 3095.9226019349244, 3195.6804319568323, 3268.444364458, 3269.9509507357407, 577.8295402856168, 578.320473443702, 586.1881294407276, 587.1427715535281, 589.4017572164257, 489.7012822178468, 521.9743204602973, 633.7274971762095, 669.7019826177304, 670.0418401685539, 7914.564698941498, 8158.632861521246, 8253.463524870864, 8537.957310213533, 8631.270342120251, 491.8275640709087, 596.7195418153461, 667.889798183304, 676.9695363708645, 681.189384632286, 3785.8674946376746, 3788.753731007476, 3835.4246862970776, 3845.057960799622, 3939.212157568498, 56256.437435625936, 56535.71732141313, 56680.71659641758, 56842.715786420806, 56987.430125699044, 45297.09405811865, 48678.51321486811, 51530.74234628878, 52203.47796521986, 52319.476805232225, 43858.780706096906, 45137.09725805466, 46204.5379546207, 46238.0, 47187.528124718316, 7332.523385980107, 7622.123455802432, 7631.1987241341085, 7656.272654097852, 7696.961515192612, 35451.82274088613, 35566.64433355633, 35824.46263306105, 35971.100722482144, 36235.818820905726, 39973.40039899346, 44741.77629111834, 45745.54254457546, 46480.53519464762, 46684.0, 10268.794624107326, 10770.246082774443, 10960.780784384428, 11000.0, 11380.54477820878, 12051.33717645538, 12154.149209555246, 12182.208156469802, 12230.205036672587, 12511.311877846805, 9494.765680461496, 9603.711888643353, 9655.468949207861, 9915.157211637092, 10056.0, 10277.280590358603, 10315.17478601695, 10405.21960852924, 10424.895751042695, 10907.181961352771, 9905.950470247892, 9942.701718948443, 10197.337173084023, 10351.896481035094, 10363.222758293008, 9357.53212339394, 9742.853857192289, 9890.0, 10219.897801021894, 10345.482725863527, 8331.708390206313, 8376.539290338846, 8390.874136888073, 8443.83112337762, 8507.95746021266], "unit": "score", "name": "yui.html", "value": 6055.6213518563345}], "name": "dromaeo_css", "value": 6958.920892353063}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 112.0, 110.0, 122.0, 112.0, 111.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [152.0, 132.0, 154.0, 162.0, 125.0, 153.0, 149.0, 132.0, 171.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [166.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0, 170.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 76.0, 76.0, 72.0, 73.0, 132.0, 76.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 139.0, 97.0, 97.0, 98.0, 139.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 147.0, 145.0, 148.0, 146.0, 148.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 64.0, 60.0, 59.0, 63.0, 61.0, 65.0, 59.0, 60.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 86.0, 87.0, 88.0, 86.0, 90.0, 87.0, 87.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [117.0, 126.0, 120.0, 133.0, 120.0, 128.0, 121.0, 129.0, 123.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [147.0, 155.0, 151.0, 150.0, 155.0, 138.0, 155.0, 150.0, 154.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 74.0, 77.0, 69.0, 67.0, 71.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1525.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.86580601324954], "unit": "score", "name": "Richards", "value": 207.82287399999998}, {"lowerIsBetter": false, "replicates": [201.6942315449778], "unit": "score", "name": "DeltaBlue", "value": 327.8130440000001}, {"lowerIsBetter": false, "replicates": [283.4467120181406], "unit": "score", "name": "Encrypt", "value": 939.0865680000002}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [711.2375533428165], "unit": "score", "name": "Earley", "value": 937.0469780000002}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [25275.0], "unit": "score", "name": "RegExp", "value": 36.042927794263136}, {"lowerIsBetter": false, "replicates": [687.8850102669404], "unit": "score", "name": "Splay", "value": 118.46602089552236}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20792.950778386374}]} 05:24:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20792.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1525.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6958.92"}}} 05:24:31 INFO - Return code: 0 05:24:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:24:31 INFO - # TBPL SUCCESS # 05:24:31 INFO - Running post-action listener: _resource_record_post_action 05:24:31 INFO - Running post-run listener: _resource_record_post_run 05:24:32 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 577617920; Read time: 0; Write time: 341928 05:24:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237920256; Read time: 0; Write time: 167996 05:24:32 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 321536000; Read time: 0; Write time: 162852 05:24:32 INFO - Running post-run listener: _upload_blobber_files 05:24:32 INFO - Blob upload gear active. 05:24:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:24:32 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:24:32 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:24:32 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:24:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:24:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:24:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:34 INFO - (blobuploader) - INFO - Done attempting. 05:24:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:24:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:24:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:34 INFO - (blobuploader) - INFO - Done attempting. 05:24:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:34 INFO - Return code: 0 05:24:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:24:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6396e2381e6244c92688247831a01e8c945155d3763ad1d8a9e9d2bfd0de7a2faf69a40550d848e7c93aff3899edf9a07d7a0a04b0b2c64cbfe536c7ccdc7946", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2821c6a92949225154cc0e270f24b67aacc33cc42015f5e211f2f6d207637fa90adcd0fb345c517bc9c13797464e7bc90175276fd489c759b2e7021868eb8844"} 05:24:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:24:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:24:34 INFO - Contents: 05:24:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6396e2381e6244c92688247831a01e8c945155d3763ad1d8a9e9d2bfd0de7a2faf69a40550d848e7c93aff3899edf9a07d7a0a04b0b2c64cbfe536c7ccdc7946", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2821c6a92949225154cc0e270f24b67aacc33cc42015f5e211f2f6d207637fa90adcd0fb345c517bc9c13797464e7bc90175276fd489c759b2e7021868eb8844"} 05:24:34 INFO - Copying logs to upload dir... 05:24:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.422115 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-06 05:24:34.040713) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:34.048463) ========= 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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 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/Fx-Team/sha512/6396e2381e6244c92688247831a01e8c945155d3763ad1d8a9e9d2bfd0de7a2faf69a40550d848e7c93aff3899edf9a07d7a0a04b0b2c64cbfe536c7ccdc7946", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2821c6a92949225154cc0e270f24b67aacc33cc42015f5e211f2f6d207637fa90adcd0fb345c517bc9c13797464e7bc90175276fd489c759b2e7021868eb8844"} build_url:https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/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/Fx-Team/sha512/6396e2381e6244c92688247831a01e8c945155d3763ad1d8a9e9d2bfd0de7a2faf69a40550d848e7c93aff3899edf9a07d7a0a04b0b2c64cbfe536c7ccdc7946", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2821c6a92949225154cc0e270f24b67aacc33cc42015f5e211f2f6d207637fa90adcd0fb345c517bc9c13797464e7bc90175276fd489c759b2e7021868eb8844"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:34.074592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:34.074972) ========= 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=6dbc10da6d83fee962c624be000001a8-1452083491.372251-1559958925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:34.159103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 05:24:34.159458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 05:24:34.160065) ========= ========= Total master_lag: 0.25 =========