builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1453140793.52 results: success (0) buildid: 20160118073201 builduid: 9a92f55854034f18af4a3a497856758a revision: a77b73c7723e1060993045fb31eb2f0a30473486 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.524720) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.525165) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.525501) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006422 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.556121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.556692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.599275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.599593) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.010104 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.660016) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.660315) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.660737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.661061) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 10:13:13-- 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% 29.7M=0s 2016-01-18 10:13:13 (29.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103003 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.780063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.780380) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.111243 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.907569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:13.907969) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a77b73c7723e1060993045fb31eb2f0a30473486 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a77b73c7723e1060993045fb31eb2f0a30473486 --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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 10:13:13,943 truncating revision to first 12 chars 2016-01-18 10:13:13,944 Setting DEBUG logging. 2016-01-18 10:13:13,944 attempt 1/10 2016-01-18 10:13:13,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a77b73c7723e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 10:13:14,223 unpacking tar archive at: mozilla-central-a77b73c7723e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:14.513326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:14.514121) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004680 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:14.570553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:14.570903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:14.591208) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:14.591487) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 10:13:14.591918) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-01-18 10:13:14.592256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:14 INFO - MultiFileLogger online at 20160118 10:13:14 in /builds/slave/test-pgo 10:13:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:13:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:13:14 INFO - {'append_to_log': False, 10:13:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:13:14 INFO - 'blob_upload_branch': 'Firefox', 10:13:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:13:14 INFO - 'branch': 'Firefox', 10:13:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:14 INFO - 'config_files': ('talos/linux_config.py',), 10:13:14 INFO - 'default_actions': ('clobber', 10:13:14 INFO - 'read-buildbot-config', 10:13:14 INFO - 'download-and-extract', 10:13:14 INFO - 'populate-webroot', 10:13:14 INFO - 'create-virtualenv', 10:13:14 INFO - 'install', 10:13:14 INFO - 'run-tests'), 10:13:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:14 INFO - 'download_minidump_stackwalk': True, 10:13:14 INFO - 'download_symbols': 'ondemand', 10:13:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:14 INFO - 'installer_path': 'installer.exe', 10:13:14 INFO - 'log_level': 'info', 10:13:14 INFO - 'log_name': 'talos', 10:13:14 INFO - 'log_to_console': True, 10:13:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:14 INFO - 'opt_config_files': (), 10:13:14 INFO - 'pip_index': False, 10:13:14 INFO - 'sps_profile': False, 10:13:14 INFO - 'sps_profile_interval': 0, 10:13:14 INFO - 'suite': 'dromaeojs-e10s', 10:13:14 INFO - 'system_bits': '32', 10:13:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:14 INFO - 'title': 'talos-linux64-ix-033', 10:13:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:14 INFO - 'use_talos_json': True, 10:13:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:13:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:14 INFO - 'work_dir': 'build'} 10:13:14 INFO - ##### 10:13:14 INFO - ##### Running clobber step. 10:13:14 INFO - ##### 10:13:14 INFO - Running pre-action listener: _resource_record_pre_action 10:13:14 INFO - Running main action method: clobber 10:13:14 INFO - rmtree: /builds/slave/test-pgo/build 10:13:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:13:16 INFO - Running post-action listener: _resource_record_post_action 10:13:16 INFO - ##### 10:13:16 INFO - ##### Running read-buildbot-config step. 10:13:16 INFO - ##### 10:13:16 INFO - Running pre-action listener: _resource_record_pre_action 10:13:16 INFO - Running main action method: read_buildbot_config 10:13:16 INFO - Using buildbot properties: 10:13:16 INFO - { 10:13:16 INFO - "project": "", 10:13:16 INFO - "product": "firefox", 10:13:16 INFO - "script_repo_revision": "production", 10:13:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:13:16 INFO - "repository": "", 10:13:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:13:16 INFO - "buildid": "20160118073201", 10:13:16 INFO - "pgo_build": "True", 10:13:16 INFO - "basedir": "/builds/slave/test-pgo", 10:13:16 INFO - "buildnumber": 310, 10:13:16 INFO - "slavename": "talos-linux64-ix-033", 10:13:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:13:16 INFO - "platform": "ubuntu64_hw", 10:13:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:13:16 INFO - "branch": "mozilla-central", 10:13:16 INFO - "repo_path": "mozilla-central", 10:13:16 INFO - "revision": "a77b73c7723e1060993045fb31eb2f0a30473486", 10:13:16 INFO - "stage_platform": "linux64-pgo", 10:13:16 INFO - "builduid": "9a92f55854034f18af4a3a497856758a", 10:13:16 INFO - "slavebuilddir": "test" 10:13:16 INFO - } 10:13:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:13:16 INFO - Running post-action listener: _resource_record_post_action 10:13:16 INFO - ##### 10:13:16 INFO - ##### Running download-and-extract step. 10:13:16 INFO - ##### 10:13:16 INFO - Running pre-action listener: _resource_record_pre_action 10:13:16 INFO - Running main action method: download_and_extract 10:13:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:16 INFO - https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/test_packages.json 10:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/test_packages.json 10:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:13:18 INFO - Downloaded 1448 bytes. 10:13:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:13:18 INFO - Using the following test package requirements: 10:13:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:18 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:13:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'jsshell-linux-x86_64.zip'], 10:13:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:13:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:13:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:18 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')]} 10:13:18 INFO - https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:21 INFO - Downloaded 22483907 bytes. 10:13:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:13:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:13:22 INFO - Return code: 0 10:13:22 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 10:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:22 INFO - https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:36 INFO - Downloaded 22483907 bytes. 10:13:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:13:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:13:37 INFO - Return code: 0 10:13:37 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')]} 10:13:37 INFO - https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:39 INFO - Downloaded 11132144 bytes. 10:13:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:13:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:13:39 INFO - Return code: 0 10:13: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')]} 10:13:39 INFO - https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/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 10:13:46 INFO - Downloaded 55919165 bytes. 10:13:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:13:46 INFO - mkdir: /builds/slave/test-pgo/properties 10:13:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:13:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:13:46 INFO - Contents: 10:13:46 INFO - build_url:https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:13:46 INFO - Running post-action listener: _resource_record_post_action 10:13:46 INFO - Running post-action listener: set_extra_try_arguments 10:13:46 INFO - ##### 10:13:46 INFO - ##### Running populate-webroot step. 10:13:46 INFO - ##### 10:13:46 INFO - Running pre-action listener: _resource_record_pre_action 10:13:46 INFO - Running main action method: populate_webroot 10:13:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:46 INFO - '--tppagecycles', 10:13:46 INFO - '7'], 10:13:46 INFO - 'tests': ['tsvgm']}}, 10:13:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:13:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:13:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:13:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'tests': ['damp', 'tps']}, 10:13:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['damp', 'tps']}, 10:13:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:13:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:46 INFO - 'other': {'tests': ['a11yr', 10:13:46 INFO - 'ts_paint', 10:13:46 INFO - 'tpaint', 10:13:46 INFO - 'sessionrestore', 10:13:46 INFO - 'sessionrestore_no_auto_restore']}, 10:13:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['a11yr', 10:13:46 INFO - 'ts_paint', 10:13:46 INFO - 'tpaint', 10:13:46 INFO - 'sessionrestore', 10:13:46 INFO - 'sessionrestore_no_auto_restore']}, 10:13:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['a11yr', 10:13:46 INFO - 'ts_paint', 10:13:46 INFO - 'tpaint', 10:13:46 INFO - 'sessionrestore', 10:13:46 INFO - 'sessionrestore_no_auto_restore']}, 10:13:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['a11yr', 10:13:46 INFO - 'ts_paint', 10:13:46 INFO - 'tpaint', 10:13:46 INFO - 'sessionrestore', 10:13:46 INFO - 'sessionrestore_no_auto_restore']}, 10:13:46 INFO - 'other_l64': {'tests': ['a11yr', 10:13:46 INFO - 'ts_paint', 10:13:46 INFO - 'tpaint', 10:13:46 INFO - 'sessionrestore', 10:13:46 INFO - 'sessionrestore_no_auto_restore']}, 10:13:46 INFO - 'other_nol64': {'tests': ['a11yr', 10:13:46 INFO - 'ts_paint', 10:13:46 INFO - 'tpaint', 10:13:46 INFO - 'sessionrestore', 10:13:46 INFO - 'sessionrestore_no_auto_restore']}, 10:13:46 INFO - 'svgr': {'tests': ['tsvgx', 10:13:46 INFO - 'tsvgr_opacity', 10:13:46 INFO - 'tart', 10:13:46 INFO - 'tscrollx', 10:13:46 INFO - 'cart']}, 10:13:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['tsvgx', 10:13:46 INFO - 'tsvgr_opacity', 10:13:46 INFO - 'tart', 10:13:46 INFO - 'tscrollx', 10:13:46 INFO - 'cart']}, 10:13:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'tests': ['tp5o']}, 10:13:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'talos_options': ['--e10s'], 10:13:46 INFO - 'tests': ['tp5o']}, 10:13:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'talos_options': ['--xperf_path', 10:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:46 INFO - 'tests': ['tp5n']}, 10:13:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:46 INFO - 'talos_options': ['--e10s', 10:13:46 INFO - '--xperf_path', 10:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:46 INFO - 'tests': ['tp5n']}}, 10:13:46 INFO - 'talos.zip': {'path': '', 10:13:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:46 INFO - Running post-action listener: _resource_record_post_action 10:13:46 INFO - ##### 10:13:46 INFO - ##### Running create-virtualenv step. 10:13:46 INFO - ##### 10:13:46 INFO - Running pre-action listener: _resource_record_pre_action 10:13:46 INFO - Running main action method: create_virtualenv 10:13:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:13:46 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 10:13:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:13:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:46 INFO - Using real prefix '/usr' 10:13:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:13:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:48 INFO - Installing pip.................done. 10:13:49 INFO - Return code: 0 10:13:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:13: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')]} 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:13: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:13: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 pip>=1.5 10:13:49 INFO - Using env: {'DISPLAY': ':0', 10:13:49 INFO - 'HOME': '/home/cltbld', 10:13:49 INFO - 'LANG': 'en_US.UTF-8', 10:13:49 INFO - 'LANGUAGE': 'en_US:en', 10:13:49 INFO - 'LOGNAME': 'cltbld', 10:13:49 INFO - 'MAIL': '/var/mail/cltbld', 10:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:49 INFO - 'MOZ_NO_REMOTE': '1', 10:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:49 INFO - 'NO_EM_RESTART': '1', 10:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:13:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:13:49 INFO - 'SHELL': '/bin/bash', 10:13:49 INFO - 'SHLVL': '1', 10:13:49 INFO - 'TERM': 'linux', 10:13:49 INFO - 'TMOUT': '86400', 10:13:49 INFO - 'USER': 'cltbld', 10:13:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:49 INFO - '_': '/tools/buildbot/bin/python'} 10:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:49 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 10:13:49 INFO - Cleaning up... 10:13:49 INFO - Return code: 0 10:13:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:13: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')]} 10:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', '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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:13: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:13: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 psutil>=0.7.1 10:13:49 INFO - Using env: {'DISPLAY': ':0', 10:13:49 INFO - 'HOME': '/home/cltbld', 10:13:49 INFO - 'LANG': 'en_US.UTF-8', 10:13:49 INFO - 'LANGUAGE': 'en_US:en', 10:13:49 INFO - 'LOGNAME': 'cltbld', 10:13:49 INFO - 'MAIL': '/var/mail/cltbld', 10:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:49 INFO - 'MOZ_NO_REMOTE': '1', 10:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:49 INFO - 'NO_EM_RESTART': '1', 10:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:13:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:13:49 INFO - 'SHELL': '/bin/bash', 10:13:49 INFO - 'SHLVL': '1', 10:13:49 INFO - 'TERM': 'linux', 10:13:49 INFO - 'TMOUT': '86400', 10:13:49 INFO - 'USER': 'cltbld', 10:13:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:49 INFO - '_': '/tools/buildbot/bin/python'} 10:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:49 INFO - Downloading/unpacking psutil>=0.7.1 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:13:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:13:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:51 INFO - Installing collected packages: psutil 10:13:51 INFO - Running setup.py install for psutil 10:13:51 INFO - building 'psutil._psutil_linux' extension 10:13:51 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 10:13:51 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 10:13:51 INFO - building 'psutil._psutil_posix' extension 10:13:51 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 10:13:51 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 10:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:51 INFO - Successfully installed psutil 10:13:51 INFO - Cleaning up... 10:13:51 INFO - Return code: 0 10:13:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:13:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:13:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:13:51 INFO - Using env: {'DISPLAY': ':0', 10:13:51 INFO - 'HOME': '/home/cltbld', 10:13:51 INFO - 'LANG': 'en_US.UTF-8', 10:13:51 INFO - 'LANGUAGE': 'en_US:en', 10:13:51 INFO - 'LOGNAME': 'cltbld', 10:13:51 INFO - 'MAIL': '/var/mail/cltbld', 10:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:51 INFO - 'MOZ_NO_REMOTE': '1', 10:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:51 INFO - 'NO_EM_RESTART': '1', 10:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:13:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:13:51 INFO - 'SHELL': '/bin/bash', 10:13:51 INFO - 'SHLVL': '1', 10:13:51 INFO - 'TERM': 'linux', 10:13:51 INFO - 'TMOUT': '86400', 10:13:51 INFO - 'USER': 'cltbld', 10:13:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:51 INFO - '_': '/tools/buildbot/bin/python'} 10:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:13:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:13:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:13:53 INFO - Installing collected packages: mozsystemmonitor 10:13:53 INFO - Running setup.py install for mozsystemmonitor 10:13:53 INFO - Successfully installed mozsystemmonitor 10:13:53 INFO - Cleaning up... 10:13:53 INFO - Return code: 0 10:13:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:53 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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:13:53 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 10:13:53 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 10:13:53 INFO - Using env: {'DISPLAY': ':0', 10:13:53 INFO - 'HOME': '/home/cltbld', 10:13:53 INFO - 'LANG': 'en_US.UTF-8', 10:13:53 INFO - 'LANGUAGE': 'en_US:en', 10:13:53 INFO - 'LOGNAME': 'cltbld', 10:13:53 INFO - 'MAIL': '/var/mail/cltbld', 10:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:53 INFO - 'MOZ_NO_REMOTE': '1', 10:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:53 INFO - 'NO_EM_RESTART': '1', 10:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:13:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:13:53 INFO - 'SHELL': '/bin/bash', 10:13:53 INFO - 'SHLVL': '1', 10:13:53 INFO - 'TERM': 'linux', 10:13:53 INFO - 'TMOUT': '86400', 10:13:53 INFO - 'USER': 'cltbld', 10:13:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:53 INFO - '_': '/tools/buildbot/bin/python'} 10:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:55 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:13:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:55 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 10:13:55 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 10:13:55 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 10:13:55 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 10:13:55 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 10:13:55 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 10:13:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:13:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:13:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:56 INFO - Downloading docopt-0.6.1.tar.gz 10:13:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:13:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:56 INFO - Running setup.py install for blobuploader 10:13:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:13:56 INFO - Running setup.py install for requests 10:13:57 INFO - Running setup.py install for docopt 10:13:57 INFO - Successfully installed blobuploader requests docopt 10:13:57 INFO - Cleaning up... 10:13:57 INFO - Return code: 0 10:13:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:57 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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:13:57 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 10:13:57 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 10:13:57 INFO - Using env: {'DISPLAY': ':0', 10:13:57 INFO - 'HOME': '/home/cltbld', 10:13:57 INFO - 'LANG': 'en_US.UTF-8', 10:13:57 INFO - 'LANGUAGE': 'en_US:en', 10:13:57 INFO - 'LOGNAME': 'cltbld', 10:13:57 INFO - 'MAIL': '/var/mail/cltbld', 10:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:57 INFO - 'MOZ_NO_REMOTE': '1', 10:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:57 INFO - 'NO_EM_RESTART': '1', 10:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:13:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:13:57 INFO - 'SHELL': '/bin/bash', 10:13:57 INFO - 'SHLVL': '1', 10:13:57 INFO - 'TERM': 'linux', 10:13:57 INFO - 'TMOUT': '86400', 10:13:57 INFO - 'USER': 'cltbld', 10:13:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:57 INFO - '_': '/tools/buildbot/bin/python'} 10:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:13:57 INFO - Running setup.py (path:/tmp/pip-MNgQ1d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:13:57 INFO - Running setup.py (path:/tmp/pip-LlBvAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:13:57 INFO - Running setup.py (path:/tmp/pip-t7XA6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:13:57 INFO - Running setup.py (path:/tmp/pip-8dFFMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:13:57 INFO - Running setup.py (path:/tmp/pip-PstNc5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:13:57 INFO - Running setup.py (path:/tmp/pip-CyNRQw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:13:57 INFO - Running setup.py (path:/tmp/pip-2JPkeY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:13:57 INFO - Running setup.py (path:/tmp/pip-w0Z0TQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:13:57 INFO - Running setup.py (path:/tmp/pip-W_Ns2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:13:58 INFO - Running setup.py (path:/tmp/pip-ZDyysY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:13:58 INFO - Running setup.py (path:/tmp/pip-MFJRRD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:13:58 INFO - Running setup.py (path:/tmp/pip-UmO81l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:13:58 INFO - Running setup.py (path:/tmp/pip-D0ceck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:13:58 INFO - Running setup.py (path:/tmp/pip-9Bil8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:13:58 INFO - Running setup.py (path:/tmp/pip-i9NaUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:13:58 INFO - Running setup.py (path:/tmp/pip-DhU9YP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:13:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:13:58 INFO - Running setup.py (path:/tmp/pip-YKpjeL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:13:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:58 INFO - Running setup.py install for manifestparser 10:13:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:13:58 INFO - Running setup.py install for mozcrash 10:13:58 INFO - Running setup.py install for mozdebug 10:13:58 INFO - Running setup.py install for mozdevice 10:13:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Running setup.py install for mozfile 10:13:59 INFO - Running setup.py install for mozhttpd 10:13:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Running setup.py install for mozinfo 10:13:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Running setup.py install for mozInstall 10:13:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Running setup.py install for mozleak 10:13:59 INFO - Running setup.py install for mozlog 10:13:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Running setup.py install for moznetwork 10:13:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Running setup.py install for mozprocess 10:13:59 INFO - Running setup.py install for mozprofile 10:13:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:13:59 INFO - Running setup.py install for mozrunner 10:14:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:14:00 INFO - Running setup.py install for mozscreenshot 10:14:00 INFO - Running setup.py install for moztest 10:14:00 INFO - Running setup.py install for mozversion 10:14:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:14:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:00 INFO - Cleaning up... 10:14:00 INFO - Return code: 0 10:14:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:14: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')]} 10:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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', '-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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:14:00 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 10:14:00 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 10:14:00 INFO - Using env: {'DISPLAY': ':0', 10:14:00 INFO - 'HOME': '/home/cltbld', 10:14:00 INFO - 'LANG': 'en_US.UTF-8', 10:14:00 INFO - 'LANGUAGE': 'en_US:en', 10:14:00 INFO - 'LOGNAME': 'cltbld', 10:14:00 INFO - 'MAIL': '/var/mail/cltbld', 10:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:00 INFO - 'MOZ_NO_REMOTE': '1', 10:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:00 INFO - 'NO_EM_RESTART': '1', 10:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:00 INFO - 'SHELL': '/bin/bash', 10:14:00 INFO - 'SHLVL': '1', 10:14:00 INFO - 'TERM': 'linux', 10:14:00 INFO - 'TMOUT': '86400', 10:14:00 INFO - 'USER': 'cltbld', 10:14:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:00 INFO - '_': '/tools/buildbot/bin/python'} 10:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:14:00 INFO - Running setup.py (path:/tmp/pip-NTlvj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:14:00 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)) 10:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:14:00 INFO - Running setup.py (path:/tmp/pip-eEaT2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:14:00 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)) 10:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:14:00 INFO - Running setup.py (path:/tmp/pip-zYYc4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:14:00 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)) 10:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:14:00 INFO - Running setup.py (path:/tmp/pip-1CX21k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:14:00 INFO - Running setup.py (path:/tmp/pip-_VSsTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:14:00 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)) 10:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:14:00 INFO - Running setup.py (path:/tmp/pip-WE_7mA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:14:01 INFO - Running setup.py (path:/tmp/pip-L1mTZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:14:01 INFO - Running setup.py (path:/tmp/pip-WNGBhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:14:01 INFO - Running setup.py (path:/tmp/pip-4ugb4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:14:01 INFO - Running setup.py (path:/tmp/pip-TMLHgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:14:01 INFO - Running setup.py (path:/tmp/pip-56vepb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:14:01 INFO - Running setup.py (path:/tmp/pip-WbWDua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:14:01 INFO - Running setup.py (path:/tmp/pip-nLEZ3x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:14:01 INFO - Running setup.py (path:/tmp/pip-_Uijgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:14:01 INFO - Running setup.py (path:/tmp/pip-0KjbUz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:14:01 INFO - Running setup.py (path:/tmp/pip-bskysV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:14:01 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)) 10:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:14:01 INFO - Running setup.py (path:/tmp/pip-Q1dpLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:14:01 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)) 10:14:01 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)) 10:14:01 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)) 10:14:01 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)) 10:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:03 INFO - Downloading blessings-1.5.1.tar.gz 10:14:03 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 10:14:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:03 INFO - Installing collected packages: blessings 10:14:03 INFO - Running setup.py install for blessings 10:14:03 INFO - Successfully installed blessings 10:14:03 INFO - Cleaning up... 10:14:03 INFO - Return code: 0 10:14:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:14:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:14:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:14:04 INFO - Reading from file tmpfile_stdout 10:14:04 INFO - Current package versions: 10:14:04 INFO - argparse == 1.2.1 10:14:04 INFO - blessings == 1.5.1 10:14:04 INFO - blobuploader == 1.2.4 10:14:04 INFO - docopt == 0.6.1 10:14:04 INFO - manifestparser == 1.1 10:14:04 INFO - mozInstall == 1.12 10:14:04 INFO - mozcrash == 0.16 10:14:04 INFO - mozdebug == 0.1 10:14:04 INFO - mozdevice == 0.48 10:14:04 INFO - mozfile == 1.2 10:14:04 INFO - mozhttpd == 0.7 10:14:04 INFO - mozinfo == 0.9 10:14:04 INFO - mozleak == 0.1 10:14:04 INFO - mozlog == 3.1 10:14:04 INFO - moznetwork == 0.27 10:14:04 INFO - mozprocess == 0.22 10:14:04 INFO - mozprofile == 0.28 10:14:04 INFO - mozrunner == 6.11 10:14:04 INFO - mozscreenshot == 0.1 10:14:04 INFO - mozsystemmonitor == 0.0 10:14:04 INFO - moztest == 0.7 10:14:04 INFO - mozversion == 1.4 10:14:04 INFO - psutil == 3.1.1 10:14:04 INFO - requests == 1.2.3 10:14:04 INFO - wsgiref == 0.1.2 10:14:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:14:04 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 10:14:04 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 10:14:04 INFO - Using env: {'DISPLAY': ':0', 10:14:04 INFO - 'HOME': '/home/cltbld', 10:14:04 INFO - 'LANG': 'en_US.UTF-8', 10:14:04 INFO - 'LANGUAGE': 'en_US:en', 10:14:04 INFO - 'LOGNAME': 'cltbld', 10:14:04 INFO - 'MAIL': '/var/mail/cltbld', 10:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:04 INFO - 'MOZ_NO_REMOTE': '1', 10:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:04 INFO - 'NO_EM_RESTART': '1', 10:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:04 INFO - 'SHELL': '/bin/bash', 10:14:04 INFO - 'SHLVL': '1', 10:14:04 INFO - 'TERM': 'linux', 10:14:04 INFO - 'TMOUT': '86400', 10:14:04 INFO - 'USER': 'cltbld', 10:14:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:04 INFO - '_': '/tools/buildbot/bin/python'} 10:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 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)) 10:14:04 INFO - Cleaning up... 10:14:04 INFO - Return code: 0 10:14:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:14:04 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 10:14:04 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 10:14:04 INFO - Using env: {'DISPLAY': ':0', 10:14:04 INFO - 'HOME': '/home/cltbld', 10:14:04 INFO - 'LANG': 'en_US.UTF-8', 10:14:04 INFO - 'LANGUAGE': 'en_US:en', 10:14:04 INFO - 'LOGNAME': 'cltbld', 10:14:04 INFO - 'MAIL': '/var/mail/cltbld', 10:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:04 INFO - 'MOZ_NO_REMOTE': '1', 10:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:04 INFO - 'NO_EM_RESTART': '1', 10:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:04 INFO - 'SHELL': '/bin/bash', 10:14:04 INFO - 'SHLVL': '1', 10:14:04 INFO - 'TERM': 'linux', 10:14:04 INFO - 'TMOUT': '86400', 10:14:04 INFO - 'USER': 'cltbld', 10:14:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:04 INFO - '_': '/tools/buildbot/bin/python'} 10:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:04 INFO - Downloading/unpacking jsonschema 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:06 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 10:14:06 INFO - Downloading/unpacking functools32 (from jsonschema) 10:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:14:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:06 INFO - warning: no files found matching '*.txt' 10:14:06 INFO - no previously-included directories found matching 'build' 10:14:06 INFO - no previously-included directories found matching 'dist' 10:14:06 INFO - no previously-included directories found matching '.git*' 10:14:06 INFO - Installing collected packages: jsonschema, functools32 10:14:06 INFO - Running setup.py install for functools32 10:14:06 INFO - warning: no files found matching '*.txt' 10:14:06 INFO - no previously-included directories found matching 'build' 10:14:06 INFO - no previously-included directories found matching 'dist' 10:14:06 INFO - no previously-included directories found matching '.git*' 10:14:06 INFO - Successfully installed jsonschema functools32 10:14:06 INFO - Cleaning up... 10:14:06 INFO - Return code: 0 10:14:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:14:06 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')]} 10:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:06 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')]} 10:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:06 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 0x7f7f62004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', '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 10:14:06 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 10:14:06 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 10:14:06 INFO - Using env: {'DISPLAY': ':0', 10:14:06 INFO - 'HOME': '/home/cltbld', 10:14:06 INFO - 'LANG': 'en_US.UTF-8', 10:14:06 INFO - 'LANGUAGE': 'en_US:en', 10:14:06 INFO - 'LOGNAME': 'cltbld', 10:14:06 INFO - 'MAIL': '/var/mail/cltbld', 10:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:06 INFO - 'MOZ_NO_REMOTE': '1', 10:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:06 INFO - 'NO_EM_RESTART': '1', 10:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:06 INFO - 'SHELL': '/bin/bash', 10:14:06 INFO - 'SHLVL': '1', 10:14:06 INFO - 'TERM': 'linux', 10:14:06 INFO - 'TMOUT': '86400', 10:14:06 INFO - 'USER': 'cltbld', 10:14:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:06 INFO - '_': '/tools/buildbot/bin/python'} 10:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:06 INFO - Downloading/unpacking flake8 10:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:14:08 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 10:14:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:14:08 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 10:14:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:08 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 10:14:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:14:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:09 INFO - no previously-included directories found matching 'docs/_build' 10:14:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:14:09 INFO - Running setup.py install for pep8 10:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:09 INFO - no previously-included directories found matching 'docs/_build' 10:14:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:14:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:14:09 INFO - Cleaning up... 10:14:10 INFO - Return code: 0 10:14:10 INFO - Running post-action listener: _resource_record_post_action 10:14:10 INFO - Running post-action listener: _start_resource_monitoring 10:14:10 INFO - Starting resource monitoring. 10:14:10 INFO - ##### 10:14:10 INFO - ##### Running install step. 10:14:10 INFO - ##### 10:14:10 INFO - Running pre-action listener: _resource_record_pre_action 10:14:10 INFO - Running main action method: install 10:14:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:14:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:14:10 INFO - Reading from file tmpfile_stdout 10:14:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:14:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:14:10 INFO - Reading from file tmpfile_stdout 10:14:10 INFO - Output received: 10:14:10 INFO - Usage: mozinstall [options] installer 10:14:10 INFO - Options: 10:14:10 INFO - -h, --help show this help message and exit 10:14:10 INFO - -d DEST, --destination=DEST 10:14:10 INFO - Directory to install application into. [default: 10:14:10 INFO - "/builds/slave/test-pgo"] 10:14:10 INFO - --app=APP Application being installed. [default: firefox] 10:14:10 INFO - mkdir: /builds/slave/test-pgo/build/application 10:14:10 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'] 10:14:10 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 10:14:26 INFO - Reading from file tmpfile_stdout 10:14:26 INFO - Output received: 10:14:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:14:26 INFO - Running post-action listener: _resource_record_post_action 10:14:26 INFO - ##### 10:14:26 INFO - ##### Running run-tests step. 10:14:26 INFO - ##### 10:14:26 INFO - Running pre-action listener: _resource_record_pre_action 10:14:26 INFO - Running main action method: run_tests 10:14:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:14:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:14:26 INFO - Python 2.7.3 10:14:26 INFO - Return code: 0 10:14:26 INFO - grabbing minidump binary from tooltool 10:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:26 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 0x25df840>, '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 0x254c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:14:26 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 10:14:26 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 10:14:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:26 INFO - Return code: 0 10:14:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:14:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:14:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:14:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:14:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:14:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:14:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:14:27 INFO - Return code: 0 10:14:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:14:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 10:14:27 INFO - Using env: {'DISPLAY': ':0', 10:14:27 INFO - 'HOME': '/home/cltbld', 10:14:27 INFO - 'LANG': 'en_US.UTF-8', 10:14:27 INFO - 'LANGUAGE': 'en_US:en', 10:14:27 INFO - 'LOGNAME': 'cltbld', 10:14:27 INFO - 'MAIL': '/var/mail/cltbld', 10:14:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:14:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:27 INFO - 'MOZ_NO_REMOTE': '1', 10:14:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:27 INFO - 'NO_EM_RESTART': '1', 10:14:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:14:27 INFO - 'SHELL': '/bin/bash', 10:14:27 INFO - 'SHLVL': '1', 10:14:27 INFO - 'TERM': 'linux', 10:14:27 INFO - 'TMOUT': '86400', 10:14:27 INFO - 'USER': 'cltbld', 10:14:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745', 10:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:27 INFO - '_': '/tools/buildbot/bin/python'} 10:14:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:14:27 INFO - mozversion application_buildid: 20160118073201 10:14:27 INFO - mozversion application_changeset: a77b73c7723e1060993045fb31eb2f0a30473486 10:14:27 INFO - mozversion application_display_name: Nightly 10:14:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:27 INFO - mozversion application_name: Firefox 10:14:27 INFO - mozversion application_remotingname: firefox 10:14:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:14:27 INFO - mozversion application_vendor: Mozilla 10:14:27 INFO - mozversion application_version: 46.0a1 10:14:27 INFO - mozversion platform_buildid: 20160118073201 10:14:27 INFO - mozversion platform_changeset: a77b73c7723e1060993045fb31eb2f0a30473486 10:14:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:14:27 INFO - mozversion platform_version: 46.0a1 10:14:27 INFO - using testdate: 1453140867 10:14:27 INFO - actual date: 1453140867 10:14:27 INFO - starting webserver on 'localhost:43843' 10:14:27 INFO - SUITE-START | Running 3 tests 10:14:27 INFO - TEST-START | dromaeo_css 10:14:27 INFO - operating with platform_type : linux_ 10:14:27 INFO - Initialising browser for dromaeo_css test... 10:14:27 INFO - TEST-INFO | started process 2509 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6cFVhJ/profile http://localhost:43843/getInfo.html) 10:14:32 INFO - PROCESS | 2509 | -- checkerboarding starts below -- 10:14:32 INFO - PROCESS | 2509 | RENDERTRACE 0.059287 rect red 0 0 1024 768 // viewport 10:14:32 INFO - PROCESS | 2509 | RENDERTRACE 297.957 rect brown 0 0 1024 768 // page 10:14:32 INFO - PROCESS | 2509 | RENDERTRACE 297.99 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 10:14:32 INFO - PROCESS | 2509 | Checkerboarded for 1 frames (299.833 ms), 786432 peak, 15466 severity. 10:14:32 INFO - PROCESS | 2509 | 10:14:32 INFO - PROCESS | 2509 | (process:2606): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:14:33 INFO - PROCESS | 2509 | __metrics Screen width/height:1600/1200 10:14:33 INFO - PROCESS | 2509 | colorDepth:24 10:14:33 INFO - PROCESS | 2509 | Browser inner width/height: 1024/697 10:14:33 INFO - PROCESS | 2509 | __metrics 10:14:33 INFO - PROCESS | 2509 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:14:34 INFO - TEST-INFO | 2509: exit 0 10:14:34 INFO - Browser initialized. 10:14:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:34 INFO - TEST-INFO | started process 2654 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6cFVhJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:35 INFO - PROCESS | 2654 | -- checkerboarding starts below -- 10:14:35 INFO - PROCESS | 2654 | RENDERTRACE 0.047532 rect red 0 0 10 10 // viewport 10:14:35 INFO - PROCESS | 2654 | RENDERTRACE 28.8449 rect brown 0 0 10 10 // page 10:14:35 INFO - PROCESS | 2654 | RENDERTRACE 28.8992 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 10:14:35 INFO - PROCESS | 2654 | Checkerboarded for 1 frames (33.1419 ms), 100 peak, 1 severity. 10:14:36 INFO - PROCESS | 2654 | 10:14:36 INFO - PROCESS | 2654 | (process:2747): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:14:46 INFO - PROCESS | 2654 | RSS: Main: 150884352 10:14:46 INFO - PROCESS | 2654 | 10:15:36 INFO - PROCESS | 2654 | 1453140936311 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] 10:17:44 INFO - PROCESS | 2654 | Cycle 1(1): loaded http://localhost:43843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43843/tests/dromaeo/cssquery-ext.html) 10:17:45 INFO - PROCESS | 2654 | RSS: Main: 156348416 10:17:45 INFO - PROCESS | 2654 | 10:20:47 INFO - PROCESS | 2654 | Cycle 1(1): loaded http://localhost:43843/tests/dromaeo/cssquery-ext.html (next: http://localhost:43843/tests/dromaeo/cssquery-jquery.html) 10:20:48 INFO - PROCESS | 2654 | RSS: Main: 151224320 10:20:48 INFO - PROCESS | 2654 | 10:23:50 INFO - PROCESS | 2654 | Cycle 1(1): loaded http://localhost:43843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43843/tests/dromaeo/cssquery-mootools.html) 10:23:50 INFO - PROCESS | 2654 | RSS: Main: 150880256 10:23:50 INFO - PROCESS | 2654 | 10:26:52 INFO - PROCESS | 2654 | Cycle 1(1): loaded http://localhost:43843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43843/tests/dromaeo/cssquery-prototype.html) 10:26:53 INFO - PROCESS | 2654 | RSS: Main: 149671936 10:26:53 INFO - PROCESS | 2654 | 10:29:55 INFO - PROCESS | 2654 | Cycle 1(1): loaded http://localhost:43843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43843/tests/dromaeo/cssquery-yui.html) 10:29:55 INFO - PROCESS | 2654 | RSS: Main: 150839296 10:29:55 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | Cycle 1(1): loaded http://localhost:43843/tests/dromaeo/cssquery-yui.html (next: http://localhost:43843/tests/dromaeo/cssquery-dojo.html) 10:32:58 INFO - PROCESS | 2654 | RSS: Main: 153354240 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | __start_tp_report 10:32:58 INFO - PROCESS | 2654 | _x_x_mozilla_page_load 10:32:58 INFO - PROCESS | 2654 | _x_x_mozilla_page_load_details 10:32:58 INFO - PROCESS | 2654 | |i|pagename|runs| 10:32:58 INFO - PROCESS | 2654 | |0;dojo.html;3178.729807966323;3193.9520907186384;3203.935921281573;3222.3394204188144;3230.2247460609447;5108.923366149511;5160.17437210046;5160.20016897381;5166.612504062196;5195.662281951671;5124.795008199668;5164.199549069891;5234.136367499358;5255.08036093683;5319.893602127955;4729.2433210686295;4737.526247375252;4751.976240118812;4799.832005879794;4821.156297647915;4783.9953609742;4813.78337974792;4826.396700412449;4860.586850117745;4865.464798872121;4685.92971105432;4722.268048452478;4729.763511824395;4793.664443488957;4807.399075115611;4697.412823397075;4716.009637976029;4724.126036683225;4731.929021064687;4773.284007398884;4679.321498382749;4710.62315014798;4712.340272361872;4723.929141062887;4792.592629626486;5043.5965122790085;5086.872828179288;5119.104156772587;5119.411267704188;5145.8936328689515;5535.280413546254;5548.195511650828;5575.637583557056;5578.30271216098;5586.938481688466;5514.641548299388;5585.916211256835;5622.353429355636;5626.156076588503;5653.745581448845;5242.79028838846;5248.475152484759;5282.154855223146;5282.735863206824;5318.734063296858;5667.319921609434;5681.914771278434;5686;5690;5702.54379649627;5420.159875219348;5472.863178420492;5493.450654934554;5546.611737178358;5567.387587365387;5577.498025177672;5581.916271255935;5590.720463976866;5603.691796951207;5620.4660557247;5570.108782594765;5574.665520068809;5583.832485025456;5592.944070559323;5595.552355811526;5492;5515.200295957064;5575.832725018256;5582;5644.717764111778;4343.1747967886;4355.237833379146;4357.411749413852;4381.474223093185;4397.626201772885;3853.3641949078087;3881.029742564359;3890.7665540067687;3905.3165696003653;3930.9017274568364;5093.2105523643895;5172.586193104543;5201.739913004335;5222.817201397933;5249.895002100013;5592.161175823659;5599.440055994368;5607.691576963306;5612.242347283064;5623.915641265385;5213.765380557884;5248.475152484797;5257.526822585909;5265.7103859287345;5270.7628156733035;4688.390509233846;4720.834770783006;4757.09615173116;4788.688735232199;4819.518048195152;5759.395263497357;5800.564957628195;5807.332156801937;5814.912776308359;5815.883682326415;5542.445755424425;5609.49514543693;5617.887642247214;5620.381758006698;5647.519960803378;5679.290088738908;5726;5749.080147176432;5772.797952071657;5791.276090488689;5491.917621235764;5500.532454741392;5505.807296744595;5511.173324001272;5527.060399732136;5462.399136095106;5522.088855338985;5551.306086739158;5572.77708891656;5574.386817450159;5486.451354864482;5514.558835293086;5520.447955204448;5531.0873705838085;5585.916211256753;5362.597805164551;5376.435474275145;5380.219868119179;5414.810481633124;5417.13325867875;5198.454162312903;5273.077211488051;5308.25684404176;5334.946650533445;5340.652857564246;5450.618456707993;5501.779928802963;5513.42109078557;5513.917291240715;5521.889562208814;5363.436839131835;5404.513593776579;5406.756695948613;5422.051141050221;5466.234727138283 10:32:58 INFO - PROCESS | 2654 | |1;ext.html;509.68144909431606;530.9301756959729;538.7952578020353;556.7967691792497;570.1277046119436;27307.453850922968;36036.2792744145;36182.638173618325;36271.637283627155;36476.08809779753;38460.42309365362;38869.61130388695;38925.805370973176;38927.61072389275;39106.8044659777;8259.091499935003;8540.829183416328;8610.44032137909;8625.26685231756;8629.913700863006;8342.16578342167;8579.871301930445;8651.437656552336;8671;8671.176238257387;8625.525596092213;8646.178613031752;8682.43564168327;8721.7819554511;8727.650893964266;8593.26957208638;8683.913160868373;8685.261752751023;8688.348373871922;8692.261157801595;8422.073571907085;8624.223819856243;8636.0932102129;8648.394612377137;8651.178138076873;38997.80501097505;39130.413043804365;39301.21397572061;39560;39620.40569391462;3304.9051121040684;3628.455731640249;3758.1732018955786;3988.501437320335;4148.771817550033;28797.712022879714;30237.244068898235;30696.2325941851;31188.688113118806;31665;3877.961220387788;3946.763194208328;3961.445397644332;3965.9801700991597;3981.6217459341315;198214;199314;199618;199951.99999999854;200068;42325.36511952323;43168.352474712905;59133.113003304126;59151.408485915454;59450;41089.38365924513;41144;41169.794151029055;41391.7930410346;41557;13053.738925221633;13200.14199077076;13269.73460530784;13307.933460332637;13308.866911330957;10086.596536138471;10159.136473399843;10227.59089636421;10259.897401026043;10267.178625709925;14279.78580321296;14316.28418579067;14894.957352985188;14936.775948360782;14937.759336099673;5657.179708942181;5663.320401551758;5738.397468265855;5747.4252574742195;5786.334571524244;892.5001998880648;907.6505545365083;952.4428209497383;953.0897992417225;1069.652362982034;28162;28493.430131397257;28676;28706.712932870403;28882;979.4319294808994;1024.9077583017415;1029.3463650581784;1044.749260177567;1084.2843723142687;14774;14938.477153299582;15011.924940375227;15011.924940375447;15052.774208386883;311438;311764;313746;316800;317402;51859.74070129625;52316;52340.214896776575;52470.21294680583;52501;1228.342836582424;1269.3653173413293;1272.338384040294;1274.2609286613927;1284.6146156153304;27710.307242319104;28277.858610706815;28537.28656783597;28557.143285701462;28585.28536786597;46345.76827115843;46561.301580477;46808.76595617;47042;47083;291627;292571;294364;295123;295591;32825;42574.361384579875;42618.786906065274;42638.36042459428;43779.34330984974;40129;40362.596374035886;40441.19117617572;40733.79633101816;40872.59127408807;36044.4593331095;36178.63821361752;36261.63738362583;36462.4530632046;37313;36514.8174259127;36884.81557592195;37041.44437833488;37156.81421592983;37384.626153739206;34423.45601996257;34746.826265868505;35342.823285884435;35398;35496;30749.8462507686;31079;32995.505067423524;33002.00993970185;33147.83426082854;25048.499030019662;25469;25600.743992559837;25611.871940640922;25790 10:32:58 INFO - PROCESS | 2654 | |2;jquery.html;360.86647940262105;361.22517200604705;368.43077445346927;369.1527943369966;371.37608817187146;15614;16928;16978.40575579855;17625.383111591098;18132;15475.45835895741;15548.144852033134;15638.921805390957;16087.195640218;16109.516714498584;4980.950190498094;5205.349331333583;5208.062548741225;5210.947890521104;5224.92162617561;5025.4472008079265;5062.31658726071;5155.71643559604;5529.198266251391;5538;5069.290299358093;5243.344581927259;5246.344206974129;5526.778928842861;5531.474509921551;5136.717480538568;5150.407703114133;5179.041877252702;5282.894342113136;5631.887362252773;5395.838124856221;5432.402435732066;5438.8912221755345;5443.047466693313;5444.346678398618;11523;13011.674708132372;13020.934895325558;13045.630208828126;13047.282399468026;2196.121551379445;2200.5818894410013;2202.0971401725214;2240.932772016842;2329.9650505242435;9738.659146929895;10708.839367409495;10821.026107650348;12633.93683031579;13252.403641836141;1787.7586525819108;1795.5959909020496;1816.9091545422675;1818.9363372281907;1880.9529761755928;55385.44614553843;56503.43496565023;57749.422505774826;57995.710021449624;58338.416615833725;9781.168600669023;10001;10017.39895606266;10078.244131690006;10082.243831712503;13099.672508187372;13110.541131060367;13212.33938303081;13221.603351899459;13284.468621255042;7100.112485939258;7176.031235783103;7182.676779544829;7200.819979500449;7224.133104027445;6571.441427478622;6572.638504882278;6606.372394622503;6606.471482281406;6631.10480085192;4376.124775045004;4491.820327186876;4511.70673906195;4514.6388288936805;4517.367568540407;1788.5334026098474;1844.2530775036132;1852.7313539536692;1869.8691091623728;1872.7752669679726;833.7248707926369;929.2380248196549;966.5940305071887;972.1542258235239;1022.8261195596766;15352.692946141238;16354.427595034116;16383.180840957904;16493.505194844172;16927.322907083824;922.8569571716395;974.6734843827397;987.5852142100335;996.5017491254373;1033.9896601034043;9403;9695.9030409695;9869.753256168653;10253.282270241161;10441.738956526147;423242;434899;435762;470601;513613;63442.36557634365;64979.350206498275;67049;68788;73057.2694273061;1135.5230803062734;1170.5025364220173;1177.5231031432284;1178.128185142988;1186.7567148734488;15420.84579154194;15427.61430964235;15488.5353439397;15714;15910;32272;32518;33172.561361857064;33378.16554586155;33581.160470987445;41973.580264196964;42836;43686.56313436825;45039.32441013322;45273.77363113163;7408.296211859864;7455.7017719290625;7468.551886886804;7486;7572.4699271050495;9194.448333100036;10202.183825294107;10527.842082368923;10703.304285221435;11518.424078796193;9433.48141337298;9588.66439674608;9794.951025244829;10171.949140254252;10178.440185789557;9278.304127190622;9914.40513569188;10039.196864250696;10045.49772511386;10078.445685487368;10178.592856285666;10272.33229840058;10369.859315475442;10421.895781042092;10629.574817007542;7182.030425892438;7448.925510744823;7471.476996610185;7473.103227612722;7489.588072656056;8219.917800822155;9489.051094890456;9537.52312384364;9690.75773105678;10302.587896484056 10:32:58 INFO - PROCESS | 2654 | |3;mootools.html;1442.877355424789;1460.6932544165725;1593.5617705131087;1740.7998080220761;1773.8846974946637;6405.1353067335895;6486.027095935612;7215.927840721592;7421.257874212576;7424.517406368589;7253.310935461136;7373.926260737391;7381.520201186919;7445.925540744591;7491.400687944965;2302.4474126209716;2329.359426157812;2334.9766502335015;2337.0534933351933;2340.0405833608224;2282.372347604414;2287.62254228053;2308.803751681109;2314.6643736658257;2314.93055208344;2272.9544409571618;2305.8501197422197;2312.6993490846166;2314.8611083335054;2335.5912715274844;2270.6366981283;2295.885205739706;2296.4832912594534;2298.436882963668;2298.4598619324447;2319.988400058006;2323;2326.1858349577683;2334.7781960713705;2349.306954448442;7627.80930476737;7727;7728.961355193244;7731.7680469586;7732.884006739903;4784.928226076577;4875.853724388274;4880.902381952341;4884.19410797218;4888.462269150391;3062.4640687879755;3066.861991210401;3187.681231876817;3215.5980502437196;3224.935501289961;996.4768496539375;1004.8794144702609;1005.6027868991707;1035.6685860524635;1105.8120119579692;10418.895811041868;10438.686839394755;10505;10579.947100264526;10583.259171857973;4359.084592235666;4390.47314322277;4442.73343599385;4485.349624304457;4486.7756612169915;9095.272378209727;9120.361574689709;9125.178733913846;9144.954275228582;9195.908040919505;4853.587445067209;4874.0495603357;4890.217565189552;4896.6572339935865;4917.631177661689;4274.7435153890865;4354.325079612665;4366.3013917773005;4405.911881762347;4482.484514280834;3577.713782897362;3585.0320413488735;3614.8915532534065;3618.2944325856733;3625.8549658013385;1134.6142311614092;1143.9599614013468;1151.740858306891;1161.8199179127248;1165.4930105404176;1047.3244757131608;1063.9308444951207;1069.8020866139789;1219.5609580550995;1351.513455156143;7318.634068296564;7338.082739657543;7344.853102937911;7354.117505899327;7359.558426494427;1092.819684752007;1104.640991677708;1106.0985296982933;1125.0999200639455;1131.5247596009697;5805.071188609802;5868.706564671749;5879.676617786063;5886;5902.704864756745;8797.340199485065;8914.777130571658;8944;8968.10318968098;8991.235744961621;8786.209241168326;8843.557822108869;8856.424332418372;8905.821883562292;8931.866022009675;6754;7049.859002819915;7079.823004424828;7093.716251349992;7097.680604372816;7083.291670832876;7088.787336379917;7102.644867756489;7177.354038136593;7283.672234749343;8023.077346105272;8027.638756256099;8279.296259817984;8362.49825010477;8364;8280.04779450371;8288.917110828814;8318.62566184511;8339.708110216114;8370.623321950648;6594.373534514213;6691.0967019451755;6738.427233685192;6743.52795304324;6910.896336555056;7255.600941948243;7298.56208627484;7305.050343455317;7325.377342925911;7361.153467351323;6714.6978385973725;6781.93218067813;6801.353871382211;6920.169579650475;6981.02265682815;6712.93287067123;6784.6946887389195;6787.626680532618;6830.009648600826;6906.792796216121;6844.897326540006;6905.274946130584;6909;6927.27263637331;7056.470764692566;6440.130582371507;6478.222613286247;6499.5775274607;6501.382368674968;6511.023346497874;6522.706478208587;6539.673016349068;6566.376194261537;6592;6602.63685497283 10:32:58 INFO - PROCESS | 2654 | |4;prototype.html;330.9123082383167;332.0172290021536;335.80019888166544;344.7138874733971;345.91525076356294;6238.376162383759;6347.5239357048295;6363.618182909028;6366.840828979278;6526.608403495782;6316.27362853272;6343.651099189554;6356.968215158918;6395.648239346846;6408.519361047916;4777.9761101194445;4778.2115950868065;4797.328374027621;4798.328234047236;4799.832005879794;4799.13615549201;4820.662553621248;4825.613950883939;4828.2274836026245;4837.685550439211;4666.160091183586;4764.404449443819;4775.331453596482;4784.928226076611;4790;4756.215224487973;4772.021735544223;4781.593564547018;4787.40157480315;4797.568218860284;4131.091159944837;4139.21354942563;4139.399787030864;4145.17096580685;4146.709730318879;5987.880242395127;6015.518758499309;6026.427489388545;6032.517398608101;6039.818805435844;5462.344518657746;5585.609007369486;5586.190002449663;5588.580856435743;5592.832215033555;6695.230048544431;6695.698693558801;6702.961041038598;6713.1944166700305;6723.93276067238;4522.050369422425;4549.954500454986;4557.794899229542;4558.680892337537;4563.703359281636;6724.462043036546;6974.686139123752;7010.75462358815;7031.859362812766;7047.612381319025;4703.412073490814;4708.458527269408;4720.575148236607;4723.031778485402;4735.786889589976;4798.304245884327;4798.712077275374;4799.592034677092;4807.086653535817;4810.11012962603;5569.944300557024;5572.08060669993;5573.080441727151;5575.972120139373;5576.9163462548095;6549.377809108127;6759.493038022168;6775.593464392152;6779.35596118368;6790.932090679129;1647.6869394814946;1655.4454257823763;1702.4041585444995;1704.1905095079985;1709.2479309103956;1084.6366467233565;1092.1044743310408;1099.9230053896151;1117.793208256475;1119.9048080913215;6279.843003924847;6290.308066112724;6302.653354065479;6319.526035547352;6322.0516922462;6795.52431329812;6796.898046529306;6825.761098361633;6842.6578671066245;6847.657617119125;6136.8772624547255;6262.592931459531;6279.717412716439;6287;6303;3709.534733780142;3732.2908647356917;3734.9066273343383;3739.569949455793;3741.1956429367815;7140.9285907140265;7144.392726618192;7152.713891444284;7159.606221657858;7183.138023437116;6949.027136200936;6961.40828029613;6987.26633703464;7007.299270073054;7012.894806577905;7335.926640733631;7337.41300695943;7346.96326518364;7361.190269070398;7365.48441609093;6941.132358455193;6972.163340399185;6974.476914231352;6984.301569842975;7001.194862590867;6828.7268509259075;6935.861282774215;6939.854923937695;6954.165500140016;6966.3730264276455;7246;7265.09186351706;7288.927110728825;7312;7321.816954575965;4653.674242802971;4663.253879379283;4689.882752931204;4702.177119004092;4702.318163866289;6805.9659701701175;6923.273056329214;6924.723011079501;6931.792046238419;6933.37599616037;6706.5640733352175;6717.462602991846;6727.663616819042;6771.627560484024;6786.049953006484;6670.366315200048;6762.661866906733;6771.119754431892;6773.458123350021;6779.661016949231;6404.199475065617;6610.206775187008;6620.337966203341;6653.63405012729;6655.833604159935;6749.021391898245;6753.3246675332075;6783.864322713617;6787.694553744995;6792.864142717217;6539.542232043711;6548.738050478118;6549.934500654933;6552.705128269144;6587.901181482186 10:32:58 INFO - PROCESS | 2654 | |5;yui.html;836.8075342671185;840.4999025579777;844.8479273730728;852.6078004118109;861.4486728493765;13487.055906086553;13496.122752021123;13616.387262573184;13634.318284085793;13635.318234088292;12547.435365408555;12585.685357866058;12594.874051259485;12654.683632909182;12691.492340306377;650.0574167457194;662.0995446193174;791.5171745235431;811.6347643560392;814.5194335342147;801.587182600958;806.0086094104255;809.3889113719164;809.4091313341264;810.5460941872541;835.8829763833069;850.4429598612887;852.7058164933119;852.8422241885271;853.3685073045964;841.6170642357713;842.6123982967842;846.0270688707974;846.4963346808609;849.1126772522729;618.8824123416537;621.2824188062749;623.2116372788427;624.522240486024;626.1859582542676;11728.651205111437;11821.113416493798;11844.881551184464;11871.406429678482;11897.167198296123;12841.35793210345;13130.54043108496;13360.732785344337;13466;13510.324483775772;10389.37663740178;10732.087772539266;11119.833202501968;11290.943545282304;11338.263012904217;3621.257642183346;3636.272745450894;3647.507586475845;3704.1850792825535;3793.715471339633;45849.312260316125;45943;46351.304730429074;46442.53557464416;46550.53449465462;9435.433873967584;9799.804003919882;9868.457234852152;9984.251181161442;10279.434631095211;17691.823081769016;17764;17800.643987120184;18086.366977155736;18420;7574.848503029909;7790.415718821111;7803.336716379172;7834.255745704149;7888.1323054463965;4230.302000169938;4303.827846886152;4311.978440107842;4345.109252603272;4346.1090476452255;3010.4129694709322;3011.4579375712583;3014.3519143383837;3014.954775678367;3017.8189308641113;564.5342592361318;580.2427831679614;586.3696526234315;590.4715279824533;593.7476572456775;611.7522403426619;617.9073139029182;624.8781487609963;686.087503620184;730.5799165479871;8902.643894244287;8919;9014.323925705467;9090.090990900857;9126.634934602675;534.767376191358;646.809191288571;682.7337338438014;684.5721424109931;692.5325405351367;4177.289860723684;4183.45615070045;4299.505556861001;4307.396964424983;4428.247197976351;53217;53747.46252537425;53785;55594.72202639042;56775;46985.5301446988;47054.5294547057;47120.528794711616;47425.28862067072;47591;44853.327200092026;44927.775361122985;45114.32328515075;45130.097398051854;45274.54725452769;8720.825583488422;8854.114588541352;8878.556072196494;8898.688545900863;8949.59726812308;33039.50440743439;33820.154496137795;33871.83064084664;33983.15042123967;34043.31913361768;39832.2033559333;40320.1935961285;43807.34288985732;44711.329330060726;47001.29498057463;10805.02754752076;11109.722256943642;11277.548898044315;11384.829227561759;11532.192746507999;12362.938185309016;12631.87368126307;12809.8078528824;12810.295433751233;12823.038272129814;11523;11783.116266280234;12119.575814846437;12135.696607584881;12435;11466.369349685847;11756.764864702829;11778.882211177779;12042.337671428155;12244.326562039174;10919;10985.83521247166;11431.314121152758;11495.885041149482;11573.594924177612;9316.161545460942;9390.24878009744;9397.671081512115;9620.972492414083;9654.951725241328;8675.436096653697;8792.736217913473;9219.815603688023;9302.395344302598;9834 10:32:58 INFO - PROCESS | 2654 | __end_tp_report 10:32:58 INFO - PROCESS | 2654 | __start_cc_report 10:32:58 INFO - PROCESS | 2654 | _x_x_mozilla_cycle_collect,317 10:32:58 INFO - PROCESS | 2654 | __end_cc_report 10:32:58 INFO - PROCESS | 2654 | __startTimestamp1453141978638__endTimestamp 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | ------- Summary: start ------- 10:32:58 INFO - PROCESS | 2654 | Number of tests: 6 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | [#0] dojo.html Cycles:165 Average:5188.74 Median:5376.44 stddev:556.22 (10.3%) stddev-sans-first:535.11 10:32:58 INFO - PROCESS | 2654 | Values: 3178.7 3194.0 3203.9 3222.3 3230.2 5108.9 5160.2 5160.2 5166.6 5195.7 5124.8 5164.2 5234.1 5255.1 5319.9 4729.2 4737.5 4752.0 4799.8 4821.2 4784.0 4813.8 4826.4 4860.6 4865.5 4685.9 4722.3 4729.8 4793.7 4807.4 4697.4 4716.0 4724.1 4731.9 4773.3 4679.3 4710.6 4712.3 4723.9 4792.6 5043.6 5086.9 5119.1 5119.4 5145.9 5535.3 5548.2 5575.6 5578.3 5586.9 5514.6 5585.9 5622.4 5626.2 5653.7 5242.8 5248.5 5282.2 5282.7 5318.7 5667.3 5681.9 5686.0 5690.0 5702.5 5420.2 5472.9 5493.5 5546.6 5567.4 5577.5 5581.9 5590.7 5603.7 5620.5 5570.1 5574.7 5583.8 5592.9 5595.6 5492.0 5515.2 5575.8 5582.0 5644.7 4343.2 4355.2 4357.4 4381.5 4397.6 3853.4 3881.0 3890.8 3905.3 3930.9 5093.2 5172.6 5201.7 5222.8 5249.9 5592.2 5599.4 5607.7 5612.2 5623.9 5213.8 5248.5 5257.5 5265.7 5270.8 4688.4 4720.8 4757.1 4788.7 4819.5 5759.4 5800.6 5807.3 5814.9 5815.9 5542.4 5609.5 5617.9 5620.4 5647.5 5679.3 5726.0 5749.1 5772.8 5791.3 5491.9 5500.5 5505.8 5511.2 5527.1 5462.4 5522.1 5551.3 5572.8 5574.4 5486.5 5514.6 5520.4 5531.1 5585.9 5362.6 5376.4 5380.2 5414.8 5417.1 5198.5 5273.1 5308.3 5334.9 5340.7 5450.6 5501.8 5513.4 5513.9 5521.9 5363.4 5404.5 5406.8 5422.1 5466.2 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | [#1] ext.html Cycles:180 Average:43376.11 Median:37234.91 stddev:71596.51 (192.3%) stddev-sans-first:71725.01 10:32:58 INFO - PROCESS | 2654 | Values: 509.7 530.9 538.8 556.8 570.1 27307.5 36036.3 36182.6 36271.6 36476.1 38460.4 38869.6 38925.8 38927.6 39106.8 8259.1 8540.8 8610.4 8625.3 8629.9 8342.2 8579.9 8651.4 8671.0 8671.2 8625.5 8646.2 8682.4 8721.8 8727.7 8593.3 8683.9 8685.3 8688.3 8692.3 8422.1 8624.2 8636.1 8648.4 8651.2 38997.8 39130.4 39301.2 39560.0 39620.4 3304.9 3628.5 3758.2 3988.5 4148.8 28797.7 30237.2 30696.2 31188.7 31665.0 3878.0 3946.8 3961.4 3966.0 3981.6 198214.0 199314.0 199618.0 199952.0 200068.0 42325.4 43168.4 59133.1 59151.4 59450.0 41089.4 41144.0 41169.8 41391.8 41557.0 13053.7 13200.1 13269.7 13307.9 13308.9 10086.6 10159.1 10227.6 10259.9 10267.2 14279.8 14316.3 14895.0 14936.8 14937.8 5657.2 5663.3 5738.4 5747.4 5786.3 892.5 907.7 952.4 953.1 1069.7 28162.0 28493.4 28676.0 28706.7 28882.0 979.4 1024.9 1029.3 1044.7 1084.3 14774.0 14938.5 15011.9 15011.9 15052.8 311438.0 311764.0 313746.0 316800.0 317402.0 51859.7 52316.0 52340.2 52470.2 52501.0 1228.3 1269.4 1272.3 1274.3 1284.6 27710.3 28277.9 28537.3 28557.1 28585.3 46345.8 46561.3 46808.8 47042.0 47083.0 291627.0 292571.0 294364.0 295123.0 295591.0 32825.0 42574.4 42618.8 42638.4 43779.3 40129.0 40362.6 40441.2 40733.8 40872.6 36044.5 36178.6 36261.6 36462.5 37313.0 36514.8 36884.8 37041.4 37156.8 37384.6 34423.5 34746.8 35342.8 35398.0 35496.0 30749.8 31079.0 32995.5 33002.0 33147.8 25048.5 25469.0 25600.7 25611.9 25790.0 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | [#2] jquery.html Cycles:180 Average:24942.97 Median:435330.50 stddev:74692.31 (17.2%) stddev-sans-first:74879.04 10:32:58 INFO - PROCESS | 2654 | Values: 360.9 361.2 368.4 369.2 371.4 15614.0 16928.0 16978.4 17625.4 18132.0 15475.5 15548.1 15638.9 16087.2 16109.5 4981.0 5205.3 5208.1 5210.9 5224.9 5025.4 5062.3 5155.7 5529.2 5538.0 5069.3 5243.3 5246.3 5526.8 5531.5 5136.7 5150.4 5179.0 5282.9 5631.9 5395.8 5432.4 5438.9 5443.0 5444.3 11523.0 13011.7 13020.9 13045.6 13047.3 2196.1 2200.6 2202.1 2240.9 2330.0 9738.7 10708.8 10821.0 12633.9 13252.4 1787.8 1795.6 1816.9 1818.9 1881.0 55385.4 56503.4 57749.4 57995.7 58338.4 9781.2 10001.0 10017.4 10078.2 10082.2 13099.7 13110.5 13212.3 13221.6 13284.5 7100.1 7176.0 7182.7 7200.8 7224.1 6571.4 6572.6 6606.4 6606.5 6631.1 4376.1 4491.8 4511.7 4514.6 4517.4 1788.5 1844.3 1852.7 1869.9 1872.8 833.7 929.2 966.6 972.2 1022.8 15352.7 16354.4 16383.2 16493.5 16927.3 922.9 974.7 987.6 996.5 1034.0 9403.0 9695.9 9869.8 10253.3 10441.7 423242.0 434899.0 435762.0 470601.0 513613.0 63442.4 64979.4 67049.0 68788.0 73057.3 1135.5 1170.5 1177.5 1178.1 1186.8 15420.8 15427.6 15488.5 15714.0 15910.0 32272.0 32518.0 33172.6 33378.2 33581.2 41973.6 42836.0 43686.6 45039.3 45273.8 7408.3 7455.7 7468.6 7486.0 7572.5 9194.4 10202.2 10527.8 10703.3 11518.4 9433.5 9588.7 9795.0 10171.9 10178.4 9278.3 9914.4 10039.2 10045.5 10078.4 10178.6 10272.3 10369.9 10421.9 10629.6 7182.0 7448.9 7471.5 7473.1 7489.6 8219.9 9489.1 9537.5 9690.8 10302.6 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | [#3] mootools.html Cycles:180 Average:5389.28 Median:6459.18 stddev:2713.23 (42.0%) stddev-sans-first:2704.63 10:32:58 INFO - PROCESS | 2654 | Values: 1442.9 1460.7 1593.6 1740.8 1773.9 6405.1 6486.0 7215.9 7421.3 7424.5 7253.3 7373.9 7381.5 7445.9 7491.4 2302.4 2329.4 2335.0 2337.1 2340.0 2282.4 2287.6 2308.8 2314.7 2314.9 2273.0 2305.9 2312.7 2314.9 2335.6 2270.6 2295.9 2296.5 2298.4 2298.5 2320.0 2323.0 2326.2 2334.8 2349.3 7627.8 7727.0 7729.0 7731.8 7732.9 4784.9 4875.9 4880.9 4884.2 4888.5 3062.5 3066.9 3187.7 3215.6 3224.9 996.5 1004.9 1005.6 1035.7 1105.8 10418.9 10438.7 10505.0 10579.9 10583.3 4359.1 4390.5 4442.7 4485.3 4486.8 9095.3 9120.4 9125.2 9145.0 9195.9 4853.6 4874.0 4890.2 4896.7 4917.6 4274.7 4354.3 4366.3 4405.9 4482.5 3577.7 3585.0 3614.9 3618.3 3625.9 1134.6 1144.0 1151.7 1161.8 1165.5 1047.3 1063.9 1069.8 1219.6 1351.5 7318.6 7338.1 7344.9 7354.1 7359.6 1092.8 1104.6 1106.1 1125.1 1131.5 5805.1 5868.7 5879.7 5886.0 5902.7 8797.3 8914.8 8944.0 8968.1 8991.2 8786.2 8843.6 8856.4 8905.8 8931.9 6754.0 7049.9 7079.8 7093.7 7097.7 7083.3 7088.8 7102.6 7177.4 7283.7 8023.1 8027.6 8279.3 8362.5 8364.0 8280.0 8288.9 8318.6 8339.7 8370.6 6594.4 6691.1 6738.4 6743.5 6910.9 7255.6 7298.6 7305.1 7325.4 7361.2 6714.7 6781.9 6801.4 6920.2 6981.0 6712.9 6784.7 6787.6 6830.0 6906.8 6844.9 6905.3 6909.0 6927.3 7056.5 6440.1 6478.2 6499.6 6501.4 6511.0 6522.7 6539.7 6566.4 6592.0 6602.6 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | [#4] prototype.html Cycles:180 Average:5598.66 Median:6320.79 stddev:1708.82 (27.0%) stddev-sans-first:1667.24 10:32:58 INFO - PROCESS | 2654 | Values: 330.9 332.0 335.8 344.7 345.9 6238.4 6347.5 6363.6 6366.8 6526.6 6316.3 6343.7 6357.0 6395.6 6408.5 4778.0 4778.2 4797.3 4798.3 4799.8 4799.1 4820.7 4825.6 4828.2 4837.7 4666.2 4764.4 4775.3 4784.9 4790.0 4756.2 4772.0 4781.6 4787.4 4797.6 4131.1 4139.2 4139.4 4145.2 4146.7 5987.9 6015.5 6026.4 6032.5 6039.8 5462.3 5585.6 5586.2 5588.6 5592.8 6695.2 6695.7 6703.0 6713.2 6723.9 4522.1 4550.0 4557.8 4558.7 4563.7 6724.5 6974.7 7010.8 7031.9 7047.6 4703.4 4708.5 4720.6 4723.0 4735.8 4798.3 4798.7 4799.6 4807.1 4810.1 5569.9 5572.1 5573.1 5576.0 5576.9 6549.4 6759.5 6775.6 6779.4 6790.9 1647.7 1655.4 1702.4 1704.2 1709.2 1084.6 1092.1 1099.9 1117.8 1119.9 6279.8 6290.3 6302.7 6319.5 6322.1 6795.5 6796.9 6825.8 6842.7 6847.7 6136.9 6262.6 6279.7 6287.0 6303.0 3709.5 3732.3 3734.9 3739.6 3741.2 7140.9 7144.4 7152.7 7159.6 7183.1 6949.0 6961.4 6987.3 7007.3 7012.9 7335.9 7337.4 7347.0 7361.2 7365.5 6941.1 6972.2 6974.5 6984.3 7001.2 6828.7 6935.9 6939.9 6954.2 6966.4 7246.0 7265.1 7288.9 7312.0 7321.8 4653.7 4663.3 4689.9 4702.2 4702.3 6806.0 6923.3 6924.7 6931.8 6933.4 6706.6 6717.5 6727.7 6771.6 6786.0 6670.4 6762.7 6771.1 6773.5 6779.7 6404.2 6610.2 6620.3 6653.6 6655.8 6749.0 6753.3 6783.9 6787.7 6792.9 6539.5 6548.7 6549.9 6552.7 6587.9 10:32:58 INFO - PROCESS | 2654 | 10:32:58 INFO - PROCESS | 2654 | [#5] yui.html Cycles:180 Average:13481.60 Median:45896.16 stddev:15139.90 (33.0%) stddev-sans-first:15152.60 10:32:58 INFO - PROCESS | 2654 | Values: 836.8 840.5 844.8 852.6 861.4 13487.1 13496.1 13616.4 13634.3 13635.3 12547.4 12585.7 12594.9 12654.7 12691.5 650.1 662.1 791.5 811.6 814.5 801.6 806.0 809.4 809.4 810.5 835.9 850.4 852.7 852.8 853.4 841.6 842.6 846.0 846.5 849.1 618.9 621.3 623.2 624.5 626.2 11728.7 11821.1 11844.9 11871.4 11897.2 12841.4 13130.5 13360.7 13466.0 13510.3 10389.4 10732.1 11119.8 11290.9 11338.3 3621.3 3636.3 3647.5 3704.2 3793.7 45849.3 45943.0 46351.3 46442.5 46550.5 9435.4 9799.8 9868.5 9984.3 10279.4 17691.8 17764.0 17800.6 18086.4 18420.0 7574.8 7790.4 7803.3 7834.3 7888.1 4230.3 4303.8 4312.0 4345.1 4346.1 3010.4 3011.5 3014.4 3015.0 3017.8 564.5 580.2 586.4 590.5 593.7 611.8 617.9 624.9 686.1 730.6 8902.6 8919.0 9014.3 9090.1 9126.6 534.8 646.8 682.7 684.6 692.5 4177.3 4183.5 4299.5 4307.4 4428.2 53217.0 53747.5 53785.0 55594.7 56775.0 46985.5 47054.5 47120.5 47425.3 47591.0 44853.3 44927.8 45114.3 45130.1 45274.5 8720.8 8854.1 8878.6 8898.7 8949.6 33039.5 33820.2 33871.8 33983.2 34043.3 39832.2 40320.2 43807.3 44711.3 47001.3 10805.0 11109.7 11277.5 11384.8 11532.2 12362.9 12631.9 12809.8 12810.3 12823.0 11523.0 11783.1 12119.6 12135.7 12435.0 11466.4 11756.8 11778.9 12042.3 12244.3 10919.0 10985.8 11431.3 11495.9 11573.6 9316.2 9390.2 9397.7 9621.0 9655.0 8675.4 8792.7 9219.8 9302.4 9834.0 10:32:58 INFO - PROCESS | 2654 | -------- Summary: end -------- 10:32:58 INFO - PROCESS | 2654 | 10:32:59 INFO - TEST-INFO | 2654: exit 0 10:32:59 INFO - TEST-OK | dromaeo_css | took 1111427ms 10:32:59 INFO - TEST-START | kraken 10:32:59 INFO - operating with platform_type : linux_ 10:32:59 INFO - Initialising browser for kraken test... 10:32:59 INFO - TEST-INFO | started process 3003 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ06pq6/profile http://localhost:43843/getInfo.html) 10:33:02 INFO - PROCESS | 3003 | -- checkerboarding starts below -- 10:33:02 INFO - PROCESS | 3003 | RENDERTRACE 0.051113 rect red 0 0 1024 768 // viewport 10:33:02 INFO - PROCESS | 3003 | RENDERTRACE 9.1676 rect brown 0 0 1024 768 // page 10:33:02 INFO - PROCESS | 3003 | RENDERTRACE 9.18595 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 10:33:02 INFO - PROCESS | 3003 | Checkerboarded for 1 frames (17.025 ms), 786432 peak, 12693 severity. 10:33:03 INFO - PROCESS | 3003 | 10:33:03 INFO - PROCESS | 3003 | (process:3073): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:33:04 INFO - PROCESS | 3003 | __metrics Screen width/height:1600/1200 10:33:04 INFO - PROCESS | 3003 | colorDepth:24 10:33:04 INFO - PROCESS | 3003 | Browser inner width/height: 1024/697 10:33:04 INFO - PROCESS | 3003 | __metrics 10:33:04 INFO - PROCESS | 3003 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:33:05 INFO - TEST-INFO | 3003: exit 0 10:33:05 INFO - Browser initialized. 10:33:05 INFO - Running cycle 1/1 for kraken test... 10:33:05 INFO - TEST-INFO | started process 3121 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ06pq6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:06 INFO - PROCESS | 3121 | -- checkerboarding starts below -- 10:33:06 INFO - PROCESS | 3121 | RENDERTRACE 0.046817 rect red 0 0 10 10 // viewport 10:33:06 INFO - PROCESS | 3121 | RENDERTRACE 55.3741 rect brown 0 0 10 10 // page 10:33:06 INFO - PROCESS | 3121 | RENDERTRACE 55.3991 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 10:33:06 INFO - PROCESS | 3121 | Checkerboarded for 1 frames (67.3956 ms), 100 peak, 1 severity. 10:33:06 INFO - PROCESS | 3121 | 10:33:06 INFO - PROCESS | 3121 | (process:3181): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:33:17 INFO - PROCESS | 3121 | RSS: Main: 150331392 10:33:17 INFO - PROCESS | 3121 | 10:33:19 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43843/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:20 INFO - PROCESS | 3121 | RSS: Main: 151056384 10:33:20 INFO - PROCESS | 3121 | 10:33:23 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43843/tests/kraken/driver.html?testName=audio-dft) 10:33:23 INFO - PROCESS | 3121 | RSS: Main: 154472448 10:33:23 INFO - PROCESS | 3121 | 10:33:26 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43843/tests/kraken/driver.html?testName=audio-fft) 10:33:27 INFO - PROCESS | 3121 | RSS: Main: 148279296 10:33:27 INFO - PROCESS | 3121 | 10:33:29 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43843/tests/kraken/driver.html?testName=audio-oscillator) 10:33:29 INFO - PROCESS | 3121 | RSS: Main: 148692992 10:33:29 INFO - PROCESS | 3121 | 10:33:31 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:32 INFO - PROCESS | 3121 | RSS: Main: 149250048 10:33:32 INFO - PROCESS | 3121 | 10:33:35 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43843/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:36 INFO - PROCESS | 3121 | RSS: Main: 148688896 10:33:36 INFO - PROCESS | 3121 | 10:33:39 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43843/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:39 INFO - PROCESS | 3121 | RSS: Main: 147832832 10:33:39 INFO - PROCESS | 3121 | 10:33:42 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43843/tests/kraken/driver.html?testName=json-parse-financial) 10:33:43 INFO - PROCESS | 3121 | RSS: Main: 147750912 10:33:43 INFO - PROCESS | 3121 | 10:33:45 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:45 INFO - PROCESS | 3121 | RSS: Main: 149368832 10:33:45 INFO - PROCESS | 3121 | 10:33:47 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:48 INFO - PROCESS | 3121 | RSS: Main: 149598208 10:33:48 INFO - PROCESS | 3121 | 10:33:50 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:50 INFO - PROCESS | 3121 | RSS: Main: 149868544 10:33:50 INFO - PROCESS | 3121 | 10:33:53 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:53 INFO - PROCESS | 3121 | RSS: Main: 150290432 10:33:53 INFO - PROCESS | 3121 | 10:33:56 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:56 INFO - PROCESS | 3121 | RSS: Main: 149880832 10:33:56 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | Cycle 1(1): loaded http://localhost:43843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43843/tests/kraken/driver.html?testName=ai-astar) 10:33:58 INFO - PROCESS | 3121 | RSS: Main: 149504000 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | __start_tp_report 10:33:58 INFO - PROCESS | 3121 | _x_x_mozilla_page_load 10:33:58 INFO - PROCESS | 3121 | _x_x_mozilla_page_load_details 10:33:58 INFO - PROCESS | 3121 | |i|pagename|runs| 10:33:58 INFO - PROCESS | 3121 | |0;ai-astar;112;107;112;110;111;122;111;110;111;110 10:33:58 INFO - PROCESS | 3121 | |1;audio-beat-detection;150;132;154;163;130;153;147;133;162;128 10:33:58 INFO - PROCESS | 3121 | |2;audio-dft;162;164;163;161;163;161;162;163;174;162 10:33:58 INFO - PROCESS | 3121 | |3;audio-fft;73;75;75;73;75;73;129;75;74;74 10:33:58 INFO - PROCESS | 3121 | |4;audio-oscillator;97;97;142;95;96;96;148;95;97;152 10:33:58 INFO - PROCESS | 3121 | |5;imaging-gaussian-blur;110;110;109;110;110;110;110;109;110;109 10:33:58 INFO - PROCESS | 3121 | |6;imaging-darkroom;148;147;148;147;147;146;147;146;147;149 10:33:58 INFO - PROCESS | 3121 | |7;imaging-desaturate;96;97;97;101;96;97;97;97;96;97 10:33:58 INFO - PROCESS | 3121 | |8;json-parse-financial;61;62;61;61;62;62;63;62;78;60 10:33:58 INFO - PROCESS | 3121 | |9;json-stringify-tinderbox;68;68;69;68;68;69;69;70;68;68 10:33:58 INFO - PROCESS | 3121 | |10;stanford-crypto-aes;81;90;84;85;83;90;85;82;85;82 10:33:58 INFO - PROCESS | 3121 | |11;stanford-crypto-ccm;120;116;121;120;124;114;119;120;118;127 10:33:58 INFO - PROCESS | 3121 | |12;stanford-crypto-pbkdf2;130;141;137;143;142;140;139;138;145;150 10:33:58 INFO - PROCESS | 3121 | |13;stanford-crypto-sha256-iterative;68;69;67;65;68;67;68;67;68;68 10:33:58 INFO - PROCESS | 3121 | __end_tp_report 10:33:58 INFO - PROCESS | 3121 | __start_cc_report 10:33:58 INFO - PROCESS | 3121 | _x_x_mozilla_cycle_collect,745 10:33:58 INFO - PROCESS | 3121 | __end_cc_report 10:33:58 INFO - PROCESS | 3121 | __startTimestamp1453142038808__endTimestamp 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | ------- Summary: start ------- 10:33:58 INFO - PROCESS | 3121 | Number of tests: 14 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:3.92 (3.5%) stddev-sans-first:4.16 10:33:58 INFO - PROCESS | 3121 | Values: 112.0 107.0 112.0 110.0 111.0 122.0 111.0 110.0 111.0 110.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:151.50 stddev:13.39 (8.8%) stddev-sans-first:14.09 10:33:58 INFO - PROCESS | 3121 | Values: 150.0 132.0 154.0 163.0 130.0 153.0 147.0 133.0 162.0 128.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.81 (2.3%) stddev-sans-first:4.00 10:33:58 INFO - PROCESS | 3121 | Values: 162.0 164.0 163.0 161.0 163.0 161.0 162.0 163.0 174.0 162.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#3] audio-fft Cycles:10 Average:79.60 Median:74.50 stddev:17.38 (23.3%) stddev-sans-first:18.27 10:33:58 INFO - PROCESS | 3121 | Values: 73.0 75.0 75.0 73.0 75.0 73.0 129.0 75.0 74.0 74.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:96.00 stddev:24.85 (25.9%) stddev-sans-first:25.80 10:33:58 INFO - PROCESS | 3121 | Values: 97.0 97.0 142.0 95.0 96.0 96.0 148.0 95.0 97.0 152.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:33:58 INFO - PROCESS | 3121 | Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 10:33:58 INFO - PROCESS | 3121 | Values: 148.0 147.0 148.0 147.0 147.0 146.0 147.0 146.0 147.0 149.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:1.45 (1.5%) stddev-sans-first:1.48 10:33:58 INFO - PROCESS | 3121 | Values: 96.0 97.0 97.0 101.0 96.0 97.0 97.0 97.0 96.0 97.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:62.00 stddev:5.27 (8.5%) stddev-sans-first:5.53 10:33:58 INFO - PROCESS | 3121 | Values: 61.0 62.0 61.0 61.0 62.0 62.0 63.0 62.0 78.0 60.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 10:33:58 INFO - PROCESS | 3121 | Values: 68.0 68.0 69.0 68.0 68.0 69.0 69.0 70.0 68.0 68.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:3.13 (3.7%) stddev-sans-first:3.02 10:33:58 INFO - PROCESS | 3121 | Values: 81.0 90.0 84.0 85.0 83.0 90.0 85.0 82.0 85.0 82.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:120.00 stddev:3.70 (3.1%) stddev-sans-first:3.92 10:33:58 INFO - PROCESS | 3121 | Values: 120.0 116.0 121.0 120.0 124.0 114.0 119.0 120.0 118.0 127.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:141.50 stddev:5.28 (3.7%) stddev-sans-first:4.00 10:33:58 INFO - PROCESS | 3121 | Values: 130.0 141.0 137.0 143.0 142.0 140.0 139.0 138.0 145.0 150.0 10:33:58 INFO - PROCESS | 3121 | 10:33:58 INFO - PROCESS | 3121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 10:33:58 INFO - PROCESS | 3121 | Values: 68.0 69.0 67.0 65.0 68.0 67.0 68.0 67.0 68.0 68.0 10:33:58 INFO - PROCESS | 3121 | -------- Summary: end -------- 10:33:58 INFO - PROCESS | 3121 | 10:33:59 INFO - TEST-INFO | 3121: exit 0 10:33:59 INFO - TEST-OK | kraken | took 60443ms 10:33:59 INFO - TEST-START | v8_7 10:33:59 INFO - operating with platform_type : linux_ 10:33:59 INFO - Initialising browser for v8_7 test... 10:33:59 INFO - TEST-INFO | started process 3409 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFnzTWI/profile http://localhost:43843/getInfo.html) 10:34:03 INFO - PROCESS | 3409 | 10:34:03 INFO - PROCESS | 3409 | (process:3483): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:34:05 INFO - PROCESS | 3409 | __metrics Screen width/height:1600/1200 10:34:05 INFO - PROCESS | 3409 | colorDepth:24 10:34:05 INFO - PROCESS | 3409 | Browser inner width/height: 1024/697 10:34:05 INFO - PROCESS | 3409 | __metrics 10:34:05 INFO - PROCESS | 3409 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:34:05 INFO - PROCESS | 3409 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:34:06 INFO - TEST-INFO | 3409: exit 0 10:34:06 INFO - Browser initialized. 10:34:06 INFO - Running cycle 1/1 for v8_7 test... 10:34:06 INFO - TEST-INFO | started process 3531 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFnzTWI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:06 INFO - PROCESS | 3531 | -- checkerboarding starts below -- 10:34:06 INFO - PROCESS | 3531 | RENDERTRACE 0.046495 rect red 0 0 10 10 // viewport 10:34:06 INFO - PROCESS | 3531 | RENDERTRACE 19.0858 rect brown 0 0 10 10 // page 10:34:06 INFO - PROCESS | 3531 | RENDERTRACE 19.1139 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 10:34:06 INFO - PROCESS | 3531 | Checkerboarded for 1 frames (21.0831 ms), 100 peak, 1 severity. 10:34:07 INFO - PROCESS | 3531 | 10:34:07 INFO - PROCESS | 3531 | (process:3590): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:34:17 INFO - PROCESS | 3531 | RSS: Main: 149975040 10:34:17 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:43843/tests/v8_7/run.html (next: http://localhost:43843/tests/v8_7/run.html) 10:34:40 INFO - PROCESS | 3531 | RSS: Main: 146534400 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | __start_tp_report 10:34:40 INFO - PROCESS | 3531 | _x_x_mozilla_page_load 10:34:40 INFO - PROCESS | 3531 | _x_x_mozilla_page_load_details 10:34:40 INFO - PROCESS | 3531 | |i|pagename|runs| 10:34:40 INFO - PROCESS | 3531 | |0;Richards;167.33601070950468 10:34:40 INFO - PROCESS | 3531 | |1;DeltaBlue;187.65246762994934 10:34:40 INFO - PROCESS | 3531 | |2;Encrypt;282.56569652444193 10:34:40 INFO - PROCESS | 3531 | |3;Decrypt;5213.541666666667 10:34:40 INFO - PROCESS | 3531 | |4;RayTrace;1062.6992561105208 10:34:40 INFO - PROCESS | 3531 | |5;Earley;722.0216606498195 10:34:40 INFO - PROCESS | 3531 | |6;Boyer;12407.407407407407 10:34:40 INFO - PROCESS | 3531 | |7;RegExp;40620 10:34:40 INFO - PROCESS | 3531 | |8;Splay;617.6652254478073 10:34:40 INFO - PROCESS | 3531 | |9;NavierStokes;4822.115384615385 10:34:40 INFO - PROCESS | 3531 | __end_tp_report 10:34:40 INFO - PROCESS | 3531 | __startTimestamp1453142080630__endTimestamp 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | ------- Summary: start ------- 10:34:40 INFO - PROCESS | 3531 | Number of tests: 10 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 167.3 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#1] DeltaBlue Cycles:1 Average:187.65 Median:187.65 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 187.7 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 282.6 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 5213.5 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 1062.7 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 722.0 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 12407.4 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#7] RegExp Cycles:1 Average:40620.00 Median:40620.00 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 40620.0 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#8] Splay Cycles:1 Average:617.67 Median:617.67 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 617.7 10:34:40 INFO - PROCESS | 3531 | 10:34:40 INFO - PROCESS | 3531 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:34:40 INFO - PROCESS | 3531 | Values: 4822.1 10:34:40 INFO - PROCESS | 3531 | -------- Summary: end -------- 10:34:40 INFO - PROCESS | 3531 | 10:34:41 INFO - TEST-INFO | 3531: exit 0 10:34:41 INFO - TEST-OK | v8_7 | took 41746ms 10:34:41 INFO - SUITE-END | took 1213s 10:34:41 INFO - Completed test suite (00:20:13) 10:34:41 INFO - Working with test: dromaeo_css 10:34:41 INFO - Generating results file: dromaeo_css 10:34:41 INFO - Working with test: kraken 10:34:41 INFO - Generating results file: kraken 10:34:41 INFO - javascript benchmark 10:34:41 INFO - Working with test: v8_7 10:34:41 INFO - Generating results file: v8_7 10:34:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:34:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:34:41 INFO - process_Request line: dromaeo_css 6855.80 graph.html#tests=[[72,1,43]] 10:34:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:34:41 INFO - process_Request line: kraken 1509.70 graph.html#tests=[[232,1,43]] 10:34:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:34:41 INFO - process_Request line: v8_7 20296.91 graph.html#tests=[[230,1,43]] 10:34:41 INFO - RETURN: dromaeo_css: 6855.80 10:34:41 INFO - RETURN: kraken: 1509.70 10:34:41 INFO - RETURN: v8_7: 20296.91 10:34:41 INFO - javascript benchmark 10:34:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3178.729807966323, 3193.9520907186384, 3203.935921281573, 3222.3394204188144, 3230.2247460609447, 5108.923366149511, 5160.17437210046, 5160.20016897381, 5166.612504062196, 5195.662281951671, 5124.795008199668, 5164.199549069891, 5234.136367499358, 5255.08036093683, 5319.893602127955, 4729.2433210686295, 4737.526247375252, 4751.976240118812, 4799.832005879794, 4821.156297647915, 4783.9953609742, 4813.78337974792, 4826.396700412449, 4860.586850117745, 4865.464798872121, 4685.92971105432, 4722.268048452478, 4729.763511824395, 4793.664443488957, 4807.399075115611, 4697.412823397075, 4716.009637976029, 4724.126036683225, 4731.929021064687, 4773.284007398884, 4679.321498382749, 4710.62315014798, 4712.340272361872, 4723.929141062887, 4792.592629626486, 5043.5965122790085, 5086.872828179288, 5119.104156772587, 5119.411267704188, 5145.8936328689515, 5535.280413546254, 5548.195511650828, 5575.637583557056, 5578.30271216098, 5586.938481688466, 5514.641548299388, 5585.916211256835, 5622.353429355636, 5626.156076588503, 5653.745581448845, 5242.79028838846, 5248.475152484759, 5282.154855223146, 5282.735863206824, 5318.734063296858, 5667.319921609434, 5681.914771278434, 5686.0, 5690.0, 5702.54379649627, 5420.159875219348, 5472.863178420492, 5493.450654934554, 5546.611737178358, 5567.387587365387, 5577.498025177672, 5581.916271255935, 5590.720463976866, 5603.691796951207, 5620.4660557247, 5570.108782594765, 5574.665520068809, 5583.832485025456, 5592.944070559323, 5595.552355811526, 5492.0, 5515.200295957064, 5575.832725018256, 5582.0, 5644.717764111778, 4343.1747967886, 4355.237833379146, 4357.411749413852, 4381.474223093185, 4397.626201772885, 3853.3641949078087, 3881.029742564359, 3890.7665540067687, 3905.3165696003653, 3930.9017274568364, 5093.2105523643895, 5172.586193104543, 5201.739913004335, 5222.817201397933, 5249.895002100013, 5592.161175823659, 5599.440055994368, 5607.691576963306, 5612.242347283064, 5623.915641265385, 5213.765380557884, 5248.475152484797, 5257.526822585909, 5265.7103859287345, 5270.7628156733035, 4688.390509233846, 4720.834770783006, 4757.09615173116, 4788.688735232199, 4819.518048195152, 5759.395263497357, 5800.564957628195, 5807.332156801937, 5814.912776308359, 5815.883682326415, 5542.445755424425, 5609.49514543693, 5617.887642247214, 5620.381758006698, 5647.519960803378, 5679.290088738908, 5726.0, 5749.080147176432, 5772.797952071657, 5791.276090488689, 5491.917621235764, 5500.532454741392, 5505.807296744595, 5511.173324001272, 5527.060399732136, 5462.399136095106, 5522.088855338985, 5551.306086739158, 5572.77708891656, 5574.386817450159, 5486.451354864482, 5514.558835293086, 5520.447955204448, 5531.0873705838085, 5585.916211256753, 5362.597805164551, 5376.435474275145, 5380.219868119179, 5414.810481633124, 5417.13325867875, 5198.454162312903, 5273.077211488051, 5308.25684404176, 5334.946650533445, 5340.652857564246, 5450.618456707993, 5501.779928802963, 5513.42109078557, 5513.917291240715, 5521.889562208814, 5363.436839131835, 5404.513593776579, 5406.756695948613, 5422.051141050221, 5466.234727138283], "unit": "score", "name": "dojo.html", "value": 5154.177210211691}, {"lowerIsBetter": false, "replicates": [509.68144909431606, 530.9301756959729, 538.7952578020353, 556.7967691792497, 570.1277046119436, 27307.453850922968, 36036.2792744145, 36182.638173618325, 36271.637283627155, 36476.08809779753, 38460.42309365362, 38869.61130388695, 38925.805370973176, 38927.61072389275, 39106.8044659777, 8259.091499935003, 8540.829183416328, 8610.44032137909, 8625.26685231756, 8629.913700863006, 8342.16578342167, 8579.871301930445, 8651.437656552336, 8671.0, 8671.176238257387, 8625.525596092213, 8646.178613031752, 8682.43564168327, 8721.7819554511, 8727.650893964266, 8593.26957208638, 8683.913160868373, 8685.261752751023, 8688.348373871922, 8692.261157801595, 8422.073571907085, 8624.223819856243, 8636.0932102129, 8648.394612377137, 8651.178138076873, 38997.80501097505, 39130.413043804365, 39301.21397572061, 39560.0, 39620.40569391462, 3304.9051121040684, 3628.455731640249, 3758.1732018955786, 3988.501437320335, 4148.771817550033, 28797.712022879714, 30237.244068898235, 30696.2325941851, 31188.688113118806, 31665.0, 3877.961220387788, 3946.763194208328, 3961.445397644332, 3965.9801700991597, 3981.6217459341315, 198214.0, 199314.0, 199618.0, 199951.99999999854, 200068.0, 42325.36511952323, 43168.352474712905, 59133.113003304126, 59151.408485915454, 59450.0, 41089.38365924513, 41144.0, 41169.794151029055, 41391.7930410346, 41557.0, 13053.738925221633, 13200.14199077076, 13269.73460530784, 13307.933460332637, 13308.866911330957, 10086.596536138471, 10159.136473399843, 10227.59089636421, 10259.897401026043, 10267.178625709925, 14279.78580321296, 14316.28418579067, 14894.957352985188, 14936.775948360782, 14937.759336099673, 5657.179708942181, 5663.320401551758, 5738.397468265855, 5747.4252574742195, 5786.334571524244, 892.5001998880648, 907.6505545365083, 952.4428209497383, 953.0897992417225, 1069.652362982034, 28162.0, 28493.430131397257, 28676.0, 28706.712932870403, 28882.0, 979.4319294808994, 1024.9077583017415, 1029.3463650581784, 1044.749260177567, 1084.2843723142687, 14774.0, 14938.477153299582, 15011.924940375227, 15011.924940375447, 15052.774208386883, 311438.0, 311764.0, 313746.0, 316800.0, 317402.0, 51859.74070129625, 52316.0, 52340.214896776575, 52470.21294680583, 52501.0, 1228.342836582424, 1269.3653173413293, 1272.338384040294, 1274.2609286613927, 1284.6146156153304, 27710.307242319104, 28277.858610706815, 28537.28656783597, 28557.143285701462, 28585.28536786597, 46345.76827115843, 46561.301580477, 46808.76595617, 47042.0, 47083.0, 291627.0, 292571.0, 294364.0, 295123.0, 295591.0, 32825.0, 42574.361384579875, 42618.786906065274, 42638.36042459428, 43779.34330984974, 40129.0, 40362.596374035886, 40441.19117617572, 40733.79633101816, 40872.59127408807, 36044.4593331095, 36178.63821361752, 36261.63738362583, 36462.4530632046, 37313.0, 36514.8174259127, 36884.81557592195, 37041.44437833488, 37156.81421592983, 37384.626153739206, 34423.45601996257, 34746.826265868505, 35342.823285884435, 35398.0, 35496.0, 30749.8462507686, 31079.0, 32995.505067423524, 33002.00993970185, 33147.83426082854, 25048.499030019662, 25469.0, 25600.743992559837, 25611.871940640922, 25790.0], "unit": "score", "name": "ext.html", "value": 17581.04188235196}, {"lowerIsBetter": false, "replicates": [360.86647940262105, 361.22517200604705, 368.43077445346927, 369.1527943369966, 371.37608817187146, 15614.0, 16928.0, 16978.40575579855, 17625.383111591098, 18132.0, 15475.45835895741, 15548.144852033134, 15638.921805390957, 16087.195640218, 16109.516714498584, 4980.950190498094, 5205.349331333583, 5208.062548741225, 5210.947890521104, 5224.92162617561, 5025.4472008079265, 5062.31658726071, 5155.71643559604, 5529.198266251391, 5538.0, 5069.290299358093, 5243.344581927259, 5246.344206974129, 5526.778928842861, 5531.474509921551, 5136.717480538568, 5150.407703114133, 5179.041877252702, 5282.894342113136, 5631.887362252773, 5395.838124856221, 5432.402435732066, 5438.8912221755345, 5443.047466693313, 5444.346678398618, 11523.0, 13011.674708132372, 13020.934895325558, 13045.630208828126, 13047.282399468026, 2196.121551379445, 2200.5818894410013, 2202.0971401725214, 2240.932772016842, 2329.9650505242435, 9738.659146929895, 10708.839367409495, 10821.026107650348, 12633.93683031579, 13252.403641836141, 1787.7586525819108, 1795.5959909020496, 1816.9091545422675, 1818.9363372281907, 1880.9529761755928, 55385.44614553843, 56503.43496565023, 57749.422505774826, 57995.710021449624, 58338.416615833725, 9781.168600669023, 10001.0, 10017.39895606266, 10078.244131690006, 10082.243831712503, 13099.672508187372, 13110.541131060367, 13212.33938303081, 13221.603351899459, 13284.468621255042, 7100.112485939258, 7176.031235783103, 7182.676779544829, 7200.819979500449, 7224.133104027445, 6571.441427478622, 6572.638504882278, 6606.372394622503, 6606.471482281406, 6631.10480085192, 4376.124775045004, 4491.820327186876, 4511.70673906195, 4514.6388288936805, 4517.367568540407, 1788.5334026098474, 1844.2530775036132, 1852.7313539536692, 1869.8691091623728, 1872.7752669679726, 833.7248707926369, 929.2380248196549, 966.5940305071887, 972.1542258235239, 1022.8261195596766, 15352.692946141238, 16354.427595034116, 16383.180840957904, 16493.505194844172, 16927.322907083824, 922.8569571716395, 974.6734843827397, 987.5852142100335, 996.5017491254373, 1033.9896601034043, 9403.0, 9695.9030409695, 9869.753256168653, 10253.282270241161, 10441.738956526147, 423242.0, 434899.0, 435762.0, 470601.0, 513613.0, 63442.36557634365, 64979.350206498275, 67049.0, 68788.0, 73057.2694273061, 1135.5230803062734, 1170.5025364220173, 1177.5231031432284, 1178.128185142988, 1186.7567148734488, 15420.84579154194, 15427.61430964235, 15488.5353439397, 15714.0, 15910.0, 32272.0, 32518.0, 33172.561361857064, 33378.16554586155, 33581.160470987445, 41973.580264196964, 42836.0, 43686.56313436825, 45039.32441013322, 45273.77363113163, 7408.296211859864, 7455.7017719290625, 7468.551886886804, 7486.0, 7572.4699271050495, 9194.448333100036, 10202.183825294107, 10527.842082368923, 10703.304285221435, 11518.424078796193, 9433.48141337298, 9588.66439674608, 9794.951025244829, 10171.949140254252, 10178.440185789557, 9278.304127190622, 9914.40513569188, 10039.196864250696, 10045.49772511386, 10078.445685487368, 10178.592856285666, 10272.33229840058, 10369.859315475442, 10421.895781042092, 10629.574817007542, 7182.030425892438, 7448.925510744823, 7471.476996610185, 7473.103227612722, 7489.588072656056, 8219.917800822155, 9489.051094890456, 9537.52312384364, 9690.75773105678, 10302.587896484056], "unit": "score", "name": "jquery.html", "value": 8087.647672935836}, {"lowerIsBetter": false, "replicates": [1442.877355424789, 1460.6932544165725, 1593.5617705131087, 1740.7998080220761, 1773.8846974946637, 6405.1353067335895, 6486.027095935612, 7215.927840721592, 7421.257874212576, 7424.517406368589, 7253.310935461136, 7373.926260737391, 7381.520201186919, 7445.925540744591, 7491.400687944965, 2302.4474126209716, 2329.359426157812, 2334.9766502335015, 2337.0534933351933, 2340.0405833608224, 2282.372347604414, 2287.62254228053, 2308.803751681109, 2314.6643736658257, 2314.93055208344, 2272.9544409571618, 2305.8501197422197, 2312.6993490846166, 2314.8611083335054, 2335.5912715274844, 2270.6366981283, 2295.885205739706, 2296.4832912594534, 2298.436882963668, 2298.4598619324447, 2319.988400058006, 2323.0, 2326.1858349577683, 2334.7781960713705, 2349.306954448442, 7627.80930476737, 7727.0, 7728.961355193244, 7731.7680469586, 7732.884006739903, 4784.928226076577, 4875.853724388274, 4880.902381952341, 4884.19410797218, 4888.462269150391, 3062.4640687879755, 3066.861991210401, 3187.681231876817, 3215.5980502437196, 3224.935501289961, 996.4768496539375, 1004.8794144702609, 1005.6027868991707, 1035.6685860524635, 1105.8120119579692, 10418.895811041868, 10438.686839394755, 10505.0, 10579.947100264526, 10583.259171857973, 4359.084592235666, 4390.47314322277, 4442.73343599385, 4485.349624304457, 4486.7756612169915, 9095.272378209727, 9120.361574689709, 9125.178733913846, 9144.954275228582, 9195.908040919505, 4853.587445067209, 4874.0495603357, 4890.217565189552, 4896.6572339935865, 4917.631177661689, 4274.7435153890865, 4354.325079612665, 4366.3013917773005, 4405.911881762347, 4482.484514280834, 3577.713782897362, 3585.0320413488735, 3614.8915532534065, 3618.2944325856733, 3625.8549658013385, 1134.6142311614092, 1143.9599614013468, 1151.740858306891, 1161.8199179127248, 1165.4930105404176, 1047.3244757131608, 1063.9308444951207, 1069.8020866139789, 1219.5609580550995, 1351.513455156143, 7318.634068296564, 7338.082739657543, 7344.853102937911, 7354.117505899327, 7359.558426494427, 1092.819684752007, 1104.640991677708, 1106.0985296982933, 1125.0999200639455, 1131.5247596009697, 5805.071188609802, 5868.706564671749, 5879.676617786063, 5886.0, 5902.704864756745, 8797.340199485065, 8914.777130571658, 8944.0, 8968.10318968098, 8991.235744961621, 8786.209241168326, 8843.557822108869, 8856.424332418372, 8905.821883562292, 8931.866022009675, 6754.0, 7049.859002819915, 7079.823004424828, 7093.716251349992, 7097.680604372816, 7083.291670832876, 7088.787336379917, 7102.644867756489, 7177.354038136593, 7283.672234749343, 8023.077346105272, 8027.638756256099, 8279.296259817984, 8362.49825010477, 8364.0, 8280.04779450371, 8288.917110828814, 8318.62566184511, 8339.708110216114, 8370.623321950648, 6594.373534514213, 6691.0967019451755, 6738.427233685192, 6743.52795304324, 6910.896336555056, 7255.600941948243, 7298.56208627484, 7305.050343455317, 7325.377342925911, 7361.153467351323, 6714.6978385973725, 6781.93218067813, 6801.353871382211, 6920.169579650475, 6981.02265682815, 6712.93287067123, 6784.6946887389195, 6787.626680532618, 6830.009648600826, 6906.792796216121, 6844.897326540006, 6905.274946130584, 6909.0, 6927.27263637331, 7056.470764692566, 6440.130582371507, 6478.222613286247, 6499.5775274607, 6501.382368674968, 6511.023346497874, 6522.706478208587, 6539.673016349068, 6566.376194261537, 6592.0, 6602.63685497283], "unit": "score", "name": "mootools.html", "value": 4468.419498750042}, {"lowerIsBetter": false, "replicates": [330.9123082383167, 332.0172290021536, 335.80019888166544, 344.7138874733971, 345.91525076356294, 6238.376162383759, 6347.5239357048295, 6363.618182909028, 6366.840828979278, 6526.608403495782, 6316.27362853272, 6343.651099189554, 6356.968215158918, 6395.648239346846, 6408.519361047916, 4777.9761101194445, 4778.2115950868065, 4797.328374027621, 4798.328234047236, 4799.832005879794, 4799.13615549201, 4820.662553621248, 4825.613950883939, 4828.2274836026245, 4837.685550439211, 4666.160091183586, 4764.404449443819, 4775.331453596482, 4784.928226076611, 4790.0, 4756.215224487973, 4772.021735544223, 4781.593564547018, 4787.40157480315, 4797.568218860284, 4131.091159944837, 4139.21354942563, 4139.399787030864, 4145.17096580685, 4146.709730318879, 5987.880242395127, 6015.518758499309, 6026.427489388545, 6032.517398608101, 6039.818805435844, 5462.344518657746, 5585.609007369486, 5586.190002449663, 5588.580856435743, 5592.832215033555, 6695.230048544431, 6695.698693558801, 6702.961041038598, 6713.1944166700305, 6723.93276067238, 4522.050369422425, 4549.954500454986, 4557.794899229542, 4558.680892337537, 4563.703359281636, 6724.462043036546, 6974.686139123752, 7010.75462358815, 7031.859362812766, 7047.612381319025, 4703.412073490814, 4708.458527269408, 4720.575148236607, 4723.031778485402, 4735.786889589976, 4798.304245884327, 4798.712077275374, 4799.592034677092, 4807.086653535817, 4810.11012962603, 5569.944300557024, 5572.08060669993, 5573.080441727151, 5575.972120139373, 5576.9163462548095, 6549.377809108127, 6759.493038022168, 6775.593464392152, 6779.35596118368, 6790.932090679129, 1647.6869394814946, 1655.4454257823763, 1702.4041585444995, 1704.1905095079985, 1709.2479309103956, 1084.6366467233565, 1092.1044743310408, 1099.9230053896151, 1117.793208256475, 1119.9048080913215, 6279.843003924847, 6290.308066112724, 6302.653354065479, 6319.526035547352, 6322.0516922462, 6795.52431329812, 6796.898046529306, 6825.761098361633, 6842.6578671066245, 6847.657617119125, 6136.8772624547255, 6262.592931459531, 6279.717412716439, 6287.0, 6303.0, 3709.534733780142, 3732.2908647356917, 3734.9066273343383, 3739.569949455793, 3741.1956429367815, 7140.9285907140265, 7144.392726618192, 7152.713891444284, 7159.606221657858, 7183.138023437116, 6949.027136200936, 6961.40828029613, 6987.26633703464, 7007.299270073054, 7012.894806577905, 7335.926640733631, 7337.41300695943, 7346.96326518364, 7361.190269070398, 7365.48441609093, 6941.132358455193, 6972.163340399185, 6974.476914231352, 6984.301569842975, 7001.194862590867, 6828.7268509259075, 6935.861282774215, 6939.854923937695, 6954.165500140016, 6966.3730264276455, 7246.0, 7265.09186351706, 7288.927110728825, 7312.0, 7321.816954575965, 4653.674242802971, 4663.253879379283, 4689.882752931204, 4702.177119004092, 4702.318163866289, 6805.9659701701175, 6923.273056329214, 6924.723011079501, 6931.792046238419, 6933.37599616037, 6706.5640733352175, 6717.462602991846, 6727.663616819042, 6771.627560484024, 6786.049953006484, 6670.366315200048, 6762.661866906733, 6771.119754431892, 6773.458123350021, 6779.661016949231, 6404.199475065617, 6610.206775187008, 6620.337966203341, 6653.63405012729, 6655.833604159935, 6749.021391898245, 6753.3246675332075, 6783.864322713617, 6787.694553744995, 6792.864142717217, 6539.542232043711, 6548.738050478118, 6549.934500654933, 6552.705128269144, 6587.901181482186], "unit": "score", "name": "prototype.html", "value": 5035.08229826303}, {"lowerIsBetter": false, "replicates": [836.8075342671185, 840.4999025579777, 844.8479273730728, 852.6078004118109, 861.4486728493765, 13487.055906086553, 13496.122752021123, 13616.387262573184, 13634.318284085793, 13635.318234088292, 12547.435365408555, 12585.685357866058, 12594.874051259485, 12654.683632909182, 12691.492340306377, 650.0574167457194, 662.0995446193174, 791.5171745235431, 811.6347643560392, 814.5194335342147, 801.587182600958, 806.0086094104255, 809.3889113719164, 809.4091313341264, 810.5460941872541, 835.8829763833069, 850.4429598612887, 852.7058164933119, 852.8422241885271, 853.3685073045964, 841.6170642357713, 842.6123982967842, 846.0270688707974, 846.4963346808609, 849.1126772522729, 618.8824123416537, 621.2824188062749, 623.2116372788427, 624.522240486024, 626.1859582542676, 11728.651205111437, 11821.113416493798, 11844.881551184464, 11871.406429678482, 11897.167198296123, 12841.35793210345, 13130.54043108496, 13360.732785344337, 13466.0, 13510.324483775772, 10389.37663740178, 10732.087772539266, 11119.833202501968, 11290.943545282304, 11338.263012904217, 3621.257642183346, 3636.272745450894, 3647.507586475845, 3704.1850792825535, 3793.715471339633, 45849.312260316125, 45943.0, 46351.304730429074, 46442.53557464416, 46550.53449465462, 9435.433873967584, 9799.804003919882, 9868.457234852152, 9984.251181161442, 10279.434631095211, 17691.823081769016, 17764.0, 17800.643987120184, 18086.366977155736, 18420.0, 7574.848503029909, 7790.415718821111, 7803.336716379172, 7834.255745704149, 7888.1323054463965, 4230.302000169938, 4303.827846886152, 4311.978440107842, 4345.109252603272, 4346.1090476452255, 3010.4129694709322, 3011.4579375712583, 3014.3519143383837, 3014.954775678367, 3017.8189308641113, 564.5342592361318, 580.2427831679614, 586.3696526234315, 590.4715279824533, 593.7476572456775, 611.7522403426619, 617.9073139029182, 624.8781487609963, 686.087503620184, 730.5799165479871, 8902.643894244287, 8919.0, 9014.323925705467, 9090.090990900857, 9126.634934602675, 534.767376191358, 646.809191288571, 682.7337338438014, 684.5721424109931, 692.5325405351367, 4177.289860723684, 4183.45615070045, 4299.505556861001, 4307.396964424983, 4428.247197976351, 53217.0, 53747.46252537425, 53785.0, 55594.72202639042, 56775.0, 46985.5301446988, 47054.5294547057, 47120.528794711616, 47425.28862067072, 47591.0, 44853.327200092026, 44927.775361122985, 45114.32328515075, 45130.097398051854, 45274.54725452769, 8720.825583488422, 8854.114588541352, 8878.556072196494, 8898.688545900863, 8949.59726812308, 33039.50440743439, 33820.154496137795, 33871.83064084664, 33983.15042123967, 34043.31913361768, 39832.2033559333, 40320.1935961285, 43807.34288985732, 44711.329330060726, 47001.29498057463, 10805.02754752076, 11109.722256943642, 11277.548898044315, 11384.829227561759, 11532.192746507999, 12362.938185309016, 12631.87368126307, 12809.8078528824, 12810.295433751233, 12823.038272129814, 11523.0, 11783.116266280234, 12119.575814846437, 12135.696607584881, 12435.0, 11466.369349685847, 11756.764864702829, 11778.882211177779, 12042.337671428155, 12244.326562039174, 10919.0, 10985.83521247166, 11431.314121152758, 11495.885041149482, 11573.594924177612, 9316.161545460942, 9390.24878009744, 9397.671081512115, 9620.972492414083, 9654.951725241328, 8675.436096653697, 8792.736217913473, 9219.815603688023, 9302.395344302598, 9834.0], "unit": "score", "name": "yui.html", "value": 6296.87800301875}], "name": "dromaeo_css", "value": 6855.795044670639}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 110.0, 111.0, 122.0, 111.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [150.0, 132.0, 154.0, 163.0, 130.0, 153.0, 147.0, 133.0, 162.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 161.0, 163.0, 161.0, 162.0, 163.0, 174.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 75.0, 73.0, 75.0, 73.0, 129.0, 75.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 95.0, 96.0, 96.0, 148.0, 95.0, 97.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 101.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 63.0, 62.0, 78.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 63.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [81.0, 90.0, 84.0, 85.0, 83.0, 90.0, 85.0, 82.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 121.0, 120.0, 124.0, 114.0, 119.0, 120.0, 118.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [130.0, 141.0, 137.0, 143.0, 142.0, 140.0, 139.0, 138.0, 145.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 65.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1509.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [187.65246762994934], "unit": "score", "name": "DeltaBlue", "value": 352.34282199999996}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [722.0216606498195], "unit": "score", "name": "Earley", "value": 923.0512549999999}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [40620.0], "unit": "score", "name": "RegExp", "value": 22.427006400787796}, {"lowerIsBetter": false, "replicates": [617.6652254478073], "unit": "score", "name": "Splay", "value": 131.93392900000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20296.913098615783}]} 10:34:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20296.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1509.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6855.80"}}} 10:34:41 INFO - Return code: 0 10:34:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:34:41 INFO - # TBPL SUCCESS # 10:34:41 INFO - Running post-action listener: _resource_record_post_action 10:34:41 INFO - Running post-run listener: _resource_record_post_run 10:34:42 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 20480; Write bytes: 413257728; Read time: 32; Write time: 401576 10:34:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98914304; Read time: 0; Write time: 71784 10:34:43 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 20480; Write bytes: 314343424; Read time: 32; Write time: 329792 10:34:43 INFO - Running post-run listener: _upload_blobber_files 10:34:43 INFO - Blob upload gear active. 10:34:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:34:43 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 10:34:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:34:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:44 INFO - (blobuploader) - INFO - Done attempting. 10:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:45 INFO - (blobuploader) - INFO - Done attempting. 10:34:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:45 INFO - Return code: 0 10:34:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:34:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/391f17a9b6b7d3a5893366c3ac451ff0557fff8b67a1c1a622ebaf8584596346d0262fced32dbe172752da5bdc1278210aba8a5689b5ac8e7c867af380bc4949", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772ea51d67e8e1cfa71a96abe7b5174553c875e80eac87b9f1109703fe542571ad32620bd0787a03a43800df0056e3e14c0c1b09a6ca78211d4fc0c8b586bd79"} 10:34:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:34:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:34:45 INFO - Contents: 10:34:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/391f17a9b6b7d3a5893366c3ac451ff0557fff8b67a1c1a622ebaf8584596346d0262fced32dbe172752da5bdc1278210aba8a5689b5ac8e7c867af380bc4949", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772ea51d67e8e1cfa71a96abe7b5174553c875e80eac87b9f1109703fe542571ad32620bd0787a03a43800df0056e3e14c0c1b09a6ca78211d4fc0c8b586bd79"} 10:34:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:45 INFO - Copying logs to upload dir... 10:34:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:34:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.471937 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-01-18 10:34:45.096968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 10:34:45.100939) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/391f17a9b6b7d3a5893366c3ac451ff0557fff8b67a1c1a622ebaf8584596346d0262fced32dbe172752da5bdc1278210aba8a5689b5ac8e7c867af380bc4949", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772ea51d67e8e1cfa71a96abe7b5174553c875e80eac87b9f1109703fe542571ad32620bd0787a03a43800df0056e3e14c0c1b09a6ca78211d4fc0c8b586bd79"} build_url:https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011481 build_url: 'https://queue.taskcluster.net/v1/task/XeZ_K_SDSMaUHQl5t4OPMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/391f17a9b6b7d3a5893366c3ac451ff0557fff8b67a1c1a622ebaf8584596346d0262fced32dbe172752da5bdc1278210aba8a5689b5ac8e7c867af380bc4949", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772ea51d67e8e1cfa71a96abe7b5174553c875e80eac87b9f1109703fe542571ad32620bd0787a03a43800df0056e3e14c0c1b09a6ca78211d4fc0c8b586bd79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 10:34:45.130171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:34:45.130880) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453140584.891078-1482595745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 10:34:45.215095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 10:34:45.215843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 10:34:45.216440) ========= ========= Total master_lag: 0.31 =========