builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1453115915.44 results: success (0) buildid: 20160118002446 builduid: 1adea15fea1941b0a97f01ae1ca58ab2 revision: b706331377c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.443976) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.444483) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.444808) ========= 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004990 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.472624) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.472964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.493367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.493758) ========= 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023865 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.543721) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.544081) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.544517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.544865) ========= 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 03:18:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-01-18 03:18:35 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.737063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.737486) ========= 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.114625 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.865081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:35.865545) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b706331377c5 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b706331377c5 --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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 03:18:35,922 Setting DEBUG logging. 2016-01-18 03:18:35,922 attempt 1/10 2016-01-18 03:18:35,922 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b706331377c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 03:18:36,186 unpacking tar archive at: mozilla-inbound-b706331377c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:36.611865) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:36.612221) ========= 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003802 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:36.660963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:36.661273) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:36.671375) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 03:18:36.671676) ========= 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 03:18:36.672088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-18 03:18:36.672419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:36 INFO - MultiFileLogger online at 20160118 03:18:36 in /builds/slave/test-pgo 03:18:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:18:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:18:36 INFO - {'append_to_log': False, 03:18:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:18:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:18:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:18:36 INFO - 'branch': 'Mozilla-Inbound', 03:18:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:36 INFO - 'config_files': ('talos/linux_config.py',), 03:18:36 INFO - 'default_actions': ('clobber', 03:18:36 INFO - 'read-buildbot-config', 03:18:36 INFO - 'download-and-extract', 03:18:36 INFO - 'populate-webroot', 03:18:36 INFO - 'create-virtualenv', 03:18:36 INFO - 'install', 03:18:36 INFO - 'run-tests'), 03:18:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:36 INFO - 'download_minidump_stackwalk': True, 03:18:36 INFO - 'download_symbols': 'ondemand', 03:18:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:36 INFO - 'installer_path': 'installer.exe', 03:18:36 INFO - 'log_level': 'info', 03:18:36 INFO - 'log_name': 'talos', 03:18:36 INFO - 'log_to_console': True, 03:18:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:36 INFO - 'opt_config_files': (), 03:18:36 INFO - 'pip_index': False, 03:18:36 INFO - 'sps_profile': False, 03:18:36 INFO - 'sps_profile_interval': 0, 03:18:36 INFO - 'suite': 'dromaeojs-e10s', 03:18:36 INFO - 'system_bits': '32', 03:18:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:36 INFO - 'title': 'talos-linux64-ix-004', 03:18:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:36 INFO - 'use_talos_json': True, 03:18:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:18:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:36 INFO - 'work_dir': 'build'} 03:18:36 INFO - ##### 03:18:36 INFO - ##### Running clobber step. 03:18:36 INFO - ##### 03:18:36 INFO - Running pre-action listener: _resource_record_pre_action 03:18:36 INFO - Running main action method: clobber 03:18:36 INFO - rmtree: /builds/slave/test-pgo/build 03:18:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:18:39 INFO - Running post-action listener: _resource_record_post_action 03:18:39 INFO - ##### 03:18:39 INFO - ##### Running read-buildbot-config step. 03:18:39 INFO - ##### 03:18:39 INFO - Running pre-action listener: _resource_record_pre_action 03:18:39 INFO - Running main action method: read_buildbot_config 03:18:39 INFO - Using buildbot properties: 03:18:39 INFO - { 03:18:39 INFO - "project": "", 03:18:39 INFO - "product": "firefox", 03:18:39 INFO - "script_repo_revision": "production", 03:18:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:18:39 INFO - "repository": "", 03:18:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:18:39 INFO - "buildid": "20160118002446", 03:18:39 INFO - "pgo_build": "True", 03:18:39 INFO - "basedir": "/builds/slave/test-pgo", 03:18:39 INFO - "buildnumber": 629, 03:18:39 INFO - "slavename": "talos-linux64-ix-004", 03:18:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:39 INFO - "platform": "ubuntu64_hw", 03:18:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:18:39 INFO - "branch": "mozilla-inbound", 03:18:39 INFO - "repo_path": "integration/mozilla-inbound", 03:18:39 INFO - "revision": "b706331377c5", 03:18:39 INFO - "stage_platform": "linux64-pgo", 03:18:39 INFO - "builduid": "1adea15fea1941b0a97f01ae1ca58ab2", 03:18:39 INFO - "slavebuilddir": "test" 03:18:39 INFO - } 03:18:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:18:39 INFO - Running post-action listener: _resource_record_post_action 03:18:39 INFO - ##### 03:18:39 INFO - ##### Running download-and-extract step. 03:18:39 INFO - ##### 03:18:39 INFO - Running pre-action listener: _resource_record_pre_action 03:18:39 INFO - Running main action method: download_and_extract 03:18:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:18: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')]} 03:18:39 INFO - https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/test_packages.json 03:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/test_packages.json 03:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:18:39 INFO - Downloaded 1448 bytes. 03:18:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:18:39 INFO - Using the following test package requirements: 03:18:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:39 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:18:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'jsshell-linux-x86_64.zip'], 03:18:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:18:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:18:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:18:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:18:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18: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')]} 03:18:39 INFO - https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:42 INFO - Downloaded 22484302 bytes. 03:18:42 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'] 03:18:42 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 03:18:43 INFO - Return code: 0 03:18:43 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 03:18:43 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')]} 03:18:43 INFO - https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:46 INFO - Downloaded 22484302 bytes. 03:18:46 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'] 03:18:46 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 03:18:47 INFO - Return code: 0 03:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:47 INFO - https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:49 INFO - Downloaded 11132144 bytes. 03:18:49 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'] 03:18:49 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 03:18:49 INFO - Return code: 0 03:18: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')]} 03:18:49 INFO - https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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 03:18:52 INFO - Downloaded 55915711 bytes. 03:18:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:18:52 INFO - mkdir: /builds/slave/test-pgo/properties 03:18:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:18:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:18:52 INFO - Contents: 03:18:52 INFO - build_url:https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:18:52 INFO - Running post-action listener: _resource_record_post_action 03:18:52 INFO - Running post-action listener: set_extra_try_arguments 03:18:52 INFO - ##### 03:18:52 INFO - ##### Running populate-webroot step. 03:18:52 INFO - ##### 03:18:52 INFO - Running pre-action listener: _resource_record_pre_action 03:18:52 INFO - Running main action method: populate_webroot 03:18:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:52 INFO - '--tppagecycles', 03:18:52 INFO - '7'], 03:18:52 INFO - 'tests': ['tsvgm']}}, 03:18:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:18:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:18:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:18:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'tests': ['damp', 'tps']}, 03:18:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['damp', 'tps']}, 03:18:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:18:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:52 INFO - 'other': {'tests': ['a11yr', 03:18:52 INFO - 'ts_paint', 03:18:52 INFO - 'tpaint', 03:18:52 INFO - 'sessionrestore', 03:18:52 INFO - 'sessionrestore_no_auto_restore']}, 03:18:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['a11yr', 03:18:52 INFO - 'ts_paint', 03:18:52 INFO - 'tpaint', 03:18:52 INFO - 'sessionrestore', 03:18:52 INFO - 'sessionrestore_no_auto_restore']}, 03:18:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['a11yr', 03:18:52 INFO - 'ts_paint', 03:18:52 INFO - 'tpaint', 03:18:52 INFO - 'sessionrestore', 03:18:52 INFO - 'sessionrestore_no_auto_restore']}, 03:18:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['a11yr', 03:18:52 INFO - 'ts_paint', 03:18:52 INFO - 'tpaint', 03:18:52 INFO - 'sessionrestore', 03:18:52 INFO - 'sessionrestore_no_auto_restore']}, 03:18:52 INFO - 'other_l64': {'tests': ['a11yr', 03:18:52 INFO - 'ts_paint', 03:18:52 INFO - 'tpaint', 03:18:52 INFO - 'sessionrestore', 03:18:52 INFO - 'sessionrestore_no_auto_restore']}, 03:18:52 INFO - 'other_nol64': {'tests': ['a11yr', 03:18:52 INFO - 'ts_paint', 03:18:52 INFO - 'tpaint', 03:18:52 INFO - 'sessionrestore', 03:18:52 INFO - 'sessionrestore_no_auto_restore']}, 03:18:52 INFO - 'svgr': {'tests': ['tsvgx', 03:18:52 INFO - 'tsvgr_opacity', 03:18:52 INFO - 'tart', 03:18:52 INFO - 'tscrollx', 03:18:52 INFO - 'cart']}, 03:18:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['tsvgx', 03:18:52 INFO - 'tsvgr_opacity', 03:18:52 INFO - 'tart', 03:18:52 INFO - 'tscrollx', 03:18:52 INFO - 'cart']}, 03:18:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'tests': ['tp5o']}, 03:18:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'talos_options': ['--e10s'], 03:18:52 INFO - 'tests': ['tp5o']}, 03:18:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'talos_options': ['--xperf_path', 03:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:52 INFO - 'tests': ['tp5n']}, 03:18:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:52 INFO - 'talos_options': ['--e10s', 03:18:52 INFO - '--xperf_path', 03:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:52 INFO - 'tests': ['tp5n']}}, 03:18:52 INFO - 'talos.zip': {'path': '', 03:18:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:52 INFO - Running post-action listener: _resource_record_post_action 03:18:52 INFO - ##### 03:18:52 INFO - ##### Running create-virtualenv step. 03:18:52 INFO - ##### 03:18:52 INFO - Running pre-action listener: _resource_record_pre_action 03:18:52 INFO - Running main action method: create_virtualenv 03:18:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:18:52 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 03:18:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:18:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:52 INFO - Using real prefix '/usr' 03:18:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:18:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:56 INFO - Installing pip.................done. 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:18:56 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 03:18:56 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 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:57 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 03:18:57 INFO - Cleaning up... 03:18:57 INFO - Return code: 0 03:18:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:18: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')]} 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:18:57 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 03:18:57 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 03:18:57 INFO - Using env: {'DISPLAY': ':0', 03:18:57 INFO - 'HOME': '/home/cltbld', 03:18:57 INFO - 'LANG': 'en_US.UTF-8', 03:18:57 INFO - 'LANGUAGE': 'en_US:en', 03:18:57 INFO - 'LOGNAME': 'cltbld', 03:18:57 INFO - 'MAIL': '/var/mail/cltbld', 03:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:57 INFO - 'MOZ_NO_REMOTE': '1', 03:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:57 INFO - 'NO_EM_RESTART': '1', 03:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:57 INFO - 'SHELL': '/bin/bash', 03:18:57 INFO - 'SHLVL': '1', 03:18:57 INFO - 'TERM': 'linux', 03:18:57 INFO - 'TMOUT': '86400', 03:18:57 INFO - 'USER': 'cltbld', 03:18:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:57 INFO - '_': '/tools/buildbot/bin/python'} 03:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:57 INFO - Downloading/unpacking psutil>=0.7.1 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:18:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:59 INFO - Installing collected packages: psutil 03:18:59 INFO - Running setup.py install for psutil 03:18:59 INFO - building 'psutil._psutil_linux' extension 03:18:59 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 03:19:00 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 03:19:01 INFO - building 'psutil._psutil_posix' extension 03:19:01 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 03:19:01 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 03:19:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:01 INFO - Successfully installed psutil 03:19:01 INFO - Cleaning up... 03:19:01 INFO - Return code: 0 03:19:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:19:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:19:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:19:01 INFO - Using env: {'DISPLAY': ':0', 03:19:01 INFO - 'HOME': '/home/cltbld', 03:19:01 INFO - 'LANG': 'en_US.UTF-8', 03:19:01 INFO - 'LANGUAGE': 'en_US:en', 03:19:01 INFO - 'LOGNAME': 'cltbld', 03:19:01 INFO - 'MAIL': '/var/mail/cltbld', 03:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:01 INFO - 'MOZ_NO_REMOTE': '1', 03:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:01 INFO - 'NO_EM_RESTART': '1', 03:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:01 INFO - 'SHELL': '/bin/bash', 03:19:01 INFO - 'SHLVL': '1', 03:19:01 INFO - 'TERM': 'linux', 03:19:01 INFO - 'TMOUT': '86400', 03:19:01 INFO - 'USER': 'cltbld', 03:19:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:01 INFO - '_': '/tools/buildbot/bin/python'} 03:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:19:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:19:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:19:03 INFO - Installing collected packages: mozsystemmonitor 03:19:03 INFO - Running setup.py install for mozsystemmonitor 03:19:03 INFO - Successfully installed mozsystemmonitor 03:19:03 INFO - Cleaning up... 03:19:03 INFO - Return code: 0 03:19:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:19:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:19:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:19:03 INFO - Using env: {'DISPLAY': ':0', 03:19:03 INFO - 'HOME': '/home/cltbld', 03:19:03 INFO - 'LANG': 'en_US.UTF-8', 03:19:03 INFO - 'LANGUAGE': 'en_US:en', 03:19:03 INFO - 'LOGNAME': 'cltbld', 03:19:03 INFO - 'MAIL': '/var/mail/cltbld', 03:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:03 INFO - 'MOZ_NO_REMOTE': '1', 03:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:03 INFO - 'NO_EM_RESTART': '1', 03:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:03 INFO - 'SHELL': '/bin/bash', 03:19:03 INFO - 'SHLVL': '1', 03:19:03 INFO - 'TERM': 'linux', 03:19:03 INFO - 'TMOUT': '86400', 03:19:03 INFO - 'USER': 'cltbld', 03:19:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:03 INFO - '_': '/tools/buildbot/bin/python'} 03:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:19:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:19:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:19:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:06 INFO - Downloading docopt-0.6.1.tar.gz 03:19:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:19:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:06 INFO - Running setup.py install for blobuploader 03:19:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:19:06 INFO - Running setup.py install for requests 03:19:06 INFO - Running setup.py install for docopt 03:19:06 INFO - Successfully installed blobuploader requests docopt 03:19:06 INFO - Cleaning up... 03:19:06 INFO - Return code: 0 03:19:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19: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')]} 03:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:06 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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:19:06 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 03:19:06 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 03:19:06 INFO - Using env: {'DISPLAY': ':0', 03:19:06 INFO - 'HOME': '/home/cltbld', 03:19:06 INFO - 'LANG': 'en_US.UTF-8', 03:19:06 INFO - 'LANGUAGE': 'en_US:en', 03:19:06 INFO - 'LOGNAME': 'cltbld', 03:19:06 INFO - 'MAIL': '/var/mail/cltbld', 03:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:06 INFO - 'MOZ_NO_REMOTE': '1', 03:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:06 INFO - 'NO_EM_RESTART': '1', 03:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:06 INFO - 'SHELL': '/bin/bash', 03:19:06 INFO - 'SHLVL': '1', 03:19:06 INFO - 'TERM': 'linux', 03:19:06 INFO - 'TMOUT': '86400', 03:19:06 INFO - 'USER': 'cltbld', 03:19:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:06 INFO - '_': '/tools/buildbot/bin/python'} 03:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:06 INFO - Running setup.py (path:/tmp/pip-nD8fKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:07 INFO - Running setup.py (path:/tmp/pip-eaQpax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:07 INFO - Running setup.py (path:/tmp/pip-_T2d7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:07 INFO - Running setup.py (path:/tmp/pip-yNj_8i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:07 INFO - Running setup.py (path:/tmp/pip-u6T0gS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:07 INFO - Running setup.py (path:/tmp/pip-FMUNB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:07 INFO - Running setup.py (path:/tmp/pip-XVzMsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:07 INFO - Running setup.py (path:/tmp/pip-NZs3mv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:07 INFO - Running setup.py (path:/tmp/pip-uSWi_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:07 INFO - Running setup.py (path:/tmp/pip-RfHIAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:07 INFO - Running setup.py (path:/tmp/pip-3Pda7X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:07 INFO - Running setup.py (path:/tmp/pip-9Ceqk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:07 INFO - Running setup.py (path:/tmp/pip-cdB_CH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:07 INFO - Running setup.py (path:/tmp/pip-bBJlYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:07 INFO - Running setup.py (path:/tmp/pip-fdY_4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:08 INFO - Running setup.py (path:/tmp/pip-OmVefo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:08 INFO - Running setup.py (path:/tmp/pip-Xnx_J5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:08 INFO - Running setup.py install for manifestparser 03:19:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Running setup.py install for mozcrash 03:19:08 INFO - Running setup.py install for mozdebug 03:19:08 INFO - Running setup.py install for mozdevice 03:19:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Running setup.py install for mozfile 03:19:08 INFO - Running setup.py install for mozhttpd 03:19:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Running setup.py install for mozinfo 03:19:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Running setup.py install for mozInstall 03:19:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:19:08 INFO - Running setup.py install for mozleak 03:19:09 INFO - Running setup.py install for mozlog 03:19:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:19:09 INFO - Running setup.py install for moznetwork 03:19:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:19:09 INFO - Running setup.py install for mozprocess 03:19:09 INFO - Running setup.py install for mozprofile 03:19:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:19:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:19:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:19:09 INFO - Running setup.py install for mozrunner 03:19:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:19:09 INFO - Running setup.py install for mozscreenshot 03:19:09 INFO - Running setup.py install for moztest 03:19:09 INFO - Running setup.py install for mozversion 03:19:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:19:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:09 INFO - Cleaning up... 03:19:09 INFO - Return code: 0 03:19:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19:09 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')]} 03:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:09 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')]} 03:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:09 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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:19:09 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 03:19:09 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 03:19:09 INFO - Using env: {'DISPLAY': ':0', 03:19:09 INFO - 'HOME': '/home/cltbld', 03:19:09 INFO - 'LANG': 'en_US.UTF-8', 03:19:09 INFO - 'LANGUAGE': 'en_US:en', 03:19:09 INFO - 'LOGNAME': 'cltbld', 03:19:09 INFO - 'MAIL': '/var/mail/cltbld', 03:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:09 INFO - 'MOZ_NO_REMOTE': '1', 03:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:09 INFO - 'NO_EM_RESTART': '1', 03:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:09 INFO - 'SHELL': '/bin/bash', 03:19:09 INFO - 'SHLVL': '1', 03:19:09 INFO - 'TERM': 'linux', 03:19:09 INFO - 'TMOUT': '86400', 03:19:09 INFO - 'USER': 'cltbld', 03:19:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:09 INFO - '_': '/tools/buildbot/bin/python'} 03:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:10 INFO - Running setup.py (path:/tmp/pip-5qGobI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:10 INFO - Running setup.py (path:/tmp/pip-2kJIXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:10 INFO - Running setup.py (path:/tmp/pip-KT2bLL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:10 INFO - Running setup.py (path:/tmp/pip-s21SL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:10 INFO - Running setup.py (path:/tmp/pip-BLv9JA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:10 INFO - Running setup.py (path:/tmp/pip-DfVNly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:10 INFO - Running setup.py (path:/tmp/pip-oEwiPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:10 INFO - Running setup.py (path:/tmp/pip-2vSxga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:10 INFO - Running setup.py (path:/tmp/pip-GVqWTI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:10 INFO - Running setup.py (path:/tmp/pip-qbAZkI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:10 INFO - Running setup.py (path:/tmp/pip-8xDfsP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:19:10 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)) 03:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:10 INFO - Running setup.py (path:/tmp/pip-EGTiqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:19:11 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)) 03:19:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:11 INFO - Running setup.py (path:/tmp/pip-1ZIUZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:19:11 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)) 03:19:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:11 INFO - Running setup.py (path:/tmp/pip-tYPz5R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:19:11 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)) 03:19:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:11 INFO - Running setup.py (path:/tmp/pip-6SIsj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:19:11 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)) 03:19:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:11 INFO - Running setup.py (path:/tmp/pip-CmgFlY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:19:11 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)) 03:19:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:11 INFO - Running setup.py (path:/tmp/pip-jf6jLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 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)) 03:19:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:11 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 03:19:11 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 03:19:11 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 03:19:11 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 03:19:11 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 03:19:11 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 03:19:13 INFO - Downloading blessings-1.5.1.tar.gz 03:19:13 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 03:19:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:13 INFO - Installing collected packages: blessings 03:19:13 INFO - Running setup.py install for blessings 03:19:13 INFO - Successfully installed blessings 03:19:13 INFO - Cleaning up... 03:19:13 INFO - Return code: 0 03:19:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:19:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:19:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:19:13 INFO - Reading from file tmpfile_stdout 03:19:13 INFO - Current package versions: 03:19:13 INFO - argparse == 1.2.1 03:19:13 INFO - blessings == 1.5.1 03:19:13 INFO - blobuploader == 1.2.4 03:19:13 INFO - docopt == 0.6.1 03:19:13 INFO - manifestparser == 1.1 03:19:13 INFO - mozInstall == 1.12 03:19:13 INFO - mozcrash == 0.16 03:19:13 INFO - mozdebug == 0.1 03:19:13 INFO - mozdevice == 0.48 03:19:13 INFO - mozfile == 1.2 03:19:13 INFO - mozhttpd == 0.7 03:19:13 INFO - mozinfo == 0.9 03:19:13 INFO - mozleak == 0.1 03:19:13 INFO - mozlog == 3.1 03:19:13 INFO - moznetwork == 0.27 03:19:13 INFO - mozprocess == 0.22 03:19:13 INFO - mozprofile == 0.28 03:19:13 INFO - mozrunner == 6.11 03:19:13 INFO - mozscreenshot == 0.1 03:19:13 INFO - mozsystemmonitor == 0.0 03:19:13 INFO - moztest == 0.7 03:19:13 INFO - mozversion == 1.4 03:19:13 INFO - psutil == 3.1.1 03:19:13 INFO - requests == 1.2.3 03:19:13 INFO - wsgiref == 0.1.2 03:19:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:19:13 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')]} 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:13 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')]} 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:13 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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:19:13 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 03:19:13 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 03:19:13 INFO - Using env: {'DISPLAY': ':0', 03:19:13 INFO - 'HOME': '/home/cltbld', 03:19:13 INFO - 'LANG': 'en_US.UTF-8', 03:19:13 INFO - 'LANGUAGE': 'en_US:en', 03:19:13 INFO - 'LOGNAME': 'cltbld', 03:19:13 INFO - 'MAIL': '/var/mail/cltbld', 03:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:13 INFO - 'MOZ_NO_REMOTE': '1', 03:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:13 INFO - 'NO_EM_RESTART': '1', 03:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:13 INFO - 'SHELL': '/bin/bash', 03:19:13 INFO - 'SHLVL': '1', 03:19:13 INFO - 'TERM': 'linux', 03:19:13 INFO - 'TMOUT': '86400', 03:19:13 INFO - 'USER': 'cltbld', 03:19:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:13 INFO - '_': '/tools/buildbot/bin/python'} 03:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 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)) 03:19:13 INFO - Cleaning up... 03:19:13 INFO - Return code: 0 03:19:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:19:13 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')]} 03:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:13 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')]} 03:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:13 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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:19:13 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 03:19:13 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 03:19:13 INFO - Using env: {'DISPLAY': ':0', 03:19:13 INFO - 'HOME': '/home/cltbld', 03:19:13 INFO - 'LANG': 'en_US.UTF-8', 03:19:13 INFO - 'LANGUAGE': 'en_US:en', 03:19:13 INFO - 'LOGNAME': 'cltbld', 03:19:13 INFO - 'MAIL': '/var/mail/cltbld', 03:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:13 INFO - 'MOZ_NO_REMOTE': '1', 03:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:13 INFO - 'NO_EM_RESTART': '1', 03:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:13 INFO - 'SHELL': '/bin/bash', 03:19:13 INFO - 'SHLVL': '1', 03:19:13 INFO - 'TERM': 'linux', 03:19:13 INFO - 'TMOUT': '86400', 03:19:13 INFO - 'USER': 'cltbld', 03:19:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:13 INFO - '_': '/tools/buildbot/bin/python'} 03:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:14 INFO - Downloading/unpacking jsonschema 03:19:14 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 03:19:14 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 03:19:14 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 03:19:14 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 03:19:14 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 03:19:14 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 03:19:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:15 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 03:19:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:19:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:15 INFO - warning: no files found matching '*.txt' 03:19:15 INFO - no previously-included directories found matching 'build' 03:19:15 INFO - no previously-included directories found matching 'dist' 03:19:15 INFO - no previously-included directories found matching '.git*' 03:19:15 INFO - Installing collected packages: jsonschema, functools32 03:19:16 INFO - Running setup.py install for functools32 03:19:16 INFO - warning: no files found matching '*.txt' 03:19:16 INFO - no previously-included directories found matching 'build' 03:19:16 INFO - no previously-included directories found matching 'dist' 03:19:16 INFO - no previously-included directories found matching '.git*' 03:19:16 INFO - Successfully installed jsonschema functools32 03:19:16 INFO - Cleaning up... 03:19:16 INFO - Return code: 0 03:19:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:19: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')]} 03:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:16 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 0x7f424c326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, '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': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', '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 03:19:16 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 03:19:16 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 03:19:16 INFO - Using env: {'DISPLAY': ':0', 03:19:16 INFO - 'HOME': '/home/cltbld', 03:19:16 INFO - 'LANG': 'en_US.UTF-8', 03:19:16 INFO - 'LANGUAGE': 'en_US:en', 03:19:16 INFO - 'LOGNAME': 'cltbld', 03:19:16 INFO - 'MAIL': '/var/mail/cltbld', 03:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:16 INFO - 'MOZ_NO_REMOTE': '1', 03:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:16 INFO - 'NO_EM_RESTART': '1', 03:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:16 INFO - 'SHELL': '/bin/bash', 03:19:16 INFO - 'SHLVL': '1', 03:19:16 INFO - 'TERM': 'linux', 03:19:16 INFO - 'TMOUT': '86400', 03:19:16 INFO - 'USER': 'cltbld', 03:19:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:16 INFO - '_': '/tools/buildbot/bin/python'} 03:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:16 INFO - Downloading/unpacking flake8 03:19:16 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 03:19:16 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 03:19:16 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 03:19:16 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 03:19:16 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 03:19:16 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 03:19:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:19:18 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 03:19:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:19:18 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 03:19:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 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 03:19:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:19:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:18 INFO - no previously-included directories found matching 'docs/_build' 03:19:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:19:18 INFO - Running setup.py install for pep8 03:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:18 INFO - no previously-included directories found matching 'docs/_build' 03:19:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:19:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:19:18 INFO - Cleaning up... 03:19:19 INFO - Return code: 0 03:19:19 INFO - Running post-action listener: _resource_record_post_action 03:19:19 INFO - Running post-action listener: _start_resource_monitoring 03:19:19 INFO - Starting resource monitoring. 03:19:19 INFO - ##### 03:19:19 INFO - ##### Running install step. 03:19:19 INFO - ##### 03:19:19 INFO - Running pre-action listener: _resource_record_pre_action 03:19:19 INFO - Running main action method: install 03:19:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:19:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:19:19 INFO - Reading from file tmpfile_stdout 03:19:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:19:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:19:19 INFO - Reading from file tmpfile_stdout 03:19:19 INFO - Output received: 03:19:19 INFO - Usage: mozinstall [options] installer 03:19:19 INFO - Options: 03:19:19 INFO - -h, --help show this help message and exit 03:19:19 INFO - -d DEST, --destination=DEST 03:19:19 INFO - Directory to install application into. [default: 03:19:19 INFO - "/builds/slave/test-pgo"] 03:19:19 INFO - --app=APP Application being installed. [default: firefox] 03:19:19 INFO - mkdir: /builds/slave/test-pgo/build/application 03:19:19 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'] 03:19:19 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 03:19:35 INFO - Reading from file tmpfile_stdout 03:19:35 INFO - Output received: 03:19:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:19:35 INFO - Running post-action listener: _resource_record_post_action 03:19:35 INFO - ##### 03:19:35 INFO - ##### Running run-tests step. 03:19:35 INFO - ##### 03:19:35 INFO - Running pre-action listener: _resource_record_pre_action 03:19:35 INFO - Running main action method: run_tests 03:19:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:19:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:19:35 INFO - Python 2.7.3 03:19:35 INFO - Return code: 0 03:19:35 INFO - grabbing minidump binary from tooltool 03:19:35 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')]} 03:19:35 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 0x22ec7f0>, '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 0x22582d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2258760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:19:35 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 03:19:35 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 03:19:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:35 INFO - Return code: 0 03:19:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:19:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:19:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:19:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:19:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:19:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:19:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:19:36 INFO - Return code: 0 03:19:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:19:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 03:19:36 INFO - Using env: {'DISPLAY': ':0', 03:19:36 INFO - 'HOME': '/home/cltbld', 03:19:36 INFO - 'LANG': 'en_US.UTF-8', 03:19:36 INFO - 'LANGUAGE': 'en_US:en', 03:19:36 INFO - 'LOGNAME': 'cltbld', 03:19:36 INFO - 'MAIL': '/var/mail/cltbld', 03:19:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:19:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:36 INFO - 'MOZ_NO_REMOTE': '1', 03:19:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:36 INFO - 'NO_EM_RESTART': '1', 03:19:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:19:36 INFO - 'PWD': '/builds/slave/test-pgo', 03:19:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:19:36 INFO - 'SHELL': '/bin/bash', 03:19:36 INFO - 'SHLVL': '1', 03:19:36 INFO - 'TERM': 'linux', 03:19:36 INFO - 'TMOUT': '86400', 03:19:36 INFO - 'USER': 'cltbld', 03:19:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896', 03:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:36 INFO - '_': '/tools/buildbot/bin/python'} 03:19:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:19:37 INFO - mozversion application_buildid: 20160118002446 03:19:37 INFO - mozversion application_changeset: b706331377c59bd1f3101f4bfdc81618b1e3dfe9 03:19:37 INFO - mozversion application_display_name: Nightly 03:19:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:37 INFO - mozversion application_name: Firefox 03:19:37 INFO - mozversion application_remotingname: firefox 03:19:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:19:37 INFO - mozversion application_vendor: Mozilla 03:19:37 INFO - mozversion application_version: 46.0a1 03:19:37 INFO - mozversion platform_buildid: 20160118002446 03:19:37 INFO - mozversion platform_changeset: b706331377c59bd1f3101f4bfdc81618b1e3dfe9 03:19:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:19:37 INFO - mozversion platform_version: 46.0a1 03:19:37 INFO - using testdate: 1453115977 03:19:37 INFO - actual date: 1453115977 03:19:37 INFO - starting webserver on 'localhost:50968' 03:19:37 INFO - SUITE-START | Running 3 tests 03:19:37 INFO - TEST-START | dromaeo_css 03:19:37 INFO - operating with platform_type : linux_ 03:19:37 INFO - Initialising browser for dromaeo_css test... 03:19:37 INFO - TEST-INFO | started process 3341 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvXFqs7/profile http://localhost:50968/getInfo.html) 03:19:43 INFO - PROCESS | 3341 | 03:19:43 INFO - PROCESS | 3341 | (process:3424): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:19:44 INFO - PROCESS | 3341 | __metrics Screen width/height:1600/1200 03:19:44 INFO - PROCESS | 3341 | colorDepth:24 03:19:44 INFO - PROCESS | 3341 | Browser inner width/height: 1024/697 03:19:44 INFO - PROCESS | 3341 | __metrics 03:19:44 INFO - PROCESS | 3341 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:19:44 INFO - PROCESS | 3341 | 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. 03:19:45 INFO - TEST-INFO | 3341: exit 0 03:19:45 INFO - Browser initialized. 03:19:45 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:45 INFO - TEST-INFO | started process 3472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvXFqs7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:45 INFO - PROCESS | 3472 | -- checkerboarding starts below -- 03:19:45 INFO - PROCESS | 3472 | RENDERTRACE 0.039456 rect red 0 0 10 10 // viewport 03:19:45 INFO - PROCESS | 3472 | RENDERTRACE 5.88753 rect red 0 0 10 10 // viewport 03:19:45 INFO - PROCESS | 3472 | RENDERTRACE 23.5772 rect brown 0 0 10 10 // page 03:19:45 INFO - PROCESS | 3472 | RENDERTRACE 23.603 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 03:19:45 INFO - PROCESS | 3472 | Checkerboarded for 2 frames (25.2161 ms), 100 peak, 588 severity. 03:19:46 INFO - PROCESS | 3472 | 03:19:46 INFO - PROCESS | 3472 | (process:3529): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:19:57 INFO - PROCESS | 3472 | RSS: Main: 150192128 03:19:57 INFO - PROCESS | 3472 | 03:20:46 INFO - PROCESS | 3472 | 1453116046642 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] 03:22:55 INFO - PROCESS | 3472 | Cycle 1(1): loaded http://localhost:50968/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50968/tests/dromaeo/cssquery-ext.html) 03:22:56 INFO - PROCESS | 3472 | RSS: Main: 155471872 03:22:56 INFO - PROCESS | 3472 | 03:25:58 INFO - PROCESS | 3472 | Cycle 1(1): loaded http://localhost:50968/tests/dromaeo/cssquery-ext.html (next: http://localhost:50968/tests/dromaeo/cssquery-jquery.html) 03:25:58 INFO - PROCESS | 3472 | RSS: Main: 150040576 03:25:58 INFO - PROCESS | 3472 | 03:29:00 INFO - PROCESS | 3472 | Cycle 1(1): loaded http://localhost:50968/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50968/tests/dromaeo/cssquery-mootools.html) 03:29:01 INFO - PROCESS | 3472 | RSS: Main: 151748608 03:29:01 INFO - PROCESS | 3472 | 03:32:02 INFO - PROCESS | 3472 | Cycle 1(1): loaded http://localhost:50968/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50968/tests/dromaeo/cssquery-prototype.html) 03:32:03 INFO - PROCESS | 3472 | RSS: Main: 150175744 03:32:03 INFO - PROCESS | 3472 | 03:35:05 INFO - PROCESS | 3472 | Cycle 1(1): loaded http://localhost:50968/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50968/tests/dromaeo/cssquery-yui.html) 03:35:06 INFO - PROCESS | 3472 | RSS: Main: 150147072 03:35:06 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | Cycle 1(1): loaded http://localhost:50968/tests/dromaeo/cssquery-yui.html (next: http://localhost:50968/tests/dromaeo/cssquery-dojo.html) 03:38:09 INFO - PROCESS | 3472 | RSS: Main: 153665536 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | __start_tp_report 03:38:09 INFO - PROCESS | 3472 | _x_x_mozilla_page_load 03:38:09 INFO - PROCESS | 3472 | _x_x_mozilla_page_load_details 03:38:09 INFO - PROCESS | 3472 | |i|pagename|runs| 03:38:09 INFO - PROCESS | 3472 | |0;dojo.html;3125.624925008999;3165.3194563168913;3188.9202769930735;3207.4386982278097;3208.4866421372585;5156.071907056728;5220.973895130519;5250.789968401265;5267.736613169341;5313.654612450188;5215.86960325992;5216.634835561512;5227.607929405301;5232.372115346155;5235.162374020158;4862.586680132193;4902.877428064291;4942.53045960635;4956.107900577895;5002.924956125661;4902.068606964684;4933.555979961803;4943.060818444484;4953.801847926079;4998.450170481262;4570.977145114286;4770.332153498513;4841.612670986313;4858.902821943577;4866.489018653061;4838.129136755382;4856.68431551948;4862.805487780484;4868.683535570177;4879.780409881564;4782.043591281723;4829.951700482985;4858.17411040124;4861.538153875376;4899.559039686445;5143.3313669223135;5151.04705629456;5151.819686310999;5209.348831396075;5214.6871187728475;5704.458076482728;5716.57125715573;5740.196372507852;5752.28096487939;5756.5682573807135;5573.191887176336;5658.632188907708;5667.121596152603;5762.193292938992;5824.068149096124;5386.218998245233;5405.702686352249;5419.458054194628;5425.6202065855405;5448.972755136238;5881.382454842265;5904.498117659961;5918.082697181943;5919.585629005928;5927.673977931169;5459.508644222039;5531.225628412026;5559.583031272671;5683.261176047087;5686.857828554319;5714.228579141846;5717.399673034354;5724.341700704389;5725.341585717612;5763.596548241667;5652.97173514138;5671.376148623648;5682.516986056232;5685.260916080883;5692.459216374521;5588.30146231721;5624.831255062355;5629.268195134607;5682.431756824284;5727.77088916447;4397.890052748643;4398.076403955141;4405.493368262627;4422.358757980075;4428.844990425319;3935.980320098381;3937.9212415751526;3939.468171796828;3985.940210896839;4003.819828107742;5176.327077479904;5280.81517146898;5295.920561191585;5345.412004679482;5372.516473517402;5694.1458781183155;5739.540836733051;5758.827235182951;5761.107028410603;5770.682612456271;5256.579473642099;5356.250124982505;5361.571074314045;5361.973190134025;5413.891722165535;4821.5178482151505;4834.806607735722;4855.174620314555;4868.683535570248;4891.63312751538;5834.095715164071;5880.529557635379;5891.116332550066;5902.262217222933;5905.46850783423;5541.5843811715085;5606.27118474612;5699.601027928005;5708.372079071216;5711.3431955324;5875.441833025856;5893.852653683521;5926.407359264039;5941.22764040672;5993.0710739835395;5532.585056120726;5560.36055853582;5563.972180139235;5592.916106258491;5601.495865372136;5582.8325150245555;5604.607677462538;5623.746931388016;5657.038303488334;5668.574856885833;5463.207834864002;5531.474509921551;5575.080111781511;5640.605157638925;5658.349289831722;5545.833624991256;5574.804881829116;5583.944160558342;5592.69240191777;5611;5356.303680521507;5469.234307197075;5480.314960629921;5514.476124768141;5556.888862222814;5528.668279903219;5560.36055853582;5662.631928924607;5707.5433965281845;5721.427857214412;5415.48552887475;5430.429804870431;5443.836684899459;5445.782168713207;5455.945440545703 03:38:09 INFO - PROCESS | 3472 | |1;ext.html;533.8638647144977;535.0743214239366;548.6351576201826;556.6075916478883;565.2143520506494;35140.297194056104;35796.46305305419;36091.819540902325;36125.81937090318;36291.81854090729;35268.64731352685;36121.27757444856;36379.27241455169;36416.45375319366;36438.635613643855;8011.999999999985;8183.140770219131;8204.466709663853;8246.299064579518;8261.710840120597;8299.962504686913;8348.916510834904;8405.159484051606;8428.704995325164;8430.367722420813;8312.750617481455;8419.242268195861;8436.114208008163;8468.44955077921;8475.703350382737;8384.161583841627;8430.831383372359;8450.746477605682;8455.577221138918;8488.23605875471;8283.17168283173;8341;8387.790305242357;8423.915760842374;8457.492550446992;36355;36901.81549092264;36982.81508592467;37012.07469813249;37030.44454333187;3165.920851978719;3245.2698142917657;3343.565336506263;3598.1364472526666;3679.5584529856587;29894.252643683863;29933;30069.398612027857;30288;31035.22411939697;3785;3808.90477738056;3817.5800661927165;3935.74417662851;4011.498562679665;198889;199457;200469.9976500123;200898;201140;52128;53512.73243633757;58581;60475;60569.39430605726;54543.45456545463;54736;54877;55001.44998549963;55063.724681376334;14484.493042743454;14708.632284192981;14746.410143594136;14746.705065898623;14785.704285914222;11046.33721976684;11141.721456963478;11149.554017839358;11160.832587511193;11254.718632034264;19533.8046619532;19808.90095549513;19907.60184796296;19920.601587968158;20031.699524507145;7124.893126603105;7237.819054523679;7258.963705181441;7267.709291628275;7331.340179383881;961.9374740641836;998.8601595776597;1025.1747343388495;1039.3192458939407;1039.4387031003173;28270.71729282722;28555.428891422056;28655.321723862802;28966;29134;1014.1025192704362;1020.6223697232072;1021.1422405179536;1058.0953284941418;1114.2033446086086;14984.325705343286;15479.613009674847;15636.296366663528;15725.764113538306;16137;371997;379941;382657;383174;383400;52650.21024684633;53183.73408132935;53206.46793532093;53247.73376133172;53259.20111198335;1330.1021810278023;1344.1128854955682;1345.3744009035845;1348.9662758431118;1354.5529975108388;29423;30424.695753042186;30490.695093048784;31129;31162.06513804499;43812.78093609639;44234;44491.332630011224;44500.777496112314;44591.77704111459;299314;300554;300646;300902;301318;41498.79250603728;42469.787651061546;42910.63889040933;42994.35508467313;43881;42231.577684223994;42346.78826605847;42371.576284238;42924.14151717011;43452.78273608612;34971.825140874134;35216.295674085864;35269.1182720434;35364.64635353613;36098.4585231227;36879.26241475102;37074.814625926694;37437.4384384229;38197.809010955876;38630.6136938627;34588.80545666684;34887.30225395427;35579.46630800592;35811.28377432385;35983.64016359803;29913.85043074771;30433.84783076159;32818.83590582032;33001.50497742488;33401.33197336088;25219;25434.74565254324;25660.486790263716;25976.480470390863;26041 03:38:09 INFO - PROCESS | 3472 | |2;jquery.html;350.7492143117671;352;352.7054909150859;357.3317895535349;364.6098674418372;15245.923770381147;16199.352025918965;16924.576885577866;17659.64680706385;17968.91015544922;11146.498407571658;11271.09831213503;11472.827907581393;11519.424028798569;11556.248843825166;4778.163821331262;4976.129177393959;5014.598832093442;5075.670081444713;5270.499302566269;4642.976785116087;5206.427292997767;5229.058769421503;5251.947480525203;5254.57963362932;5016;5207.323048003755;5677.659340439566;5679.5740319476;5689.829305120832;5145.279660847485;5152.9742351288005;5183.300254465656;5200.115980283361;5211.270422140903;5303.36359636846;5310;5318.680879147263;5330.760115794798;5342.305500284977;12999.220046797222;17380.913095434567;19564.413067607853;20018.599628007505;20180;1980.8712433691765;2139.475828422031;2193.3529608765293;2253.966190507144;2340.9816729722625;9317.44095354281;9373.484458354787;9511.66709165176;9512.429254244767;9797.755056123582;1780.1811166863129;1785.1520527749344;1823.6170404215131;1842;1874.156629516723;55010;55649;56988.43011569873;57056.42943570594;58185.12722309169;10090.394576325443;10287;10361.689149325532;10369;10427.582896684047;13283.933580332037;13392.129511581716;13465.798013029616;13507.392167352493;13542.187468751907;7387.926120738832;7442.404607631484;7448.478606497493;7466.925330746623;7518.323350898446;7037.894431583531;7062.540934839219;7063.964680176567;7098.645067746592;7112.110986126734;4454.1982443159895;4504.391907092566;4510.774461276923;4553.954460455419;4567.931481027787;1724.1120822776281;1812.1211212561898;1850.0379802502623;1859.3492277702967;1861.5346163459135;863.374053810982;873.6898401067657;892.3753372639178;934;991.6612573026357;15440.691186176213;15893.364265429485;15916.283767230503;16328.836711632732;16343.18284085791;885.6988623867916;888.5690440136528;925.3060204846365;927.248928368024;938.7512309238058;8485.193906578865;9268.397554158959;9306.53467326631;9345.299102567335;9389.357530891224;361696;367616;478545;481819;485087;64635.353646462936;66071.33928660749;73001;74039.25960740431;76825.23174768292;1078.379931539368;1111.7609713911386;1112.1325366214367;1121.3496172220255;1121.3664279681955;15001.549953501413;15093.47172848945;15131.167785771888;15182.848171518144;15625.218739063228;22138.77861221367;23651.881740591187;28309.867605295556;33530;34363.31273374568;43759.562404376826;44986.77506612446;46156;47060.29409558928;47502;6822.283660215804;6965.303469652994;7058.752943646948;7093.574385536885;7164.355208031302;8399.41204115706;10772.353658780497;10968.17738669587;11213.60752373663;11265.831012534654;8982.595783189641;9311.975682674765;9447.433154010781;9682.612695492384;9851;9263.953680231825;9425.764355891157;9655.179309758749;9701.805963880824;9838.26213034011;9660.275479338938;9730.805383892424;9858.112769850748;9939.254555908481;10051.849222261819;7548.207438218908;7724.8455030900195;7731.342835859015;7734;7746.845063098819;9097.818043639223;9398.530073496435;9429.905700943178;9539.14147726708;9703.951480242553 03:38:09 INFO - PROCESS | 3472 | |3;mootools.html;1392.0742706100443;1462.013141129737;1580.399448209681;1723.1039859273171;1738.8956662600244;6848.96575517123;6957.373836354727;7785.532868027915;7914.327282181014;7977.321927636151;7505.286997735207;7655.349295309906;7722.768316950501;7723.691052357899;7731.304182623563;2291.8854057297153;2310.9947172979723;2319.3969567912295;2321.0599707118645;2340.1224540797202;2234.8100411465043;2252.7296724393013;2262.864228146308;2267.875266860322;2276.203328834911;2269.5347453771938;2271.3526644906206;2295.942601434969;2302.2172461363134;2324.372419446748;2299.977000229993;2308.492131731025;2324.3143272734414;2324.6745455636224;2324.76752324767;2358.8466749661216;2364.2552595932225;2365.5268946210826;2366.6804981327473;2370.3007612754277;7956.60216989154;8003.439759216857;8013.677743172369;8058;8090.433669643127;4766.856994290177;4839.782209800567;4850.611951043908;4866.853994380139;4868.610511159099;3092.7371173450283;3109.875604975798;3158.7473002159772;3179.71382575567;3182.236263296815;1052.9631462898838;1059.4808543813554;1061.6496556136456;1090.4057288777635;1091.49245600796;10733.141348692086;10775.515101820358;10802.6759197225;10824.72938176544;10861.34831910088;4324.481062272484;4332.848350307787;4426.446694163165;4454.420925279693;4463.285874260103;9276.860847087299;9281.814363712689;9282.860757088649;9319.207867331217;9327.486988215713;4832.695172303458;4886.926696099561;4911.287863259808;4918.942427378131;4935.851924442272;4353.1293741251875;4441.4892287387365;4450.35469856869;4459.10817836434;4482.327650852333;3625.8549658013385;3637.1452708613456;3674.6876515495946;3681.37416639172;3700.1489657378415;1097.2703152403562;1097.9780404391868;1098.5386137821974;1101.9559217631204;1115.9330440173615;1272.6054922973908;1272.885440310358;1283.9550615728592;1295.559509766684;1301.3623324570892;7429.85140297191;7450.701971921062;7479.626018699043;7595.088589369311;7612.467127301146;1105.336797921257;1106.6624679472677;1107.789519991199;1114.9609763658234;1115.6876074699098;5567.693776842231;5631.577631677558;5640.182173584807;5645.689487078168;5668.659880407189;9446.244300455946;9651.613935442643;9863.506824658738;9995.250356223312;10007.849882251772;9797.363171393836;9812.215022798158;9828.361156524803;9849.261305402124;9871.01289871007;7255.782326530212;7483.102027756704;7487.401007919353;7553.282438168365;7586.506877052974;7072.823179420556;7134.785956421316;7186.820329491805;7218.061651985208;7227.530210536298;8270.2556769891;8418.116097809887;8596.91403085961;8619.525926073875;8654.913450865663;8557.229849313591;8704.129587041245;8719.65121395137;8725.78185545341;8845.4250473719;6871.106756121672;7042.260562640849;7074.929250707427;7144.678489467882;7240.96379518099;7530.28462296081;7535.623218839146;7536.171021187774;7574.81062973408;7586.582737949466;6782.423494003065;7111.715531378687;7136.4647651427385;7172.641367931687;7303.561786292839;7010.859782804418;7015.754448594274;7126.536775109601;7212.819679508054;7226.060612120391;7058.894116588358;7078.823029424099;7096.077509923677;7096.353193757614;7103;6411.3909178627955;6428.100065990859;6442;6444.806655800334;6446.806595802133;6682.532222744556;6738.932610673831;6772.627505487246;6796.694148763218;6799.7620083298825 03:38:09 INFO - PROCESS | 3472 | |4;prototype.html;330.3821853134638;333.94656854903207;337.40784922461074;340.8994346667733;341.73515525467775;6107.60300580462;6224.84437889053;6294.118823364727;6294.307626161124;6297.559170858041;6070.2412198475195;6171.166892469515;6190.102435146901;6204.379562043793;6235.438810507054;4736.786844592001;4739.763011849411;4741.976290118562;4748.928766068503;4770.212914869043;4688.5311468853015;4723.456802467708;4730.929036064462;4738.857834264961;4741.478437371887;4517.435320584927;4653.232216684243;4663.813447462097;4667.043256132485;4713.43438787346;4618.930716039262;4655.557722016403;4663.137319595886;4664.416947881497;4679.766011699436;4033.0925541753163;4036.253293140749;4037.9905023744063;4039.6970227233073;4044.0496483326397;5917.940820591782;5918.378570250148;5929.466348028698;5929.970350148222;5941.435563621449;5314.388845282803;5394.838154855322;5459.535939445152;5476.945230547683;5497.835064948018;6608;6620.23867255267;6647.468202543785;6647.66761661915;6659.300773418819;4518.254488009475;4527.592516673482;4536.954630453686;4548.113117942003;4553.977230113828;6799.762008329734;6827.556208846409;6871.862562748767;6873.450123990069;6902.413294869892;4532;4542.613877820356;4546.954530454719;4551.5676010778925;4553.908921821611;4601.44782626087;4601.953980460219;4609.308603709471;4616.399868017136;4617.907641847211;5327.627066105413;5370.516653501204;5378.757955891994;5383.703896285742;5415.160650099241;6414.102025716404;6564.212294524687;6577.408033277028;6587.143671322793;6605.86788264232;1583.2875206157275;1594.6810637872472;1594.8165960914412;1598.3207136966744;1618.3364820423806;1050.7845891592206;1054.5570860238718;1055.994720026395;1059.5073290919759;1070.2347821307803;6188.8762224755255;6198.349173336825;6205.81382558524;6210.875782484325;6212.875742485125;6621.735130594722;6703.966480167665;6706.22878368984;6725.529212955046;6735.326467353226;6104.908426373608;6178.165947597106;6203.534734894901;6205.720742566596;6210.4410603045035;3648.927021459556;3659.0852286928266;3672.467492213614;3672.8347224374966;3673.430618254175;6979.651017449107;7009.509334346547;7048.471364647569;7065.82335441618;7066.399356054793;6730.629815360105;6867.07294515234;6879.140107486564;6901.102856628606;6903.6203008835;6934.930650693529;6940.375366217065;7013.473989450812;7013.754518591825;7043.471739619446;6671.499637527302;6680.298568650416;6684.866302674017;6687.4984376171005;6710.4631629470505;6511.967440162769;6601.735930562916;6602.570832895846;6617.569857959217;6627.436667883284;6826.146731658543;6853.931460685529;6879.174499060145;6894.069300644349;6896.069030680794;4548.6361091113295;4554.385158003627;4568.817247310203;4572.291294849304;4574.565416285448;6690.330966903271;6690.632015239208;6703.597784132968;6738.865222695421;6865.107536020485;6650.534462587572;6665.666716664245;6679.265280819203;6688.83277918056;6699.29657385987;6641.634710090992;6675.933240667531;6681.098051763144;6687.398134167948;6701.530892837454;6463.57986730861;6556.0493728410065;6574.3754343337305;6577.2107347116735;6583.275839657729;6586.571872828251;6655.866882662222;6680.465562755066;6703.765368212089;6715.093462382712;6499.1876015498065;6506.316836732264;6531.575447595891;6531.934680653133;6534.379233972765 03:38:09 INFO - PROCESS | 3472 | |5;yui.html;734.8162959260181;742.743753405075;778.4045205417855;815.2092470303807;824.938129640277;12360.44378002991;12488.375581220926;12555.309457979818;12557.183783054095;12572.622821315352;12163.939180304109;12205.938970305158;12215.816762748544;12216.144869859114;12231;767.957762323072;771.2326235395775;775.7091090840935;779.5361759752966;801.1587832775563;794.5629903553051;800.1918062756629;800.4756884240832;803.2008151888879;808.8058865872207;830.4104086098877;835.5404527509876;838.9622466989;839.6431516605448;841.7811369044063;830.9750707478785;831.1190138453198;832.629479881453;834.090840983328;834.2700137379793;613.4417679911304;614.4930432393294;615.6890770161085;616.8272883592601;617.5183356981562;12811.359432028361;12872.09895307329;12874.356282185854;12876.291803950779;12925.15986460877;12449.75100497985;12639.684007899785;12648.241105533698;12842.807357889638;12904.225746455242;9863.358881672668;10121.746956326077;10243.590256389736;10456.790864182749;10676.092532134779;4191.7694526801015;4243.596858298457;4257.489101307832;4284.164587905359;4426.911461770779;44974;45355.773221133684;45361.09277814458;45407.77296113531;45824.77087614574;9459.90540094604;9745.463999479955;9843.901560984299;10113.190944724405;10145.137663298554;16268.186590670419;16623.83376166223;16624.25190866414;16630.6673866522;16642.3343066276;6618;6810.659467026629;6885.345892140239;6996.755113571001;7195.784126476214;3713.9814300928865;3845.384738441836;3912.139329347539;3938.2517321708783;4035.535913369941;3019;3028.1369809604157;3029.7727670424806;3032.5451182322386;3036.817790932551;550.3148580017823;555.2809112199711;564.2833601326292;572.0646742575918;574.7815829984579;507.7461269365317;553.7923278770461;577.971101444926;581.979630712923;650.5218664281749;8598.613062412207;8603.437186831507;8714.738557843275;8766.60550275239;8842.557872106498;577.053632043449;578.9305283366023;627.2754968011953;630.8895943210011;666.6266890541312;4008.2985477541315;4150.875473735793;4231.322988321854;4427.2252355838245;4527.253003254426;57046;57719.422805771406;57732;58052;58504.70747646235;50342.74828625907;50792;50974;51361;51920.22119668133;43566.56433435689;43602.345964810556;44039.33940990888;44724.77637611791;44964.55035449669;8149.877751833846;8242.711505097293;8407;8716.738497845075;8903.171636196497;34233.82883085569;35181.47227791534;35439.82280088583;35498.46752298666;36192.457113142795;43108.568914310454;43673.56326436695;43816.12367752563;43882;44469;10857.402842843403;10897.455127243447;10905.400202988912;10982.780134764163;11030.841761614915;11700.47347869331;11701.356425396685;11791.726684585188;11982.940085299517;12120.333381664093;10404.68785936423;10548.683539493828;10555.788884222426;10579.15366770641;10882.673519794418;10861.891381086089;11386.373749443861;11444.313341199555;11489.482973266391;11845.052395808143;10579.682609521727;10762.838557421488;10790.514426850654;10798.73003174927;10803.729906752395;9023.639054437748;9112.20880777227;9203.838510929436;9224.538773061186;9665.130138287588;8111.675532978615;8147.388945828968;8274.29668478186;8344.83310333802;8431.578421078799 03:38:09 INFO - PROCESS | 3472 | __end_tp_report 03:38:09 INFO - PROCESS | 3472 | __start_cc_report 03:38:09 INFO - PROCESS | 3472 | _x_x_mozilla_cycle_collect,310 03:38:09 INFO - PROCESS | 3472 | __end_cc_report 03:38:09 INFO - PROCESS | 3472 | __startTimestamp1453117089422__endTimestamp 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | ------- Summary: start ------- 03:38:09 INFO - PROCESS | 3472 | Number of tests: 6 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | [#0] dojo.html Cycles:165 Average:5289.94 Median:5463.21 stddev:582.30 (10.7%) stddev-sans-first:558.79 03:38:09 INFO - PROCESS | 3472 | Values: 3125.6 3165.3 3188.9 3207.4 3208.5 5156.1 5221.0 5250.8 5267.7 5313.7 5215.9 5216.6 5227.6 5232.4 5235.2 4862.6 4902.9 4942.5 4956.1 5002.9 4902.1 4933.6 4943.1 4953.8 4998.5 4571.0 4770.3 4841.6 4858.9 4866.5 4838.1 4856.7 4862.8 4868.7 4879.8 4782.0 4830.0 4858.2 4861.5 4899.6 5143.3 5151.0 5151.8 5209.3 5214.7 5704.5 5716.6 5740.2 5752.3 5756.6 5573.2 5658.6 5667.1 5762.2 5824.1 5386.2 5405.7 5419.5 5425.6 5449.0 5881.4 5904.5 5918.1 5919.6 5927.7 5459.5 5531.2 5559.6 5683.3 5686.9 5714.2 5717.4 5724.3 5725.3 5763.6 5653.0 5671.4 5682.5 5685.3 5692.5 5588.3 5624.8 5629.3 5682.4 5727.8 4397.9 4398.1 4405.5 4422.4 4428.8 3936.0 3937.9 3939.5 3985.9 4003.8 5176.3 5280.8 5295.9 5345.4 5372.5 5694.1 5739.5 5758.8 5761.1 5770.7 5256.6 5356.3 5361.6 5362.0 5413.9 4821.5 4834.8 4855.2 4868.7 4891.6 5834.1 5880.5 5891.1 5902.3 5905.5 5541.6 5606.3 5699.6 5708.4 5711.3 5875.4 5893.9 5926.4 5941.2 5993.1 5532.6 5560.4 5564.0 5592.9 5601.5 5582.8 5604.6 5623.7 5657.0 5668.6 5463.2 5531.5 5575.1 5640.6 5658.3 5545.8 5574.8 5583.9 5592.7 5611.0 5356.3 5469.2 5480.3 5514.5 5556.9 5528.7 5560.4 5662.6 5707.5 5721.4 5415.5 5430.4 5443.8 5445.8 5455.9 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | [#1] ext.html Cycles:180 Average:46155.41 Median:36397.86 stddev:79567.08 (218.6%) stddev-sans-first:79716.55 03:38:09 INFO - PROCESS | 3472 | Values: 533.9 535.1 548.6 556.6 565.2 35140.3 35796.5 36091.8 36125.8 36291.8 35268.6 36121.3 36379.3 36416.5 36438.6 8012.0 8183.1 8204.5 8246.3 8261.7 8300.0 8348.9 8405.2 8428.7 8430.4 8312.8 8419.2 8436.1 8468.4 8475.7 8384.2 8430.8 8450.7 8455.6 8488.2 8283.2 8341.0 8387.8 8423.9 8457.5 36355.0 36901.8 36982.8 37012.1 37030.4 3165.9 3245.3 3343.6 3598.1 3679.6 29894.3 29933.0 30069.4 30288.0 31035.2 3785.0 3808.9 3817.6 3935.7 4011.5 198889.0 199457.0 200470.0 200898.0 201140.0 52128.0 53512.7 58581.0 60475.0 60569.4 54543.5 54736.0 54877.0 55001.4 55063.7 14484.5 14708.6 14746.4 14746.7 14785.7 11046.3 11141.7 11149.6 11160.8 11254.7 19533.8 19808.9 19907.6 19920.6 20031.7 7124.9 7237.8 7259.0 7267.7 7331.3 961.9 998.9 1025.2 1039.3 1039.4 28270.7 28555.4 28655.3 28966.0 29134.0 1014.1 1020.6 1021.1 1058.1 1114.2 14984.3 15479.6 15636.3 15725.8 16137.0 371997.0 379941.0 382657.0 383174.0 383400.0 52650.2 53183.7 53206.5 53247.7 53259.2 1330.1 1344.1 1345.4 1349.0 1354.6 29423.0 30424.7 30490.7 31129.0 31162.1 43812.8 44234.0 44491.3 44500.8 44591.8 299314.0 300554.0 300646.0 300902.0 301318.0 41498.8 42469.8 42910.6 42994.4 43881.0 42231.6 42346.8 42371.6 42924.1 43452.8 34971.8 35216.3 35269.1 35364.6 36098.5 36879.3 37074.8 37437.4 38197.8 38630.6 34588.8 34887.3 35579.5 35811.3 35983.6 29913.9 30433.8 32818.8 33001.5 33401.3 25219.0 25434.7 25660.5 25976.5 26041.0 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | [#2] jquery.html Cycles:180 Average:24287.91 Median:5110.47 stddev:71886.09 (1406.6%) stddev-sans-first:72065.28 03:38:09 INFO - PROCESS | 3472 | Values: 350.7 352.0 352.7 357.3 364.6 15245.9 16199.4 16924.6 17659.6 17968.9 11146.5 11271.1 11472.8 11519.4 11556.2 4778.2 4976.1 5014.6 5075.7 5270.5 4643.0 5206.4 5229.1 5251.9 5254.6 5016.0 5207.3 5677.7 5679.6 5689.8 5145.3 5153.0 5183.3 5200.1 5211.3 5303.4 5310.0 5318.7 5330.8 5342.3 12999.2 17380.9 19564.4 20018.6 20180.0 1980.9 2139.5 2193.4 2254.0 2341.0 9317.4 9373.5 9511.7 9512.4 9797.8 1780.2 1785.2 1823.6 1842.0 1874.2 55010.0 55649.0 56988.4 57056.4 58185.1 10090.4 10287.0 10361.7 10369.0 10427.6 13283.9 13392.1 13465.8 13507.4 13542.2 7387.9 7442.4 7448.5 7466.9 7518.3 7037.9 7062.5 7064.0 7098.6 7112.1 4454.2 4504.4 4510.8 4554.0 4567.9 1724.1 1812.1 1850.0 1859.3 1861.5 863.4 873.7 892.4 934.0 991.7 15440.7 15893.4 15916.3 16328.8 16343.2 885.7 888.6 925.3 927.2 938.8 8485.2 9268.4 9306.5 9345.3 9389.4 361696.0 367616.0 478545.0 481819.0 485087.0 64635.4 66071.3 73001.0 74039.3 76825.2 1078.4 1111.8 1112.1 1121.3 1121.4 15001.5 15093.5 15131.2 15182.8 15625.2 22138.8 23651.9 28309.9 33530.0 34363.3 43759.6 44986.8 46156.0 47060.3 47502.0 6822.3 6965.3 7058.8 7093.6 7164.4 8399.4 10772.4 10968.2 11213.6 11265.8 8982.6 9312.0 9447.4 9682.6 9851.0 9264.0 9425.8 9655.2 9701.8 9838.3 9660.3 9730.8 9858.1 9939.3 10051.8 7548.2 7724.8 7731.3 7734.0 7746.8 9097.8 9398.5 9429.9 9539.1 9704.0 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | [#3] mootools.html Cycles:180 Average:5559.02 Median:6040.03 stddev:2877.16 (47.6%) stddev-sans-first:2868.18 03:38:09 INFO - PROCESS | 3472 | Values: 1392.1 1462.0 1580.4 1723.1 1738.9 6849.0 6957.4 7785.5 7914.3 7977.3 7505.3 7655.3 7722.8 7723.7 7731.3 2291.9 2311.0 2319.4 2321.1 2340.1 2234.8 2252.7 2262.9 2267.9 2276.2 2269.5 2271.4 2295.9 2302.2 2324.4 2300.0 2308.5 2324.3 2324.7 2324.8 2358.8 2364.3 2365.5 2366.7 2370.3 7956.6 8003.4 8013.7 8058.0 8090.4 4766.9 4839.8 4850.6 4866.9 4868.6 3092.7 3109.9 3158.7 3179.7 3182.2 1053.0 1059.5 1061.6 1090.4 1091.5 10733.1 10775.5 10802.7 10824.7 10861.3 4324.5 4332.8 4426.4 4454.4 4463.3 9276.9 9281.8 9282.9 9319.2 9327.5 4832.7 4886.9 4911.3 4918.9 4935.9 4353.1 4441.5 4450.4 4459.1 4482.3 3625.9 3637.1 3674.7 3681.4 3700.1 1097.3 1098.0 1098.5 1102.0 1115.9 1272.6 1272.9 1284.0 1295.6 1301.4 7429.9 7450.7 7479.6 7595.1 7612.5 1105.3 1106.7 1107.8 1115.0 1115.7 5567.7 5631.6 5640.2 5645.7 5668.7 9446.2 9651.6 9863.5 9995.3 10007.8 9797.4 9812.2 9828.4 9849.3 9871.0 7255.8 7483.1 7487.4 7553.3 7586.5 7072.8 7134.8 7186.8 7218.1 7227.5 8270.3 8418.1 8596.9 8619.5 8654.9 8557.2 8704.1 8719.7 8725.8 8845.4 6871.1 7042.3 7074.9 7144.7 7241.0 7530.3 7535.6 7536.2 7574.8 7586.6 6782.4 7111.7 7136.5 7172.6 7303.6 7010.9 7015.8 7126.5 7212.8 7226.1 7058.9 7078.8 7096.1 7096.4 7103.0 6411.4 6428.1 6442.0 6444.8 6446.8 6682.5 6738.9 6772.6 6796.7 6799.8 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | [#4] prototype.html Cycles:180 Average:5468.25 Median:6205.77 stddev:1669.55 (26.9%) stddev-sans-first:1629.09 03:38:09 INFO - PROCESS | 3472 | Values: 330.4 333.9 337.4 340.9 341.7 6107.6 6224.8 6294.1 6294.3 6297.6 6070.2 6171.2 6190.1 6204.4 6235.4 4736.8 4739.8 4742.0 4748.9 4770.2 4688.5 4723.5 4730.9 4738.9 4741.5 4517.4 4653.2 4663.8 4667.0 4713.4 4618.9 4655.6 4663.1 4664.4 4679.8 4033.1 4036.3 4038.0 4039.7 4044.0 5917.9 5918.4 5929.5 5930.0 5941.4 5314.4 5394.8 5459.5 5476.9 5497.8 6608.0 6620.2 6647.5 6647.7 6659.3 4518.3 4527.6 4537.0 4548.1 4554.0 6799.8 6827.6 6871.9 6873.5 6902.4 4532.0 4542.6 4547.0 4551.6 4553.9 4601.4 4602.0 4609.3 4616.4 4617.9 5327.6 5370.5 5378.8 5383.7 5415.2 6414.1 6564.2 6577.4 6587.1 6605.9 1583.3 1594.7 1594.8 1598.3 1618.3 1050.8 1054.6 1056.0 1059.5 1070.2 6188.9 6198.3 6205.8 6210.9 6212.9 6621.7 6704.0 6706.2 6725.5 6735.3 6104.9 6178.2 6203.5 6205.7 6210.4 3648.9 3659.1 3672.5 3672.8 3673.4 6979.7 7009.5 7048.5 7065.8 7066.4 6730.6 6867.1 6879.1 6901.1 6903.6 6934.9 6940.4 7013.5 7013.8 7043.5 6671.5 6680.3 6684.9 6687.5 6710.5 6512.0 6601.7 6602.6 6617.6 6627.4 6826.1 6853.9 6879.2 6894.1 6896.1 4548.6 4554.4 4568.8 4572.3 4574.6 6690.3 6690.6 6703.6 6738.9 6865.1 6650.5 6665.7 6679.3 6688.8 6699.3 6641.6 6675.9 6681.1 6687.4 6701.5 6463.6 6556.0 6574.4 6577.2 6583.3 6586.6 6655.9 6680.5 6703.8 6715.1 6499.2 6506.3 6531.6 6531.9 6534.4 03:38:09 INFO - PROCESS | 3472 | 03:38:09 INFO - PROCESS | 3472 | [#5] yui.html Cycles:180 Average:13431.45 Median:24750.63 stddev:15657.33 (63.3%) stddev-sans-first:15672.22 03:38:09 INFO - PROCESS | 3472 | Values: 734.8 742.7 778.4 815.2 824.9 12360.4 12488.4 12555.3 12557.2 12572.6 12163.9 12205.9 12215.8 12216.1 12231.0 768.0 771.2 775.7 779.5 801.2 794.6 800.2 800.5 803.2 808.8 830.4 835.5 839.0 839.6 841.8 831.0 831.1 832.6 834.1 834.3 613.4 614.5 615.7 616.8 617.5 12811.4 12872.1 12874.4 12876.3 12925.2 12449.8 12639.7 12648.2 12842.8 12904.2 9863.4 10121.7 10243.6 10456.8 10676.1 4191.8 4243.6 4257.5 4284.2 4426.9 44974.0 45355.8 45361.1 45407.8 45824.8 9459.9 9745.5 9843.9 10113.2 10145.1 16268.2 16623.8 16624.3 16630.7 16642.3 6618.0 6810.7 6885.3 6996.8 7195.8 3714.0 3845.4 3912.1 3938.3 4035.5 3019.0 3028.1 3029.8 3032.5 3036.8 550.3 555.3 564.3 572.1 574.8 507.7 553.8 578.0 582.0 650.5 8598.6 8603.4 8714.7 8766.6 8842.6 577.1 578.9 627.3 630.9 666.6 4008.3 4150.9 4231.3 4427.2 4527.3 57046.0 57719.4 57732.0 58052.0 58504.7 50342.7 50792.0 50974.0 51361.0 51920.2 43566.6 43602.3 44039.3 44724.8 44964.6 8149.9 8242.7 8407.0 8716.7 8903.2 34233.8 35181.5 35439.8 35498.5 36192.5 43108.6 43673.6 43816.1 43882.0 44469.0 10857.4 10897.5 10905.4 10982.8 11030.8 11700.5 11701.4 11791.7 11982.9 12120.3 10404.7 10548.7 10555.8 10579.2 10882.7 10861.9 11386.4 11444.3 11489.5 11845.1 10579.7 10762.8 10790.5 10798.7 10803.7 9023.6 9112.2 9203.8 9224.5 9665.1 8111.7 8147.4 8274.3 8344.8 8431.6 03:38:09 INFO - PROCESS | 3472 | -------- Summary: end -------- 03:38:09 INFO - PROCESS | 3472 | 03:38:10 INFO - TEST-INFO | 3472: exit 0 03:38:10 INFO - TEST-OK | dromaeo_css | took 1113015ms 03:38:10 INFO - TEST-START | kraken 03:38:10 INFO - operating with platform_type : linux_ 03:38:10 INFO - Initialising browser for kraken test... 03:38:10 INFO - TEST-INFO | started process 3750 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi8gt7p/profile http://localhost:50968/getInfo.html) 03:38:13 INFO - PROCESS | 3750 | 03:38:13 INFO - PROCESS | 3750 | (process:3819): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:14 INFO - PROCESS | 3750 | __metrics Screen width/height:1600/1200 03:38:14 INFO - PROCESS | 3750 | colorDepth:24 03:38:14 INFO - PROCESS | 3750 | Browser inner width/height: 1024/697 03:38:14 INFO - PROCESS | 3750 | __metrics 03:38:14 INFO - PROCESS | 3750 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:38:15 INFO - TEST-INFO | 3750: exit 0 03:38:15 INFO - Browser initialized. 03:38:15 INFO - Running cycle 1/1 for kraken test... 03:38:15 INFO - TEST-INFO | started process 3867 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi8gt7p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:16 INFO - PROCESS | 3867 | -- checkerboarding starts below -- 03:38:16 INFO - PROCESS | 3867 | RENDERTRACE 0.057186 rect red 0 0 10 10 // viewport 03:38:16 INFO - PROCESS | 3867 | RENDERTRACE 28.4672 rect brown 0 0 10 10 // page 03:38:16 INFO - PROCESS | 3867 | RENDERTRACE 28.4892 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 03:38:16 INFO - PROCESS | 3867 | Checkerboarded for 1 frames (28.5218 ms), 100 peak, 1 severity. 03:38:17 INFO - PROCESS | 3867 | 03:38:17 INFO - PROCESS | 3867 | (process:3926): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:27 INFO - PROCESS | 3867 | RSS: Main: 150077440 03:38:27 INFO - PROCESS | 3867 | 03:38:30 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50968/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:30 INFO - PROCESS | 3867 | RSS: Main: 150380544 03:38:30 INFO - PROCESS | 3867 | 03:38:33 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50968/tests/kraken/driver.html?testName=audio-dft) 03:38:34 INFO - PROCESS | 3867 | RSS: Main: 154476544 03:38:34 INFO - PROCESS | 3867 | 03:38:36 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50968/tests/kraken/driver.html?testName=audio-fft) 03:38:37 INFO - PROCESS | 3867 | RSS: Main: 146984960 03:38:37 INFO - PROCESS | 3867 | 03:38:39 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50968/tests/kraken/driver.html?testName=audio-oscillator) 03:38:40 INFO - PROCESS | 3867 | RSS: Main: 147628032 03:38:40 INFO - PROCESS | 3867 | 03:38:42 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50968/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:43 INFO - PROCESS | 3867 | RSS: Main: 147943424 03:38:43 INFO - PROCESS | 3867 | 03:38:46 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50968/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:46 INFO - PROCESS | 3867 | RSS: Main: 146272256 03:38:46 INFO - PROCESS | 3867 | 03:38:50 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50968/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:50 INFO - PROCESS | 3867 | RSS: Main: 146272256 03:38:50 INFO - PROCESS | 3867 | 03:38:53 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50968/tests/kraken/driver.html?testName=json-parse-financial) 03:38:54 INFO - PROCESS | 3867 | RSS: Main: 148873216 03:38:54 INFO - PROCESS | 3867 | 03:38:55 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50968/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:56 INFO - PROCESS | 3867 | RSS: Main: 150687744 03:38:56 INFO - PROCESS | 3867 | 03:38:58 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:58 INFO - PROCESS | 3867 | RSS: Main: 150523904 03:38:58 INFO - PROCESS | 3867 | 03:39:00 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:01 INFO - PROCESS | 3867 | RSS: Main: 150396928 03:39:01 INFO - PROCESS | 3867 | 03:39:03 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:04 INFO - PROCESS | 3867 | RSS: Main: 150966272 03:39:04 INFO - PROCESS | 3867 | 03:39:06 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:07 INFO - PROCESS | 3867 | RSS: Main: 150528000 03:39:07 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:50968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50968/tests/kraken/driver.html?testName=ai-astar) 03:39:09 INFO - PROCESS | 3867 | RSS: Main: 150437888 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | __start_tp_report 03:39:09 INFO - PROCESS | 3867 | _x_x_mozilla_page_load 03:39:09 INFO - PROCESS | 3867 | _x_x_mozilla_page_load_details 03:39:09 INFO - PROCESS | 3867 | |i|pagename|runs| 03:39:09 INFO - PROCESS | 3867 | |0;ai-astar;111;107;112;113;111;122;113;111;112;111 03:39:09 INFO - PROCESS | 3867 | |1;audio-beat-detection;152;126;153;171;129;150;149;128;180;123 03:39:09 INFO - PROCESS | 3867 | |2;audio-dft;162;165;163;163;161;162;163;167;165;165 03:39:09 INFO - PROCESS | 3867 | |3;audio-fft;71;76;71;71;73;71;146;75;73;74 03:39:09 INFO - PROCESS | 3867 | |4;audio-oscillator;96;97;140;95;96;95;140;96;96;140 03:39:09 INFO - PROCESS | 3867 | |5;imaging-gaussian-blur;110;111;109;110;110;110;110;110;110;110 03:39:09 INFO - PROCESS | 3867 | |6;imaging-darkroom;147;146;146;147;148;146;147;147;146;147 03:39:09 INFO - PROCESS | 3867 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;95 03:39:09 INFO - PROCESS | 3867 | |8;json-parse-financial;59;61;60;58;60;62;63;58;66;61 03:39:09 INFO - PROCESS | 3867 | |9;json-stringify-tinderbox;66;69;71;67;68;67;67;69;68;67 03:39:09 INFO - PROCESS | 3867 | |10;stanford-crypto-aes;87;79;80;82;82;80;80;88;84;84 03:39:09 INFO - PROCESS | 3867 | |11;stanford-crypto-ccm;119;122;124;116;121;119;122;123;114;118 03:39:09 INFO - PROCESS | 3867 | |12;stanford-crypto-pbkdf2;138;144;145;149;148;147;143;146;144;129 03:39:09 INFO - PROCESS | 3867 | |13;stanford-crypto-sha256-iterative;68;69;72;69;72;68;67;70;66;66 03:39:09 INFO - PROCESS | 3867 | __end_tp_report 03:39:09 INFO - PROCESS | 3867 | __start_cc_report 03:39:09 INFO - PROCESS | 3867 | _x_x_mozilla_cycle_collect,742 03:39:09 INFO - PROCESS | 3867 | __end_cc_report 03:39:09 INFO - PROCESS | 3867 | __startTimestamp1453117149339__endTimestamp 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | ------- Summary: start ------- 03:39:09 INFO - PROCESS | 3867 | Number of tests: 14 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.80 (3.4%) stddev-sans-first:4.00 03:39:09 INFO - PROCESS | 3867 | Values: 111.0 107.0 112.0 113.0 111.0 122.0 113.0 111.0 112.0 111.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.00 stddev:19.53 (12.9%) stddev-sans-first:20.60 03:39:09 INFO - PROCESS | 3867 | Values: 152.0 126.0 153.0 171.0 129.0 150.0 149.0 128.0 180.0 123.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.84 (1.1%) stddev-sans-first:1.86 03:39:09 INFO - PROCESS | 3867 | Values: 162.0 165.0 163.0 163.0 161.0 162.0 163.0 167.0 165.0 165.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:23.23 (31.8%) stddev-sans-first:24.40 03:39:09 INFO - PROCESS | 3867 | Values: 71.0 76.0 71.0 71.0 73.0 71.0 146.0 75.0 73.0 74.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:21.33 (22.2%) stddev-sans-first:22.09 03:39:09 INFO - PROCESS | 3867 | Values: 96.0 97.0 140.0 95.0 96.0 95.0 140.0 96.0 96.0 140.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 03:39:09 INFO - PROCESS | 3867 | Values: 110.0 111.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:39:09 INFO - PROCESS | 3867 | Values: 147.0 146.0 146.0 147.0 148.0 146.0 147.0 147.0 146.0 147.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:39:09 INFO - PROCESS | 3867 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:61.00 stddev:2.44 (4.0%) stddev-sans-first:2.50 03:39:09 INFO - PROCESS | 3867 | Values: 59.0 61.0 60.0 58.0 60.0 62.0 63.0 58.0 66.0 61.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.36 03:39:09 INFO - PROCESS | 3867 | Values: 66.0 69.0 71.0 67.0 68.0 67.0 67.0 69.0 68.0 67.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:3.10 (3.7%) stddev-sans-first:2.85 03:39:09 INFO - PROCESS | 3867 | Values: 87.0 79.0 80.0 82.0 82.0 80.0 80.0 88.0 84.0 84.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:121.50 stddev:3.19 (2.6%) stddev-sans-first:3.37 03:39:09 INFO - PROCESS | 3867 | Values: 119.0 122.0 124.0 116.0 121.0 119.0 122.0 123.0 114.0 118.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:145.50 stddev:5.89 (4.0%) stddev-sans-first:5.93 03:39:09 INFO - PROCESS | 3867 | Values: 138.0 144.0 145.0 149.0 148.0 147.0 143.0 146.0 144.0 129.0 03:39:09 INFO - PROCESS | 3867 | 03:39:09 INFO - PROCESS | 3867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.16 (3.1%) stddev-sans-first:2.28 03:39:09 INFO - PROCESS | 3867 | Values: 68.0 69.0 72.0 69.0 72.0 68.0 67.0 70.0 66.0 66.0 03:39:09 INFO - PROCESS | 3867 | -------- Summary: end -------- 03:39:09 INFO - PROCESS | 3867 | 03:39:10 INFO - TEST-INFO | 3867: exit 0 03:39:10 INFO - TEST-OK | kraken | took 60121ms 03:39:10 INFO - TEST-START | v8_7 03:39:10 INFO - operating with platform_type : linux_ 03:39:10 INFO - Initialising browser for v8_7 test... 03:39:10 INFO - TEST-INFO | started process 4153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2Jl3sV/profile http://localhost:50968/getInfo.html) 03:39:13 INFO - PROCESS | 4153 | 03:39:13 INFO - PROCESS | 4153 | (process:4225): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:39:14 INFO - PROCESS | 4153 | __metrics Screen width/height:1600/1200 03:39:14 INFO - PROCESS | 4153 | colorDepth:24 03:39:14 INFO - PROCESS | 4153 | Browser inner width/height: 1024/697 03:39:14 INFO - PROCESS | 4153 | __metrics 03:39:14 INFO - PROCESS | 4153 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:39:15 INFO - TEST-INFO | 4153: exit 0 03:39:15 INFO - Browser initialized. 03:39:15 INFO - Running cycle 1/1 for v8_7 test... 03:39:15 INFO - TEST-INFO | started process 4273 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2Jl3sV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:16 INFO - PROCESS | 4273 | -- checkerboarding starts below -- 03:39:16 INFO - PROCESS | 4273 | RENDERTRACE 0.081192 rect red 0 0 10 10 // viewport 03:39:16 INFO - PROCESS | 4273 | RENDERTRACE 22.7596 rect brown 0 0 10 10 // page 03:39:16 INFO - PROCESS | 4273 | RENDERTRACE 22.7789 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 03:39:16 INFO - PROCESS | 4273 | Checkerboarded for 1 frames (22.8101 ms), 100 peak, 2 severity. 03:39:17 INFO - PROCESS | 4273 | 03:39:17 INFO - PROCESS | 4273 | (process:4332): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:39:27 INFO - PROCESS | 4273 | RSS: Main: 150237184 03:39:27 INFO - PROCESS | 4273 | 03:39:49 INFO - PROCESS | 4273 | Cycle 1(1): loaded http://localhost:50968/tests/v8_7/run.html (next: http://localhost:50968/tests/v8_7/run.html) 03:39:50 INFO - PROCESS | 4273 | RSS: Main: 146800640 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | __start_tp_report 03:39:50 INFO - PROCESS | 4273 | _x_x_mozilla_page_load 03:39:50 INFO - PROCESS | 4273 | _x_x_mozilla_page_load_details 03:39:50 INFO - PROCESS | 4273 | |i|pagename|runs| 03:39:50 INFO - PROCESS | 4273 | |0;Richards;166.08536787908986 03:39:50 INFO - PROCESS | 4273 | |1;DeltaBlue;187.82870022539444 03:39:50 INFO - PROCESS | 4273 | |2;Encrypt;279.09572983533354 03:39:50 INFO - PROCESS | 4273 | |3;Decrypt;5218.75 03:39:50 INFO - PROCESS | 4273 | |4;RayTrace;1070.6638115631692 03:39:50 INFO - PROCESS | 4273 | |5;Earley;719.4244604316547 03:39:50 INFO - PROCESS | 4273 | |6;Boyer;12358.024691358025 03:39:50 INFO - PROCESS | 4273 | |7;RegExp;40098.03921568627 03:39:50 INFO - PROCESS | 4273 | |8;Splay;642.6735218508998 03:39:50 INFO - PROCESS | 4273 | |9;NavierStokes;4859.223300970873 03:39:50 INFO - PROCESS | 4273 | __end_tp_report 03:39:50 INFO - PROCESS | 4273 | __startTimestamp1453117190226__endTimestamp 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | ------- Summary: start ------- 03:39:50 INFO - PROCESS | 4273 | Number of tests: 10 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 166.1 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#1] DeltaBlue Cycles:1 Average:187.83 Median:187.83 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 187.8 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 279.1 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 5218.8 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 1070.7 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#5] Earley Cycles:1 Average:719.42 Median:719.42 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 719.4 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 12358.0 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#7] RegExp Cycles:1 Average:40098.04 Median:40098.04 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 40098.0 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#8] Splay Cycles:1 Average:642.67 Median:642.67 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 642.7 03:39:50 INFO - PROCESS | 4273 | 03:39:50 INFO - PROCESS | 4273 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 03:39:50 INFO - PROCESS | 4273 | Values: 4859.2 03:39:50 INFO - PROCESS | 4273 | -------- Summary: end -------- 03:39:50 INFO - PROCESS | 4273 | 03:39:51 INFO - TEST-INFO | 4273: exit 0 03:39:51 INFO - TEST-OK | v8_7 | took 40863ms 03:39:51 INFO - SUITE-END | took 1213s 03:39:51 INFO - Completed test suite (00:20:14) 03:39:51 INFO - Working with test: dromaeo_css 03:39:51 INFO - Generating results file: dromaeo_css 03:39:51 INFO - Working with test: kraken 03:39:51 INFO - Generating results file: kraken 03:39:51 INFO - javascript benchmark 03:39:51 INFO - Working with test: v8_7 03:39:51 INFO - Generating results file: v8_7 03:39:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 03:39:51 INFO - process_Request line: dromaeo_css 6864.45 graph.html#tests=[[72,63,43]] 03:39:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:51 INFO - process_Request line: kraken 1507.00 graph.html#tests=[[232,63,43]] 03:39:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:39:51 INFO - process_Request line: v8_7 20262.90 graph.html#tests=[[230,63,43]] 03:39:51 INFO - RETURN: dromaeo_css: 6864.45 03:39:51 INFO - RETURN: kraken: 1507.00 03:39:51 INFO - RETURN: v8_7: 20262.90 03:39:51 INFO - javascript benchmark 03:39:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3125.624925008999, 3165.3194563168913, 3188.9202769930735, 3207.4386982278097, 3208.4866421372585, 5156.071907056728, 5220.973895130519, 5250.789968401265, 5267.736613169341, 5313.654612450188, 5215.86960325992, 5216.634835561512, 5227.607929405301, 5232.372115346155, 5235.162374020158, 4862.586680132193, 4902.877428064291, 4942.53045960635, 4956.107900577895, 5002.924956125661, 4902.068606964684, 4933.555979961803, 4943.060818444484, 4953.801847926079, 4998.450170481262, 4570.977145114286, 4770.332153498513, 4841.612670986313, 4858.902821943577, 4866.489018653061, 4838.129136755382, 4856.68431551948, 4862.805487780484, 4868.683535570177, 4879.780409881564, 4782.043591281723, 4829.951700482985, 4858.17411040124, 4861.538153875376, 4899.559039686445, 5143.3313669223135, 5151.04705629456, 5151.819686310999, 5209.348831396075, 5214.6871187728475, 5704.458076482728, 5716.57125715573, 5740.196372507852, 5752.28096487939, 5756.5682573807135, 5573.191887176336, 5658.632188907708, 5667.121596152603, 5762.193292938992, 5824.068149096124, 5386.218998245233, 5405.702686352249, 5419.458054194628, 5425.6202065855405, 5448.972755136238, 5881.382454842265, 5904.498117659961, 5918.082697181943, 5919.585629005928, 5927.673977931169, 5459.508644222039, 5531.225628412026, 5559.583031272671, 5683.261176047087, 5686.857828554319, 5714.228579141846, 5717.399673034354, 5724.341700704389, 5725.341585717612, 5763.596548241667, 5652.97173514138, 5671.376148623648, 5682.516986056232, 5685.260916080883, 5692.459216374521, 5588.30146231721, 5624.831255062355, 5629.268195134607, 5682.431756824284, 5727.77088916447, 4397.890052748643, 4398.076403955141, 4405.493368262627, 4422.358757980075, 4428.844990425319, 3935.980320098381, 3937.9212415751526, 3939.468171796828, 3985.940210896839, 4003.819828107742, 5176.327077479904, 5280.81517146898, 5295.920561191585, 5345.412004679482, 5372.516473517402, 5694.1458781183155, 5739.540836733051, 5758.827235182951, 5761.107028410603, 5770.682612456271, 5256.579473642099, 5356.250124982505, 5361.571074314045, 5361.973190134025, 5413.891722165535, 4821.5178482151505, 4834.806607735722, 4855.174620314555, 4868.683535570248, 4891.63312751538, 5834.095715164071, 5880.529557635379, 5891.116332550066, 5902.262217222933, 5905.46850783423, 5541.5843811715085, 5606.27118474612, 5699.601027928005, 5708.372079071216, 5711.3431955324, 5875.441833025856, 5893.852653683521, 5926.407359264039, 5941.22764040672, 5993.0710739835395, 5532.585056120726, 5560.36055853582, 5563.972180139235, 5592.916106258491, 5601.495865372136, 5582.8325150245555, 5604.607677462538, 5623.746931388016, 5657.038303488334, 5668.574856885833, 5463.207834864002, 5531.474509921551, 5575.080111781511, 5640.605157638925, 5658.349289831722, 5545.833624991256, 5574.804881829116, 5583.944160558342, 5592.69240191777, 5611.0, 5356.303680521507, 5469.234307197075, 5480.314960629921, 5514.476124768141, 5556.888862222814, 5528.668279903219, 5560.36055853582, 5662.631928924607, 5707.5433965281845, 5721.427857214412, 5415.48552887475, 5430.429804870431, 5443.836684899459, 5445.782168713207, 5455.945440545703], "unit": "score", "name": "dojo.html", "value": 5252.498290392107}, {"lowerIsBetter": false, "replicates": [533.8638647144977, 535.0743214239366, 548.6351576201826, 556.6075916478883, 565.2143520506494, 35140.297194056104, 35796.46305305419, 36091.819540902325, 36125.81937090318, 36291.81854090729, 35268.64731352685, 36121.27757444856, 36379.27241455169, 36416.45375319366, 36438.635613643855, 8011.999999999985, 8183.140770219131, 8204.466709663853, 8246.299064579518, 8261.710840120597, 8299.962504686913, 8348.916510834904, 8405.159484051606, 8428.704995325164, 8430.367722420813, 8312.750617481455, 8419.242268195861, 8436.114208008163, 8468.44955077921, 8475.703350382737, 8384.161583841627, 8430.831383372359, 8450.746477605682, 8455.577221138918, 8488.23605875471, 8283.17168283173, 8341.0, 8387.790305242357, 8423.915760842374, 8457.492550446992, 36355.0, 36901.81549092264, 36982.81508592467, 37012.07469813249, 37030.44454333187, 3165.920851978719, 3245.2698142917657, 3343.565336506263, 3598.1364472526666, 3679.5584529856587, 29894.252643683863, 29933.0, 30069.398612027857, 30288.0, 31035.22411939697, 3785.0, 3808.90477738056, 3817.5800661927165, 3935.74417662851, 4011.498562679665, 198889.0, 199457.0, 200469.9976500123, 200898.0, 201140.0, 52128.0, 53512.73243633757, 58581.0, 60475.0, 60569.39430605726, 54543.45456545463, 54736.0, 54877.0, 55001.44998549963, 55063.724681376334, 14484.493042743454, 14708.632284192981, 14746.410143594136, 14746.705065898623, 14785.704285914222, 11046.33721976684, 11141.721456963478, 11149.554017839358, 11160.832587511193, 11254.718632034264, 19533.8046619532, 19808.90095549513, 19907.60184796296, 19920.601587968158, 20031.699524507145, 7124.893126603105, 7237.819054523679, 7258.963705181441, 7267.709291628275, 7331.340179383881, 961.9374740641836, 998.8601595776597, 1025.1747343388495, 1039.3192458939407, 1039.4387031003173, 28270.71729282722, 28555.428891422056, 28655.321723862802, 28966.0, 29134.0, 1014.1025192704362, 1020.6223697232072, 1021.1422405179536, 1058.0953284941418, 1114.2033446086086, 14984.325705343286, 15479.613009674847, 15636.296366663528, 15725.764113538306, 16137.0, 371997.0, 379941.0, 382657.0, 383174.0, 383400.0, 52650.21024684633, 53183.73408132935, 53206.46793532093, 53247.73376133172, 53259.20111198335, 1330.1021810278023, 1344.1128854955682, 1345.3744009035845, 1348.9662758431118, 1354.5529975108388, 29423.0, 30424.695753042186, 30490.695093048784, 31129.0, 31162.06513804499, 43812.78093609639, 44234.0, 44491.332630011224, 44500.777496112314, 44591.77704111459, 299314.0, 300554.0, 300646.0, 300902.0, 301318.0, 41498.79250603728, 42469.787651061546, 42910.63889040933, 42994.35508467313, 43881.0, 42231.577684223994, 42346.78826605847, 42371.576284238, 42924.14151717011, 43452.78273608612, 34971.825140874134, 35216.295674085864, 35269.1182720434, 35364.64635353613, 36098.4585231227, 36879.26241475102, 37074.814625926694, 37437.4384384229, 38197.809010955876, 38630.6136938627, 34588.80545666684, 34887.30225395427, 35579.46630800592, 35811.28377432385, 35983.64016359803, 29913.85043074771, 30433.84783076159, 32818.83590582032, 33001.50497742488, 33401.33197336088, 25219.0, 25434.74565254324, 25660.486790263716, 25976.480470390863, 26041.0], "unit": "score", "name": "ext.html", "value": 18205.68837918237}, {"lowerIsBetter": false, "replicates": [350.7492143117671, 352.0, 352.7054909150859, 357.3317895535349, 364.6098674418372, 15245.923770381147, 16199.352025918965, 16924.576885577866, 17659.64680706385, 17968.91015544922, 11146.498407571658, 11271.09831213503, 11472.827907581393, 11519.424028798569, 11556.248843825166, 4778.163821331262, 4976.129177393959, 5014.598832093442, 5075.670081444713, 5270.499302566269, 4642.976785116087, 5206.427292997767, 5229.058769421503, 5251.947480525203, 5254.57963362932, 5016.0, 5207.323048003755, 5677.659340439566, 5679.5740319476, 5689.829305120832, 5145.279660847485, 5152.9742351288005, 5183.300254465656, 5200.115980283361, 5211.270422140903, 5303.36359636846, 5310.0, 5318.680879147263, 5330.760115794798, 5342.305500284977, 12999.220046797222, 17380.913095434567, 19564.413067607853, 20018.599628007505, 20180.0, 1980.8712433691765, 2139.475828422031, 2193.3529608765293, 2253.966190507144, 2340.9816729722625, 9317.44095354281, 9373.484458354787, 9511.66709165176, 9512.429254244767, 9797.755056123582, 1780.1811166863129, 1785.1520527749344, 1823.6170404215131, 1842.0, 1874.156629516723, 55010.0, 55649.0, 56988.43011569873, 57056.42943570594, 58185.12722309169, 10090.394576325443, 10287.0, 10361.689149325532, 10369.0, 10427.582896684047, 13283.933580332037, 13392.129511581716, 13465.798013029616, 13507.392167352493, 13542.187468751907, 7387.926120738832, 7442.404607631484, 7448.478606497493, 7466.925330746623, 7518.323350898446, 7037.894431583531, 7062.540934839219, 7063.964680176567, 7098.645067746592, 7112.110986126734, 4454.1982443159895, 4504.391907092566, 4510.774461276923, 4553.954460455419, 4567.931481027787, 1724.1120822776281, 1812.1211212561898, 1850.0379802502623, 1859.3492277702967, 1861.5346163459135, 863.374053810982, 873.6898401067657, 892.3753372639178, 934.0, 991.6612573026357, 15440.691186176213, 15893.364265429485, 15916.283767230503, 16328.836711632732, 16343.18284085791, 885.6988623867916, 888.5690440136528, 925.3060204846365, 927.248928368024, 938.7512309238058, 8485.193906578865, 9268.397554158959, 9306.53467326631, 9345.299102567335, 9389.357530891224, 361696.0, 367616.0, 478545.0, 481819.0, 485087.0, 64635.353646462936, 66071.33928660749, 73001.0, 74039.25960740431, 76825.23174768292, 1078.379931539368, 1111.7609713911386, 1112.1325366214367, 1121.3496172220255, 1121.3664279681955, 15001.549953501413, 15093.47172848945, 15131.167785771888, 15182.848171518144, 15625.218739063228, 22138.77861221367, 23651.881740591187, 28309.867605295556, 33530.0, 34363.31273374568, 43759.562404376826, 44986.77506612446, 46156.0, 47060.29409558928, 47502.0, 6822.283660215804, 6965.303469652994, 7058.752943646948, 7093.574385536885, 7164.355208031302, 8399.41204115706, 10772.353658780497, 10968.17738669587, 11213.60752373663, 11265.831012534654, 8982.595783189641, 9311.975682674765, 9447.433154010781, 9682.612695492384, 9851.0, 9263.953680231825, 9425.764355891157, 9655.179309758749, 9701.805963880824, 9838.26213034011, 9660.275479338938, 9730.805383892424, 9858.112769850748, 9939.254555908481, 10051.849222261819, 7548.207438218908, 7724.8455030900195, 7731.342835859015, 7734.0, 7746.845063098819, 9097.818043639223, 9398.530073496435, 9429.905700943178, 9539.14147726708, 9703.951480242553], "unit": "score", "name": "jquery.html", "value": 7934.830998822079}, {"lowerIsBetter": false, "replicates": [1392.0742706100443, 1462.013141129737, 1580.399448209681, 1723.1039859273171, 1738.8956662600244, 6848.96575517123, 6957.373836354727, 7785.532868027915, 7914.327282181014, 7977.321927636151, 7505.286997735207, 7655.349295309906, 7722.768316950501, 7723.691052357899, 7731.304182623563, 2291.8854057297153, 2310.9947172979723, 2319.3969567912295, 2321.0599707118645, 2340.1224540797202, 2234.8100411465043, 2252.7296724393013, 2262.864228146308, 2267.875266860322, 2276.203328834911, 2269.5347453771938, 2271.3526644906206, 2295.942601434969, 2302.2172461363134, 2324.372419446748, 2299.977000229993, 2308.492131731025, 2324.3143272734414, 2324.6745455636224, 2324.76752324767, 2358.8466749661216, 2364.2552595932225, 2365.5268946210826, 2366.6804981327473, 2370.3007612754277, 7956.60216989154, 8003.439759216857, 8013.677743172369, 8058.0, 8090.433669643127, 4766.856994290177, 4839.782209800567, 4850.611951043908, 4866.853994380139, 4868.610511159099, 3092.7371173450283, 3109.875604975798, 3158.7473002159772, 3179.71382575567, 3182.236263296815, 1052.9631462898838, 1059.4808543813554, 1061.6496556136456, 1090.4057288777635, 1091.49245600796, 10733.141348692086, 10775.515101820358, 10802.6759197225, 10824.72938176544, 10861.34831910088, 4324.481062272484, 4332.848350307787, 4426.446694163165, 4454.420925279693, 4463.285874260103, 9276.860847087299, 9281.814363712689, 9282.860757088649, 9319.207867331217, 9327.486988215713, 4832.695172303458, 4886.926696099561, 4911.287863259808, 4918.942427378131, 4935.851924442272, 4353.1293741251875, 4441.4892287387365, 4450.35469856869, 4459.10817836434, 4482.327650852333, 3625.8549658013385, 3637.1452708613456, 3674.6876515495946, 3681.37416639172, 3700.1489657378415, 1097.2703152403562, 1097.9780404391868, 1098.5386137821974, 1101.9559217631204, 1115.9330440173615, 1272.6054922973908, 1272.885440310358, 1283.9550615728592, 1295.559509766684, 1301.3623324570892, 7429.85140297191, 7450.701971921062, 7479.626018699043, 7595.088589369311, 7612.467127301146, 1105.336797921257, 1106.6624679472677, 1107.789519991199, 1114.9609763658234, 1115.6876074699098, 5567.693776842231, 5631.577631677558, 5640.182173584807, 5645.689487078168, 5668.659880407189, 9446.244300455946, 9651.613935442643, 9863.506824658738, 9995.250356223312, 10007.849882251772, 9797.363171393836, 9812.215022798158, 9828.361156524803, 9849.261305402124, 9871.01289871007, 7255.782326530212, 7483.102027756704, 7487.401007919353, 7553.282438168365, 7586.506877052974, 7072.823179420556, 7134.785956421316, 7186.820329491805, 7218.061651985208, 7227.530210536298, 8270.2556769891, 8418.116097809887, 8596.91403085961, 8619.525926073875, 8654.913450865663, 8557.229849313591, 8704.129587041245, 8719.65121395137, 8725.78185545341, 8845.4250473719, 6871.106756121672, 7042.260562640849, 7074.929250707427, 7144.678489467882, 7240.96379518099, 7530.28462296081, 7535.623218839146, 7536.171021187774, 7574.81062973408, 7586.582737949466, 6782.423494003065, 7111.715531378687, 7136.4647651427385, 7172.641367931687, 7303.561786292839, 7010.859782804418, 7015.754448594274, 7126.536775109601, 7212.819679508054, 7226.060612120391, 7058.894116588358, 7078.823029424099, 7096.077509923677, 7096.353193757614, 7103.0, 6411.3909178627955, 6428.100065990859, 6442.0, 6444.806655800334, 6446.806595802133, 6682.532222744556, 6738.932610673831, 6772.627505487246, 6796.694148763218, 6799.7620083298825], "unit": "score", "name": "mootools.html", "value": 4572.524024546529}, {"lowerIsBetter": false, "replicates": [330.3821853134638, 333.94656854903207, 337.40784922461074, 340.8994346667733, 341.73515525467775, 6107.60300580462, 6224.84437889053, 6294.118823364727, 6294.307626161124, 6297.559170858041, 6070.2412198475195, 6171.166892469515, 6190.102435146901, 6204.379562043793, 6235.438810507054, 4736.786844592001, 4739.763011849411, 4741.976290118562, 4748.928766068503, 4770.212914869043, 4688.5311468853015, 4723.456802467708, 4730.929036064462, 4738.857834264961, 4741.478437371887, 4517.435320584927, 4653.232216684243, 4663.813447462097, 4667.043256132485, 4713.43438787346, 4618.930716039262, 4655.557722016403, 4663.137319595886, 4664.416947881497, 4679.766011699436, 4033.0925541753163, 4036.253293140749, 4037.9905023744063, 4039.6970227233073, 4044.0496483326397, 5917.940820591782, 5918.378570250148, 5929.466348028698, 5929.970350148222, 5941.435563621449, 5314.388845282803, 5394.838154855322, 5459.535939445152, 5476.945230547683, 5497.835064948018, 6608.0, 6620.23867255267, 6647.468202543785, 6647.66761661915, 6659.300773418819, 4518.254488009475, 4527.592516673482, 4536.954630453686, 4548.113117942003, 4553.977230113828, 6799.762008329734, 6827.556208846409, 6871.862562748767, 6873.450123990069, 6902.413294869892, 4532.0, 4542.613877820356, 4546.954530454719, 4551.5676010778925, 4553.908921821611, 4601.44782626087, 4601.953980460219, 4609.308603709471, 4616.399868017136, 4617.907641847211, 5327.627066105413, 5370.516653501204, 5378.757955891994, 5383.703896285742, 5415.160650099241, 6414.102025716404, 6564.212294524687, 6577.408033277028, 6587.143671322793, 6605.86788264232, 1583.2875206157275, 1594.6810637872472, 1594.8165960914412, 1598.3207136966744, 1618.3364820423806, 1050.7845891592206, 1054.5570860238718, 1055.994720026395, 1059.5073290919759, 1070.2347821307803, 6188.8762224755255, 6198.349173336825, 6205.81382558524, 6210.875782484325, 6212.875742485125, 6621.735130594722, 6703.966480167665, 6706.22878368984, 6725.529212955046, 6735.326467353226, 6104.908426373608, 6178.165947597106, 6203.534734894901, 6205.720742566596, 6210.4410603045035, 3648.927021459556, 3659.0852286928266, 3672.467492213614, 3672.8347224374966, 3673.430618254175, 6979.651017449107, 7009.509334346547, 7048.471364647569, 7065.82335441618, 7066.399356054793, 6730.629815360105, 6867.07294515234, 6879.140107486564, 6901.102856628606, 6903.6203008835, 6934.930650693529, 6940.375366217065, 7013.473989450812, 7013.754518591825, 7043.471739619446, 6671.499637527302, 6680.298568650416, 6684.866302674017, 6687.4984376171005, 6710.4631629470505, 6511.967440162769, 6601.735930562916, 6602.570832895846, 6617.569857959217, 6627.436667883284, 6826.146731658543, 6853.931460685529, 6879.174499060145, 6894.069300644349, 6896.069030680794, 4548.6361091113295, 4554.385158003627, 4568.817247310203, 4572.291294849304, 4574.565416285448, 6690.330966903271, 6690.632015239208, 6703.597784132968, 6738.865222695421, 6865.107536020485, 6650.534462587572, 6665.666716664245, 6679.265280819203, 6688.83277918056, 6699.29657385987, 6641.634710090992, 6675.933240667531, 6681.098051763144, 6687.398134167948, 6701.530892837454, 6463.57986730861, 6556.0493728410065, 6574.3754343337305, 6577.2107347116735, 6583.275839657729, 6586.571872828251, 6655.866882662222, 6680.465562755066, 6703.765368212089, 6715.093462382712, 6499.1876015498065, 6506.316836732264, 6531.575447595891, 6531.934680653133, 6534.379233972765], "unit": "score", "name": "prototype.html", "value": 4916.3738131420905}, {"lowerIsBetter": false, "replicates": [734.8162959260181, 742.743753405075, 778.4045205417855, 815.2092470303807, 824.938129640277, 12360.44378002991, 12488.375581220926, 12555.309457979818, 12557.183783054095, 12572.622821315352, 12163.939180304109, 12205.938970305158, 12215.816762748544, 12216.144869859114, 12231.0, 767.957762323072, 771.2326235395775, 775.7091090840935, 779.5361759752966, 801.1587832775563, 794.5629903553051, 800.1918062756629, 800.4756884240832, 803.2008151888879, 808.8058865872207, 830.4104086098877, 835.5404527509876, 838.9622466989, 839.6431516605448, 841.7811369044063, 830.9750707478785, 831.1190138453198, 832.629479881453, 834.090840983328, 834.2700137379793, 613.4417679911304, 614.4930432393294, 615.6890770161085, 616.8272883592601, 617.5183356981562, 12811.359432028361, 12872.09895307329, 12874.356282185854, 12876.291803950779, 12925.15986460877, 12449.75100497985, 12639.684007899785, 12648.241105533698, 12842.807357889638, 12904.225746455242, 9863.358881672668, 10121.746956326077, 10243.590256389736, 10456.790864182749, 10676.092532134779, 4191.7694526801015, 4243.596858298457, 4257.489101307832, 4284.164587905359, 4426.911461770779, 44974.0, 45355.773221133684, 45361.09277814458, 45407.77296113531, 45824.77087614574, 9459.90540094604, 9745.463999479955, 9843.901560984299, 10113.190944724405, 10145.137663298554, 16268.186590670419, 16623.83376166223, 16624.25190866414, 16630.6673866522, 16642.3343066276, 6618.0, 6810.659467026629, 6885.345892140239, 6996.755113571001, 7195.784126476214, 3713.9814300928865, 3845.384738441836, 3912.139329347539, 3938.2517321708783, 4035.535913369941, 3019.0, 3028.1369809604157, 3029.7727670424806, 3032.5451182322386, 3036.817790932551, 550.3148580017823, 555.2809112199711, 564.2833601326292, 572.0646742575918, 574.7815829984579, 507.7461269365317, 553.7923278770461, 577.971101444926, 581.979630712923, 650.5218664281749, 8598.613062412207, 8603.437186831507, 8714.738557843275, 8766.60550275239, 8842.557872106498, 577.053632043449, 578.9305283366023, 627.2754968011953, 630.8895943210011, 666.6266890541312, 4008.2985477541315, 4150.875473735793, 4231.322988321854, 4427.2252355838245, 4527.253003254426, 57046.0, 57719.422805771406, 57732.0, 58052.0, 58504.70747646235, 50342.74828625907, 50792.0, 50974.0, 51361.0, 51920.22119668133, 43566.56433435689, 43602.345964810556, 44039.33940990888, 44724.77637611791, 44964.55035449669, 8149.877751833846, 8242.711505097293, 8407.0, 8716.738497845075, 8903.171636196497, 34233.82883085569, 35181.47227791534, 35439.82280088583, 35498.46752298666, 36192.457113142795, 43108.568914310454, 43673.56326436695, 43816.12367752563, 43882.0, 44469.0, 10857.402842843403, 10897.455127243447, 10905.400202988912, 10982.780134764163, 11030.841761614915, 11700.47347869331, 11701.356425396685, 11791.726684585188, 11982.940085299517, 12120.333381664093, 10404.68785936423, 10548.683539493828, 10555.788884222426, 10579.15366770641, 10882.673519794418, 10861.891381086089, 11386.373749443861, 11444.313341199555, 11489.482973266391, 11845.052395808143, 10579.682609521727, 10762.838557421488, 10790.514426850654, 10798.73003174927, 10803.729906752395, 9023.639054437748, 9112.20880777227, 9203.838510929436, 9224.538773061186, 9665.130138287588, 8111.675532978615, 8147.388945828968, 8274.29668478186, 8344.83310333802, 8431.578421078799], "unit": "score", "name": "yui.html", "value": 6133.213009465714}], "name": "dromaeo_css", "value": 6864.45251563343}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 113.0, 111.0, 122.0, 113.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 153.0, 171.0, 129.0, 150.0, 149.0, 128.0, 180.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 163.0, 163.0, 161.0, 162.0, 163.0, 167.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [71.0, 76.0, 71.0, 71.0, 73.0, 71.0, 146.0, 75.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 140.0, 95.0, 96.0, 95.0, 140.0, 96.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 60.0, 58.0, 60.0, 62.0, 63.0, 58.0, 66.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 60.8}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 71.0, 67.0, 68.0, 67.0, 67.0, 69.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [87.0, 79.0, 80.0, 82.0, 82.0, 80.0, 80.0, 88.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 124.0, 116.0, 121.0, 119.0, 122.0, 123.0, 114.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [138.0, 144.0, 145.0, 149.0, 148.0, 147.0, 143.0, 146.0, 144.0, 129.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 72.0, 69.0, 72.0, 68.0, 67.0, 70.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1507.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [187.82870022539444], "unit": "score", "name": "DeltaBlue", "value": 352.01223200000004}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [719.4244604316547], "unit": "score", "name": "Earley", "value": 926.3835699999998}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [40098.03921568627], "unit": "score", "name": "RegExp", "value": 22.7189413202934}, {"lowerIsBetter": false, "replicates": [642.6735218508998], "unit": "score", "name": "Splay", "value": 126.799996}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 20262.901754849692}]} 03:39:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20262.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1507.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6864.45"}}} 03:39:51 INFO - Return code: 0 03:39:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:39:51 INFO - # TBPL SUCCESS # 03:39:51 INFO - Running post-action listener: _resource_record_post_action 03:39:51 INFO - Running post-run listener: _resource_record_post_run 03:39:52 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 12533760; Write bytes: 441638912; Read time: 2764; Write time: 490268 03:39:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5091328; Read time: 0; Write time: 8088 03:39:52 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 10776576; Write bytes: 415469568; Read time: 2708; Write time: 474228 03:39:52 INFO - Running post-run listener: _upload_blobber_files 03:39:52 INFO - Blob upload gear active. 03:39:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:39:52 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 03:39:52 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:39:52 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:39:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:53 INFO - (blobuploader) - INFO - Done attempting. 03:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:54 INFO - (blobuploader) - INFO - Done attempting. 03:39:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:54 INFO - Return code: 0 03:39:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:39:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9940908fabaf20a838e6d19789ec4b4c3c74d556973ceb8703e62888b6dd5ccd87d5d960d46663bbd14cf42c1deb696287ab7dfd1f056a9cb923f2bbe7e9b46e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91d3b44eda68b11486e1b9a15c14ef1a207416d6f38c399ca718a1b0334bae4caf9d97dca76cbafd4c751c06218de5de8f6e9f1b24c1692c78325bdbbd9c1ee9"} 03:39:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:39:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:39:54 INFO - Contents: 03:39:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9940908fabaf20a838e6d19789ec4b4c3c74d556973ceb8703e62888b6dd5ccd87d5d960d46663bbd14cf42c1deb696287ab7dfd1f056a9cb923f2bbe7e9b46e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91d3b44eda68b11486e1b9a15c14ef1a207416d6f38c399ca718a1b0334bae4caf9d97dca76cbafd4c751c06218de5de8f6e9f1b24c1692c78325bdbbd9c1ee9"} 03:39:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:54 INFO - Copying logs to upload dir... 03:39:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:39:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.175119 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-18 03:39:54.866432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 03:39:54.869770) ========= 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 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/Mozilla-Inbound/sha512/9940908fabaf20a838e6d19789ec4b4c3c74d556973ceb8703e62888b6dd5ccd87d5d960d46663bbd14cf42c1deb696287ab7dfd1f056a9cb923f2bbe7e9b46e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91d3b44eda68b11486e1b9a15c14ef1a207416d6f38c399ca718a1b0334bae4caf9d97dca76cbafd4c751c06218de5de8f6e9f1b24c1692c78325bdbbd9c1ee9"} build_url:https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/VHTFzjB9QYOx-1ql_6_MGQ/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/Mozilla-Inbound/sha512/9940908fabaf20a838e6d19789ec4b4c3c74d556973ceb8703e62888b6dd5ccd87d5d960d46663bbd14cf42c1deb696287ab7dfd1f056a9cb923f2bbe7e9b46e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/91d3b44eda68b11486e1b9a15c14ef1a207416d6f38c399ca718a1b0334bae4caf9d97dca76cbafd4c751c06218de5de8f6e9f1b24c1692c78325bdbbd9c1ee9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 03:39:54.897224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:39:54.897967) ========= 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=c6927cf182745ad25b1d38b9000001fe-1453115913.990375-1767614896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:39:54.981441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 03:39:54.981788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 03:39:54.982121) ========= ========= Total master_lag: 0.25 =========