builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1456579863.92 results: success (0) buildid: 20160225005029 builduid: 3da0c03b862e43d3be251c62de973dd4 revision: a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.917089) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.917784) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.918289) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006366 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.939515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.939828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.947367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.947649) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.996145) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.996469) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.996876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:03.997154) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 05:31:04-- 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% 223M=0s 2016-02-27 05:31:04 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175700 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:04.184876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:04.185208) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017857 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:04.235169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:04.235552) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f --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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 05:31:04,757 truncating revision to first 12 chars 2016-02-27 05:31:04,757 Setting DEBUG logging. 2016-02-27 05:31:04,757 attempt 1/10 2016-02-27 05:31:04,757 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a28dc9d1e31e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 05:31:05,140 unpacking tar archive at: mozilla-aurora-a28dc9d1e31e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:04.957873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:04.958234) ========= echo a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f'] 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f program finished with exit code 0 elapsedTime=0.004192 script_repo_revision: 'a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:05.007993) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:05.008318) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:05.018653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-27 05:31:05.018971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:31:05 INFO - MultiFileLogger online at 20160227 05:31:05 in /builds/slave/test-pgo 05:31:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:31:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:31:05 INFO - {'append_to_log': False, 05:31:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:31:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:31:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:31:05 INFO - 'branch': 'Mozilla-Aurora', 05:31:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:05 INFO - 'config_files': ('talos/linux_config.py',), 05:31:05 INFO - 'default_actions': ('clobber', 05:31:05 INFO - 'read-buildbot-config', 05:31:05 INFO - 'download-and-extract', 05:31:05 INFO - 'populate-webroot', 05:31:05 INFO - 'create-virtualenv', 05:31:05 INFO - 'install', 05:31:05 INFO - 'run-tests'), 05:31:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:05 INFO - 'download_minidump_stackwalk': True, 05:31:05 INFO - 'download_symbols': 'ondemand', 05:31:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:05 INFO - 'installer_path': 'installer.exe', 05:31:05 INFO - 'log_level': 'info', 05:31:05 INFO - 'log_name': 'talos', 05:31:05 INFO - 'log_to_console': True, 05:31:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:31:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:31:05 INFO - 'opt_config_files': (), 05:31:05 INFO - 'pip_index': False, 05:31:05 INFO - 'sps_profile': False, 05:31:05 INFO - 'sps_profile_interval': 0, 05:31:05 INFO - 'suite': 'dromaeojs-e10s', 05:31:05 INFO - 'system_bits': '32', 05:31:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:05 INFO - 'title': 'talos-linux64-ix-064', 05:31:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:05 INFO - 'use_talos_json': True, 05:31:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:31:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:05 INFO - 'work_dir': 'build'} 05:31:05 INFO - ##### 05:31:05 INFO - ##### Running clobber step. 05:31:05 INFO - ##### 05:31:05 INFO - Running pre-action listener: _resource_record_pre_action 05:31:05 INFO - Running main action method: clobber 05:31:05 INFO - rmtree: /builds/slave/test-pgo/build 05:31:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:31:06 INFO - Running post-action listener: _resource_record_post_action 05:31:06 INFO - ##### 05:31:06 INFO - ##### Running read-buildbot-config step. 05:31:06 INFO - ##### 05:31:06 INFO - Running pre-action listener: _resource_record_pre_action 05:31:06 INFO - Running main action method: read_buildbot_config 05:31:06 INFO - Using buildbot properties: 05:31:06 INFO - { 05:31:06 INFO - "project": "", 05:31:06 INFO - "product": "firefox", 05:31:06 INFO - "script_repo_revision": "production", 05:31:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:31:06 INFO - "repository": "", 05:31:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:31:06 INFO - "buildid": "20160225005029", 05:31:06 INFO - "pgo_build": "True", 05:31:06 INFO - "basedir": "/builds/slave/test-pgo", 05:31:06 INFO - "buildnumber": 96, 05:31:06 INFO - "slavename": "talos-linux64-ix-064", 05:31:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:31:06 INFO - "platform": "ubuntu64_hw", 05:31:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:31:06 INFO - "branch": "mozilla-aurora", 05:31:06 INFO - "repo_path": "releases/mozilla-aurora", 05:31:06 INFO - "revision": "a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f", 05:31:06 INFO - "stage_platform": "linux64-pgo", 05:31:06 INFO - "builduid": "3da0c03b862e43d3be251c62de973dd4", 05:31:06 INFO - "slavebuilddir": "test" 05:31:06 INFO - } 05:31:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 05:31:06 INFO - Running post-action listener: _resource_record_post_action 05:31:06 INFO - ##### 05:31:06 INFO - ##### Running download-and-extract step. 05:31:06 INFO - ##### 05:31:06 INFO - Running pre-action listener: _resource_record_pre_action 05:31:06 INFO - Running main action method: download_and_extract 05:31:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:31: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')]} 05:31:06 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:31:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json 05:31:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json 05:31:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:31:07 INFO - Downloaded 1448 bytes. 05:31:07 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:31:07 INFO - Using the following test package requirements: 05:31:07 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:31:07 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:31:07 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:31:07 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'jsshell-linux-x86_64.zip'], 05:31:07 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:31:07 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:31:07 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:31:07 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:31:07 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:31:07 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:31:07 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:31:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:31:07 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:07 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:31:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:31:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:31:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:31:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:31:09 INFO - Downloaded 23079153 bytes. 05:31:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:31:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:31:10 INFO - Return code: 0 05:31:10 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:10 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:31:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:31:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:31:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:31:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:31:11 INFO - Downloaded 23079153 bytes. 05:31:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:31:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:31:12 INFO - Return code: 0 05:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:12 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:31:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:31:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:31:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:31:13 INFO - Downloaded 10706649 bytes. 05:31:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:31:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:31:13 INFO - Return code: 0 05:31: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')]} 05:31:13 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:31:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:31:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:31:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:31:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:31:16 INFO - Downloaded 59964862 bytes. 05:31:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:31:16 INFO - mkdir: /builds/slave/test-pgo/properties 05:31:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:31:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:31:16 INFO - Contents: 05:31:16 INFO - build_url:https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:31:17 INFO - Running post-action listener: _resource_record_post_action 05:31:17 INFO - Running post-action listener: set_extra_try_arguments 05:31:17 INFO - ##### 05:31:17 INFO - ##### Running populate-webroot step. 05:31:17 INFO - ##### 05:31:17 INFO - Running pre-action listener: _resource_record_pre_action 05:31:17 INFO - Running main action method: populate_webroot 05:31:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:17 INFO - '--tppagecycles', 05:31:17 INFO - '7'], 05:31:17 INFO - 'tests': ['tsvgm']}}, 05:31:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:31:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:31:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:31:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'tests': ['damp', 'tps']}, 05:31:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['damp', 'tps']}, 05:31:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:31:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:17 INFO - 'other': {'tests': ['a11yr', 05:31:17 INFO - 'ts_paint', 05:31:17 INFO - 'tpaint', 05:31:17 INFO - 'sessionrestore', 05:31:17 INFO - 'sessionrestore_no_auto_restore']}, 05:31:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['a11yr', 05:31:17 INFO - 'ts_paint', 05:31:17 INFO - 'tpaint', 05:31:17 INFO - 'sessionrestore', 05:31:17 INFO - 'sessionrestore_no_auto_restore']}, 05:31:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['a11yr', 05:31:17 INFO - 'ts_paint', 05:31:17 INFO - 'tpaint', 05:31:17 INFO - 'sessionrestore', 05:31:17 INFO - 'sessionrestore_no_auto_restore']}, 05:31:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['a11yr', 05:31:17 INFO - 'ts_paint', 05:31:17 INFO - 'tpaint', 05:31:17 INFO - 'sessionrestore', 05:31:17 INFO - 'sessionrestore_no_auto_restore']}, 05:31:17 INFO - 'other_l64': {'tests': ['a11yr', 05:31:17 INFO - 'ts_paint', 05:31:17 INFO - 'tpaint', 05:31:17 INFO - 'sessionrestore', 05:31:17 INFO - 'sessionrestore_no_auto_restore']}, 05:31:17 INFO - 'other_nol64': {'tests': ['a11yr', 05:31:17 INFO - 'ts_paint', 05:31:17 INFO - 'tpaint', 05:31:17 INFO - 'sessionrestore', 05:31:17 INFO - 'sessionrestore_no_auto_restore']}, 05:31:17 INFO - 'svgr': {'tests': ['tsvgx', 05:31:17 INFO - 'tsvgr_opacity', 05:31:17 INFO - 'tart', 05:31:17 INFO - 'tscrollx', 05:31:17 INFO - 'cart']}, 05:31:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['tsvgx', 05:31:17 INFO - 'tsvgr_opacity', 05:31:17 INFO - 'tart', 05:31:17 INFO - 'tscrollx', 05:31:17 INFO - 'cart']}, 05:31:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'tests': ['tp5o']}, 05:31:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'talos_options': ['--e10s'], 05:31:17 INFO - 'tests': ['tp5o']}, 05:31:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'talos_options': ['--xperf_path', 05:31:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:17 INFO - 'tests': ['tp5n']}, 05:31:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:17 INFO - 'talos_options': ['--e10s', 05:31:17 INFO - '--xperf_path', 05:31:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:17 INFO - 'tests': ['tp5n']}}, 05:31:17 INFO - 'talos.zip': {'path': '', 05:31:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:17 INFO - Running post-action listener: _resource_record_post_action 05:31:17 INFO - ##### 05:31:17 INFO - ##### Running create-virtualenv step. 05:31:17 INFO - ##### 05:31:17 INFO - Running pre-action listener: _resource_record_pre_action 05:31:17 INFO - Running main action method: create_virtualenv 05:31:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:31:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:31:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:31:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:17 INFO - Using real prefix '/usr' 05:31:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:31:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:20 INFO - Installing pip.................done. 05:31:20 INFO - Return code: 0 05:31:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:31:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:31:20 INFO - Using env: {'DISPLAY': ':0', 05:31:20 INFO - 'HOME': '/home/cltbld', 05:31:20 INFO - 'LANG': 'en_US.UTF-8', 05:31:20 INFO - 'LANGUAGE': 'en_US:en', 05:31:20 INFO - 'LOGNAME': 'cltbld', 05:31:20 INFO - 'MAIL': '/var/mail/cltbld', 05:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:20 INFO - 'MOZ_NO_REMOTE': '1', 05:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:20 INFO - 'NO_EM_RESTART': '1', 05:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:20 INFO - 'SHELL': '/bin/bash', 05:31:20 INFO - 'SHLVL': '1', 05:31:20 INFO - 'TERM': 'linux', 05:31:20 INFO - 'TMOUT': '86400', 05:31:20 INFO - 'USER': 'cltbld', 05:31:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:20 INFO - '_': '/tools/buildbot/bin/python'} 05:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:31:20 INFO - Cleaning up... 05:31:20 INFO - Return code: 0 05:31:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:31:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:31:20 INFO - Using env: {'DISPLAY': ':0', 05:31:20 INFO - 'HOME': '/home/cltbld', 05:31:20 INFO - 'LANG': 'en_US.UTF-8', 05:31:20 INFO - 'LANGUAGE': 'en_US:en', 05:31:20 INFO - 'LOGNAME': 'cltbld', 05:31:20 INFO - 'MAIL': '/var/mail/cltbld', 05:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:20 INFO - 'MOZ_NO_REMOTE': '1', 05:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:20 INFO - 'NO_EM_RESTART': '1', 05:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:20 INFO - 'SHELL': '/bin/bash', 05:31:20 INFO - 'SHLVL': '1', 05:31:20 INFO - 'TERM': 'linux', 05:31:20 INFO - 'TMOUT': '86400', 05:31:20 INFO - 'USER': 'cltbld', 05:31:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:20 INFO - '_': '/tools/buildbot/bin/python'} 05:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:20 INFO - Downloading/unpacking psutil>=0.7.1 05:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:22 INFO - Installing collected packages: psutil 05:31:22 INFO - Running setup.py install for psutil 05:31:22 INFO - building 'psutil._psutil_linux' extension 05:31:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:31:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:31:22 INFO - building 'psutil._psutil_posix' extension 05:31:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:31:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:31:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:22 INFO - Successfully installed psutil 05:31:22 INFO - Cleaning up... 05:31:23 INFO - Return code: 0 05:31:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:31:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:31:23 INFO - Using env: {'DISPLAY': ':0', 05:31:23 INFO - 'HOME': '/home/cltbld', 05:31:23 INFO - 'LANG': 'en_US.UTF-8', 05:31:23 INFO - 'LANGUAGE': 'en_US:en', 05:31:23 INFO - 'LOGNAME': 'cltbld', 05:31:23 INFO - 'MAIL': '/var/mail/cltbld', 05:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:23 INFO - 'MOZ_NO_REMOTE': '1', 05:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:23 INFO - 'NO_EM_RESTART': '1', 05:31:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:23 INFO - 'SHELL': '/bin/bash', 05:31:23 INFO - 'SHLVL': '1', 05:31:23 INFO - 'TERM': 'linux', 05:31:23 INFO - 'TMOUT': '86400', 05:31:23 INFO - 'USER': 'cltbld', 05:31:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:23 INFO - '_': '/tools/buildbot/bin/python'} 05:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:31:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:31:25 INFO - Installing collected packages: mozsystemmonitor 05:31:25 INFO - Running setup.py install for mozsystemmonitor 05:31:25 INFO - Successfully installed mozsystemmonitor 05:31:25 INFO - Cleaning up... 05:31:25 INFO - Return code: 0 05:31:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:31:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:31:25 INFO - Using env: {'DISPLAY': ':0', 05:31:25 INFO - 'HOME': '/home/cltbld', 05:31:25 INFO - 'LANG': 'en_US.UTF-8', 05:31:25 INFO - 'LANGUAGE': 'en_US:en', 05:31:25 INFO - 'LOGNAME': 'cltbld', 05:31:25 INFO - 'MAIL': '/var/mail/cltbld', 05:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:25 INFO - 'MOZ_NO_REMOTE': '1', 05:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:25 INFO - 'NO_EM_RESTART': '1', 05:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:25 INFO - 'SHELL': '/bin/bash', 05:31:25 INFO - 'SHLVL': '1', 05:31:25 INFO - 'TERM': 'linux', 05:31:25 INFO - 'TMOUT': '86400', 05:31:25 INFO - 'USER': 'cltbld', 05:31:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:25 INFO - '_': '/tools/buildbot/bin/python'} 05:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:31:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:27 INFO - Downloading docopt-0.6.1.tar.gz 05:31:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:31:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:31:27 INFO - Running setup.py install for blobuploader 05:31:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:31:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:31:28 INFO - Running setup.py install for requests 05:31:28 INFO - Running setup.py install for docopt 05:31:28 INFO - Successfully installed blobuploader requests docopt 05:31:28 INFO - Cleaning up... 05:31:28 INFO - Return code: 0 05:31:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:31:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:28 INFO - Using env: {'DISPLAY': ':0', 05:31:28 INFO - 'HOME': '/home/cltbld', 05:31:28 INFO - 'LANG': 'en_US.UTF-8', 05:31:28 INFO - 'LANGUAGE': 'en_US:en', 05:31:28 INFO - 'LOGNAME': 'cltbld', 05:31:28 INFO - 'MAIL': '/var/mail/cltbld', 05:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:28 INFO - 'MOZ_NO_REMOTE': '1', 05:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:28 INFO - 'NO_EM_RESTART': '1', 05:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:28 INFO - 'SHELL': '/bin/bash', 05:31:28 INFO - 'SHLVL': '1', 05:31:28 INFO - 'TERM': 'linux', 05:31:28 INFO - 'TMOUT': '86400', 05:31:28 INFO - 'USER': 'cltbld', 05:31:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:28 INFO - '_': '/tools/buildbot/bin/python'} 05:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:28 INFO - Running setup.py (path:/tmp/pip-rKWLFU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:28 INFO - Running setup.py (path:/tmp/pip-JE6ziS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:28 INFO - Running setup.py (path:/tmp/pip-edRJXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:29 INFO - Running setup.py (path:/tmp/pip-DuqPDu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:29 INFO - Running setup.py (path:/tmp/pip-wpDs5M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:29 INFO - Running setup.py (path:/tmp/pip-ajTkvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:29 INFO - Running setup.py (path:/tmp/pip-w9m7R_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:29 INFO - Running setup.py (path:/tmp/pip-5X_kk_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:29 INFO - Running setup.py (path:/tmp/pip-_XgTJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:29 INFO - Running setup.py (path:/tmp/pip-eUHdrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:29 INFO - Running setup.py (path:/tmp/pip-lDSev4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:29 INFO - Running setup.py (path:/tmp/pip-oJiy9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:29 INFO - Running setup.py (path:/tmp/pip-NEZSSf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:29 INFO - Running setup.py (path:/tmp/pip-HYcXol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:29 INFO - Running setup.py (path:/tmp/pip-60OONg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:29 INFO - Running setup.py (path:/tmp/pip-dESPxZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:29 INFO - Running setup.py (path:/tmp/pip-SqdM8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:30 INFO - Running setup.py install for manifestparser 05:31:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Running setup.py install for mozcrash 05:31:30 INFO - Running setup.py install for mozdebug 05:31:30 INFO - Running setup.py install for mozdevice 05:31:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Running setup.py install for mozfile 05:31:30 INFO - Running setup.py install for mozhttpd 05:31:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Running setup.py install for mozinfo 05:31:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Running setup.py install for mozInstall 05:31:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:31:30 INFO - Running setup.py install for mozleak 05:31:30 INFO - Running setup.py install for mozlog 05:31:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:31:31 INFO - Running setup.py install for moznetwork 05:31:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:31:31 INFO - Running setup.py install for mozprocess 05:31:31 INFO - Running setup.py install for mozprofile 05:31:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:31:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:31:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:31:31 INFO - Running setup.py install for mozrunner 05:31:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:31:31 INFO - Running setup.py install for mozscreenshot 05:31:31 INFO - Running setup.py install for moztest 05:31:31 INFO - Running setup.py install for mozversion 05:31:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:31:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:31 INFO - Cleaning up... 05:31:31 INFO - Return code: 0 05:31:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:31:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:31 INFO - Using env: {'DISPLAY': ':0', 05:31:31 INFO - 'HOME': '/home/cltbld', 05:31:31 INFO - 'LANG': 'en_US.UTF-8', 05:31:31 INFO - 'LANGUAGE': 'en_US:en', 05:31:31 INFO - 'LOGNAME': 'cltbld', 05:31:31 INFO - 'MAIL': '/var/mail/cltbld', 05:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:31 INFO - 'MOZ_NO_REMOTE': '1', 05:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:31 INFO - 'NO_EM_RESTART': '1', 05:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:31 INFO - 'SHELL': '/bin/bash', 05:31:31 INFO - 'SHLVL': '1', 05:31:31 INFO - 'TERM': 'linux', 05:31:31 INFO - 'TMOUT': '86400', 05:31:31 INFO - 'USER': 'cltbld', 05:31:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:31 INFO - '_': '/tools/buildbot/bin/python'} 05:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:32 INFO - Running setup.py (path:/tmp/pip-iUfdv1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:32 INFO - Running setup.py (path:/tmp/pip-XtcLuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:32 INFO - Running setup.py (path:/tmp/pip-3i9OAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:32 INFO - Running setup.py (path:/tmp/pip-pqXg3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:32 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)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:32 INFO - Running setup.py (path:/tmp/pip-2S3vzl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:32 INFO - Running setup.py (path:/tmp/pip-68Im4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:32 INFO - Running setup.py (path:/tmp/pip-qk3R7u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:32 INFO - Running setup.py (path:/tmp/pip-oGla98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:32 INFO - Running setup.py (path:/tmp/pip-MMTrDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:32 INFO - Running setup.py (path:/tmp/pip-sKJgAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:32 INFO - Running setup.py (path:/tmp/pip-JlCwxe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:32 INFO - Running setup.py (path:/tmp/pip-46Frlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:32 INFO - Running setup.py (path:/tmp/pip-owhF19-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:31:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:32 INFO - Running setup.py (path:/tmp/pip-BVS05b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:33 INFO - Running setup.py (path:/tmp/pip-9ATF8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:33 INFO - Running setup.py (path:/tmp/pip-ZzYI_h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:31:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:33 INFO - Running setup.py (path:/tmp/pip-HWa0nm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:31:33 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)) 05:31:33 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)) 05:31:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:35 INFO - Downloading blessings-1.6.tar.gz 05:31:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:35 INFO - Installing collected packages: blessings 05:31:35 INFO - Running setup.py install for blessings 05:31:35 INFO - Successfully installed blessings 05:31:35 INFO - Cleaning up... 05:31:35 INFO - Return code: 0 05:31:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:31:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:31:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:31:35 INFO - Reading from file tmpfile_stdout 05:31:35 INFO - Current package versions: 05:31:35 INFO - argparse == 1.2.1 05:31:35 INFO - blessings == 1.6 05:31:35 INFO - blobuploader == 1.2.4 05:31:35 INFO - docopt == 0.6.1 05:31:35 INFO - manifestparser == 1.1 05:31:35 INFO - mozInstall == 1.12 05:31:35 INFO - mozcrash == 0.16 05:31:35 INFO - mozdebug == 0.1 05:31:35 INFO - mozdevice == 0.48 05:31:35 INFO - mozfile == 1.2 05:31:35 INFO - mozhttpd == 0.7 05:31:35 INFO - mozinfo == 0.9 05:31:35 INFO - mozleak == 0.1 05:31:35 INFO - mozlog == 3.1 05:31:35 INFO - moznetwork == 0.27 05:31:35 INFO - mozprocess == 0.22 05:31:35 INFO - mozprofile == 0.28 05:31:35 INFO - mozrunner == 6.11 05:31:35 INFO - mozscreenshot == 0.1 05:31:35 INFO - mozsystemmonitor == 0.0 05:31:35 INFO - moztest == 0.7 05:31:35 INFO - mozversion == 1.4 05:31:35 INFO - psutil == 3.1.1 05:31:35 INFO - requests == 1.2.3 05:31:35 INFO - wsgiref == 0.1.2 05:31:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:31: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')]} 05:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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')]} 05:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:31:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:35 INFO - Using env: {'DISPLAY': ':0', 05:31:35 INFO - 'HOME': '/home/cltbld', 05:31:35 INFO - 'LANG': 'en_US.UTF-8', 05:31:35 INFO - 'LANGUAGE': 'en_US:en', 05:31:35 INFO - 'LOGNAME': 'cltbld', 05:31:35 INFO - 'MAIL': '/var/mail/cltbld', 05:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:35 INFO - 'MOZ_NO_REMOTE': '1', 05:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:35 INFO - 'NO_EM_RESTART': '1', 05:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:35 INFO - 'SHELL': '/bin/bash', 05:31:35 INFO - 'SHLVL': '1', 05:31:35 INFO - 'TERM': 'linux', 05:31:35 INFO - 'TMOUT': '86400', 05:31:35 INFO - 'USER': 'cltbld', 05:31:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:35 INFO - '_': '/tools/buildbot/bin/python'} 05:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:31:35 INFO - Cleaning up... 05:31:35 INFO - Return code: 0 05:31:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:31: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')]} 05:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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')]} 05:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:31:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:31:35 INFO - Using env: {'DISPLAY': ':0', 05:31:35 INFO - 'HOME': '/home/cltbld', 05:31:35 INFO - 'LANG': 'en_US.UTF-8', 05:31:35 INFO - 'LANGUAGE': 'en_US:en', 05:31:35 INFO - 'LOGNAME': 'cltbld', 05:31:35 INFO - 'MAIL': '/var/mail/cltbld', 05:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:35 INFO - 'MOZ_NO_REMOTE': '1', 05:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:35 INFO - 'NO_EM_RESTART': '1', 05:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:35 INFO - 'SHELL': '/bin/bash', 05:31:35 INFO - 'SHLVL': '1', 05:31:35 INFO - 'TERM': 'linux', 05:31:35 INFO - 'TMOUT': '86400', 05:31:35 INFO - 'USER': 'cltbld', 05:31:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:35 INFO - '_': '/tools/buildbot/bin/python'} 05:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:35 INFO - Downloading/unpacking jsonschema 05:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:37 INFO - Downloading/unpacking functools32 (from jsonschema) 05:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:38 INFO - warning: no files found matching '*.txt' 05:31:38 INFO - no previously-included directories found matching 'build' 05:31:38 INFO - no previously-included directories found matching 'dist' 05:31:38 INFO - no previously-included directories found matching '.git*' 05:31:38 INFO - Installing collected packages: jsonschema, functools32 05:31:38 INFO - Running setup.py install for functools32 05:31:38 INFO - warning: no files found matching '*.txt' 05:31:38 INFO - no previously-included directories found matching 'build' 05:31:38 INFO - no previously-included directories found matching 'dist' 05:31:38 INFO - no previously-included directories found matching '.git*' 05:31:38 INFO - Successfully installed jsonschema functools32 05:31:38 INFO - Cleaning up... 05:31:38 INFO - Return code: 0 05:31:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc5bd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:31:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:31:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:31:38 INFO - Using env: {'DISPLAY': ':0', 05:31:38 INFO - 'HOME': '/home/cltbld', 05:31:38 INFO - 'LANG': 'en_US.UTF-8', 05:31:38 INFO - 'LANGUAGE': 'en_US:en', 05:31:38 INFO - 'LOGNAME': 'cltbld', 05:31:38 INFO - 'MAIL': '/var/mail/cltbld', 05:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:38 INFO - 'MOZ_NO_REMOTE': '1', 05:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:38 INFO - 'NO_EM_RESTART': '1', 05:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:38 INFO - 'SHELL': '/bin/bash', 05:31:38 INFO - 'SHLVL': '1', 05:31:38 INFO - 'TERM': 'linux', 05:31:38 INFO - 'TMOUT': '86400', 05:31:38 INFO - 'USER': 'cltbld', 05:31:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:38 INFO - '_': '/tools/buildbot/bin/python'} 05:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:38 INFO - Downloading/unpacking flake8 05:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:31:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:31:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:31:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:40 INFO - no previously-included directories found matching 'docs/_build' 05:31:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:31:41 INFO - Running setup.py install for pep8 05:31:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:41 INFO - no previously-included directories found matching 'docs/_build' 05:31:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:31:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:31:41 INFO - Cleaning up... 05:31:41 INFO - Return code: 0 05:31:41 INFO - Running post-action listener: _resource_record_post_action 05:31:41 INFO - Running post-action listener: _start_resource_monitoring 05:31:41 INFO - Starting resource monitoring. 05:31:41 INFO - ##### 05:31:41 INFO - ##### Running install step. 05:31:41 INFO - ##### 05:31:41 INFO - Running pre-action listener: _resource_record_pre_action 05:31:41 INFO - Running main action method: install 05:31:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:31:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:31:41 INFO - Reading from file tmpfile_stdout 05:31:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:31:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:31:41 INFO - Reading from file tmpfile_stdout 05:31:41 INFO - Output received: 05:31:41 INFO - Usage: mozinstall [options] installer 05:31:41 INFO - Options: 05:31:41 INFO - -h, --help show this help message and exit 05:31:41 INFO - -d DEST, --destination=DEST 05:31:41 INFO - Directory to install application into. [default: 05:31:41 INFO - "/builds/slave/test-pgo"] 05:31:41 INFO - --app=APP Application being installed. [default: firefox] 05:31:41 INFO - mkdir: /builds/slave/test-pgo/build/application 05:31:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:31:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:31:56 INFO - Reading from file tmpfile_stdout 05:31:56 INFO - Output received: 05:31:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:31:56 INFO - Running post-action listener: _resource_record_post_action 05:31:56 INFO - ##### 05:31:56 INFO - ##### Running run-tests step. 05:31:56 INFO - ##### 05:31:56 INFO - Running pre-action listener: _resource_record_pre_action 05:31:56 INFO - Running main action method: run_tests 05:31:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:31:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:31:56 INFO - Python 2.7.3 05:31:56 INFO - Return code: 0 05:31:56 INFO - grabbing minidump binary from tooltool 05:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:56 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 0xd9c7f0>, '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 0xd082d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd08760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:31:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:31:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:31:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:56 INFO - Return code: 0 05:31:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:31:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:31:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:31:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:31:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:31:57 INFO - Return code: 0 05:31:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:31:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:31:57 INFO - Using env: {'DISPLAY': ':0', 05:31:57 INFO - 'HOME': '/home/cltbld', 05:31:57 INFO - 'LANG': 'en_US.UTF-8', 05:31:57 INFO - 'LANGUAGE': 'en_US:en', 05:31:57 INFO - 'LOGNAME': 'cltbld', 05:31:57 INFO - 'MAIL': '/var/mail/cltbld', 05:31:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:57 INFO - 'MOZ_NO_REMOTE': '1', 05:31:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:57 INFO - 'NO_EM_RESTART': '1', 05:31:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:31:57 INFO - 'SHELL': '/bin/bash', 05:31:57 INFO - 'SHLVL': '1', 05:31:57 INFO - 'TERM': 'linux', 05:31:57 INFO - 'TMOUT': '86400', 05:31:57 INFO - 'USER': 'cltbld', 05:31:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278', 05:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:57 INFO - '_': '/tools/buildbot/bin/python'} 05:31:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:31:57 INFO - mozversion application_buildid: 20160225005029 05:31:57 INFO - mozversion application_changeset: a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f 05:31:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:31:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:57 INFO - mozversion application_name: Firefox 05:31:57 INFO - mozversion application_remotingname: firefox-dev 05:31:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:31:57 INFO - mozversion application_vendor: Mozilla 05:31:57 INFO - mozversion application_version: 46.0a2 05:31:57 INFO - mozversion platform_buildid: 20160225005029 05:31:57 INFO - mozversion platform_changeset: a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f 05:31:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:31:57 INFO - mozversion platform_version: 46.0a2 05:31:57 INFO - using testdate: 1456579917 05:31:57 INFO - actual date: 1456579917 05:31:57 INFO - starting webserver on 'localhost:46199' 05:31:57 INFO - SUITE-START | Running 3 tests 05:31:57 INFO - TEST-START | dromaeo_css 05:31:57 INFO - operating with platform_type : linux_ 05:31:57 INFO - Initialising browser for dromaeo_css test... 05:31:57 INFO - TEST-INFO | started process 31724 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppM5grH/profile http://localhost:46199/getInfo.html) 05:32:01 INFO - PROCESS | 31724 | 05:32:01 INFO - PROCESS | 31724 | (process:31801): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:32:02 INFO - PROCESS | 31724 | __metrics Screen width/height:1600/1200 05:32:02 INFO - PROCESS | 31724 | colorDepth:24 05:32:02 INFO - PROCESS | 31724 | Browser inner width/height: 1024/697 05:32:02 INFO - PROCESS | 31724 | __metrics 05:32:03 INFO - TEST-INFO | 31724: exit 0 05:32:03 INFO - Browser initialized. 05:32:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:03 INFO - TEST-INFO | started process 31850 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppM5grH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:05 INFO - PROCESS | 31850 | 05:32:05 INFO - PROCESS | 31850 | (process:31913): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:32:15 INFO - PROCESS | 31850 | RSS: Main: 140689408 05:32:15 INFO - PROCESS | 31850 | 05:33:05 INFO - PROCESS | 31850 | 1456579985262 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:35:12 INFO - PROCESS | 31850 | Cycle 1(1): loaded http://localhost:46199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46199/tests/dromaeo/cssquery-ext.html) 05:35:13 INFO - PROCESS | 31850 | RSS: Main: 145633280 05:35:13 INFO - PROCESS | 31850 | 05:38:15 INFO - PROCESS | 31850 | Cycle 1(1): loaded http://localhost:46199/tests/dromaeo/cssquery-ext.html (next: http://localhost:46199/tests/dromaeo/cssquery-jquery.html) 05:38:16 INFO - PROCESS | 31850 | RSS: Main: 144580608 05:38:16 INFO - PROCESS | 31850 | 05:41:18 INFO - PROCESS | 31850 | Cycle 1(1): loaded http://localhost:46199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46199/tests/dromaeo/cssquery-mootools.html) 05:41:18 INFO - PROCESS | 31850 | RSS: Main: 143949824 05:41:18 INFO - PROCESS | 31850 | 05:44:20 INFO - PROCESS | 31850 | Cycle 1(1): loaded http://localhost:46199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46199/tests/dromaeo/cssquery-prototype.html) 05:44:21 INFO - PROCESS | 31850 | RSS: Main: 143519744 05:44:21 INFO - PROCESS | 31850 | 05:47:23 INFO - PROCESS | 31850 | Cycle 1(1): loaded http://localhost:46199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46199/tests/dromaeo/cssquery-yui.html) 05:47:23 INFO - PROCESS | 31850 | RSS: Main: 143986688 05:47:23 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | Cycle 1(1): loaded http://localhost:46199/tests/dromaeo/cssquery-yui.html (next: http://localhost:46199/tests/dromaeo/cssquery-dojo.html) 05:50:26 INFO - PROCESS | 31850 | RSS: Main: 147415040 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | __start_tp_report 05:50:26 INFO - PROCESS | 31850 | _x_x_mozilla_page_load 05:50:26 INFO - PROCESS | 31850 | _x_x_mozilla_page_load_details 05:50:26 INFO - PROCESS | 31850 | |i|pagename|runs| 05:50:26 INFO - PROCESS | 31850 | |0;dojo.html;3320.2695407010456;3359.0930448778813;3363.1760218746413;3388.644192359802;3390.271091715281;5425.294711687475;5432.83701488955;5444.047291723948;5448.863778405542;5451.945480545193;5450.509454149126;5491.697956612395;5493.478119578644;5497.367802702691;5541.9168712469245;4914.311996320509;4985.850424487253;5065.772040258179;5084.949150508503;5159.432462429129;4909.926351104737;5018.749062546858;5045.293658887758;5069.74651267437;5078.949210507903;5000.874978125557;5030.723310217936;5048.924266136011;5058.873528161788;5077.517635824609;5081.59347252219;5091.439941606439;5093.745312734349;5106.923396149061;5126.871828204287;4875.366202393701;4919.77860996256;5005.924911126336;5022;5079.949200508022;5264.92102618461;5320.201969704575;5324.85515614141;5343.545798607123;5352.4915133062295;5864.853378665567;5886.3230728465915;5924.170616113704;5931.051031834886;5935.673537955411;5851.122331650244;5851.268591426072;5940;5976.64140151588;5995.790147344822;5505.476979686883;5530.778768849241;5535.197396377543;5537.1140617501405;5545.639533430354;5963.0459126539545;5976.193213916065;5982;5986.161937328778;5988.28140623128;5725.055365864586;5780.826575202751;5791.7683292667825;5825.271841019872;5959;5877.823665290048;5877.970610147007;5893.616914900604;5893.909626719071;5901.7639294427745;5699.800506982236;5843.444872737083;5853.297604287428;5854.590178687451;5880.176775251468;5717.485426311652;5802.912956305574;5816.389279125716;5820.214271073435;5927.347991720907;4490.348899409632;4495.595396414338;4515.300128480091;4520.4575450946095;4555.681102322806;3976.6619837313574;4050.7772072536295;4097;4112.588741125924;4121.690873184463;5474.7262636868;5477.616566840283;5524.475174858382;5556.138798486241;5559.082751346064;5856.94143058564;5909.438603332676;5927.555433342516;5937.317208521075;5939.22790037301;5432.375276843213;5484.533814625722;5487.862803429946;5509.063459211943;5532.031894418461;4981.2030075187795;5064.911044125457;5066.16408292635;5067.8986420271385;5114.948850511521;6019.187409699634;6028.0355143176885;6041.365656606081;6063.120847477091;6082.391760823971;5754.683492407958;5895.67573783446;5948.791792287336;5970.5522085844605;5972.820815375546;5974.820755377345;6010.2186715726675;6038.275406951018;6038.3357830637715;6059.21230240066;5788.131780232999;5801.3038435388025;5811.970940145272;5818.650880947157;5820.883582328245;5830.096335068071;5872.588918775816;5886.499647530008;5914.083317085859;5951.9881620123815;5773.480386765212;5782.884342313214;5783.595148339576;5789.073748200268;5792.536597072309;5701.600887937804;5720.885582288414;5739.2252045973255;5774.0184168690585;5784.94215057844;5561.6663000220115;5652.491275785034;5690.77236910519;5698.344690360662;5726.513246374105;5685.943140568706;5726.9713651431475;5732.168835518743;5837.67892765902;5854.2389489366105;5639.520640745583;5650.23721797552;5654.349749778664;5676.148577713376;5686.943130568807 05:50:26 INFO - PROCESS | 31850 | |1;ext.html;541.9825100271463;577.4629594477136;585.4321308330921;595.1845971019703;622.9345918678536;38874.41688374673;40029.19941601173;40480.39279410808;40521.79739101304;40624;42031.57968420315;42282;42537.787311063475;42762.14475710484;43005.35491967615;8782.91217087829;8852.734417967471;8857.645694172226;8919.821603567925;8964.775880602972;8708.998465176492;8805.16350946659;8849.823003539925;8864.069272726367;8866.290696744278;8784.824303513959;10813.567457301699;11086.889131108706;11129.387883666435;11130.610428635;10646.414447205401;10745.83881241782;10765.730856728605;10768.407737574431;10792.622258220963;10495.73760655982;10558.04977552024;10630.574777008987;10653;10656.893431065668;41082.58917410817;41873.581264187575;41888.58111418908;41895.58104418947;41926.16147677029;3624.746267761258;3648.087978005499;3790.753601015953;3833.9424908626393;4426.889327766831;32234.516482252784;32456.675433245837;32705.6729432705;32732.672673273202;33113.834430827934;4299.699021068526;4305.375720520507;4332.67504937131;4345.869623911256;4382.517923028497;272422;274668;275390;276642;277997;64517;64738;65007.34992650013;65269.67365163144;65281.347186528474;68111.65944170248;68457.65771171112;68703;68852.31147688458;68862.31137688659;17871.46385608408;18018.279268829363;18058.27766889336;18155.818441815678;18259.72610410845;12774.872251277555;12929.353532323346;12958.481660733465;12982;13058.934705326412;21675.67486487704;21718.26253899684;21807.34577962632;21851.562968740534;21932.780672193392;8562.828743425096;8728.869066964;8777.341699372573;8778.040407169929;8904.332175086894;956.2111258212003;1001.8998100190068;1075.3118004476985;1107.5901916291025;1151.5566506894907;29972.700272997427;29998.250043748645;30553.083407497812;30819.229519262197;31003.689963100533;1024.1192574386023;1115.5482029777952;1129.8983091521638;1154.8440960470398;1174.5008371442102;15234.619134521725;15352.385904563916;15387.692246155015;15499.767503487457;15658.138802365978;419028;501307;501821;505403;511207;52788.47211527835;53089.734551327;53592.19611705827;53697.73151134297;53909.46090539044;1423.9288035598179;1443.0980637101811;1446.797448357231;1449.9130052196901;1467.3176972707743;29739.40521189521;32992.340153197285;33168.66831331656;33398.998030059134;33447.33105337928;51280;52000;52136.21795673144;52188.739056304476;52226;297615;301790;302305;302313;303196;43248;43449.3482597755;43539;43589.78205108954;43781.34327985146;46949.76525117353;47153.292700608836;47834.28248576204;48119.75940120277;48867;40845.183096337314;41609.79195104005;41812;42103.15793684171;42223.7888810554;41135.7943210282;43136.35295470508;44824;44882;45085.77457112825;39472.40791388074;39520.802395987834;39862.60137398589;41863.06958512997;42396.364054538586;32939.67060329462;33594.160145996546;33636.831815840764;36615.816920915226;37319.067023324635;25117;25854.224373268833;28094.578581321704;28201.816286735888;28818.279543010754 05:50:26 INFO - PROCESS | 31850 | |2;jquery.html;384.6864805183776;387.074891010485;387.15406836063204;388.22161566060043;389.09147141424774;15392.538223853275;16395.098269595168;16395.344186232553;19517.512062198453;19568.902155489202;11537.653870383881;12134.69663258419;12160.087993400508;17437.7384339235;17751.73372399415;4810.470848206694;5059.139946209144;5217.921731174036;5228.372595288571;6228.096925945758;4006.4190692349594;4103.261412945669;5574.219609254707;5814.12788081789;6085.056816193497;5559.416261292567;5656.151577263423;5772.4227577242145;5824.388439213885;5839.883202335951;5523.585731070166;5596.300462442195;5602.60781745278;5607.80372686954;5626.156076588524;5235.895282094337;5360.2763626910255;5361.249425080492;5377.193420986844;5411.621186516945;15102.320395582225;20396.796032039638;20548.79451205484;21315.253966111268;21315.893420532953;2231.1967691631;2252.966205506919;2261.357708835295;2339.368370539945;2404.7955923746504;10186.388816671024;10198.745031374201;10316.793664126675;10445.895541044645;10558.313709608929;1823.4073925974112;1902.4482899959135;1909.0836398528784;1976.2589029114083;1980.4553747719349;59510.40489595092;59908;62031.379686203014;62290.377096229364;72921.63539182323;15603.687926241639;15905.681886362208;16337.83662163363;16408.83591164097;16748.581285467717;24961.500769984497;24979.375515612253;25080.87459562727;25132.874335628207;25372.365690857878;9793.265505087147;9929.950350248348;9931.205503559842;9935.751606209902;10144.087032167141;8327.583620818934;8357.498550087013;8395.160483951557;8401.36989725773;8437.95781021091;4716.127516409407;8037.598120093972;8127.918720812834;8150.470219435718;8291.170882911782;2013.6677448221174;2034.7965203479534;2092.1526781653456;2095.4447071526056;2096.968545471819;933.4352716606492;953.0993211415284;1052.6526246338842;1073.742301847551;1111.7998760223238;16981.660366792843;17045.7443138353;17439.302427902996;17670.469885903443;18042.2783088675;966.9516524173763;1007.561710655867;1024.2369434770994;1055.5091882274778;1089.1014912697058;10042.397456152654;10325.225608079425;10690.893091069145;10712.089472394779;10726.517306721216;591026;597054;600179;612222;615065;69022;70220.64889675518;71016.28983710097;76085;79378;1119.960801371948;1157.2130950953433;1164.6040346282305;1178.5168081086886;1190.6904204906787;15435.459758908384;15902.840971590136;16109.516714498584;16456.67086658284;16458.670826583642;34407.79759766998;34530.82734586311;34646;35504.28991420209;36073.458898117075;43903.121937560434;44044.33933491064;45487.77256113698;45827;47613.76193119012;7840.3727701784865;8069.959650201711;8103.31121854649;8107.878381824396;8141.430099893188;11338.94330528375;11565.653030409101;11922.940385298365;12254.938725306672;12313.56902508408;9893.950530247303;10093.142082923034;10145.746356341151;10348.948255258676;10806.621768238074;9890;9957.402555846673;10254.28220024591;10264.948675256575;10304;10165.898341016495;10242.692719218436;10358.637447689294;10454;10478.423686697304;8161.306288965505;8334.416590838584;8335.083140854622;8351.914251147313;8416.410851240355;9987.250956178461;11087.72280692989;11130.499127539442;11213;11345.262557933707 05:50:26 INFO - PROCESS | 31850 | |3;mootools.html;1502.7520459124244;1521.939122435103;1759.7624320716707;1882.8117188281165;1919.7216403621476;8024.759257222278;8040.517568945867;8357.74926752197;8523.744287671372;8566.271866891313;8232.83534329313;8237.794055148624;8270.0489443714;8352.24829765321;8451.070382257947;2400.23192578375;2416.9395765105837;2438.4635380216323;2439.316991242446;2441.2554170977846;2415.1788391946734;2421.891014904325;2465.469923966347;2467.605183170693;2468.6420469031978;2397.496525729599;2437.5124975004983;2442.926712198637;2445.620928756037;2468.02513007362;2429.5505331513727;2451.6812814334203;2453.8405003674793;2456.0421435640114;2464.297675162579;2445.0097710427126;2450.338408629678;2459.2376363327426;2460.065175233418;2473.1591258971857;8611.26804221642;8654.177853104007;8666.52334121623;8668.739937801813;8675.045744968049;5011.749412529359;5070.594352451832;5124.666896651743;5134.768935397916;5146.794128234867;3166.2717574957887;3212.855421506038;3246.626637936644;3293.720033797106;3299.026787097812;1063.457636605329;2126.436494329004;2132.520182958822;2154.4721543222013;2178.59695956247;11909.940450297692;12091.93954030233;12164.756704865853;12171.695707607203;12190.878091219063;4444.777761111996;4496.842610508616;4571.474280457724;4579.107074120515;4584.083183363341;9786.657466988621;9804.36271642341;9890.307678462583;9907.702768916944;9927.900720992697;5077.238414237894;5112.8466146014935;5141.460146684619;5163.948360516422;5174.767135478913;4637.5130611286;4698.36572062774;4717.858464246078;4743.928841067387;4750.334953106568;3669.9266014680093;3707.3882809336696;3742.4760533525327;3776.339140650375;3797.9620203798163;1080.0981180714034;1083.1876092930302;1084.6908631040274;1103.1560855945208;1148.2134737704698;1440.5462279381961;1442.8557144285487;1458.9708205836037;1490.3144553505508;1496.3416096917322;8008.27925486709;8094.392920530984;8130.146334634896;8158.021037475541;8185.590720463953;1173.8473998380327;1180.1738782852037;1220.9342888182332;1246.4453318273463;1255.9246445213316;5707.828765137053;5721.971390143022;5731.799387021434;5757.568182386338;5797.36229014808;9937.751556211007;10654.307470014424;10670.093042091354;10699;10746.194035447374;10237.23220758446;10485.108765754843;10494.055535001886;10512.947435262775;10524.63163789279;8164.591770411455;8240.052393974649;8246.670133194724;8298.377621678399;8366.37252206087;7722;7743.760998240255;7767.417443691633;7864.449488535747;7886;9010.234130099016;9050.275977921881;9125.680601178927;9165.679201227926;9178.632854686004;9144.405613635092;9347.485888276211;9357.111074447917;9432.95283523578;9505.477198754135;7309.634518274172;7339.302766237199;7417.406607471282;7434.665440055319;7436.256374362737;7783.104942931635;7947.165547617417;7969.721059763112;7977.162397948132;8034.638441270274;7563.697452101855;7613.9238607613215;7624.5425274483705;7635.312821846061;7787.961060194662;7495.7001719930595;7559.017327747358;7585.127710313384;7598.392128629807;7735.22647735222;7718.691252350068;7736.226377362219;7833.764987050397;7846.293833555007;7853.685852565834;7054.470914681317;7108.964455177691;7111.53775004623;7135.50051496411;7141.928580714126;7050.858982820418;7182.138143422822;7199.424046076406;7243.601601911945;7305.634718263959 05:50:26 INFO - PROCESS | 31850 | |4;prototype.html;363.13211424695;368.1330466750803;371.2945403732907;374.2477619983832;381.7442313649854;6403.3596640335945;6424.2290925089;6483.708233129509;6490.610563366201;6679.5658282211625;6417.743290268395;6428.77499287525;6428.807135785923;6447.484201263899;6474.1907261592305;4903.117438860994;4939.654224204307;4948.2824990376375;4957.429895562021;5013.699178049311;4961.950380496203;4988.351514303135;4996.075725990685;5012.72430016349;5013.824516141935;4546.749928753918;4843.128236917353;4846.297286893398;4849.490803465638;4861.805527778884;4852.563269305761;4853.296272040552;4856.635752318591;4862.659613827033;4877.829275975324;4239.109786944745;4246.660267178619;4254.298040823292;4255.893602659928;4258.893527661802;6028.39716028398;6061.484773794233;6112.572119951606;6119.326874043852;6149.96925015372;5762.942370576325;5783.942160578383;5788.8842223155725;5789.565782566325;5796.449337312949;6825.726970921157;6831.6242606656615;6840.521163518556;6845.863082738367;6881.311868813129;4803.351547541072;4803.951960480385;4806.206975848981;4812.230043193073;4837.540433658797;6896.620685862275;7161.856762864713;7172.569645821268;7185.6766445510075;7191.89212161818;4953.925691114636;4954.727489988013;4956.182229932093;4958.355413796256;4959.330490383824;5019.247112933089;5035.874103147377;5039.042581909425;5040.395152581714;5043.420006699203;5677.148427735872;5774.855628609234;5782.797602083991;5783.219265399117;5786.103154011135;6862.416694581017;6873.1064961554675;6874.896876546856;6887.070245516891;6887.139107611549;1728.524655719662;1738.0614468187036;1740.6692728381568;1743.8692098092695;1750.64111857069;1201.597464849268;1205.6865215044152;1211.6304527119137;1214.0591041942564;1219.567053695925;6426.2931077581425;6578.572392794453;6583.242927063449;6598.769043083469;6602.405783479414;7052.33002864727;7076.752313668997;7085.43316534676;7125.073740413713;7145.428365730729;6369.331220221903;6434.517411194179;6495.902561461582;6496.252930913006;6528.281888992207;3833.0800607853917;3846.6345697159286;3853.113783829735;3857.765515035162;3860.575336712959;7238.420926325882;7269.418446524372;7283.672234749449;7289.380402665727;7291.817704557322;7183.62066820905;7191.7842464726145;7251.4923955323675;7256.310650488195;7277.708891644381;7222.133343998754;7239.276072392719;7242.7102915883825;7257.709691612382;7264.200937896932;7063.858722825617;7102.076730025064;7112.182099058675;7119.679614417467;7126.964365178348;6866.793996180123;6958.443324534126;6960.9303906962305;6977.476689248225;7007.964960175371;7201.243869393638;7217.133943926762;7243.492955493065;7248.130224373109;7249.746258880914;4911.68074075184;4914;4916.360873086476;4919.139150648693;4922.704637721748;6901.378875901193;7018.192907815463;7070.974708667111;7072.681729322296;7206.423486121203;6968.442524598121;6995.965020174866;6997.230304666585;7009.894851577333;7020.859582808417;6942.375186233263;6971.268016858156;6979.581225126509;7018.543794653331;7022.929770702228;6633.9668301658185;6856.554323968926;6862.828429289308;6881.552699074544;6883.3116688330765;7034.487585169213;7035.296470352924;7041.5775053496955;7053.929460705327;7063.1524217094275;6725.562838415487;6824.112865327475;6850.794476165723;6853.9314606853295;6861.725530978904 05:50:26 INFO - PROCESS | 31850 | |5;yui.html;743.8214828441176;800.2317774936062;842.4229402859038;924.3760461688358;943.2454036770584;12642.178258413196;12715.554955576557;12758.362081895903;12804.039697022714;12813.551525696603;13607.115537490055;15342.84657153428;15526.922365388185;15552.766708499354;15621.765673514907;861.8621020636683;872.2542226396434;877.8858748362704;881.6120906800987;883.2713011765287;874.3398733955854;878.2447095497866;884.6594061286419;885.9069797671249;888.5201990924925;922.580225997173;934.1732566678504;934.2946075712862;934.5841100710187;934.8364036293656;908.1554154636186;915.2860768600502;918.4122161816442;922.9769255768559;926.1294383279695;669.6049330894747;670.125486240456;670.8859493886002;672.6804767735335;672.9226138994029;13880.51418200358;14088.295585220698;14089;14092.647683807885;14096.788548171786;13261.933690331487;13331.86668133316;13406.530771423051;13722.176669399869;13936.86063139376;11078.667639970814;11127.443627818577;11183.769785323608;11308.208425410225;11314.434278286053;3798.2023775007283;3851.73037887348;3882.417637354391;3920.0199950012498;3947.1118998225456;50490.495095048944;51866.48133518692;52239.73880130613;52314.738426307624;52455;10240;10553.683389498327;10621.468926553796;10705.83941240882;10975.28660637056;18874.24503019864;19048.52378690516;19055.80944190568;19101.426957191306;19126;7821.217878212134;7873.291403773688;7970.083440404312;8150.38872084596;8262.884510591113;4203.369494575838;4381.518033016366;4446.221911165533;4463.107378524243;4617;3325.068980685412;3349.2296771742635;3362.882299119568;3364.2934983653217;3373.983130084334;577.6967092276504;583.4194975998909;587.3803137689779;652.100101859431;682.0757873082001;592.6355291495785;600.7326739600923;628.4752231886334;720.2077714513993;779.8235500774376;8408.495490270603;9478.763030924281;9666.178374838217;10103.444310562989;10175.236857235737;579.9188113664006;583.2650859916536;606.233115109387;759.9322951253498;788.4480863395531;4373.343998400265;4486.865883245655;4489.19194544985;4494.797734101973;4640.327152562927;61779.6911015442;62078;62439.37560624335;62529.68735156295;62645;53178;53239.46760532423;53355.73322133364;53356;53774;48339.5166048335;48898.99999999929;49420.75289623601;49632;50775.746121269156;9017.684381046894;9054.592543335433;9198.172164505228;9294.070592940652;9313.068693130634;35020.82489587536;35292.29415411626;35356.823215883756;35548;35612.64387356197;42496;45044.32433513434;46495.767521162175;46638;47924.7603761979;11272.67456100436;11526;11567.768644626893;11597.246178998337;11606.883931160917;12348.567800126952;12645.810312845131;12961.22232666043;13157.934210328887;13208;12189.695257618276;12660.430280637209;12936.935315323362;13074.803877941647;13233.536826211037;11945.701357465785;12007.219530730825;12073.034157267573;12451;12643.178193417398;11834.289942603471;11855.881441185478;13088.541901033419;13338.041267362718;13671.043026988413;10283;10746.247762656853;10850.891491084989;10910.509027093642;11208.327500350006;10724.927507249213;10830.620928267474;11002.174836887425;11057.281276716987;11062.22564420483 05:50:26 INFO - PROCESS | 31850 | __end_tp_report 05:50:26 INFO - PROCESS | 31850 | __start_cc_report 05:50:26 INFO - PROCESS | 31850 | _x_x_mozilla_cycle_collect,292 05:50:26 INFO - PROCESS | 31850 | __end_cc_report 05:50:26 INFO - PROCESS | 31850 | __startTimestamp1456581026388__endTimestamp 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | ------- Summary: start ------- 05:50:26 INFO - PROCESS | 31850 | Number of tests: 6 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | [#0] dojo.html Cycles:165 Average:5465.81 Median:5686.94 stddev:588.59 (10.3%) stddev-sans-first:565.82 05:50:26 INFO - PROCESS | 31850 | Values: 3320.3 3359.1 3363.2 3388.6 3390.3 5425.3 5432.8 5444.0 5448.9 5451.9 5450.5 5491.7 5493.5 5497.4 5541.9 4914.3 4985.9 5065.8 5084.9 5159.4 4909.9 5018.7 5045.3 5069.7 5078.9 5000.9 5030.7 5048.9 5058.9 5077.5 5081.6 5091.4 5093.7 5106.9 5126.9 4875.4 4919.8 5005.9 5022.0 5079.9 5264.9 5320.2 5324.9 5343.5 5352.5 5864.9 5886.3 5924.2 5931.1 5935.7 5851.1 5851.3 5940.0 5976.6 5995.8 5505.5 5530.8 5535.2 5537.1 5545.6 5963.0 5976.2 5982.0 5986.2 5988.3 5725.1 5780.8 5791.8 5825.3 5959.0 5877.8 5878.0 5893.6 5893.9 5901.8 5699.8 5843.4 5853.3 5854.6 5880.2 5717.5 5802.9 5816.4 5820.2 5927.3 4490.3 4495.6 4515.3 4520.5 4555.7 3976.7 4050.8 4097.0 4112.6 4121.7 5474.7 5477.6 5524.5 5556.1 5559.1 5856.9 5909.4 5927.6 5937.3 5939.2 5432.4 5484.5 5487.9 5509.1 5532.0 4981.2 5064.9 5066.2 5067.9 5114.9 6019.2 6028.0 6041.4 6063.1 6082.4 5754.7 5895.7 5948.8 5970.6 5972.8 5974.8 6010.2 6038.3 6038.3 6059.2 5788.1 5801.3 5812.0 5818.7 5820.9 5830.1 5872.6 5886.5 5914.1 5952.0 5773.5 5782.9 5783.6 5789.1 5792.5 5701.6 5720.9 5739.2 5774.0 5784.9 5561.7 5652.5 5690.8 5698.3 5726.5 5685.9 5727.0 5732.2 5837.7 5854.2 5639.5 5650.2 5654.3 5676.1 5686.9 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | [#1] ext.html Cycles:180 Average:53947.58 Median:39945.90 stddev:97026.15 (242.9%) stddev-sans-first:97215.48 05:50:26 INFO - PROCESS | 31850 | Values: 542.0 577.5 585.4 595.2 622.9 38874.4 40029.2 40480.4 40521.8 40624.0 42031.6 42282.0 42537.8 42762.1 43005.4 8782.9 8852.7 8857.6 8919.8 8964.8 8709.0 8805.2 8849.8 8864.1 8866.3 8784.8 10813.6 11086.9 11129.4 11130.6 10646.4 10745.8 10765.7 10768.4 10792.6 10495.7 10558.0 10630.6 10653.0 10656.9 41082.6 41873.6 41888.6 41895.6 41926.2 3624.7 3648.1 3790.8 3833.9 4426.9 32234.5 32456.7 32705.7 32732.7 33113.8 4299.7 4305.4 4332.7 4345.9 4382.5 272422.0 274668.0 275390.0 276642.0 277997.0 64517.0 64738.0 65007.3 65269.7 65281.3 68111.7 68457.7 68703.0 68852.3 68862.3 17871.5 18018.3 18058.3 18155.8 18259.7 12774.9 12929.4 12958.5 12982.0 13058.9 21675.7 21718.3 21807.3 21851.6 21932.8 8562.8 8728.9 8777.3 8778.0 8904.3 956.2 1001.9 1075.3 1107.6 1151.6 29972.7 29998.3 30553.1 30819.2 31003.7 1024.1 1115.5 1129.9 1154.8 1174.5 15234.6 15352.4 15387.7 15499.8 15658.1 419028.0 501307.0 501821.0 505403.0 511207.0 52788.5 53089.7 53592.2 53697.7 53909.5 1423.9 1443.1 1446.8 1449.9 1467.3 29739.4 32992.3 33168.7 33399.0 33447.3 51280.0 52000.0 52136.2 52188.7 52226.0 297615.0 301790.0 302305.0 302313.0 303196.0 43248.0 43449.3 43539.0 43589.8 43781.3 46949.8 47153.3 47834.3 48119.8 48867.0 40845.2 41609.8 41812.0 42103.2 42223.8 41135.8 43136.4 44824.0 44882.0 45085.8 39472.4 39520.8 39862.6 41863.1 42396.4 32939.7 33594.2 33636.8 36615.8 37319.1 25117.0 25854.2 28094.6 28201.8 28818.3 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | [#2] jquery.html Cycles:180 Average:30548.81 Median:25030.13 stddev:98395.58 (393.1%) stddev-sans-first:98645.54 05:50:26 INFO - PROCESS | 31850 | Values: 384.7 387.1 387.2 388.2 389.1 15392.5 16395.1 16395.3 19517.5 19568.9 11537.7 12134.7 12160.1 17437.7 17751.7 4810.5 5059.1 5217.9 5228.4 6228.1 4006.4 4103.3 5574.2 5814.1 6085.1 5559.4 5656.2 5772.4 5824.4 5839.9 5523.6 5596.3 5602.6 5607.8 5626.2 5235.9 5360.3 5361.2 5377.2 5411.6 15102.3 20396.8 20548.8 21315.3 21315.9 2231.2 2253.0 2261.4 2339.4 2404.8 10186.4 10198.7 10316.8 10445.9 10558.3 1823.4 1902.4 1909.1 1976.3 1980.5 59510.4 59908.0 62031.4 62290.4 72921.6 15603.7 15905.7 16337.8 16408.8 16748.6 24961.5 24979.4 25080.9 25132.9 25372.4 9793.3 9930.0 9931.2 9935.8 10144.1 8327.6 8357.5 8395.2 8401.4 8438.0 4716.1 8037.6 8127.9 8150.5 8291.2 2013.7 2034.8 2092.2 2095.4 2097.0 933.4 953.1 1052.7 1073.7 1111.8 16981.7 17045.7 17439.3 17670.5 18042.3 967.0 1007.6 1024.2 1055.5 1089.1 10042.4 10325.2 10690.9 10712.1 10726.5 591026.0 597054.0 600179.0 612222.0 615065.0 69022.0 70220.6 71016.3 76085.0 79378.0 1120.0 1157.2 1164.6 1178.5 1190.7 15435.5 15902.8 16109.5 16456.7 16458.7 34407.8 34530.8 34646.0 35504.3 36073.5 43903.1 44044.3 45487.8 45827.0 47613.8 7840.4 8070.0 8103.3 8107.9 8141.4 11338.9 11565.7 11922.9 12254.9 12313.6 9894.0 10093.1 10145.7 10348.9 10806.6 9890.0 9957.4 10254.3 10264.9 10304.0 10165.9 10242.7 10358.6 10454.0 10478.4 8161.3 8334.4 8335.1 8351.9 8416.4 9987.3 11087.7 11130.5 11213.0 11345.3 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | [#3] mootools.html Cycles:180 Average:5983.20 Median:5144.13 stddev:3104.80 (60.4%) stddev-sans-first:3095.25 05:50:26 INFO - PROCESS | 31850 | Values: 1502.8 1521.9 1759.8 1882.8 1919.7 8024.8 8040.5 8357.7 8523.7 8566.3 8232.8 8237.8 8270.0 8352.2 8451.1 2400.2 2416.9 2438.5 2439.3 2441.3 2415.2 2421.9 2465.5 2467.6 2468.6 2397.5 2437.5 2442.9 2445.6 2468.0 2429.6 2451.7 2453.8 2456.0 2464.3 2445.0 2450.3 2459.2 2460.1 2473.2 8611.3 8654.2 8666.5 8668.7 8675.0 5011.7 5070.6 5124.7 5134.8 5146.8 3166.3 3212.9 3246.6 3293.7 3299.0 1063.5 2126.4 2132.5 2154.5 2178.6 11909.9 12091.9 12164.8 12171.7 12190.9 4444.8 4496.8 4571.5 4579.1 4584.1 9786.7 9804.4 9890.3 9907.7 9927.9 5077.2 5112.8 5141.5 5163.9 5174.8 4637.5 4698.4 4717.9 4743.9 4750.3 3669.9 3707.4 3742.5 3776.3 3798.0 1080.1 1083.2 1084.7 1103.2 1148.2 1440.5 1442.9 1459.0 1490.3 1496.3 8008.3 8094.4 8130.1 8158.0 8185.6 1173.8 1180.2 1220.9 1246.4 1255.9 5707.8 5722.0 5731.8 5757.6 5797.4 9937.8 10654.3 10670.1 10699.0 10746.2 10237.2 10485.1 10494.1 10512.9 10524.6 8164.6 8240.1 8246.7 8298.4 8366.4 7722.0 7743.8 7767.4 7864.4 7886.0 9010.2 9050.3 9125.7 9165.7 9178.6 9144.4 9347.5 9357.1 9433.0 9505.5 7309.6 7339.3 7417.4 7434.7 7436.3 7783.1 7947.2 7969.7 7977.2 8034.6 7563.7 7613.9 7624.5 7635.3 7788.0 7495.7 7559.0 7585.1 7598.4 7735.2 7718.7 7736.2 7833.8 7846.3 7853.7 7054.5 7109.0 7111.5 7135.5 7141.9 7050.9 7182.1 7199.4 7243.6 7305.6 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | [#4] prototype.html Cycles:180 Average:5751.56 Median:6487.16 stddev:1726.17 (26.6%) stddev-sans-first:1682.97 05:50:26 INFO - PROCESS | 31850 | Values: 363.1 368.1 371.3 374.2 381.7 6403.4 6424.2 6483.7 6490.6 6679.6 6417.7 6428.8 6428.8 6447.5 6474.2 4903.1 4939.7 4948.3 4957.4 5013.7 4962.0 4988.4 4996.1 5012.7 5013.8 4546.7 4843.1 4846.3 4849.5 4861.8 4852.6 4853.3 4856.6 4862.7 4877.8 4239.1 4246.7 4254.3 4255.9 4258.9 6028.4 6061.5 6112.6 6119.3 6150.0 5762.9 5783.9 5788.9 5789.6 5796.4 6825.7 6831.6 6840.5 6845.9 6881.3 4803.4 4804.0 4806.2 4812.2 4837.5 6896.6 7161.9 7172.6 7185.7 7191.9 4953.9 4954.7 4956.2 4958.4 4959.3 5019.2 5035.9 5039.0 5040.4 5043.4 5677.1 5774.9 5782.8 5783.2 5786.1 6862.4 6873.1 6874.9 6887.1 6887.1 1728.5 1738.1 1740.7 1743.9 1750.6 1201.6 1205.7 1211.6 1214.1 1219.6 6426.3 6578.6 6583.2 6598.8 6602.4 7052.3 7076.8 7085.4 7125.1 7145.4 6369.3 6434.5 6495.9 6496.3 6528.3 3833.1 3846.6 3853.1 3857.8 3860.6 7238.4 7269.4 7283.7 7289.4 7291.8 7183.6 7191.8 7251.5 7256.3 7277.7 7222.1 7239.3 7242.7 7257.7 7264.2 7063.9 7102.1 7112.2 7119.7 7127.0 6866.8 6958.4 6960.9 6977.5 7008.0 7201.2 7217.1 7243.5 7248.1 7249.7 4911.7 4914.0 4916.4 4919.1 4922.7 6901.4 7018.2 7071.0 7072.7 7206.4 6968.4 6996.0 6997.2 7009.9 7020.9 6942.4 6971.3 6979.6 7018.5 7022.9 6634.0 6856.6 6862.8 6881.6 6883.3 7034.5 7035.3 7041.6 7053.9 7063.2 6725.6 6824.1 6850.8 6853.9 6861.7 05:50:26 INFO - PROCESS | 31850 | 05:50:26 INFO - PROCESS | 31850 | [#5] yui.html Cycles:180 Average:14674.15 Median:4413.87 stddev:16841.43 (381.6%) stddev-sans-first:16856.18 05:50:26 INFO - PROCESS | 31850 | Values: 743.8 800.2 842.4 924.4 943.2 12642.2 12715.6 12758.4 12804.0 12813.6 13607.1 15342.8 15526.9 15552.8 15621.8 861.9 872.3 877.9 881.6 883.3 874.3 878.2 884.7 885.9 888.5 922.6 934.2 934.3 934.6 934.8 908.2 915.3 918.4 923.0 926.1 669.6 670.1 670.9 672.7 672.9 13880.5 14088.3 14089.0 14092.6 14096.8 13261.9 13331.9 13406.5 13722.2 13936.9 11078.7 11127.4 11183.8 11308.2 11314.4 3798.2 3851.7 3882.4 3920.0 3947.1 50490.5 51866.5 52239.7 52314.7 52455.0 10240.0 10553.7 10621.5 10705.8 10975.3 18874.2 19048.5 19055.8 19101.4 19126.0 7821.2 7873.3 7970.1 8150.4 8262.9 4203.4 4381.5 4446.2 4463.1 4617.0 3325.1 3349.2 3362.9 3364.3 3374.0 577.7 583.4 587.4 652.1 682.1 592.6 600.7 628.5 720.2 779.8 8408.5 9478.8 9666.2 10103.4 10175.2 579.9 583.3 606.2 759.9 788.4 4373.3 4486.9 4489.2 4494.8 4640.3 61779.7 62078.0 62439.4 62529.7 62645.0 53178.0 53239.5 53355.7 53356.0 53774.0 48339.5 48899.0 49420.8 49632.0 50775.7 9017.7 9054.6 9198.2 9294.1 9313.1 35020.8 35292.3 35356.8 35548.0 35612.6 42496.0 45044.3 46495.8 46638.0 47924.8 11272.7 11526.0 11567.8 11597.2 11606.9 12348.6 12645.8 12961.2 13157.9 13208.0 12189.7 12660.4 12936.9 13074.8 13233.5 11945.7 12007.2 12073.0 12451.0 12643.2 11834.3 11855.9 13088.5 13338.0 13671.0 10283.0 10746.2 10850.9 10910.5 11208.3 10724.9 10830.6 11002.2 11057.3 11062.2 05:50:26 INFO - PROCESS | 31850 | -------- Summary: end -------- 05:50:26 INFO - PROCESS | 31850 | 05:50:27 INFO - TEST-INFO | 31850: exit 0 05:50:27 INFO - TEST-OK | dromaeo_css | took 1109094ms 05:50:27 INFO - TEST-START | kraken 05:50:27 INFO - operating with platform_type : linux_ 05:50:27 INFO - Initialising browser for kraken test... 05:50:27 INFO - TEST-INFO | started process 32093 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptqr09D/profile http://localhost:46199/getInfo.html) 05:50:30 INFO - PROCESS | 32093 | 05:50:30 INFO - PROCESS | 32093 | (process:32170): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:31 INFO - PROCESS | 32093 | __metrics Screen width/height:1600/1200 05:50:31 INFO - PROCESS | 32093 | colorDepth:24 05:50:31 INFO - PROCESS | 32093 | Browser inner width/height: 1024/697 05:50:31 INFO - PROCESS | 32093 | __metrics 05:50:32 INFO - TEST-INFO | 32093: exit 0 05:50:32 INFO - Browser initialized. 05:50:32 INFO - Running cycle 1/1 for kraken test... 05:50:32 INFO - TEST-INFO | started process 32219 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptqr09D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:34 INFO - PROCESS | 32219 | 05:50:34 INFO - PROCESS | 32219 | (process:32282): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:44 INFO - PROCESS | 32219 | RSS: Main: 141262848 05:50:44 INFO - PROCESS | 32219 | 05:50:47 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46199/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:47 INFO - PROCESS | 32219 | RSS: Main: 145641472 05:50:47 INFO - PROCESS | 32219 | 05:50:50 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46199/tests/kraken/driver.html?testName=audio-dft) 05:50:50 INFO - PROCESS | 32219 | RSS: Main: 146001920 05:50:50 INFO - PROCESS | 32219 | 05:50:53 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46199/tests/kraken/driver.html?testName=audio-fft) 05:50:54 INFO - PROCESS | 32219 | RSS: Main: 146018304 05:50:54 INFO - PROCESS | 32219 | 05:50:56 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46199/tests/kraken/driver.html?testName=audio-oscillator) 05:50:56 INFO - PROCESS | 32219 | RSS: Main: 145383424 05:50:56 INFO - PROCESS | 32219 | 05:50:59 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:59 INFO - PROCESS | 32219 | RSS: Main: 144998400 05:50:59 INFO - PROCESS | 32219 | 05:51:02 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46199/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:03 INFO - PROCESS | 32219 | RSS: Main: 147013632 05:51:03 INFO - PROCESS | 32219 | 05:51:06 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46199/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:07 INFO - PROCESS | 32219 | RSS: Main: 146472960 05:51:07 INFO - PROCESS | 32219 | 05:51:10 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46199/tests/kraken/driver.html?testName=json-parse-financial) 05:51:10 INFO - PROCESS | 32219 | RSS: Main: 146624512 05:51:10 INFO - PROCESS | 32219 | 05:51:12 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:12 INFO - PROCESS | 32219 | RSS: Main: 146595840 05:51:12 INFO - PROCESS | 32219 | 05:51:14 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:15 INFO - PROCESS | 32219 | RSS: Main: 146395136 05:51:15 INFO - PROCESS | 32219 | 05:51:17 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:17 INFO - PROCESS | 32219 | RSS: Main: 146374656 05:51:17 INFO - PROCESS | 32219 | 05:51:20 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:20 INFO - PROCESS | 32219 | RSS: Main: 145502208 05:51:20 INFO - PROCESS | 32219 | 05:51:23 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:23 INFO - PROCESS | 32219 | RSS: Main: 146214912 05:51:23 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | Cycle 1(1): loaded http://localhost:46199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46199/tests/kraken/driver.html?testName=ai-astar) 05:51:25 INFO - PROCESS | 32219 | RSS: Main: 147165184 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | __start_tp_report 05:51:25 INFO - PROCESS | 32219 | _x_x_mozilla_page_load 05:51:25 INFO - PROCESS | 32219 | _x_x_mozilla_page_load_details 05:51:25 INFO - PROCESS | 32219 | |i|pagename|runs| 05:51:25 INFO - PROCESS | 32219 | |0;ai-astar;112;106;112;113;114;121;116;109;110;111 05:51:25 INFO - PROCESS | 32219 | |1;audio-beat-detection;157;129;162;161;128;149;149;128;168;132 05:51:25 INFO - PROCESS | 32219 | |2;audio-dft;162;161;163;162;162;164;166;166;165;162 05:51:25 INFO - PROCESS | 32219 | |3;audio-fft;73;77;76;159;83;76;77;77;157;74 05:51:25 INFO - PROCESS | 32219 | |4;audio-oscillator;96;96;143;97;94;94;139;94;97;137 05:51:25 INFO - PROCESS | 32219 | |5;imaging-gaussian-blur;110;111;109;110;109;109;109;110;109;110 05:51:25 INFO - PROCESS | 32219 | |6;imaging-darkroom;148;147;148;148;149;147;147;146;147;147 05:51:25 INFO - PROCESS | 32219 | |7;imaging-desaturate;96;96;97;96;96;97;97;97;96;97 05:51:25 INFO - PROCESS | 32219 | |8;json-parse-financial;55;57;56;60;55;55;59;65;54;56 05:51:25 INFO - PROCESS | 32219 | |9;json-stringify-tinderbox;64;65;64;65;65;64;64;65;65;65 05:51:25 INFO - PROCESS | 32219 | |10;stanford-crypto-aes;81;83;83;82;83;83;91;82;83;82 05:51:25 INFO - PROCESS | 32219 | |11;stanford-crypto-ccm;114;110;110;112;129;113;114;116;117;114 05:51:25 INFO - PROCESS | 32219 | |12;stanford-crypto-pbkdf2;141;140;136;130;140;145;137;137;136;134 05:51:25 INFO - PROCESS | 32219 | |13;stanford-crypto-sha256-iterative;66;66;66;67;67;65;65;66;69;64 05:51:25 INFO - PROCESS | 32219 | __end_tp_report 05:51:25 INFO - PROCESS | 32219 | __start_cc_report 05:51:25 INFO - PROCESS | 32219 | _x_x_mozilla_cycle_collect,734 05:51:25 INFO - PROCESS | 32219 | __end_cc_report 05:51:25 INFO - PROCESS | 32219 | __startTimestamp1456581085758__endTimestamp 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | ------- Summary: start ------- 05:51:25 INFO - PROCESS | 32219 | Number of tests: 14 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:4.09 (3.6%) stddev-sans-first:4.33 05:51:25 INFO - PROCESS | 32219 | Values: 112.0 106.0 112.0 113.0 114.0 121.0 116.0 109.0 110.0 111.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:153.00 stddev:15.76 (10.3%) stddev-sans-first:16.24 05:51:25 INFO - PROCESS | 32219 | Values: 157.0 129.0 162.0 161.0 128.0 149.0 149.0 128.0 168.0 132.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.83 (1.1%) stddev-sans-first:1.88 05:51:25 INFO - PROCESS | 32219 | Values: 162.0 161.0 163.0 162.0 162.0 164.0 166.0 166.0 165.0 162.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.50 stddev:34.41 (45.0%) stddev-sans-first:35.74 05:51:25 INFO - PROCESS | 32219 | Values: 73.0 77.0 76.0 159.0 83.0 76.0 77.0 77.0 157.0 74.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:21.45 (22.6%) stddev-sans-first:22.25 05:51:25 INFO - PROCESS | 32219 | Values: 96.0 96.0 143.0 97.0 94.0 94.0 139.0 94.0 97.0 137.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:51:25 INFO - PROCESS | 32219 | Values: 110.0 111.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 05:51:25 INFO - PROCESS | 32219 | Values: 148.0 147.0 148.0 148.0 149.0 147.0 147.0 146.0 147.0 147.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:51:25 INFO - PROCESS | 32219 | Values: 96.0 96.0 97.0 96.0 96.0 97.0 97.0 97.0 96.0 97.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.50 stddev:3.33 (5.9%) stddev-sans-first:3.43 05:51:25 INFO - PROCESS | 32219 | Values: 55.0 57.0 56.0 60.0 55.0 55.0 59.0 65.0 54.0 56.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:51:25 INFO - PROCESS | 32219 | Values: 64.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.79 (3.4%) stddev-sans-first:2.83 05:51:25 INFO - PROCESS | 32219 | Values: 81.0 83.0 83.0 82.0 83.0 83.0 91.0 82.0 83.0 82.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:114.00 stddev:5.45 (4.8%) stddev-sans-first:5.77 05:51:25 INFO - PROCESS | 32219 | Values: 114.0 110.0 110.0 112.0 129.0 113.0 114.0 116.0 117.0 114.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.60 Median:138.50 stddev:4.14 (3.0%) stddev-sans-first:4.21 05:51:25 INFO - PROCESS | 32219 | Values: 141.0 140.0 136.0 130.0 140.0 145.0 137.0 137.0 136.0 134.0 05:51:25 INFO - PROCESS | 32219 | 05:51:25 INFO - PROCESS | 32219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 05:51:25 INFO - PROCESS | 32219 | Values: 66.0 66.0 66.0 67.0 67.0 65.0 65.0 66.0 69.0 64.0 05:51:25 INFO - PROCESS | 32219 | -------- Summary: end -------- 05:51:25 INFO - PROCESS | 32219 | 05:51:26 INFO - TEST-INFO | 32219: exit 0 05:51:26 INFO - TEST-OK | kraken | took 59650ms 05:51:26 INFO - TEST-START | v8_7 05:51:26 INFO - operating with platform_type : linux_ 05:51:26 INFO - Initialising browser for v8_7 test... 05:51:26 INFO - TEST-INFO | started process 32510 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphkWYPM/profile http://localhost:46199/getInfo.html) 05:51:30 INFO - PROCESS | 32510 | 05:51:30 INFO - PROCESS | 32510 | (process:32593): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:31 INFO - PROCESS | 32510 | __metrics Screen width/height:1600/1200 05:51:31 INFO - PROCESS | 32510 | colorDepth:24 05:51:31 INFO - PROCESS | 32510 | Browser inner width/height: 1024/697 05:51:31 INFO - PROCESS | 32510 | __metrics 05:51:32 INFO - TEST-INFO | 32510: exit 0 05:51:32 INFO - Browser initialized. 05:51:32 INFO - Running cycle 1/1 for v8_7 test... 05:51:32 INFO - TEST-INFO | started process 32642 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphkWYPM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:33 INFO - PROCESS | 32642 | 05:51:33 INFO - PROCESS | 32642 | (process:32706): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:44 INFO - PROCESS | 32642 | RSS: Main: 141430784 05:51:44 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | Cycle 1(1): loaded http://localhost:46199/tests/v8_7/run.html (next: http://localhost:46199/tests/v8_7/run.html) 05:52:06 INFO - PROCESS | 32642 | RSS: Main: 145043456 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | __start_tp_report 05:52:06 INFO - PROCESS | 32642 | _x_x_mozilla_page_load 05:52:06 INFO - PROCESS | 32642 | _x_x_mozilla_page_load_details 05:52:06 INFO - PROCESS | 32642 | |i|pagename|runs| 05:52:06 INFO - PROCESS | 32642 | |0;Richards;165.94756057085962 05:52:06 INFO - PROCESS | 32642 | |1;DeltaBlue;170.96939647803043 05:52:06 INFO - PROCESS | 32642 | |2;Encrypt;278.55153203342616 05:52:06 INFO - PROCESS | 32642 | |3;Decrypt;5208.333333333333 05:52:06 INFO - PROCESS | 32642 | |4;RayTrace;928.5051067780872 05:52:06 INFO - PROCESS | 32642 | |5;Earley;571.1022272986864 05:52:06 INFO - PROCESS | 32642 | |6;Boyer;11054.945054945056 05:52:06 INFO - PROCESS | 32642 | |7;RegExp;39538.46153846154 05:52:06 INFO - PROCESS | 32642 | |8;Splay;514.1388174807198 05:52:06 INFO - PROCESS | 32642 | |9;NavierStokes;4822.115384615385 05:52:06 INFO - PROCESS | 32642 | __end_tp_report 05:52:06 INFO - PROCESS | 32642 | __startTimestamp1456581126921__endTimestamp 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | ------- Summary: start ------- 05:52:06 INFO - PROCESS | 32642 | Number of tests: 10 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#0] Richards Cycles:1 Average:165.95 Median:165.95 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 165.9 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#1] DeltaBlue Cycles:1 Average:170.97 Median:170.97 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 171.0 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 278.6 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 5208.3 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#4] RayTrace Cycles:1 Average:928.51 Median:928.51 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 928.5 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#5] Earley Cycles:1 Average:571.10 Median:571.10 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 571.1 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#6] Boyer Cycles:1 Average:11054.95 Median:11054.95 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 11054.9 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#7] RegExp Cycles:1 Average:39538.46 Median:39538.46 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 39538.5 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#8] Splay Cycles:1 Average:514.14 Median:514.14 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 514.1 05:52:06 INFO - PROCESS | 32642 | 05:52:06 INFO - PROCESS | 32642 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:52:06 INFO - PROCESS | 32642 | Values: 4822.1 05:52:06 INFO - PROCESS | 32642 | -------- Summary: end -------- 05:52:06 INFO - PROCESS | 32642 | 05:52:07 INFO - TEST-INFO | 32642: exit 0 05:52:07 INFO - TEST-OK | v8_7 | took 41195ms 05:52:07 INFO - SUITE-END | took 1209s 05:52:07 INFO - Completed test suite (00:20:10) 05:52:07 INFO - Working with test: dromaeo_css 05:52:07 INFO - Generating results file: dromaeo_css 05:52:07 INFO - Working with test: kraken 05:52:07 INFO - Generating results file: kraken 05:52:07 INFO - javascript benchmark 05:52:07 INFO - Working with test: v8_7 05:52:07 INFO - Generating results file: v8_7 05:52:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:52:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:52:08 INFO - process_Request line: dromaeo_css 7489.44 graph.html#tests=[[72,52,43]] 05:52:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:52:08 INFO - process_Request line: kraken 1500.80 graph.html#tests=[[232,52,43]] 05:52:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:52:08 INFO - process_Request line: v8_7 22011.09 graph.html#tests=[[230,52,43]] 05:52:08 INFO - RETURN: dromaeo_css: 7489.44 05:52:08 INFO - RETURN: kraken: 1500.80 05:52:08 INFO - RETURN: v8_7: 22011.09 05:52:08 INFO - javascript benchmark 05:52:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3320.2695407010456, 3359.0930448778813, 3363.1760218746413, 3388.644192359802, 3390.271091715281, 5425.294711687475, 5432.83701488955, 5444.047291723948, 5448.863778405542, 5451.945480545193, 5450.509454149126, 5491.697956612395, 5493.478119578644, 5497.367802702691, 5541.9168712469245, 4914.311996320509, 4985.850424487253, 5065.772040258179, 5084.949150508503, 5159.432462429129, 4909.926351104737, 5018.749062546858, 5045.293658887758, 5069.74651267437, 5078.949210507903, 5000.874978125557, 5030.723310217936, 5048.924266136011, 5058.873528161788, 5077.517635824609, 5081.59347252219, 5091.439941606439, 5093.745312734349, 5106.923396149061, 5126.871828204287, 4875.366202393701, 4919.77860996256, 5005.924911126336, 5022.0, 5079.949200508022, 5264.92102618461, 5320.201969704575, 5324.85515614141, 5343.545798607123, 5352.4915133062295, 5864.853378665567, 5886.3230728465915, 5924.170616113704, 5931.051031834886, 5935.673537955411, 5851.122331650244, 5851.268591426072, 5940.0, 5976.64140151588, 5995.790147344822, 5505.476979686883, 5530.778768849241, 5535.197396377543, 5537.1140617501405, 5545.639533430354, 5963.0459126539545, 5976.193213916065, 5982.0, 5986.161937328778, 5988.28140623128, 5725.055365864586, 5780.826575202751, 5791.7683292667825, 5825.271841019872, 5959.0, 5877.823665290048, 5877.970610147007, 5893.616914900604, 5893.909626719071, 5901.7639294427745, 5699.800506982236, 5843.444872737083, 5853.297604287428, 5854.590178687451, 5880.176775251468, 5717.485426311652, 5802.912956305574, 5816.389279125716, 5820.214271073435, 5927.347991720907, 4490.348899409632, 4495.595396414338, 4515.300128480091, 4520.4575450946095, 4555.681102322806, 3976.6619837313574, 4050.7772072536295, 4097.0, 4112.588741125924, 4121.690873184463, 5474.7262636868, 5477.616566840283, 5524.475174858382, 5556.138798486241, 5559.082751346064, 5856.94143058564, 5909.438603332676, 5927.555433342516, 5937.317208521075, 5939.22790037301, 5432.375276843213, 5484.533814625722, 5487.862803429946, 5509.063459211943, 5532.031894418461, 4981.2030075187795, 5064.911044125457, 5066.16408292635, 5067.8986420271385, 5114.948850511521, 6019.187409699634, 6028.0355143176885, 6041.365656606081, 6063.120847477091, 6082.391760823971, 5754.683492407958, 5895.67573783446, 5948.791792287336, 5970.5522085844605, 5972.820815375546, 5974.820755377345, 6010.2186715726675, 6038.275406951018, 6038.3357830637715, 6059.21230240066, 5788.131780232999, 5801.3038435388025, 5811.970940145272, 5818.650880947157, 5820.883582328245, 5830.096335068071, 5872.588918775816, 5886.499647530008, 5914.083317085859, 5951.9881620123815, 5773.480386765212, 5782.884342313214, 5783.595148339576, 5789.073748200268, 5792.536597072309, 5701.600887937804, 5720.885582288414, 5739.2252045973255, 5774.0184168690585, 5784.94215057844, 5561.6663000220115, 5652.491275785034, 5690.77236910519, 5698.344690360662, 5726.513246374105, 5685.943140568706, 5726.9713651431475, 5732.168835518743, 5837.67892765902, 5854.2389489366105, 5639.520640745583, 5650.23721797552, 5654.349749778664, 5676.148577713376, 5686.943130568807], "unit": "score", "name": "dojo.html", "value": 5428.939057700019}, {"lowerIsBetter": false, "replicates": [541.9825100271463, 577.4629594477136, 585.4321308330921, 595.1845971019703, 622.9345918678536, 38874.41688374673, 40029.19941601173, 40480.39279410808, 40521.79739101304, 40624.0, 42031.57968420315, 42282.0, 42537.787311063475, 42762.14475710484, 43005.35491967615, 8782.91217087829, 8852.734417967471, 8857.645694172226, 8919.821603567925, 8964.775880602972, 8708.998465176492, 8805.16350946659, 8849.823003539925, 8864.069272726367, 8866.290696744278, 8784.824303513959, 10813.567457301699, 11086.889131108706, 11129.387883666435, 11130.610428635, 10646.414447205401, 10745.83881241782, 10765.730856728605, 10768.407737574431, 10792.622258220963, 10495.73760655982, 10558.04977552024, 10630.574777008987, 10653.0, 10656.893431065668, 41082.58917410817, 41873.581264187575, 41888.58111418908, 41895.58104418947, 41926.16147677029, 3624.746267761258, 3648.087978005499, 3790.753601015953, 3833.9424908626393, 4426.889327766831, 32234.516482252784, 32456.675433245837, 32705.6729432705, 32732.672673273202, 33113.834430827934, 4299.699021068526, 4305.375720520507, 4332.67504937131, 4345.869623911256, 4382.517923028497, 272422.0, 274668.0, 275390.0, 276642.0, 277997.0, 64517.0, 64738.0, 65007.34992650013, 65269.67365163144, 65281.347186528474, 68111.65944170248, 68457.65771171112, 68703.0, 68852.31147688458, 68862.31137688659, 17871.46385608408, 18018.279268829363, 18058.27766889336, 18155.818441815678, 18259.72610410845, 12774.872251277555, 12929.353532323346, 12958.481660733465, 12982.0, 13058.934705326412, 21675.67486487704, 21718.26253899684, 21807.34577962632, 21851.562968740534, 21932.780672193392, 8562.828743425096, 8728.869066964, 8777.341699372573, 8778.040407169929, 8904.332175086894, 956.2111258212003, 1001.8998100190068, 1075.3118004476985, 1107.5901916291025, 1151.5566506894907, 29972.700272997427, 29998.250043748645, 30553.083407497812, 30819.229519262197, 31003.689963100533, 1024.1192574386023, 1115.5482029777952, 1129.8983091521638, 1154.8440960470398, 1174.5008371442102, 15234.619134521725, 15352.385904563916, 15387.692246155015, 15499.767503487457, 15658.138802365978, 419028.0, 501307.0, 501821.0, 505403.0, 511207.0, 52788.47211527835, 53089.734551327, 53592.19611705827, 53697.73151134297, 53909.46090539044, 1423.9288035598179, 1443.0980637101811, 1446.797448357231, 1449.9130052196901, 1467.3176972707743, 29739.40521189521, 32992.340153197285, 33168.66831331656, 33398.998030059134, 33447.33105337928, 51280.0, 52000.0, 52136.21795673144, 52188.739056304476, 52226.0, 297615.0, 301790.0, 302305.0, 302313.0, 303196.0, 43248.0, 43449.3482597755, 43539.0, 43589.78205108954, 43781.34327985146, 46949.76525117353, 47153.292700608836, 47834.28248576204, 48119.75940120277, 48867.0, 40845.183096337314, 41609.79195104005, 41812.0, 42103.15793684171, 42223.7888810554, 41135.7943210282, 43136.35295470508, 44824.0, 44882.0, 45085.77457112825, 39472.40791388074, 39520.802395987834, 39862.60137398589, 41863.06958512997, 42396.364054538586, 32939.67060329462, 33594.160145996546, 33636.831815840764, 36615.816920915226, 37319.067023324635, 25117.0, 25854.224373268833, 28094.578581321704, 28201.816286735888, 28818.279543010754], "unit": "score", "name": "ext.html", "value": 20557.62092470405}, {"lowerIsBetter": false, "replicates": [384.6864805183776, 387.074891010485, 387.15406836063204, 388.22161566060043, 389.09147141424774, 15392.538223853275, 16395.098269595168, 16395.344186232553, 19517.512062198453, 19568.902155489202, 11537.653870383881, 12134.69663258419, 12160.087993400508, 17437.7384339235, 17751.73372399415, 4810.470848206694, 5059.139946209144, 5217.921731174036, 5228.372595288571, 6228.096925945758, 4006.4190692349594, 4103.261412945669, 5574.219609254707, 5814.12788081789, 6085.056816193497, 5559.416261292567, 5656.151577263423, 5772.4227577242145, 5824.388439213885, 5839.883202335951, 5523.585731070166, 5596.300462442195, 5602.60781745278, 5607.80372686954, 5626.156076588524, 5235.895282094337, 5360.2763626910255, 5361.249425080492, 5377.193420986844, 5411.621186516945, 15102.320395582225, 20396.796032039638, 20548.79451205484, 21315.253966111268, 21315.893420532953, 2231.1967691631, 2252.966205506919, 2261.357708835295, 2339.368370539945, 2404.7955923746504, 10186.388816671024, 10198.745031374201, 10316.793664126675, 10445.895541044645, 10558.313709608929, 1823.4073925974112, 1902.4482899959135, 1909.0836398528784, 1976.2589029114083, 1980.4553747719349, 59510.40489595092, 59908.0, 62031.379686203014, 62290.377096229364, 72921.63539182323, 15603.687926241639, 15905.681886362208, 16337.83662163363, 16408.83591164097, 16748.581285467717, 24961.500769984497, 24979.375515612253, 25080.87459562727, 25132.874335628207, 25372.365690857878, 9793.265505087147, 9929.950350248348, 9931.205503559842, 9935.751606209902, 10144.087032167141, 8327.583620818934, 8357.498550087013, 8395.160483951557, 8401.36989725773, 8437.95781021091, 4716.127516409407, 8037.598120093972, 8127.918720812834, 8150.470219435718, 8291.170882911782, 2013.6677448221174, 2034.7965203479534, 2092.1526781653456, 2095.4447071526056, 2096.968545471819, 933.4352716606492, 953.0993211415284, 1052.6526246338842, 1073.742301847551, 1111.7998760223238, 16981.660366792843, 17045.7443138353, 17439.302427902996, 17670.469885903443, 18042.2783088675, 966.9516524173763, 1007.561710655867, 1024.2369434770994, 1055.5091882274778, 1089.1014912697058, 10042.397456152654, 10325.225608079425, 10690.893091069145, 10712.089472394779, 10726.517306721216, 591026.0, 597054.0, 600179.0, 612222.0, 615065.0, 69022.0, 70220.64889675518, 71016.28983710097, 76085.0, 79378.0, 1119.960801371948, 1157.2130950953433, 1164.6040346282305, 1178.5168081086886, 1190.6904204906787, 15435.459758908384, 15902.840971590136, 16109.516714498584, 16456.67086658284, 16458.670826583642, 34407.79759766998, 34530.82734586311, 34646.0, 35504.28991420209, 36073.458898117075, 43903.121937560434, 44044.33933491064, 45487.77256113698, 45827.0, 47613.76193119012, 7840.3727701784865, 8069.959650201711, 8103.31121854649, 8107.878381824396, 8141.430099893188, 11338.94330528375, 11565.653030409101, 11922.940385298365, 12254.938725306672, 12313.56902508408, 9893.950530247303, 10093.142082923034, 10145.746356341151, 10348.948255258676, 10806.621768238074, 9890.0, 9957.402555846673, 10254.28220024591, 10264.948675256575, 10304.0, 10165.898341016495, 10242.692719218436, 10358.637447689294, 10454.0, 10478.423686697304, 8161.306288965505, 8334.416590838584, 8335.083140854622, 8351.914251147313, 8416.410851240355, 9987.250956178461, 11087.72280692989, 11130.499127539442, 11213.0, 11345.262557933707], "unit": "score", "name": "jquery.html", "value": 9086.123022585936}, {"lowerIsBetter": false, "replicates": [1502.7520459124244, 1521.939122435103, 1759.7624320716707, 1882.8117188281165, 1919.7216403621476, 8024.759257222278, 8040.517568945867, 8357.74926752197, 8523.744287671372, 8566.271866891313, 8232.83534329313, 8237.794055148624, 8270.0489443714, 8352.24829765321, 8451.070382257947, 2400.23192578375, 2416.9395765105837, 2438.4635380216323, 2439.316991242446, 2441.2554170977846, 2415.1788391946734, 2421.891014904325, 2465.469923966347, 2467.605183170693, 2468.6420469031978, 2397.496525729599, 2437.5124975004983, 2442.926712198637, 2445.620928756037, 2468.02513007362, 2429.5505331513727, 2451.6812814334203, 2453.8405003674793, 2456.0421435640114, 2464.297675162579, 2445.0097710427126, 2450.338408629678, 2459.2376363327426, 2460.065175233418, 2473.1591258971857, 8611.26804221642, 8654.177853104007, 8666.52334121623, 8668.739937801813, 8675.045744968049, 5011.749412529359, 5070.594352451832, 5124.666896651743, 5134.768935397916, 5146.794128234867, 3166.2717574957887, 3212.855421506038, 3246.626637936644, 3293.720033797106, 3299.026787097812, 1063.457636605329, 2126.436494329004, 2132.520182958822, 2154.4721543222013, 2178.59695956247, 11909.940450297692, 12091.93954030233, 12164.756704865853, 12171.695707607203, 12190.878091219063, 4444.777761111996, 4496.842610508616, 4571.474280457724, 4579.107074120515, 4584.083183363341, 9786.657466988621, 9804.36271642341, 9890.307678462583, 9907.702768916944, 9927.900720992697, 5077.238414237894, 5112.8466146014935, 5141.460146684619, 5163.948360516422, 5174.767135478913, 4637.5130611286, 4698.36572062774, 4717.858464246078, 4743.928841067387, 4750.334953106568, 3669.9266014680093, 3707.3882809336696, 3742.4760533525327, 3776.339140650375, 3797.9620203798163, 1080.0981180714034, 1083.1876092930302, 1084.6908631040274, 1103.1560855945208, 1148.2134737704698, 1440.5462279381961, 1442.8557144285487, 1458.9708205836037, 1490.3144553505508, 1496.3416096917322, 8008.27925486709, 8094.392920530984, 8130.146334634896, 8158.021037475541, 8185.590720463953, 1173.8473998380327, 1180.1738782852037, 1220.9342888182332, 1246.4453318273463, 1255.9246445213316, 5707.828765137053, 5721.971390143022, 5731.799387021434, 5757.568182386338, 5797.36229014808, 9937.751556211007, 10654.307470014424, 10670.093042091354, 10699.0, 10746.194035447374, 10237.23220758446, 10485.108765754843, 10494.055535001886, 10512.947435262775, 10524.63163789279, 8164.591770411455, 8240.052393974649, 8246.670133194724, 8298.377621678399, 8366.37252206087, 7722.0, 7743.760998240255, 7767.417443691633, 7864.449488535747, 7886.0, 9010.234130099016, 9050.275977921881, 9125.680601178927, 9165.679201227926, 9178.632854686004, 9144.405613635092, 9347.485888276211, 9357.111074447917, 9432.95283523578, 9505.477198754135, 7309.634518274172, 7339.302766237199, 7417.406607471282, 7434.665440055319, 7436.256374362737, 7783.104942931635, 7947.165547617417, 7969.721059763112, 7977.162397948132, 8034.638441270274, 7563.697452101855, 7613.9238607613215, 7624.5425274483705, 7635.312821846061, 7787.961060194662, 7495.7001719930595, 7559.017327747358, 7585.127710313384, 7598.392128629807, 7735.22647735222, 7718.691252350068, 7736.226377362219, 7833.764987050397, 7846.293833555007, 7853.685852565834, 7054.470914681317, 7108.964455177691, 7111.53775004623, 7135.50051496411, 7141.928580714126, 7050.858982820418, 7182.138143422822, 7199.424046076406, 7243.601601911945, 7305.634718263959], "unit": "score", "name": "mootools.html", "value": 4955.204998443189}, {"lowerIsBetter": false, "replicates": [363.13211424695, 368.1330466750803, 371.2945403732907, 374.2477619983832, 381.7442313649854, 6403.3596640335945, 6424.2290925089, 6483.708233129509, 6490.610563366201, 6679.5658282211625, 6417.743290268395, 6428.77499287525, 6428.807135785923, 6447.484201263899, 6474.1907261592305, 4903.117438860994, 4939.654224204307, 4948.2824990376375, 4957.429895562021, 5013.699178049311, 4961.950380496203, 4988.351514303135, 4996.075725990685, 5012.72430016349, 5013.824516141935, 4546.749928753918, 4843.128236917353, 4846.297286893398, 4849.490803465638, 4861.805527778884, 4852.563269305761, 4853.296272040552, 4856.635752318591, 4862.659613827033, 4877.829275975324, 4239.109786944745, 4246.660267178619, 4254.298040823292, 4255.893602659928, 4258.893527661802, 6028.39716028398, 6061.484773794233, 6112.572119951606, 6119.326874043852, 6149.96925015372, 5762.942370576325, 5783.942160578383, 5788.8842223155725, 5789.565782566325, 5796.449337312949, 6825.726970921157, 6831.6242606656615, 6840.521163518556, 6845.863082738367, 6881.311868813129, 4803.351547541072, 4803.951960480385, 4806.206975848981, 4812.230043193073, 4837.540433658797, 6896.620685862275, 7161.856762864713, 7172.569645821268, 7185.6766445510075, 7191.89212161818, 4953.925691114636, 4954.727489988013, 4956.182229932093, 4958.355413796256, 4959.330490383824, 5019.247112933089, 5035.874103147377, 5039.042581909425, 5040.395152581714, 5043.420006699203, 5677.148427735872, 5774.855628609234, 5782.797602083991, 5783.219265399117, 5786.103154011135, 6862.416694581017, 6873.1064961554675, 6874.896876546856, 6887.070245516891, 6887.139107611549, 1728.524655719662, 1738.0614468187036, 1740.6692728381568, 1743.8692098092695, 1750.64111857069, 1201.597464849268, 1205.6865215044152, 1211.6304527119137, 1214.0591041942564, 1219.567053695925, 6426.2931077581425, 6578.572392794453, 6583.242927063449, 6598.769043083469, 6602.405783479414, 7052.33002864727, 7076.752313668997, 7085.43316534676, 7125.073740413713, 7145.428365730729, 6369.331220221903, 6434.517411194179, 6495.902561461582, 6496.252930913006, 6528.281888992207, 3833.0800607853917, 3846.6345697159286, 3853.113783829735, 3857.765515035162, 3860.575336712959, 7238.420926325882, 7269.418446524372, 7283.672234749449, 7289.380402665727, 7291.817704557322, 7183.62066820905, 7191.7842464726145, 7251.4923955323675, 7256.310650488195, 7277.708891644381, 7222.133343998754, 7239.276072392719, 7242.7102915883825, 7257.709691612382, 7264.200937896932, 7063.858722825617, 7102.076730025064, 7112.182099058675, 7119.679614417467, 7126.964365178348, 6866.793996180123, 6958.443324534126, 6960.9303906962305, 6977.476689248225, 7007.964960175371, 7201.243869393638, 7217.133943926762, 7243.492955493065, 7248.130224373109, 7249.746258880914, 4911.68074075184, 4914.0, 4916.360873086476, 4919.139150648693, 4922.704637721748, 6901.378875901193, 7018.192907815463, 7070.974708667111, 7072.681729322296, 7206.423486121203, 6968.442524598121, 6995.965020174866, 6997.230304666585, 7009.894851577333, 7020.859582808417, 6942.375186233263, 6971.268016858156, 6979.581225126509, 7018.543794653331, 7022.929770702228, 6633.9668301658185, 6856.554323968926, 6862.828429289308, 6881.552699074544, 6883.3116688330765, 7034.487585169213, 7035.296470352924, 7041.5775053496955, 7053.929460705327, 7063.1524217094275, 6725.562838415487, 6824.112865327475, 6850.794476165723, 6853.9314606853295, 6861.725530978904], "unit": "score", "name": "prototype.html", "value": 5195.0778357823565}, {"lowerIsBetter": false, "replicates": [743.8214828441176, 800.2317774936062, 842.4229402859038, 924.3760461688358, 943.2454036770584, 12642.178258413196, 12715.554955576557, 12758.362081895903, 12804.039697022714, 12813.551525696603, 13607.115537490055, 15342.84657153428, 15526.922365388185, 15552.766708499354, 15621.765673514907, 861.8621020636683, 872.2542226396434, 877.8858748362704, 881.6120906800987, 883.2713011765287, 874.3398733955854, 878.2447095497866, 884.6594061286419, 885.9069797671249, 888.5201990924925, 922.580225997173, 934.1732566678504, 934.2946075712862, 934.5841100710187, 934.8364036293656, 908.1554154636186, 915.2860768600502, 918.4122161816442, 922.9769255768559, 926.1294383279695, 669.6049330894747, 670.125486240456, 670.8859493886002, 672.6804767735335, 672.9226138994029, 13880.51418200358, 14088.295585220698, 14089.0, 14092.647683807885, 14096.788548171786, 13261.933690331487, 13331.86668133316, 13406.530771423051, 13722.176669399869, 13936.86063139376, 11078.667639970814, 11127.443627818577, 11183.769785323608, 11308.208425410225, 11314.434278286053, 3798.2023775007283, 3851.73037887348, 3882.417637354391, 3920.0199950012498, 3947.1118998225456, 50490.495095048944, 51866.48133518692, 52239.73880130613, 52314.738426307624, 52455.0, 10240.0, 10553.683389498327, 10621.468926553796, 10705.83941240882, 10975.28660637056, 18874.24503019864, 19048.52378690516, 19055.80944190568, 19101.426957191306, 19126.0, 7821.217878212134, 7873.291403773688, 7970.083440404312, 8150.38872084596, 8262.884510591113, 4203.369494575838, 4381.518033016366, 4446.221911165533, 4463.107378524243, 4617.0, 3325.068980685412, 3349.2296771742635, 3362.882299119568, 3364.2934983653217, 3373.983130084334, 577.6967092276504, 583.4194975998909, 587.3803137689779, 652.100101859431, 682.0757873082001, 592.6355291495785, 600.7326739600923, 628.4752231886334, 720.2077714513993, 779.8235500774376, 8408.495490270603, 9478.763030924281, 9666.178374838217, 10103.444310562989, 10175.236857235737, 579.9188113664006, 583.2650859916536, 606.233115109387, 759.9322951253498, 788.4480863395531, 4373.343998400265, 4486.865883245655, 4489.19194544985, 4494.797734101973, 4640.327152562927, 61779.6911015442, 62078.0, 62439.37560624335, 62529.68735156295, 62645.0, 53178.0, 53239.46760532423, 53355.73322133364, 53356.0, 53774.0, 48339.5166048335, 48898.99999999929, 49420.75289623601, 49632.0, 50775.746121269156, 9017.684381046894, 9054.592543335433, 9198.172164505228, 9294.070592940652, 9313.068693130634, 35020.82489587536, 35292.29415411626, 35356.823215883756, 35548.0, 35612.64387356197, 42496.0, 45044.32433513434, 46495.767521162175, 46638.0, 47924.7603761979, 11272.67456100436, 11526.0, 11567.768644626893, 11597.246178998337, 11606.883931160917, 12348.567800126952, 12645.810312845131, 12961.22232666043, 13157.934210328887, 13208.0, 12189.695257618276, 12660.430280637209, 12936.935315323362, 13074.803877941647, 13233.536826211037, 11945.701357465785, 12007.219530730825, 12073.034157267573, 12451.0, 12643.178193417398, 11834.289942603471, 11855.881441185478, 13088.541901033419, 13338.041267362718, 13671.043026988413, 10283.0, 10746.247762656853, 10850.891491084989, 10910.509027093642, 11208.327500350006, 10724.927507249213, 10830.620928267474, 11002.174836887425, 11057.281276716987, 11062.22564420483], "unit": "score", "name": "yui.html", "value": 6759.910365228019}], "name": "dromaeo_css", "value": 7489.444173547874}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 113.0, 114.0, 121.0, 116.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 162.0, 161.0, 128.0, 149.0, 149.0, 128.0, 168.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 164.0, 166.0, 166.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 76.0, 159.0, 83.0, 76.0, 77.0, 77.0, 157.0, 74.0], "unit": "score", "name": "audio-fft", "value": 92.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 97.0, 94.0, 94.0, 139.0, 94.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 60.0, 55.0, 55.0, 59.0, 65.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 82.0, 83.0, 83.0, 91.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [114.0, 110.0, 110.0, 112.0, 129.0, 113.0, 114.0, 116.0, 117.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 136.0, 130.0, 140.0, 145.0, 137.0, 137.0, 136.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 65.0, 66.0, 69.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1500.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.94756057085962], "unit": "score", "name": "Richards", "value": 212.72985200000008}, {"lowerIsBetter": false, "replicates": [170.96939647803043], "unit": "score", "name": "DeltaBlue", "value": 386.7241819999999}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [928.5051067780872], "unit": "score", "name": "RayTrace", "value": 796.9681530000001}, {"lowerIsBetter": false, "replicates": [571.1022272986864], "unit": "score", "name": "Earley", "value": 1166.976713}, {"lowerIsBetter": false, "replicates": [11054.945054945056], "unit": "score", "name": "Boyer", "value": 60.28641451292241}, {"lowerIsBetter": false, "replicates": [39538.46153846154], "unit": "score", "name": "RegExp", "value": 23.040476653696484}, {"lowerIsBetter": false, "replicates": [514.1388174807198], "unit": "score", "name": "Splay", "value": 158.49999499999993}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22011.08599167768}]} 05:52:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22011.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1500.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7489.44"}}} 05:52:08 INFO - Return code: 0 05:52:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:52:08 INFO - # TBPL SUCCESS # 05:52:08 INFO - Running post-action listener: _resource_record_post_action 05:52:08 INFO - Running post-run listener: _resource_record_post_run 05:52:09 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518070272; Read time: 228; Write time: 530540 05:52:09 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 253272064; Read time: 0; Write time: 319044 05:52:09 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264798208; Read time: 228; Write time: 211496 05:52:09 INFO - Running post-run listener: _upload_blobber_files 05:52:09 INFO - Blob upload gear active. 05:52:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:52:09 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:52:09 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:52:09 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:52:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:10 INFO - (blobuploader) - INFO - Done attempting. 05:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:52:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:11 INFO - (blobuploader) - INFO - Done attempting. 05:52:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:11 INFO - Return code: 0 05:52:11 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:52:11 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82f777788ae826462dc5eb9cae8532adcd343bc5dc357331d3c5363f42123b6cf3e33ad310a2473af5d21053e5bd40c52c8c384aaa8f329b558306483e6ada3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5127c72566a293c2c632dcffcdb0397a34d0889278c881cd3e4da053c3b895bf64017d6c95dd57274190501191410cd52329eab40e299de012e66bd47f0eef52"} 05:52:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:52:11 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:52:11 INFO - Contents: 05:52:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82f777788ae826462dc5eb9cae8532adcd343bc5dc357331d3c5363f42123b6cf3e33ad310a2473af5d21053e5bd40c52c8c384aaa8f329b558306483e6ada3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5127c72566a293c2c632dcffcdb0397a34d0889278c881cd3e4da053c3b895bf64017d6c95dd57274190501191410cd52329eab40e299de012e66bd47f0eef52"} 05:52:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:11 INFO - Copying logs to upload dir... 05:52:11 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:52:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.523383 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-27 05:52:11.532288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:52:11.535673) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 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-Aurora/sha512/82f777788ae826462dc5eb9cae8532adcd343bc5dc357331d3c5363f42123b6cf3e33ad310a2473af5d21053e5bd40c52c8c384aaa8f329b558306483e6ada3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5127c72566a293c2c632dcffcdb0397a34d0889278c881cd3e4da053c3b895bf64017d6c95dd57274190501191410cd52329eab40e299de012e66bd47f0eef52"} build_url:https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82f777788ae826462dc5eb9cae8532adcd343bc5dc357331d3c5363f42123b6cf3e33ad310a2473af5d21053e5bd40c52c8c384aaa8f329b558306483e6ada3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5127c72566a293c2c632dcffcdb0397a34d0889278c881cd3e4da053c3b895bf64017d6c95dd57274190501191410cd52329eab40e299de012e66bd47f0eef52"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:52:11.560052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:52:11.560404) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1456579863.784689-445476278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:52:11.643097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:52:11.643419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:52:11.643699) ========= ========= Total master_lag: 0.24 =========