builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1454591997.85 results: success (0) buildid: 20160204024527 builduid: 921122775165499b9d09ff481b53b0f9 revision: 72a58edbc72101064d8dcf095d012b975e21dbf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.853104) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.853582) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.853896) ========= 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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006142 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.883440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.883782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.922215) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.925554) ========= 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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.976526) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.976849) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.977212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:57.980551) ========= 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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-04 05:19:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.4M=0s 2016-02-04 05:19:59 (83.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162377 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.158520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.158884) ========= 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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014432 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.212665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.213034) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 72a58edbc72101064d8dcf095d012b975e21dbf1 --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 72a58edbc72101064d8dcf095d012b975e21dbf1 --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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-04 05:20:00,047 truncating revision to first 12 chars 2016-02-04 05:20:00,047 Setting DEBUG logging. 2016-02-04 05:20:00,047 attempt 1/10 2016-02-04 05:20:00,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/72a58edbc721?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 05:20:00,285 unpacking tar archive at: mozilla-aurora-72a58edbc721/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520388 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.746000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.746300) ========= echo 72a58edbc72101064d8dcf095d012b975e21dbf1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'72a58edbc72101064d8dcf095d012b975e21dbf1'] 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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 72a58edbc72101064d8dcf095d012b975e21dbf1 program finished with exit code 0 elapsedTime=0.003784 script_repo_revision: '72a58edbc72101064d8dcf095d012b975e21dbf1' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.794743) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.795043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 05:19:58.805117) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-04 05:19:58.805422) ========= /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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:00 INFO - MultiFileLogger online at 20160204 05:20:00 in /builds/slave/test-pgo 05:20:00 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:20:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:20:00 INFO - {'append_to_log': False, 05:20:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:20:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:20:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:20:00 INFO - 'branch': 'Mozilla-Aurora', 05:20:00 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:00 INFO - 'config_files': ('talos/linux_config.py',), 05:20:00 INFO - 'default_actions': ('clobber', 05:20:00 INFO - 'read-buildbot-config', 05:20:00 INFO - 'download-and-extract', 05:20:00 INFO - 'populate-webroot', 05:20:00 INFO - 'create-virtualenv', 05:20:00 INFO - 'install', 05:20:00 INFO - 'run-tests'), 05:20:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:00 INFO - 'download_minidump_stackwalk': True, 05:20:00 INFO - 'download_symbols': 'ondemand', 05:20:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:00 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:00 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:00 INFO - 'installer_path': 'installer.exe', 05:20:00 INFO - 'log_level': 'info', 05:20:00 INFO - 'log_name': 'talos', 05:20:00 INFO - 'log_to_console': True, 05:20:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:00 INFO - 'opt_config_files': (), 05:20:00 INFO - 'pip_index': False, 05:20:00 INFO - 'sps_profile': False, 05:20:00 INFO - 'sps_profile_interval': 0, 05:20:00 INFO - 'suite': 'dromaeojs-e10s', 05:20:00 INFO - 'system_bits': '32', 05:20:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:00 INFO - 'title': 'talos-linux64-ix-063', 05:20:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:00 INFO - 'use_talos_json': True, 05:20:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:20:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:00 INFO - 'work_dir': 'build'} 05:20:00 INFO - ##### 05:20:00 INFO - ##### Running clobber step. 05:20:00 INFO - ##### 05:20:00 INFO - Running pre-action listener: _resource_record_pre_action 05:20:00 INFO - Running main action method: clobber 05:20:00 INFO - rmtree: /builds/slave/test-pgo/build 05:20:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:20:01 INFO - Running post-action listener: _resource_record_post_action 05:20:01 INFO - ##### 05:20:01 INFO - ##### Running read-buildbot-config step. 05:20:01 INFO - ##### 05:20:01 INFO - Running pre-action listener: _resource_record_pre_action 05:20:01 INFO - Running main action method: read_buildbot_config 05:20:01 INFO - Using buildbot properties: 05:20:01 INFO - { 05:20:01 INFO - "project": "", 05:20:01 INFO - "product": "firefox", 05:20:01 INFO - "script_repo_revision": "production", 05:20:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:20:01 INFO - "repository": "", 05:20:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:20:01 INFO - "buildid": "20160204024527", 05:20:01 INFO - "pgo_build": "True", 05:20:01 INFO - "basedir": "/builds/slave/test-pgo", 05:20:01 INFO - "buildnumber": 125, 05:20:01 INFO - "slavename": "talos-linux64-ix-063", 05:20:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:20:01 INFO - "platform": "ubuntu64_hw", 05:20:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:20:01 INFO - "branch": "mozilla-aurora", 05:20:01 INFO - "repo_path": "releases/mozilla-aurora", 05:20:01 INFO - "revision": "72a58edbc72101064d8dcf095d012b975e21dbf1", 05:20:01 INFO - "stage_platform": "linux64-pgo", 05:20:01 INFO - "builduid": "921122775165499b9d09ff481b53b0f9", 05:20:01 INFO - "slavebuilddir": "test" 05:20:01 INFO - } 05:20:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 05:20:01 INFO - Running post-action listener: _resource_record_post_action 05:20:01 INFO - ##### 05:20:01 INFO - ##### Running download-and-extract step. 05:20:01 INFO - ##### 05:20:01 INFO - Running pre-action listener: _resource_record_pre_action 05:20:01 INFO - Running main action method: download_and_extract 05:20:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:01 INFO - https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:20:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/test_packages.json 05:20:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/test_packages.json 05:20:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:20:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:20:03 INFO - Downloaded 1448 bytes. 05:20:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:20:03 INFO - Using the following test package requirements: 05:20:03 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:20:03 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:03 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:20:03 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'jsshell-linux-x86_64.zip'], 05:20:03 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:03 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:20:03 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:20:03 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:20:03 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:03 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:20:03 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:20:03 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:03 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:03 INFO - https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:20:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:20:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:04 INFO - Downloaded 22399717 bytes. 05:20:04 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:20:04 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:20:05 INFO - Return code: 0 05:20:05 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:20:05 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:20:05 INFO - https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:20:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:20:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:07 INFO - Downloaded 22399717 bytes. 05:20:07 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:20:07 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:20:08 INFO - Return code: 0 05:20:08 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:20:08 INFO - https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:20:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:20:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:09 INFO - Downloaded 10706572 bytes. 05:20:09 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:20:09 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:20:09 INFO - Return code: 0 05:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:09 INFO - https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:20:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:20:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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:20:11 INFO - Downloaded 59583451 bytes. 05:20:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:20:11 INFO - mkdir: /builds/slave/test-pgo/properties 05:20:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:20:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:20:11 INFO - Contents: 05:20:11 INFO - build_url:https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:20:11 INFO - Running post-action listener: _resource_record_post_action 05:20:11 INFO - Running post-action listener: set_extra_try_arguments 05:20:11 INFO - ##### 05:20:11 INFO - ##### Running populate-webroot step. 05:20:11 INFO - ##### 05:20:11 INFO - Running pre-action listener: _resource_record_pre_action 05:20:11 INFO - Running main action method: populate_webroot 05:20:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:11 INFO - '--tppagecycles', 05:20:11 INFO - '7'], 05:20:11 INFO - 'tests': ['tsvgm']}}, 05:20:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:20:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:20:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:20:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'tests': ['damp', 'tps']}, 05:20:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['damp', 'tps']}, 05:20:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:20:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:11 INFO - 'other': {'tests': ['a11yr', 05:20:11 INFO - 'ts_paint', 05:20:11 INFO - 'tpaint', 05:20:11 INFO - 'sessionrestore', 05:20:11 INFO - 'sessionrestore_no_auto_restore']}, 05:20:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['a11yr', 05:20:11 INFO - 'ts_paint', 05:20:11 INFO - 'tpaint', 05:20:11 INFO - 'sessionrestore', 05:20:11 INFO - 'sessionrestore_no_auto_restore']}, 05:20:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['a11yr', 05:20:11 INFO - 'ts_paint', 05:20:11 INFO - 'tpaint', 05:20:11 INFO - 'sessionrestore', 05:20:11 INFO - 'sessionrestore_no_auto_restore']}, 05:20:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['a11yr', 05:20:11 INFO - 'ts_paint', 05:20:11 INFO - 'tpaint', 05:20:11 INFO - 'sessionrestore', 05:20:11 INFO - 'sessionrestore_no_auto_restore']}, 05:20:11 INFO - 'other_l64': {'tests': ['a11yr', 05:20:11 INFO - 'ts_paint', 05:20:11 INFO - 'tpaint', 05:20:11 INFO - 'sessionrestore', 05:20:11 INFO - 'sessionrestore_no_auto_restore']}, 05:20:11 INFO - 'other_nol64': {'tests': ['a11yr', 05:20:11 INFO - 'ts_paint', 05:20:11 INFO - 'tpaint', 05:20:11 INFO - 'sessionrestore', 05:20:11 INFO - 'sessionrestore_no_auto_restore']}, 05:20:11 INFO - 'svgr': {'tests': ['tsvgx', 05:20:11 INFO - 'tsvgr_opacity', 05:20:11 INFO - 'tart', 05:20:11 INFO - 'tscrollx', 05:20:11 INFO - 'cart']}, 05:20:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['tsvgx', 05:20:11 INFO - 'tsvgr_opacity', 05:20:11 INFO - 'tart', 05:20:11 INFO - 'tscrollx', 05:20:11 INFO - 'cart']}, 05:20:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'tests': ['tp5o']}, 05:20:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'talos_options': ['--e10s'], 05:20:11 INFO - 'tests': ['tp5o']}, 05:20:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'talos_options': ['--xperf_path', 05:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:11 INFO - 'tests': ['tp5n']}, 05:20:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:11 INFO - 'talos_options': ['--e10s', 05:20:11 INFO - '--xperf_path', 05:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:11 INFO - 'tests': ['tp5n']}}, 05:20:11 INFO - 'talos.zip': {'path': '', 05:20:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:11 INFO - Running post-action listener: _resource_record_post_action 05:20:11 INFO - ##### 05:20:11 INFO - ##### Running create-virtualenv step. 05:20:11 INFO - ##### 05:20:11 INFO - Running pre-action listener: _resource_record_pre_action 05:20:11 INFO - Running main action method: create_virtualenv 05:20:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:20:11 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:20:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:20:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:11 INFO - Using real prefix '/usr' 05:20:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:20:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:14 INFO - Installing pip.................done. 05:20:14 INFO - Return code: 0 05:20:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:20:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:14 INFO - Using env: {'DISPLAY': ':0', 05:20:14 INFO - 'HOME': '/home/cltbld', 05:20:14 INFO - 'LANG': 'en_US.UTF-8', 05:20:14 INFO - 'LANGUAGE': 'en_US:en', 05:20:14 INFO - 'LOGNAME': 'cltbld', 05:20:14 INFO - 'MAIL': '/var/mail/cltbld', 05:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:14 INFO - 'MOZ_NO_REMOTE': '1', 05:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:14 INFO - 'NO_EM_RESTART': '1', 05:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:14 INFO - 'SHELL': '/bin/bash', 05:20:14 INFO - 'SHLVL': '1', 05:20:14 INFO - 'TERM': 'linux', 05:20:14 INFO - 'TMOUT': '86400', 05:20:14 INFO - 'USER': 'cltbld', 05:20:14 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:14 INFO - '_': '/tools/buildbot/bin/python'} 05:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:14 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:20:14 INFO - Cleaning up... 05:20:14 INFO - Return code: 0 05:20:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:20:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:20:14 INFO - Using env: {'DISPLAY': ':0', 05:20:14 INFO - 'HOME': '/home/cltbld', 05:20:14 INFO - 'LANG': 'en_US.UTF-8', 05:20:14 INFO - 'LANGUAGE': 'en_US:en', 05:20:14 INFO - 'LOGNAME': 'cltbld', 05:20:14 INFO - 'MAIL': '/var/mail/cltbld', 05:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:14 INFO - 'MOZ_NO_REMOTE': '1', 05:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:14 INFO - 'NO_EM_RESTART': '1', 05:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:14 INFO - 'SHELL': '/bin/bash', 05:20:14 INFO - 'SHLVL': '1', 05:20:14 INFO - 'TERM': 'linux', 05:20:14 INFO - 'TMOUT': '86400', 05:20:14 INFO - 'USER': 'cltbld', 05:20:14 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:14 INFO - '_': '/tools/buildbot/bin/python'} 05:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:14 INFO - Downloading/unpacking psutil>=0.7.1 05:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:16 INFO - Installing collected packages: psutil 05:20:16 INFO - Running setup.py install for psutil 05:20:16 INFO - building 'psutil._psutil_linux' extension 05:20:16 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:20:16 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:20:16 INFO - building 'psutil._psutil_posix' extension 05:20:16 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:20:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:17 INFO - Successfully installed psutil 05:20:17 INFO - Cleaning up... 05:20:17 INFO - Return code: 0 05:20:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:20:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:20:17 INFO - Using env: {'DISPLAY': ':0', 05:20:17 INFO - 'HOME': '/home/cltbld', 05:20:17 INFO - 'LANG': 'en_US.UTF-8', 05:20:17 INFO - 'LANGUAGE': 'en_US:en', 05:20:17 INFO - 'LOGNAME': 'cltbld', 05:20:17 INFO - 'MAIL': '/var/mail/cltbld', 05:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:17 INFO - 'MOZ_NO_REMOTE': '1', 05:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:17 INFO - 'NO_EM_RESTART': '1', 05:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:17 INFO - 'SHELL': '/bin/bash', 05:20:17 INFO - 'SHLVL': '1', 05:20:17 INFO - 'TERM': 'linux', 05:20:17 INFO - 'TMOUT': '86400', 05:20:17 INFO - 'USER': 'cltbld', 05:20:17 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:17 INFO - '_': '/tools/buildbot/bin/python'} 05:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:20:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:20:19 INFO - Installing collected packages: mozsystemmonitor 05:20:19 INFO - Running setup.py install for mozsystemmonitor 05:20:19 INFO - Successfully installed mozsystemmonitor 05:20:19 INFO - Cleaning up... 05:20:19 INFO - Return code: 0 05:20:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:20:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:20:19 INFO - Using env: {'DISPLAY': ':0', 05:20:19 INFO - 'HOME': '/home/cltbld', 05:20:19 INFO - 'LANG': 'en_US.UTF-8', 05:20:19 INFO - 'LANGUAGE': 'en_US:en', 05:20:19 INFO - 'LOGNAME': 'cltbld', 05:20:19 INFO - 'MAIL': '/var/mail/cltbld', 05:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:19 INFO - 'MOZ_NO_REMOTE': '1', 05:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:19 INFO - 'NO_EM_RESTART': '1', 05:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:19 INFO - 'SHELL': '/bin/bash', 05:20:19 INFO - 'SHLVL': '1', 05:20:19 INFO - 'TERM': 'linux', 05:20:19 INFO - 'TMOUT': '86400', 05:20:19 INFO - 'USER': 'cltbld', 05:20:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:19 INFO - '_': '/tools/buildbot/bin/python'} 05:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:19 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:20:19 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:20:19 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:20:19 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:20:19 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:20:19 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:20:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:20:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - Downloading docopt-0.6.1.tar.gz 05:20:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:22 INFO - Running setup.py install for blobuploader 05:20:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:20:22 INFO - Running setup.py install for requests 05:20:22 INFO - Running setup.py install for docopt 05:20:22 INFO - Successfully installed blobuploader requests docopt 05:20:22 INFO - Cleaning up... 05:20:22 INFO - Return code: 0 05:20:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:22 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 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:22 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:20:22 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:20:22 INFO - Using env: {'DISPLAY': ':0', 05:20:22 INFO - 'HOME': '/home/cltbld', 05:20:22 INFO - 'LANG': 'en_US.UTF-8', 05:20:22 INFO - 'LANGUAGE': 'en_US:en', 05:20:22 INFO - 'LOGNAME': 'cltbld', 05:20:22 INFO - 'MAIL': '/var/mail/cltbld', 05:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:22 INFO - 'MOZ_NO_REMOTE': '1', 05:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:22 INFO - 'NO_EM_RESTART': '1', 05:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:22 INFO - 'SHELL': '/bin/bash', 05:20:22 INFO - 'SHLVL': '1', 05:20:22 INFO - 'TERM': 'linux', 05:20:22 INFO - 'TMOUT': '86400', 05:20:22 INFO - 'USER': 'cltbld', 05:20:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:22 INFO - '_': '/tools/buildbot/bin/python'} 05:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:20:22 INFO - Running setup.py (path:/tmp/pip-OMmLQr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:20:22 INFO - Running setup.py (path:/tmp/pip-fH55e1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:20:23 INFO - Running setup.py (path:/tmp/pip-eQZkt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:20:23 INFO - Running setup.py (path:/tmp/pip-ezqoDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:20:23 INFO - Running setup.py (path:/tmp/pip-rasMl1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:20:23 INFO - Running setup.py (path:/tmp/pip-OPpqm2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:20:23 INFO - Running setup.py (path:/tmp/pip-hJtpWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:20:23 INFO - Running setup.py (path:/tmp/pip-hiXbTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:20:23 INFO - Running setup.py (path:/tmp/pip-HAmKSp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:20:23 INFO - Running setup.py (path:/tmp/pip-OS90wj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:20:23 INFO - Running setup.py (path:/tmp/pip-RNzxIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:20:23 INFO - Running setup.py (path:/tmp/pip-BPT2pb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:20:23 INFO - Running setup.py (path:/tmp/pip-pcAj2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:20:23 INFO - Running setup.py (path:/tmp/pip-BGY9z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:20:23 INFO - Running setup.py (path:/tmp/pip-YF_1Uq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:20:23 INFO - Running setup.py (path:/tmp/pip-uSDfHH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:20:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:20:24 INFO - Running setup.py (path:/tmp/pip-c1HXQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:20:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:24 INFO - Running setup.py install for manifestparser 05:20:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Running setup.py install for mozcrash 05:20:24 INFO - Running setup.py install for mozdebug 05:20:24 INFO - Running setup.py install for mozdevice 05:20:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Running setup.py install for mozfile 05:20:24 INFO - Running setup.py install for mozhttpd 05:20:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Running setup.py install for mozinfo 05:20:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Running setup.py install for mozInstall 05:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:20:24 INFO - Running setup.py install for mozleak 05:20:25 INFO - Running setup.py install for mozlog 05:20:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:20:25 INFO - Running setup.py install for moznetwork 05:20:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:20:25 INFO - Running setup.py install for mozprocess 05:20:25 INFO - Running setup.py install for mozprofile 05:20:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:20:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:20:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:20:25 INFO - Running setup.py install for mozrunner 05:20:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:20:25 INFO - Running setup.py install for mozscreenshot 05:20:25 INFO - Running setup.py install for moztest 05:20:25 INFO - Running setup.py install for mozversion 05:20:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:25 INFO - Cleaning up... 05:20:25 INFO - Return code: 0 05:20:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:20: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:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:25 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 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:25 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:20:25 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:20:25 INFO - Using env: {'DISPLAY': ':0', 05:20:25 INFO - 'HOME': '/home/cltbld', 05:20:25 INFO - 'LANG': 'en_US.UTF-8', 05:20:25 INFO - 'LANGUAGE': 'en_US:en', 05:20:25 INFO - 'LOGNAME': 'cltbld', 05:20:25 INFO - 'MAIL': '/var/mail/cltbld', 05:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:25 INFO - 'MOZ_NO_REMOTE': '1', 05:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:25 INFO - 'NO_EM_RESTART': '1', 05:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:25 INFO - 'SHELL': '/bin/bash', 05:20:25 INFO - 'SHLVL': '1', 05:20:25 INFO - 'TERM': 'linux', 05:20:25 INFO - 'TMOUT': '86400', 05:20:25 INFO - 'USER': 'cltbld', 05:20:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:25 INFO - '_': '/tools/buildbot/bin/python'} 05:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:20:26 INFO - Running setup.py (path:/tmp/pip-S3RlQV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:20:26 INFO - Running setup.py (path:/tmp/pip-yk_A1u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:20:26 INFO - Running setup.py (path:/tmp/pip-CKyLCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:20:26 INFO - Running setup.py (path:/tmp/pip-Cp0gZp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:20:26 INFO - Running setup.py (path:/tmp/pip-N2iM7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:20:26 INFO - Running setup.py (path:/tmp/pip-SS4yyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:20:26 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:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:20:26 INFO - Running setup.py (path:/tmp/pip-aFvMQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:20:26 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:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:20:26 INFO - Running setup.py (path:/tmp/pip-OziPat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:20:26 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:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:20:26 INFO - Running setup.py (path:/tmp/pip-KU3rUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:20:26 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:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:20:26 INFO - Running setup.py (path:/tmp/pip-TMMSVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:20:26 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:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:20:26 INFO - Running setup.py (path:/tmp/pip-p4V4Xm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:20:26 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:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:20:26 INFO - Running setup.py (path:/tmp/pip-IS_hCP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:20:26 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:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:20:26 INFO - Running setup.py (path:/tmp/pip-6yNgl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:20:27 INFO - Running setup.py (path:/tmp/pip-p0flC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:20:27 INFO - Running setup.py (path:/tmp/pip-nWoTRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:20:27 INFO - Running setup.py (path:/tmp/pip-yCYmn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:20:27 INFO - Running setup.py (path:/tmp/pip-SAKyKw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:20: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:20: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:20: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:20: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:20: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:20: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:20:29 INFO - Downloading blessings-1.6.tar.gz 05:20:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:29 INFO - Installing collected packages: blessings 05:20:29 INFO - Running setup.py install for blessings 05:20:29 INFO - Successfully installed blessings 05:20:29 INFO - Cleaning up... 05:20:29 INFO - Return code: 0 05:20:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:20:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:20:29 INFO - Reading from file tmpfile_stdout 05:20:29 INFO - Current package versions: 05:20:29 INFO - argparse == 1.2.1 05:20:29 INFO - blessings == 1.6 05:20:29 INFO - blobuploader == 1.2.4 05:20:29 INFO - docopt == 0.6.1 05:20:29 INFO - manifestparser == 1.1 05:20:29 INFO - mozInstall == 1.12 05:20:29 INFO - mozcrash == 0.16 05:20:29 INFO - mozdebug == 0.1 05:20:29 INFO - mozdevice == 0.48 05:20:29 INFO - mozfile == 1.2 05:20:29 INFO - mozhttpd == 0.7 05:20:29 INFO - mozinfo == 0.9 05:20:29 INFO - mozleak == 0.1 05:20:29 INFO - mozlog == 3.1 05:20:29 INFO - moznetwork == 0.27 05:20:29 INFO - mozprocess == 0.22 05:20:29 INFO - mozprofile == 0.28 05:20:29 INFO - mozrunner == 6.11 05:20:29 INFO - mozscreenshot == 0.1 05:20:29 INFO - mozsystemmonitor == 0.0 05:20:29 INFO - moztest == 0.7 05:20:29 INFO - mozversion == 1.4 05:20:29 INFO - psutil == 3.1.1 05:20:29 INFO - requests == 1.2.3 05:20:29 INFO - wsgiref == 0.1.2 05:20:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:20:29 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:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:29 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:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:29 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 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:29 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:20:29 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:20:29 INFO - Using env: {'DISPLAY': ':0', 05:20:29 INFO - 'HOME': '/home/cltbld', 05:20:29 INFO - 'LANG': 'en_US.UTF-8', 05:20:29 INFO - 'LANGUAGE': 'en_US:en', 05:20:29 INFO - 'LOGNAME': 'cltbld', 05:20:29 INFO - 'MAIL': '/var/mail/cltbld', 05:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:29 INFO - 'MOZ_NO_REMOTE': '1', 05:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:29 INFO - 'NO_EM_RESTART': '1', 05:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:29 INFO - 'SHELL': '/bin/bash', 05:20:29 INFO - 'SHLVL': '1', 05:20:29 INFO - 'TERM': 'linux', 05:20:29 INFO - 'TMOUT': '86400', 05:20:29 INFO - 'USER': 'cltbld', 05:20:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:29 INFO - '_': '/tools/buildbot/bin/python'} 05:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 INFO - Cleaning up... 05:20:29 INFO - Return code: 0 05:20:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:20:29 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:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:29 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:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:29 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 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:29 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:20:29 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:20:29 INFO - Using env: {'DISPLAY': ':0', 05:20:29 INFO - 'HOME': '/home/cltbld', 05:20:29 INFO - 'LANG': 'en_US.UTF-8', 05:20:29 INFO - 'LANGUAGE': 'en_US:en', 05:20:29 INFO - 'LOGNAME': 'cltbld', 05:20:29 INFO - 'MAIL': '/var/mail/cltbld', 05:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:29 INFO - 'MOZ_NO_REMOTE': '1', 05:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:29 INFO - 'NO_EM_RESTART': '1', 05:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:29 INFO - 'SHELL': '/bin/bash', 05:20:29 INFO - 'SHLVL': '1', 05:20:29 INFO - 'TERM': 'linux', 05:20:29 INFO - 'TMOUT': '86400', 05:20:29 INFO - 'USER': 'cltbld', 05:20:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:29 INFO - '_': '/tools/buildbot/bin/python'} 05:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:30 INFO - Downloading/unpacking jsonschema 05:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:31 INFO - Downloading/unpacking functools32 (from jsonschema) 05:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:32 INFO - warning: no files found matching '*.txt' 05:20:32 INFO - no previously-included directories found matching 'build' 05:20:32 INFO - no previously-included directories found matching 'dist' 05:20:32 INFO - no previously-included directories found matching '.git*' 05:20:32 INFO - Installing collected packages: jsonschema, functools32 05:20:32 INFO - Running setup.py install for functools32 05:20:32 INFO - warning: no files found matching '*.txt' 05:20:32 INFO - no previously-included directories found matching 'build' 05:20:32 INFO - no previously-included directories found matching 'dist' 05:20:32 INFO - no previously-included directories found matching '.git*' 05:20:32 INFO - Successfully installed jsonschema functools32 05:20:32 INFO - Cleaning up... 05:20:32 INFO - Return code: 0 05:20:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912f830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, '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': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', '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:20:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:20:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:20:32 INFO - Using env: {'DISPLAY': ':0', 05:20:32 INFO - 'HOME': '/home/cltbld', 05:20:32 INFO - 'LANG': 'en_US.UTF-8', 05:20:32 INFO - 'LANGUAGE': 'en_US:en', 05:20:32 INFO - 'LOGNAME': 'cltbld', 05:20:32 INFO - 'MAIL': '/var/mail/cltbld', 05:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:32 INFO - 'MOZ_NO_REMOTE': '1', 05:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:32 INFO - 'NO_EM_RESTART': '1', 05:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:32 INFO - 'SHELL': '/bin/bash', 05:20:32 INFO - 'SHLVL': '1', 05:20:32 INFO - 'TERM': 'linux', 05:20:32 INFO - 'TMOUT': '86400', 05:20:32 INFO - 'USER': 'cltbld', 05:20:32 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:32 INFO - '_': '/tools/buildbot/bin/python'} 05:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:32 INFO - Downloading/unpacking flake8 05:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:20:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:20:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:34 INFO - no previously-included directories found matching 'docs/_build' 05:20:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:20:34 INFO - Running setup.py install for pep8 05:20:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:35 INFO - no previously-included directories found matching 'docs/_build' 05:20:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:20:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:20:35 INFO - Cleaning up... 05:20:35 INFO - Return code: 0 05:20:35 INFO - Running post-action listener: _resource_record_post_action 05:20:35 INFO - Running post-action listener: _start_resource_monitoring 05:20:35 INFO - Starting resource monitoring. 05:20:35 INFO - ##### 05:20:35 INFO - ##### Running install step. 05:20:35 INFO - ##### 05:20:35 INFO - Running pre-action listener: _resource_record_pre_action 05:20:35 INFO - Running main action method: install 05:20:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:20:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:20:35 INFO - Reading from file tmpfile_stdout 05:20:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:20:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:20:35 INFO - Reading from file tmpfile_stdout 05:20:35 INFO - Output received: 05:20:35 INFO - Usage: mozinstall [options] installer 05:20:35 INFO - Options: 05:20:35 INFO - -h, --help show this help message and exit 05:20:35 INFO - -d DEST, --destination=DEST 05:20:35 INFO - Directory to install application into. [default: 05:20:35 INFO - "/builds/slave/test-pgo"] 05:20:35 INFO - --app=APP Application being installed. [default: firefox] 05:20:35 INFO - mkdir: /builds/slave/test-pgo/build/application 05:20:35 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:20:35 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:20:50 INFO - Reading from file tmpfile_stdout 05:20:50 INFO - Output received: 05:20:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:20:50 INFO - Running post-action listener: _resource_record_post_action 05:20:50 INFO - ##### 05:20:50 INFO - ##### Running run-tests step. 05:20:50 INFO - ##### 05:20:50 INFO - Running pre-action listener: _resource_record_pre_action 05:20:50 INFO - Running main action method: run_tests 05:20:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:20:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:20:50 INFO - Python 2.7.3 05:20:50 INFO - Return code: 0 05:20:50 INFO - grabbing minidump binary from tooltool 05:20:50 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:20:50 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 0x2c66540>, '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 0x2c67440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c678f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:20:50 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:20:50 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:20:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:50 INFO - Return code: 0 05:20:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:20:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:20:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:20:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:20:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:20:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:20:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:20:51 INFO - Return code: 0 05:20:51 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/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:20:51 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/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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:20:51 INFO - Using env: {'DISPLAY': ':0', 05:20:51 INFO - 'HOME': '/home/cltbld', 05:20:51 INFO - 'LANG': 'en_US.UTF-8', 05:20:51 INFO - 'LANGUAGE': 'en_US:en', 05:20:51 INFO - 'LOGNAME': 'cltbld', 05:20:51 INFO - 'MAIL': '/var/mail/cltbld', 05:20:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:20:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:51 INFO - 'MOZ_NO_REMOTE': '1', 05:20:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:51 INFO - 'NO_EM_RESTART': '1', 05:20:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:20:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:20:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:20:51 INFO - 'SHELL': '/bin/bash', 05:20:51 INFO - 'SHLVL': '1', 05:20:51 INFO - 'TERM': 'linux', 05:20:51 INFO - 'TMOUT': '86400', 05:20:51 INFO - 'USER': 'cltbld', 05:20:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485', 05:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:51 INFO - '_': '/tools/buildbot/bin/python'} 05:20:51 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/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:20:51 INFO - mozversion application_buildid: 20160204024527 05:20:51 INFO - mozversion application_changeset: 72a58edbc72101064d8dcf095d012b975e21dbf1 05:20:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:20:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:51 INFO - mozversion application_name: Firefox 05:20:51 INFO - mozversion application_remotingname: firefox-dev 05:20:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:20:51 INFO - mozversion application_vendor: Mozilla 05:20:51 INFO - mozversion application_version: 46.0a2 05:20:51 INFO - mozversion platform_buildid: 20160204024527 05:20:51 INFO - mozversion platform_changeset: 72a58edbc72101064d8dcf095d012b975e21dbf1 05:20:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:20:51 INFO - mozversion platform_version: 46.0a2 05:20:51 INFO - using testdate: 1454592051 05:20:51 INFO - actual date: 1454592051 05:20:51 INFO - starting webserver on 'localhost:35986' 05:20:51 INFO - SUITE-START | Running 3 tests 05:20:51 INFO - TEST-START | dromaeo_css 05:20:51 INFO - operating with platform_type : linux_ 05:20:51 INFO - Initialising browser for dromaeo_css test... 05:20:51 INFO - TEST-INFO | started process 21638 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1puCDl/profile http://localhost:35986/getInfo.html) 05:20:55 INFO - PROCESS | 21638 | 05:20:55 INFO - PROCESS | 21638 | (process:21718): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:20:56 INFO - PROCESS | 21638 | __metrics Screen width/height:1600/1200 05:20:56 INFO - PROCESS | 21638 | colorDepth:24 05:20:56 INFO - PROCESS | 21638 | Browser inner width/height: 1024/697 05:20:56 INFO - PROCESS | 21638 | __metrics 05:20:57 INFO - TEST-INFO | 21638: exit 0 05:20:57 INFO - Browser initialized. 05:20:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:20:57 INFO - TEST-INFO | started process 21767 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1puCDl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:58 INFO - PROCESS | 21767 | 05:20:58 INFO - PROCESS | 21767 | (process:21830): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:21:08 INFO - PROCESS | 21767 | RSS: Main: 140582912 05:21:08 INFO - PROCESS | 21767 | 05:21:58 INFO - PROCESS | 21767 | 1454592118641 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:24:06 INFO - PROCESS | 21767 | Cycle 1(1): loaded http://localhost:35986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35986/tests/dromaeo/cssquery-ext.html) 05:24:07 INFO - PROCESS | 21767 | RSS: Main: 145596416 05:24:07 INFO - PROCESS | 21767 | 05:27:09 INFO - PROCESS | 21767 | Cycle 1(1): loaded http://localhost:35986/tests/dromaeo/cssquery-ext.html (next: http://localhost:35986/tests/dromaeo/cssquery-jquery.html) 05:27:09 INFO - PROCESS | 21767 | RSS: Main: 143822848 05:27:09 INFO - PROCESS | 21767 | 05:30:11 INFO - PROCESS | 21767 | Cycle 1(1): loaded http://localhost:35986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35986/tests/dromaeo/cssquery-mootools.html) 05:30:11 INFO - PROCESS | 21767 | RSS: Main: 143351808 05:30:11 INFO - PROCESS | 21767 | 05:33:13 INFO - PROCESS | 21767 | Cycle 1(1): loaded http://localhost:35986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35986/tests/dromaeo/cssquery-prototype.html) 05:33:14 INFO - PROCESS | 21767 | RSS: Main: 143581184 05:33:14 INFO - PROCESS | 21767 | 05:36:16 INFO - PROCESS | 21767 | Cycle 1(1): loaded http://localhost:35986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35986/tests/dromaeo/cssquery-yui.html) 05:36:17 INFO - PROCESS | 21767 | RSS: Main: 143142912 05:36:17 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | Cycle 1(1): loaded http://localhost:35986/tests/dromaeo/cssquery-yui.html (next: http://localhost:35986/tests/dromaeo/cssquery-dojo.html) 05:39:19 INFO - PROCESS | 21767 | RSS: Main: 146890752 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | __start_tp_report 05:39:19 INFO - PROCESS | 21767 | _x_x_mozilla_page_load 05:39:19 INFO - PROCESS | 21767 | _x_x_mozilla_page_load_details 05:39:19 INFO - PROCESS | 21767 | |i|pagename|runs| 05:39:19 INFO - PROCESS | 21767 | |0;dojo.html;3297.3075654112636;3304.223507475744;3305.4711246200613;3337.98331008345;3338.7495937804656;5372.382176049756;5388.892222155555;5414.91877621836;5417.702026388547;5418.349798024237;5371.81198658047;5408.945910540893;5413.485718856712;5413.756380962856;5427.213054107152;4895.46149923509;4936.925946110793;4988.625853061017;5026.924596131061;5083.3391659084455;4754.930140718328;4914.189158788796;4917.065757506062;4919.926201106969;4979.526944940225;5064.797408103672;5080.085584594772;5105.872353191181;5141.331626888499;5141.614378921578;5037.420696619899;5054.974725126369;5057.241413787924;5071.746412679388;5118.718470484122;4883.4628190898975;4964.081644895669;4980.003999200175;4987.401511818569;5049.5455409013;5277.261183434322;5285.075111855448;5389.9191512127345;5391.73041347931;5397.082495975694;5798.304203495565;5861.88276234473;5883.764649414018;5917.31950825652;5927.851803704899;5892.381299963485;5893.381194974551;5926.525877929756;5927.170196172539;5972.611780234271;5428;5478.096114141162;5483.7806487740445;5501.697406642633;5519.2824932758485;5872.412758724094;5910.8817823643285;5925.644461332334;5930.406959304035;5964.612300200473;5779.2775903012125;5795.768169273182;5853.9414605854245;5869.7945571904775;5875.559333050039;5792.594518383757;5818.069108942549;5824.417558244142;5829.44620261083;5862.120681897664;5872.853178670482;5927.9703601481715;5957.642541447527;5968.612040217459;6008.3390827009;5730.828075157752;5794.942050579441;5828.417158284223;5931.08068249422;5973.522118230531;4483.327500874895;4500.459944806644;4505.031418245093;4510.954890451119;4516.1419330327135;3991.92016159681;4027.234825383168;4033.576474470197;4043.5147782265726;4049.4128351389472;5476.890462190734;5556.111022236423;5570.359408667974;5613.382527922007;5642.322921249476;5982.341942386334;5982.9401705983255;5984.371640977634;5993.970030149909;6032.939670603326;5658.377578466366;5679.2333035040565;5683.147527870852;5685.857853553694;5696.544276457957;4937.851864444073;4995.150824359867;5003.199488081889;5012.298278241049;5034.723090230073;6114.996965385453;6117.847053823601;6121.357257487989;6127.097902969301;6137.7851775187655;5947.375525569752;5979.043353063489;5980.162777211194;5991.161237426851;5991.910121348271;6087.36082711309;6104.633721976696;6119.045604113885;6126.142340072304;6140.3552626975315;5854.414558544111;5896.8820623586425;5908.025175846109;5909.113632955091;5924.970375148269;5963.165156878127;5971.940280597312;5977.6114552553945;5998.670073146019;6018.939810601838;5487.176923461353;5533.750981205775;5575.581831362745;5769.94230057694;5819.330776960704;5814.592978491634;5819;5837.5038121758425;5845.8538536535225;5855.795047173328;5699.772009119589;5705.172749951151;5724.141378793214;5729.2265544151005;5745.339285981999;5666.433356664301;5697.7436015380235;5751.971240143773;5845.18167456565;5853.94146058534;5597.244372009726;5605.215269862141;5620;5646.237757902631;5657.9151312731165 05:39:19 INFO - PROCESS | 21767 | |1;ext.html;555.633282033858;557.2198921509886;575.1602660116231;581.1805354450227;590.4095904095905;36320.63679363205;37951.24097518048;37955.240895182076;37955.81022094889;38021.42967855484;41275.79362103185;41374.379384309184;41674;41786.79106604463;41855.790721046425;8731.95634021829;8890.777730556756;8923.15230053144;8928.73213803587;8931.062238464965;8483.278921291698;8640.65437382504;8644.827103457927;8839.867401988975;8864.556772161399;8715.825683486326;8824.294056475466;8877.600507977124;8907.777305567348;8912.688055918044;8706.738797836075;8725.869111963293;8763.868541971875;8803.823923521526;8835.955820220923;8753.518556479392;8885.200331970154;8900.243479304267;8901.554922253861;8968.686095986674;41361.79319103385;41754.373684394755;41844.1631167378;42073.78963105165;42109.57890421087;3416.777909435879;3532.417151170054;3622.710183185339;3640.1445660269815;4173.227952828706;28327.858360708065;28360.00739974091;28699.56950645742;28776.60581069904;29442.70557294421;4108.465899433085;4122.40225167349;4152.1072969311745;4172.91654166918;4174.290370636969;262246;265553;266726;267120;267158;43928.78035609866;44168.3374749379;44524.554754452685;44563;44654.553454465036;42229.15541689211;42420;42564.787176063925;42822.143557128686;42904.78547607242;14952.925235373754;15047.849521504864;15138.772918406232;15149.848501514844;15251.923740381228;11410.42947852604;11550.768984620428;11591.536338546532;11608.071354291806;12130.939345303217;15144.636982671393;15199.620009499851;15235.314410851539;15287.388504459697;15317.770233446507;6116.60242084272;6187.288461826857;6235.314115447297;6249.156363890907;6264.59280146789;1069.2835800014009;1082.258652822819;1089.4334945828125;1104.5857803323754;1183.8102706779803;32953.505697414555;33174.3365132696;33321.333573328884;33467.66532334694;33896.15259618529;1087.9564817407215;1182.798924182891;1209.1838009343658;1216.2398500936915;1223.25992774372;15135.697286054217;16231.26959286835;17157.485275441755;17169.656606867793;17464.563385915455;452166;519311;532865;532912;532989;56691.71654141703;57664.42335576675;58003.83992320214;58133.70933145307;58204.41795582075;1449.7535418978798;1464.2459133546233;1467.8238611366492;1467.9119252844864;1475.0928179169734;30840.383192336478;31661;31678.208044799063;31696;32187.35625287528;47153.292700608836;47875.28187077266;48108.759456203894;48414.515854841;48421.75789121032;268942;269812;271766;273091;273133;33260.33479330448;33280.667193327754;33594.66405336013;33670.66329336675;33907.15232119217;47880.521194789;47899.76050119727;48347.51652483571;48837.75581122072;49269.50730492792;37792.244155117296;38619.42070868883;39464.4409667877;39729.2054158921;39850.40224396694;39051.609483904795;39775.40336894891;39823.2035359297;40263.59736402598;42897.35653965255;36484.45273320955;36991.44512832256;37248.6275137256;37248.81375593105;37420;35683.64316356907;36068.4589731149;36311;36562.26875462422;37504;26325.86837065879;27524.174274771787;27664.723352766214;27679.44641107126;27722.72277277282 05:39:19 INFO - PROCESS | 21767 | |2;jquery.html;390.51771062737515;392.62896562748205;393.23908237560306;398.5436675007117;400.1966226582787;14435.927820360883;14951.327190276465;17925.641487170265;18477.353292634743;18506.90746546267;11371.374574398405;11647.592334268302;16022.519324420256;17733.290668373284;17765.28938842448;5074.594032477411;5358.2498450217;5516.889662206753;5523.088690366085;5532.585056120787;3886.980565097185;4290.935635965463;5424.186372044205;5646.717664116798;5686.800961966332;5322.387925388591;5618.4662457066715;5623.212750214973;5629.155626656014;5675.744591493372;5285.312909321802;5396.406395296514;5397.7571009304675;5439.265699130646;5459.754311055992;5466.125419932831;5512.6692398456225;5553.194786755938;5589.664620122806;5603.187537806995;12904.54834080812;16389.59026024347;20022.89874056941;21255.36233912985;21264.787352126434;2170.240415854454;2199.8900054997184;2270.931872043825;2378.797802186816;2437.890294936732;9776.51117444132;9832.508374581243;9868.80262394748;10139.391636501834;10170.745731356701;1949.9220031198736;1950.8439324853978;1963.1165975311023;1984.6824508078782;2006.9197232110698;60168.09747853786;61036.389636103515;61973.690131549505;62343.6882815583;63157.68421157911;10313;10634.893651063545;10729.83905241422;10733.355998640107;10811.945940270249;14104.833763034274;14193.503227387198;14219.573412797632;14223.146611203361;14301.856981430261;7419.629018549051;7555.471117021865;7740.574268415291;7760.767176984699;7773.455858089879;7381.040464739657;7406.111266648037;7421.220771818989;7441.925580744231;7479.401647868158;4443.733375997451;4553.817847286072;4603.746793926366;4628.120657075145;4657.743824089707;1818.2545156485778;1956.1979588368702;1965.508622844289;1988.6519859024613;1994.9401517954484;472.3222176177197;992.4789485520159;999.8450240212778;1015.8679371681634;1105.3533682795655;10774.138068954622;10842;10919.344839309666;11030.393328367018;11055.170862185369;451.97740112994217;463.6684770389188;471.5355374955666;475.2728325661743;490.35273439060813;5954.345022047572;6116.327204007555;6169.784057557964;9861.506924653739;10316.690499285034;572510;577706;582676;583399;622645;73309.26690733024;76672;76905.61547192228;77684;80399;1161.4715304536417;1206.0291465370285;1209.8929479526312;1211.4185191108318;1217.34263497712;15776.684466310839;15795.447159349367;15888.841111589198;16049.839501604834;16165.67668646597;34427.4835877457;35007.824960875034;35765.82117089398;35963.1009224761;36161.27677446489;44775.55224447714;46683.53316466928;46690.533094668615;46759.29861052019;48807.75596121997;7222.205557388788;7622.466427350254;7678.61606919663;7768.7669369918995;7793.337566306927;10708.73228169302;10967.780644387227;11258.83111753308;11309.71725706864;11475.885241147482;9546.18857397129;9882.85175722379;9978.600855965971;10049.196064314983;10111.140553053074;9684.903150968681;10092.394456332644;10193.643222487177;10361.585536578452;10424.947875260576;10547.630832920811;10550;10579.62971296001;10603.204759643211;10736.355818650905;7741.341985931259;8007.919920800718;8013.15861834499;8024.638891249791;8047.637856296364;9390.974004017666;9815.607375705178;9841.704748857546;10074.44590547527;10487.475626218811 05:39:19 INFO - PROCESS | 21767 | |3;mootools.html;1534.9232538373083;1549.3802479008398;1650.9504714858551;1740.9477715668534;1752.5005373468564;8043.155468675793;8135.837283254331;8205.097439281673;8274.958625206873;8320.084790673021;8237.794055148624;8276.83446331073;8308.70919517817;8318.251357377834;8359.164083591639;2461.249318957717;2491.028498885427;2491.1405565080017;2491.638712386712;2496.750324967507;2483.1681386735377;2547.0957809977467;2578.4843031393702;2580.9225723228333;2588.184721812623;2022.5449273913325;2044.0597325230412;2339.1345202275097;2457.041753716052;2495.862727549984;2409.3615191974054;2438.1588352018525;2444.6699695541142;2452.0559584559896;2459.274514018369;2400.195934361991;2454.1778504201116;2454.631805229212;2455.177515532299;2456.066694656019;8169.387295952827;8235.38234632399;8239.505629662239;8274.875876861852;8298.751037468886;4848.903021939576;4995.650304478688;4998.975210081924;5014.523620256106;5026.974865125688;3226.2740883301303;3296.307775367152;3336.08257729124;3357.446021406465;3393.694567488938;1135.727425417902;1151.1251448898813;1155.895969362753;1161.5644133449957;1185.1822242652543;11245.325280483115;11489.368084755335;11501.712457188554;11505.13711471643;11513.539458421654;4471.038726673716;4495.483019452805;4509.436320459942;4516.322551617283;4547.772611369418;8870.778230544289;8922.910770892338;8967.955160224288;9025;9311.72064838056;5025.045241404122;5050.217216331474;5061.493850614909;5072.340595722606;5077.949220507821;4619.976900115478;4643.744594047293;4660.580547750718;4678;4729.9054018920115;3732.346839303111;3761.435784632327;3774.962250377516;3787.8106094695154;3803.5625903020955;1135.1316243074054;1159.8898104680043;1169.1231576317762;1175.488662431845;1177.8645455772526;1067.588978243382;1072.1369297715257;1083.0577397664083;1267.499337761579;1389.805427240187;7342.229065948105;7391.963040184764;7463;7499.475036747375;7627.69489220436;1189.452851688233;1189.7025743564109;1191.2257032928667;1201.0331682995097;1205.1021988618536;5975.850603734854;6001.729922153426;6012.549058820518;6035.1249068885645;6065.514758819284;9779.804403912025;10282;10344.32761870476;10387.584496620051;10469.476526173661;10003.24975626831;10163.644272450429;10183;10277;10298.279120461646;7687.846243075107;7788.415868809749;7791.415643826849;7800.102988156435;7848;7396.334329910119;7498.62506874665;7503.88744168827;7573.129090154703;7574.697012119454;8896.154865287788;9059.592318345558;9066.456012639263;9149.176574108362;9245.768855778659;9234.492102934135;9274.026227246311;9296;9299.814003719752;9643.710688679352;6879.346462086094;7007.649617519001;7061.293870612898;7084.079069720903;7100;7921.603919803872;8017.599120044091;8058.113607503287;8073.798155046171;8084.231997960184;7128.893066603901;7388;7388.778336649909;7401.148867880047;7562.886556701544;6774.119364482585;6844.939034449668;6944.652767361713;6973.4072603829245;7001.299870012958;7181.317774811385;7192.748253811092;7199.1361036675935;7204.56772593646;7251.854962900818;6312.842178945563;6361.522885783492;6374.776882809079;6376.075469056868;6376.171097757262;6668.966655166693;6671.33286671329;6806.285340039224;6871.209810871814;6910.343517365842 05:39:19 INFO - PROCESS | 21767 | |4;prototype.html;358.1440357545466;366.3095065800964;368.94281386385086;369.66175949006663;377.5827710380028;6216.222972128484;6239.313675495698;6295.811125666238;6405.871882562346;6434.549581529295;6173.845653858656;6266.279377871546;6301.6849157542165;6342.714577844008;6371.299157092716;4775.188218002939;4832.0335932813405;4856.538628830255;4877.731724755137;4884.706917584938;4859.829905953292;4880.341153944208;4886.560209581137;4895.0944075346;4909.091818013661;4658.86023419298;4710.3405523226775;4740.312654665088;4765.976170119162;4781.976090119544;4743.976280118612;4745.525447455244;4752.049590081998;4756.453007904101;4756.476787553366;4174.123434078847;4199.391088292181;4201.936970945439;4218.725782824106;4238.961454443681;5893.723150240005;5941.138534912414;5942.316633587149;5955.315138759055;5978.342382337939;5601.103823388238;5634.943650563483;5651.519620832193;5667.319921609434;5671.943280567183;6697.196336439659;6707.731690732365;6709.127813384229;6712.765053223163;6757.290484499106;4650.441946966385;4660.557247061523;4676.5089665584965;4704.388429504177;4711.4346278446465;6883.036374907517;6970.442364610819;7036.577805331696;7047.823804404879;7065.081539399896;4798;4835.58897493717;4841.104395686809;4846.781894814671;4848.660593758474;4907.533784290486;4912.312276281324;4916.483769204254;4919.631027672939;4932.235503496964;5560.944390556124;5656.095024796013;5668.801591944262;5670.943290567124;5673.375928647845;6814.114165158498;6838.692258848364;6846.938724497711;6854.485913556503;6854.691538880663;1683.2257161705509;1714.562786489462;1714.8285171482753;1716.828317168273;1720.5096547483906;1139.5441823270758;1149.0348107589664;1157.288267715349;1166.457597217281;1174.1956759619688;6403.967980160162;6404.0467657364015;6411.6153030818305;6419.2938776735455;6423.293437721847;6843.726250949906;6868.107146071079;6875.243723190445;6888.862222755517;6895.482838787011;6287.2769631492965;6319.241690997018;6382.553221274559;6425.132607097982;6432.2281326241155;3714.53568303962;3745.0824547985917;3747.831347589365;3747.8500859965843;3750.7937063461227;7124.786256412316;7138.464615153885;7144;7153.4992550522;7153.7138514459875;6924.896126558106;6986.615736134561;7057.435405167575;7110.466714996396;7120.572765633975;7064.399526040344;7101.11236095488;7115.252898445692;7126.182823380109;7148.39238664709;6890.621015844176;6912.447004239548;6968.6864091115;6972.651367431709;6972.895406568804;6692.6988285526295;6806.965965170142;6827.965860170667;6832.0435139081565;6842.657867106525;7117.395021423237;7131.144262688511;7134.607596582237;7138.714451421885;7161.319674630901;4791.089692958327;4801.063792560417;4820.30105634674;4832.44426890912;4833.927491087707;6779.118714567075;6881.587104773729;6886.276940921131;6893.414059804973;6898.724051038103;6633.270340262471;6702.765403210864;6704.229013663296;6714.060031595678;6716.462682985251;6639.7012134455035;6641.568298060611;6644.435223006099;6693.698783554654;6718.865622687421;6421.646809425526;6549.672516374258;6568.277489476058;6575.178102737158;6585.341465853568;6700.631465269262;6701.731930722912;6718.126643536309;6735.158105236846;6740.73037078531;6496.610203387623;6516.989866570689;6565.179352580927;6568.638724870178;6572.572782769104 05:39:19 INFO - PROCESS | 21767 | |5;yui.html;796.2276591706043;819.9262066414024;865.1132589096179;878.0517041595078;879.0989236033066;13655.31723413829;13693.794593081087;13753.518626848063;13820.101693389923;13847.792283115748;13119.803202951964;13366.66583335417;15481;15569.922150389231;15574.922125389385;889.5818965086415;906.4063038709655;909.3407279722181;910.1899309614448;913.0276255787599;900.918917297443;909.9363044586881;915.094056883687;915.3089417489786;918.347972939214;951.7858481841599;964.0552258786358;966.5215718219491;969.093897206111;973.5764942250108;949.5157469690473;952.3333666433524;956.5647630328253;961.4375590279625;963.2438535749438;697.6023666510041;704.2781149321935;705.5801797930275;706.5866468116159;708.7802781137813;13910.234937078456;13972.790408143886;14179.645508862257;14331.78502322466;14338.928305358511;13042.804357934638;13049.543265985645;13161.144525605901;13191.472341106344;13751.862481375258;11640.243384180001;11748.236364636272;11886.821697674543;11968.281903085755;12250.571230006906;4529.932051019205;4572.154151481986;4599.264117741145;4600.493945665974;4650.558196971282;53691.731541342044;53935.19097213506;54698.453015470135;54929;55080.724596377164;11014.339139651647;11097.778044439066;11121.332720036662;11135.164862635334;11316.094712422986;18822.71765923512;19001.619967600847;19052;19080.33218837334;19109.331173408864;7926.286634202949;7957.5225486471;8145.104038555754;8378.874316885252;8638.956805215934;4399.142167277414;4430.601245887886;4458.777061146994;4488.461384633865;4521.615662668644;3214.164317277525;3219.4526930421885;3257.38109759145;3266.3304022675293;3282.638909719929;565.926429564154;567.9943200567941;572.8796952639909;577.9450952159622;579.4408395897979;580.3326174898816;590.1649166429454;595.5414330965133;653.3792896748108;687.2886562407883;9056.411333263317;9067;9128.041555636695;9257.490838003974;9319.254459643213;566.583561082604;606.824021033904;644.6841047886595;647.6923461355818;655.1777519213357;4247.8088486018205;4324.654027677841;4362.629176519968;4407.515173330931;4454;57167.42832571704;59294.407055929754;59777.402225978054;60523.69738151281;60531.394686053456;50750;53590.7320463403;53722;57339;60319.39680603138;48520.7573962135;48881.26678099831;49116.50883491191;49227.75386123046;49359.25961110586;9567.856482152913;9573.18627916607;9654.806903862023;9766.267529935141;9900.50497475109;33656;34907.4763878537;35246.471302930986;35348.29303413866;35401.291974160886;44718.3292250623;48569.5143048565;48578.51421485881;48978.26532601943;49062.75468622634;11562.88437115618;11893.881061189277;12058.276503409823;12148.088893333212;12222.388880556115;13289.468421263042;13609.795853062014;13796.862031379958;14076.859231407554;14310.356033978704;12615.558455454382;12701.87298127007;12828.935855321037;12850.228986260854;13311.334433278103;11813.588320090197;12124.75750485003;12127.393630318626;12177.391130443266;12913.418896149507;11788.882111179122;12266.570670026505;12280.26318420862;12323;12432.502699891904;10023.949880250551;10026.097651211427;10321.896781032094;10376.533056012346;10703.090237329914;10431.843522347323;10839.945800270949;10956.181238135912;11041.889581104086;11058.060064894253 05:39:19 INFO - PROCESS | 21767 | __end_tp_report 05:39:19 INFO - PROCESS | 21767 | __start_cc_report 05:39:19 INFO - PROCESS | 21767 | _x_x_mozilla_cycle_collect,295 05:39:19 INFO - PROCESS | 21767 | __end_cc_report 05:39:19 INFO - PROCESS | 21767 | __startTimestamp1454593159497__endTimestamp 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | ------- Summary: start ------- 05:39:19 INFO - PROCESS | 21767 | Number of tests: 6 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | [#0] dojo.html Cycles:165 Average:5473.55 Median:5685.86 stddev:617.03 (10.9%) stddev-sans-first:594.83 05:39:19 INFO - PROCESS | 21767 | Values: 3297.3 3304.2 3305.5 3338.0 3338.7 5372.4 5388.9 5414.9 5417.7 5418.3 5371.8 5408.9 5413.5 5413.8 5427.2 4895.5 4936.9 4988.6 5026.9 5083.3 4754.9 4914.2 4917.1 4919.9 4979.5 5064.8 5080.1 5105.9 5141.3 5141.6 5037.4 5055.0 5057.2 5071.7 5118.7 4883.5 4964.1 4980.0 4987.4 5049.5 5277.3 5285.1 5389.9 5391.7 5397.1 5798.3 5861.9 5883.8 5917.3 5927.9 5892.4 5893.4 5926.5 5927.2 5972.6 5428.0 5478.1 5483.8 5501.7 5519.3 5872.4 5910.9 5925.6 5930.4 5964.6 5779.3 5795.8 5853.9 5869.8 5875.6 5792.6 5818.1 5824.4 5829.4 5862.1 5872.9 5928.0 5957.6 5968.6 6008.3 5730.8 5794.9 5828.4 5931.1 5973.5 4483.3 4500.5 4505.0 4511.0 4516.1 3991.9 4027.2 4033.6 4043.5 4049.4 5476.9 5556.1 5570.4 5613.4 5642.3 5982.3 5982.9 5984.4 5994.0 6032.9 5658.4 5679.2 5683.1 5685.9 5696.5 4937.9 4995.2 5003.2 5012.3 5034.7 6115.0 6117.8 6121.4 6127.1 6137.8 5947.4 5979.0 5980.2 5991.2 5991.9 6087.4 6104.6 6119.0 6126.1 6140.4 5854.4 5896.9 5908.0 5909.1 5925.0 5963.2 5971.9 5977.6 5998.7 6018.9 5487.2 5533.8 5575.6 5769.9 5819.3 5814.6 5819.0 5837.5 5845.9 5855.8 5699.8 5705.2 5724.1 5729.2 5745.3 5666.4 5697.7 5752.0 5845.2 5853.9 5597.2 5605.2 5620.0 5646.2 5657.9 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | [#1] ext.html Cycles:180 Average:51166.86 Median:38835.52 stddev:98014.21 (252.4%) stddev-sans-first:98215.51 05:39:19 INFO - PROCESS | 21767 | Values: 555.6 557.2 575.2 581.2 590.4 36320.6 37951.2 37955.2 37955.8 38021.4 41275.8 41374.4 41674.0 41786.8 41855.8 8732.0 8890.8 8923.2 8928.7 8931.1 8483.3 8640.7 8644.8 8839.9 8864.6 8715.8 8824.3 8877.6 8907.8 8912.7 8706.7 8725.9 8763.9 8803.8 8836.0 8753.5 8885.2 8900.2 8901.6 8968.7 41361.8 41754.4 41844.2 42073.8 42109.6 3416.8 3532.4 3622.7 3640.1 4173.2 28327.9 28360.0 28699.6 28776.6 29442.7 4108.5 4122.4 4152.1 4172.9 4174.3 262246.0 265553.0 266726.0 267120.0 267158.0 43928.8 44168.3 44524.6 44563.0 44654.6 42229.2 42420.0 42564.8 42822.1 42904.8 14952.9 15047.8 15138.8 15149.8 15251.9 11410.4 11550.8 11591.5 11608.1 12130.9 15144.6 15199.6 15235.3 15287.4 15317.8 6116.6 6187.3 6235.3 6249.2 6264.6 1069.3 1082.3 1089.4 1104.6 1183.8 32953.5 33174.3 33321.3 33467.7 33896.2 1088.0 1182.8 1209.2 1216.2 1223.3 15135.7 16231.3 17157.5 17169.7 17464.6 452166.0 519311.0 532865.0 532912.0 532989.0 56691.7 57664.4 58003.8 58133.7 58204.4 1449.8 1464.2 1467.8 1467.9 1475.1 30840.4 31661.0 31678.2 31696.0 32187.4 47153.3 47875.3 48108.8 48414.5 48421.8 268942.0 269812.0 271766.0 273091.0 273133.0 33260.3 33280.7 33594.7 33670.7 33907.2 47880.5 47899.8 48347.5 48837.8 49269.5 37792.2 38619.4 39464.4 39729.2 39850.4 39051.6 39775.4 39823.2 40263.6 42897.4 36484.5 36991.4 37248.6 37248.8 37420.0 35683.6 36068.5 36311.0 36562.3 37504.0 26325.9 27524.2 27664.7 27679.4 27722.7 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | [#2] jquery.html Cycles:180 Average:29202.24 Median:24609.64 stddev:96151.38 (390.7%) stddev-sans-first:96396.76 05:39:19 INFO - PROCESS | 21767 | Values: 390.5 392.6 393.2 398.5 400.2 14435.9 14951.3 17925.6 18477.4 18506.9 11371.4 11647.6 16022.5 17733.3 17765.3 5074.6 5358.2 5516.9 5523.1 5532.6 3887.0 4290.9 5424.2 5646.7 5686.8 5322.4 5618.5 5623.2 5629.2 5675.7 5285.3 5396.4 5397.8 5439.3 5459.8 5466.1 5512.7 5553.2 5589.7 5603.2 12904.5 16389.6 20022.9 21255.4 21264.8 2170.2 2199.9 2270.9 2378.8 2437.9 9776.5 9832.5 9868.8 10139.4 10170.7 1949.9 1950.8 1963.1 1984.7 2006.9 60168.1 61036.4 61973.7 62343.7 63157.7 10313.0 10634.9 10729.8 10733.4 10811.9 14104.8 14193.5 14219.6 14223.1 14301.9 7419.6 7555.5 7740.6 7760.8 7773.5 7381.0 7406.1 7421.2 7441.9 7479.4 4443.7 4553.8 4603.7 4628.1 4657.7 1818.3 1956.2 1965.5 1988.7 1994.9 472.3 992.5 999.8 1015.9 1105.4 10774.1 10842.0 10919.3 11030.4 11055.2 452.0 463.7 471.5 475.3 490.4 5954.3 6116.3 6169.8 9861.5 10316.7 572510.0 577706.0 582676.0 583399.0 622645.0 73309.3 76672.0 76905.6 77684.0 80399.0 1161.5 1206.0 1209.9 1211.4 1217.3 15776.7 15795.4 15888.8 16049.8 16165.7 34427.5 35007.8 35765.8 35963.1 36161.3 44775.6 46683.5 46690.5 46759.3 48807.8 7222.2 7622.5 7678.6 7768.8 7793.3 10708.7 10967.8 11258.8 11309.7 11475.9 9546.2 9882.9 9978.6 10049.2 10111.1 9684.9 10092.4 10193.6 10361.6 10424.9 10547.6 10550.0 10579.6 10603.2 10736.4 7741.3 8007.9 8013.2 8024.6 8047.6 9391.0 9815.6 9841.7 10074.4 10487.5 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | [#3] mootools.html Cycles:180 Average:5760.76 Median:5055.86 stddev:2989.23 (59.1%) stddev-sans-first:2980.74 05:39:19 INFO - PROCESS | 21767 | Values: 1534.9 1549.4 1651.0 1740.9 1752.5 8043.2 8135.8 8205.1 8275.0 8320.1 8237.8 8276.8 8308.7 8318.3 8359.2 2461.2 2491.0 2491.1 2491.6 2496.8 2483.2 2547.1 2578.5 2580.9 2588.2 2022.5 2044.1 2339.1 2457.0 2495.9 2409.4 2438.2 2444.7 2452.1 2459.3 2400.2 2454.2 2454.6 2455.2 2456.1 8169.4 8235.4 8239.5 8274.9 8298.8 4848.9 4995.7 4999.0 5014.5 5027.0 3226.3 3296.3 3336.1 3357.4 3393.7 1135.7 1151.1 1155.9 1161.6 1185.2 11245.3 11489.4 11501.7 11505.1 11513.5 4471.0 4495.5 4509.4 4516.3 4547.8 8870.8 8922.9 8968.0 9025.0 9311.7 5025.0 5050.2 5061.5 5072.3 5077.9 4620.0 4643.7 4660.6 4678.0 4729.9 3732.3 3761.4 3775.0 3787.8 3803.6 1135.1 1159.9 1169.1 1175.5 1177.9 1067.6 1072.1 1083.1 1267.5 1389.8 7342.2 7392.0 7463.0 7499.5 7627.7 1189.5 1189.7 1191.2 1201.0 1205.1 5975.9 6001.7 6012.5 6035.1 6065.5 9779.8 10282.0 10344.3 10387.6 10469.5 10003.2 10163.6 10183.0 10277.0 10298.3 7687.8 7788.4 7791.4 7800.1 7848.0 7396.3 7498.6 7503.9 7573.1 7574.7 8896.2 9059.6 9066.5 9149.2 9245.8 9234.5 9274.0 9296.0 9299.8 9643.7 6879.3 7007.6 7061.3 7084.1 7100.0 7921.6 8017.6 8058.1 8073.8 8084.2 7128.9 7388.0 7388.8 7401.1 7562.9 6774.1 6844.9 6944.7 6973.4 7001.3 7181.3 7192.7 7199.1 7204.6 7251.9 6312.8 6361.5 6374.8 6376.1 6376.2 6669.0 6671.3 6806.3 6871.2 6910.3 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | [#4] prototype.html Cycles:180 Average:5608.64 Median:6393.26 stddev:1678.09 (26.2%) stddev-sans-first:1635.86 05:39:19 INFO - PROCESS | 21767 | Values: 358.1 366.3 368.9 369.7 377.6 6216.2 6239.3 6295.8 6405.9 6434.5 6173.8 6266.3 6301.7 6342.7 6371.3 4775.2 4832.0 4856.5 4877.7 4884.7 4859.8 4880.3 4886.6 4895.1 4909.1 4658.9 4710.3 4740.3 4766.0 4782.0 4744.0 4745.5 4752.0 4756.5 4756.5 4174.1 4199.4 4201.9 4218.7 4239.0 5893.7 5941.1 5942.3 5955.3 5978.3 5601.1 5634.9 5651.5 5667.3 5671.9 6697.2 6707.7 6709.1 6712.8 6757.3 4650.4 4660.6 4676.5 4704.4 4711.4 6883.0 6970.4 7036.6 7047.8 7065.1 4798.0 4835.6 4841.1 4846.8 4848.7 4907.5 4912.3 4916.5 4919.6 4932.2 5560.9 5656.1 5668.8 5670.9 5673.4 6814.1 6838.7 6846.9 6854.5 6854.7 1683.2 1714.6 1714.8 1716.8 1720.5 1139.5 1149.0 1157.3 1166.5 1174.2 6404.0 6404.0 6411.6 6419.3 6423.3 6843.7 6868.1 6875.2 6888.9 6895.5 6287.3 6319.2 6382.6 6425.1 6432.2 3714.5 3745.1 3747.8 3747.9 3750.8 7124.8 7138.5 7144.0 7153.5 7153.7 6924.9 6986.6 7057.4 7110.5 7120.6 7064.4 7101.1 7115.3 7126.2 7148.4 6890.6 6912.4 6968.7 6972.7 6972.9 6692.7 6807.0 6828.0 6832.0 6842.7 7117.4 7131.1 7134.6 7138.7 7161.3 4791.1 4801.1 4820.3 4832.4 4833.9 6779.1 6881.6 6886.3 6893.4 6898.7 6633.3 6702.8 6704.2 6714.1 6716.5 6639.7 6641.6 6644.4 6693.7 6718.9 6421.6 6549.7 6568.3 6575.2 6585.3 6700.6 6701.7 6718.1 6735.2 6740.7 6496.6 6517.0 6565.2 6568.6 6572.6 05:39:19 INFO - PROCESS | 21767 | 05:39:19 INFO - PROCESS | 21767 | [#5] yui.html Cycles:180 Average:14830.33 Median:4525.77 stddev:16976.21 (375.1%) stddev-sans-first:16991.12 05:39:19 INFO - PROCESS | 21767 | Values: 796.2 819.9 865.1 878.1 879.1 13655.3 13693.8 13753.5 13820.1 13847.8 13119.8 13366.7 15481.0 15569.9 15574.9 889.6 906.4 909.3 910.2 913.0 900.9 909.9 915.1 915.3 918.3 951.8 964.1 966.5 969.1 973.6 949.5 952.3 956.6 961.4 963.2 697.6 704.3 705.6 706.6 708.8 13910.2 13972.8 14179.6 14331.8 14338.9 13042.8 13049.5 13161.1 13191.5 13751.9 11640.2 11748.2 11886.8 11968.3 12250.6 4529.9 4572.2 4599.3 4600.5 4650.6 53691.7 53935.2 54698.5 54929.0 55080.7 11014.3 11097.8 11121.3 11135.2 11316.1 18822.7 19001.6 19052.0 19080.3 19109.3 7926.3 7957.5 8145.1 8378.9 8639.0 4399.1 4430.6 4458.8 4488.5 4521.6 3214.2 3219.5 3257.4 3266.3 3282.6 565.9 568.0 572.9 577.9 579.4 580.3 590.2 595.5 653.4 687.3 9056.4 9067.0 9128.0 9257.5 9319.3 566.6 606.8 644.7 647.7 655.2 4247.8 4324.7 4362.6 4407.5 4454.0 57167.4 59294.4 59777.4 60523.7 60531.4 50750.0 53590.7 53722.0 57339.0 60319.4 48520.8 48881.3 49116.5 49227.8 49359.3 9567.9 9573.2 9654.8 9766.3 9900.5 33656.0 34907.5 35246.5 35348.3 35401.3 44718.3 48569.5 48578.5 48978.3 49062.8 11562.9 11893.9 12058.3 12148.1 12222.4 13289.5 13609.8 13796.9 14076.9 14310.4 12615.6 12701.9 12828.9 12850.2 13311.3 11813.6 12124.8 12127.4 12177.4 12913.4 11788.9 12266.6 12280.3 12323.0 12432.5 10023.9 10026.1 10321.9 10376.5 10703.1 10431.8 10839.9 10956.2 11041.9 11058.1 05:39:19 INFO - PROCESS | 21767 | -------- Summary: end -------- 05:39:19 INFO - PROCESS | 21767 | 05:39:20 INFO - TEST-INFO | 21767: exit 0 05:39:20 INFO - TEST-OK | dromaeo_css | took 1108322ms 05:39:20 INFO - TEST-START | kraken 05:39:20 INFO - operating with platform_type : linux_ 05:39:20 INFO - Initialising browser for kraken test... 05:39:20 INFO - TEST-INFO | started process 22011 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ_dvYc/profile http://localhost:35986/getInfo.html) 05:39:23 INFO - PROCESS | 22011 | 05:39:23 INFO - PROCESS | 22011 | (process:22091): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:39:24 INFO - PROCESS | 22011 | __metrics Screen width/height:1600/1200 05:39:24 INFO - PROCESS | 22011 | colorDepth:24 05:39:24 INFO - PROCESS | 22011 | Browser inner width/height: 1024/697 05:39:24 INFO - PROCESS | 22011 | __metrics 05:39:25 INFO - TEST-INFO | 22011: exit 0 05:39:25 INFO - Browser initialized. 05:39:25 INFO - Running cycle 1/1 for kraken test... 05:39:25 INFO - TEST-INFO | started process 22140 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ_dvYc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:26 INFO - PROCESS | 22140 | 05:39:26 INFO - PROCESS | 22140 | (process:22208): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:39:37 INFO - PROCESS | 22140 | RSS: Main: 140124160 05:39:37 INFO - PROCESS | 22140 | 05:39:39 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35986/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:40 INFO - PROCESS | 22140 | RSS: Main: 143597568 05:39:40 INFO - PROCESS | 22140 | 05:39:42 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35986/tests/kraken/driver.html?testName=audio-dft) 05:39:43 INFO - PROCESS | 22140 | RSS: Main: 143290368 05:39:43 INFO - PROCESS | 22140 | 05:39:46 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35986/tests/kraken/driver.html?testName=audio-fft) 05:39:46 INFO - PROCESS | 22140 | RSS: Main: 145883136 05:39:46 INFO - PROCESS | 22140 | 05:39:48 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35986/tests/kraken/driver.html?testName=audio-oscillator) 05:39:49 INFO - PROCESS | 22140 | RSS: Main: 145649664 05:39:49 INFO - PROCESS | 22140 | 05:39:51 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:52 INFO - PROCESS | 22140 | RSS: Main: 143699968 05:39:52 INFO - PROCESS | 22140 | 05:39:55 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35986/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:55 INFO - PROCESS | 22140 | RSS: Main: 145793024 05:39:55 INFO - PROCESS | 22140 | 05:39:59 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35986/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:59 INFO - PROCESS | 22140 | RSS: Main: 144842752 05:39:59 INFO - PROCESS | 22140 | 05:40:02 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35986/tests/kraken/driver.html?testName=json-parse-financial) 05:40:03 INFO - PROCESS | 22140 | RSS: Main: 146882560 05:40:03 INFO - PROCESS | 22140 | 05:40:04 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:05 INFO - PROCESS | 22140 | RSS: Main: 145657856 05:40:05 INFO - PROCESS | 22140 | 05:40:07 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:07 INFO - PROCESS | 22140 | RSS: Main: 145833984 05:40:07 INFO - PROCESS | 22140 | 05:40:09 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:10 INFO - PROCESS | 22140 | RSS: Main: 145371136 05:40:10 INFO - PROCESS | 22140 | 05:40:12 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:13 INFO - PROCESS | 22140 | RSS: Main: 144470016 05:40:13 INFO - PROCESS | 22140 | 05:40:15 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:16 INFO - PROCESS | 22140 | RSS: Main: 146665472 05:40:16 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | Cycle 1(1): loaded http://localhost:35986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35986/tests/kraken/driver.html?testName=ai-astar) 05:40:18 INFO - PROCESS | 22140 | RSS: Main: 146325504 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | __start_tp_report 05:40:18 INFO - PROCESS | 22140 | _x_x_mozilla_page_load 05:40:18 INFO - PROCESS | 22140 | _x_x_mozilla_page_load_details 05:40:18 INFO - PROCESS | 22140 | |i|pagename|runs| 05:40:18 INFO - PROCESS | 22140 | |0;ai-astar;111;106;110;111;112;120;112;111;111;111 05:40:18 INFO - PROCESS | 22140 | |1;audio-beat-detection;157;140;153;168;128;150;150;128;169;125 05:40:18 INFO - PROCESS | 22140 | |2;audio-dft;163;161;162;162;163;163;163;159;164;162 05:40:18 INFO - PROCESS | 22140 | |3;audio-fft;72;73;73;167;76;75;73;76;149;74 05:40:18 INFO - PROCESS | 22140 | |4;audio-oscillator;96;99;139;95;95;96;135;95;95;136 05:40:18 INFO - PROCESS | 22140 | |5;imaging-gaussian-blur;110;109;110;111;110;110;109;110;111;110 05:40:18 INFO - PROCESS | 22140 | |6;imaging-darkroom;148;147;147;147;146;146;147;146;146;147 05:40:18 INFO - PROCESS | 22140 | |7;imaging-desaturate;98;97;96;96;95;97;96;97;97;98 05:40:18 INFO - PROCESS | 22140 | |8;json-parse-financial;55;59;55;59;56;58;61;62;53;58 05:40:18 INFO - PROCESS | 22140 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;66;66;64 05:40:18 INFO - PROCESS | 22140 | |10;stanford-crypto-aes;89;82;85;82;85;81;83;81;83;82 05:40:18 INFO - PROCESS | 22140 | |11;stanford-crypto-ccm;109;111;108;111;111;113;116;110;115;114 05:40:18 INFO - PROCESS | 22140 | |12;stanford-crypto-pbkdf2;140;136;138;137;139;137;137;143;142;137 05:40:18 INFO - PROCESS | 22140 | |13;stanford-crypto-sha256-iterative;68;67;64;66;72;70;68;66;66;65 05:40:18 INFO - PROCESS | 22140 | __end_tp_report 05:40:18 INFO - PROCESS | 22140 | __start_cc_report 05:40:18 INFO - PROCESS | 22140 | _x_x_mozilla_cycle_collect,733 05:40:18 INFO - PROCESS | 22140 | __end_cc_report 05:40:18 INFO - PROCESS | 22140 | __startTimestamp1454593218256__endTimestamp 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | ------- Summary: start ------- 05:40:18 INFO - PROCESS | 22140 | Number of tests: 14 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:3.44 (3.1%) stddev-sans-first:3.64 05:40:18 INFO - PROCESS | 22140 | Values: 111.0 106.0 110.0 111.0 112.0 120.0 112.0 111.0 111.0 111.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:151.50 stddev:16.10 (10.6%) stddev-sans-first:16.65 05:40:18 INFO - PROCESS | 22140 | Values: 157.0 140.0 153.0 168.0 128.0 150.0 150.0 128.0 169.0 125.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 05:40:18 INFO - PROCESS | 22140 | Values: 163.0 161.0 162.0 162.0 163.0 163.0 163.0 159.0 164.0 162.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#3] audio-fft Cycles:10 Average:90.80 Median:73.50 stddev:35.70 (48.6%) stddev-sans-first:37.21 05:40:18 INFO - PROCESS | 22140 | Values: 72.0 73.0 73.0 167.0 76.0 75.0 73.0 76.0 149.0 74.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:95.00 stddev:19.77 (20.8%) stddev-sans-first:20.48 05:40:18 INFO - PROCESS | 22140 | Values: 96.0 99.0 139.0 95.0 95.0 96.0 135.0 95.0 95.0 136.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:40:18 INFO - PROCESS | 22140 | Values: 110.0 109.0 110.0 111.0 110.0 110.0 109.0 110.0 111.0 110.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 05:40:18 INFO - PROCESS | 22140 | Values: 148.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.95 (1.0%) stddev-sans-first:0.88 05:40:18 INFO - PROCESS | 22140 | Values: 98.0 97.0 96.0 96.0 95.0 97.0 96.0 97.0 97.0 98.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.50 stddev:2.84 (4.8%) stddev-sans-first:2.85 05:40:18 INFO - PROCESS | 22140 | Values: 55.0 59.0 55.0 59.0 56.0 58.0 61.0 62.0 53.0 58.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 05:40:18 INFO - PROCESS | 22140 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 66.0 66.0 64.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.45 (3.0%) stddev-sans-first:1.50 05:40:18 INFO - PROCESS | 22140 | Values: 89.0 82.0 85.0 82.0 85.0 81.0 83.0 81.0 83.0 82.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#11] stanford-crypto-ccm Cycles:10 Average:111.80 Median:112.00 stddev:2.62 (2.3%) stddev-sans-first:2.57 05:40:18 INFO - PROCESS | 22140 | Values: 109.0 111.0 108.0 111.0 111.0 113.0 116.0 110.0 115.0 114.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:138.50 stddev:2.37 (1.7%) stddev-sans-first:2.46 05:40:18 INFO - PROCESS | 22140 | Values: 140.0 136.0 138.0 137.0 139.0 137.0 137.0 143.0 142.0 137.0 05:40:18 INFO - PROCESS | 22140 | 05:40:18 INFO - PROCESS | 22140 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.39 (3.5%) stddev-sans-first:2.52 05:40:18 INFO - PROCESS | 22140 | Values: 68.0 67.0 64.0 66.0 72.0 70.0 68.0 66.0 66.0 65.0 05:40:18 INFO - PROCESS | 22140 | -------- Summary: end -------- 05:40:18 INFO - PROCESS | 22140 | 05:40:19 INFO - TEST-INFO | 22140: exit 0 05:40:19 INFO - TEST-OK | kraken | took 59010ms 05:40:19 INFO - TEST-START | v8_7 05:40:19 INFO - operating with platform_type : linux_ 05:40:19 INFO - Initialising browser for v8_7 test... 05:40:19 INFO - TEST-INFO | started process 22436 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGl3XwK/profile http://localhost:35986/getInfo.html) 05:40:22 INFO - PROCESS | 22436 | 05:40:22 INFO - PROCESS | 22436 | (process:22519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:23 INFO - PROCESS | 22436 | __metrics Screen width/height:1600/1200 05:40:23 INFO - PROCESS | 22436 | colorDepth:24 05:40:23 INFO - PROCESS | 22436 | Browser inner width/height: 1024/697 05:40:23 INFO - PROCESS | 22436 | __metrics 05:40:24 INFO - TEST-INFO | 22436: exit 0 05:40:24 INFO - Browser initialized. 05:40:24 INFO - Running cycle 1/1 for v8_7 test... 05:40:24 INFO - TEST-INFO | started process 22568 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGl3XwK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:25 INFO - PROCESS | 22568 | 05:40:25 INFO - PROCESS | 22568 | (process:22634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:36 INFO - PROCESS | 22568 | RSS: Main: 140357632 05:40:36 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | Cycle 1(1): loaded http://localhost:35986/tests/v8_7/run.html (next: http://localhost:35986/tests/v8_7/run.html) 05:40:58 INFO - PROCESS | 22568 | RSS: Main: 144564224 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | __start_tp_report 05:40:58 INFO - PROCESS | 22568 | _x_x_mozilla_page_load 05:40:58 INFO - PROCESS | 22568 | _x_x_mozilla_page_load_details 05:40:58 INFO - PROCESS | 22568 | |i|pagename|runs| 05:40:58 INFO - PROCESS | 22568 | |0;Richards;165.80998176090202 05:40:58 INFO - PROCESS | 22568 | |1;DeltaBlue;170.2127659574468 05:40:58 INFO - PROCESS | 22568 | |2;Encrypt;279.09572983533354 05:40:58 INFO - PROCESS | 22568 | |3;Decrypt;5223.958333333333 05:40:58 INFO - PROCESS | 22568 | |4;RayTrace;924.2144177449168 05:40:58 INFO - PROCESS | 22568 | |5;Earley;551.2679162072767 05:40:58 INFO - PROCESS | 22568 | |6;Boyer;11235.955056179775 05:40:58 INFO - PROCESS | 22568 | |7;RegExp;39403.846153846156 05:40:58 INFO - PROCESS | 22568 | |8;Splay;513.083632632119 05:40:58 INFO - PROCESS | 22568 | |9;NavierStokes;4822.115384615385 05:40:58 INFO - PROCESS | 22568 | __end_tp_report 05:40:58 INFO - PROCESS | 22568 | __startTimestamp1454593258846__endTimestamp 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | ------- Summary: start ------- 05:40:58 INFO - PROCESS | 22568 | Number of tests: 10 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 165.8 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#1] DeltaBlue Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 170.2 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 279.1 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 5224.0 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#4] RayTrace Cycles:1 Average:924.21 Median:924.21 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 924.2 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#5] Earley Cycles:1 Average:551.27 Median:551.27 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 551.3 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#6] Boyer Cycles:1 Average:11235.96 Median:11235.96 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 11236.0 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#7] RegExp Cycles:1 Average:39403.85 Median:39403.85 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 39403.8 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#8] Splay Cycles:1 Average:513.08 Median:513.08 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 513.1 05:40:58 INFO - PROCESS | 22568 | 05:40:58 INFO - PROCESS | 22568 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:40:58 INFO - PROCESS | 22568 | Values: 4822.1 05:40:58 INFO - PROCESS | 22568 | -------- Summary: end -------- 05:40:58 INFO - PROCESS | 22568 | 05:40:59 INFO - TEST-INFO | 22568: exit 0 05:40:59 INFO - TEST-OK | v8_7 | took 40526ms 05:40:59 INFO - SUITE-END | took 1207s 05:40:59 INFO - Completed test suite (00:20:08) 05:40:59 INFO - Working with test: dromaeo_css 05:40:59 INFO - Generating results file: dromaeo_css 05:40:59 INFO - Working with test: kraken 05:40:59 INFO - Generating results file: kraken 05:40:59 INFO - javascript benchmark 05:40:59 INFO - Working with test: v8_7 05:40:59 INFO - Generating results file: v8_7 05:40:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:41:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:41:00 INFO - process_Request line: dromaeo_css 7183.59 graph.html#tests=[[72,52,43]] 05:41:00 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:41:00 INFO - process_Request line: kraken 1495.80 graph.html#tests=[[232,52,43]] 05:41:00 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:41:00 INFO - process_Request line: v8_7 22076.72 graph.html#tests=[[230,52,43]] 05:41:00 INFO - RETURN: dromaeo_css: 7183.59 05:41:00 INFO - RETURN: kraken: 1495.80 05:41:00 INFO - RETURN: v8_7: 22076.72 05:41:00 INFO - javascript benchmark 05:41:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3297.3075654112636, 3304.223507475744, 3305.4711246200613, 3337.98331008345, 3338.7495937804656, 5372.382176049756, 5388.892222155555, 5414.91877621836, 5417.702026388547, 5418.349798024237, 5371.81198658047, 5408.945910540893, 5413.485718856712, 5413.756380962856, 5427.213054107152, 4895.46149923509, 4936.925946110793, 4988.625853061017, 5026.924596131061, 5083.3391659084455, 4754.930140718328, 4914.189158788796, 4917.065757506062, 4919.926201106969, 4979.526944940225, 5064.797408103672, 5080.085584594772, 5105.872353191181, 5141.331626888499, 5141.614378921578, 5037.420696619899, 5054.974725126369, 5057.241413787924, 5071.746412679388, 5118.718470484122, 4883.4628190898975, 4964.081644895669, 4980.003999200175, 4987.401511818569, 5049.5455409013, 5277.261183434322, 5285.075111855448, 5389.9191512127345, 5391.73041347931, 5397.082495975694, 5798.304203495565, 5861.88276234473, 5883.764649414018, 5917.31950825652, 5927.851803704899, 5892.381299963485, 5893.381194974551, 5926.525877929756, 5927.170196172539, 5972.611780234271, 5428.0, 5478.096114141162, 5483.7806487740445, 5501.697406642633, 5519.2824932758485, 5872.412758724094, 5910.8817823643285, 5925.644461332334, 5930.406959304035, 5964.612300200473, 5779.2775903012125, 5795.768169273182, 5853.9414605854245, 5869.7945571904775, 5875.559333050039, 5792.594518383757, 5818.069108942549, 5824.417558244142, 5829.44620261083, 5862.120681897664, 5872.853178670482, 5927.9703601481715, 5957.642541447527, 5968.612040217459, 6008.3390827009, 5730.828075157752, 5794.942050579441, 5828.417158284223, 5931.08068249422, 5973.522118230531, 4483.327500874895, 4500.459944806644, 4505.031418245093, 4510.954890451119, 4516.1419330327135, 3991.92016159681, 4027.234825383168, 4033.576474470197, 4043.5147782265726, 4049.4128351389472, 5476.890462190734, 5556.111022236423, 5570.359408667974, 5613.382527922007, 5642.322921249476, 5982.341942386334, 5982.9401705983255, 5984.371640977634, 5993.970030149909, 6032.939670603326, 5658.377578466366, 5679.2333035040565, 5683.147527870852, 5685.857853553694, 5696.544276457957, 4937.851864444073, 4995.150824359867, 5003.199488081889, 5012.298278241049, 5034.723090230073, 6114.996965385453, 6117.847053823601, 6121.357257487989, 6127.097902969301, 6137.7851775187655, 5947.375525569752, 5979.043353063489, 5980.162777211194, 5991.161237426851, 5991.910121348271, 6087.36082711309, 6104.633721976696, 6119.045604113885, 6126.142340072304, 6140.3552626975315, 5854.414558544111, 5896.8820623586425, 5908.025175846109, 5909.113632955091, 5924.970375148269, 5963.165156878127, 5971.940280597312, 5977.6114552553945, 5998.670073146019, 6018.939810601838, 5487.176923461353, 5533.750981205775, 5575.581831362745, 5769.94230057694, 5819.330776960704, 5814.592978491634, 5819.0, 5837.5038121758425, 5845.8538536535225, 5855.795047173328, 5699.772009119589, 5705.172749951151, 5724.141378793214, 5729.2265544151005, 5745.339285981999, 5666.433356664301, 5697.7436015380235, 5751.971240143773, 5845.18167456565, 5853.94146058534, 5597.244372009726, 5605.215269862141, 5620.0, 5646.237757902631, 5657.9151312731165], "unit": "score", "name": "dojo.html", "value": 5433.120500633023}, {"lowerIsBetter": false, "replicates": [555.633282033858, 557.2198921509886, 575.1602660116231, 581.1805354450227, 590.4095904095905, 36320.63679363205, 37951.24097518048, 37955.240895182076, 37955.81022094889, 38021.42967855484, 41275.79362103185, 41374.379384309184, 41674.0, 41786.79106604463, 41855.790721046425, 8731.95634021829, 8890.777730556756, 8923.15230053144, 8928.73213803587, 8931.062238464965, 8483.278921291698, 8640.65437382504, 8644.827103457927, 8839.867401988975, 8864.556772161399, 8715.825683486326, 8824.294056475466, 8877.600507977124, 8907.777305567348, 8912.688055918044, 8706.738797836075, 8725.869111963293, 8763.868541971875, 8803.823923521526, 8835.955820220923, 8753.518556479392, 8885.200331970154, 8900.243479304267, 8901.554922253861, 8968.686095986674, 41361.79319103385, 41754.373684394755, 41844.1631167378, 42073.78963105165, 42109.57890421087, 3416.777909435879, 3532.417151170054, 3622.710183185339, 3640.1445660269815, 4173.227952828706, 28327.858360708065, 28360.00739974091, 28699.56950645742, 28776.60581069904, 29442.70557294421, 4108.465899433085, 4122.40225167349, 4152.1072969311745, 4172.91654166918, 4174.290370636969, 262246.0, 265553.0, 266726.0, 267120.0, 267158.0, 43928.78035609866, 44168.3374749379, 44524.554754452685, 44563.0, 44654.553454465036, 42229.15541689211, 42420.0, 42564.787176063925, 42822.143557128686, 42904.78547607242, 14952.925235373754, 15047.849521504864, 15138.772918406232, 15149.848501514844, 15251.923740381228, 11410.42947852604, 11550.768984620428, 11591.536338546532, 11608.071354291806, 12130.939345303217, 15144.636982671393, 15199.620009499851, 15235.314410851539, 15287.388504459697, 15317.770233446507, 6116.60242084272, 6187.288461826857, 6235.314115447297, 6249.156363890907, 6264.59280146789, 1069.2835800014009, 1082.258652822819, 1089.4334945828125, 1104.5857803323754, 1183.8102706779803, 32953.505697414555, 33174.3365132696, 33321.333573328884, 33467.66532334694, 33896.15259618529, 1087.9564817407215, 1182.798924182891, 1209.1838009343658, 1216.2398500936915, 1223.25992774372, 15135.697286054217, 16231.26959286835, 17157.485275441755, 17169.656606867793, 17464.563385915455, 452166.0, 519311.0, 532865.0, 532912.0, 532989.0, 56691.71654141703, 57664.42335576675, 58003.83992320214, 58133.70933145307, 58204.41795582075, 1449.7535418978798, 1464.2459133546233, 1467.8238611366492, 1467.9119252844864, 1475.0928179169734, 30840.383192336478, 31661.0, 31678.208044799063, 31696.0, 32187.35625287528, 47153.292700608836, 47875.28187077266, 48108.759456203894, 48414.515854841, 48421.75789121032, 268942.0, 269812.0, 271766.0, 273091.0, 273133.0, 33260.33479330448, 33280.667193327754, 33594.66405336013, 33670.66329336675, 33907.15232119217, 47880.521194789, 47899.76050119727, 48347.51652483571, 48837.75581122072, 49269.50730492792, 37792.244155117296, 38619.42070868883, 39464.4409667877, 39729.2054158921, 39850.40224396694, 39051.609483904795, 39775.40336894891, 39823.2035359297, 40263.59736402598, 42897.35653965255, 36484.45273320955, 36991.44512832256, 37248.6275137256, 37248.81375593105, 37420.0, 35683.64316356907, 36068.4589731149, 36311.0, 36562.26875462422, 37504.0, 26325.86837065879, 27524.174274771787, 27664.723352766214, 27679.44641107126, 27722.72277277282], "unit": "score", "name": "ext.html", "value": 18904.51827321661}, {"lowerIsBetter": false, "replicates": [390.51771062737515, 392.62896562748205, 393.23908237560306, 398.5436675007117, 400.1966226582787, 14435.927820360883, 14951.327190276465, 17925.641487170265, 18477.353292634743, 18506.90746546267, 11371.374574398405, 11647.592334268302, 16022.519324420256, 17733.290668373284, 17765.28938842448, 5074.594032477411, 5358.2498450217, 5516.889662206753, 5523.088690366085, 5532.585056120787, 3886.980565097185, 4290.935635965463, 5424.186372044205, 5646.717664116798, 5686.800961966332, 5322.387925388591, 5618.4662457066715, 5623.212750214973, 5629.155626656014, 5675.744591493372, 5285.312909321802, 5396.406395296514, 5397.7571009304675, 5439.265699130646, 5459.754311055992, 5466.125419932831, 5512.6692398456225, 5553.194786755938, 5589.664620122806, 5603.187537806995, 12904.54834080812, 16389.59026024347, 20022.89874056941, 21255.36233912985, 21264.787352126434, 2170.240415854454, 2199.8900054997184, 2270.931872043825, 2378.797802186816, 2437.890294936732, 9776.51117444132, 9832.508374581243, 9868.80262394748, 10139.391636501834, 10170.745731356701, 1949.9220031198736, 1950.8439324853978, 1963.1165975311023, 1984.6824508078782, 2006.9197232110698, 60168.09747853786, 61036.389636103515, 61973.690131549505, 62343.6882815583, 63157.68421157911, 10313.0, 10634.893651063545, 10729.83905241422, 10733.355998640107, 10811.945940270249, 14104.833763034274, 14193.503227387198, 14219.573412797632, 14223.146611203361, 14301.856981430261, 7419.629018549051, 7555.471117021865, 7740.574268415291, 7760.767176984699, 7773.455858089879, 7381.040464739657, 7406.111266648037, 7421.220771818989, 7441.925580744231, 7479.401647868158, 4443.733375997451, 4553.817847286072, 4603.746793926366, 4628.120657075145, 4657.743824089707, 1818.2545156485778, 1956.1979588368702, 1965.508622844289, 1988.6519859024613, 1994.9401517954484, 472.3222176177197, 992.4789485520159, 999.8450240212778, 1015.8679371681634, 1105.3533682795655, 10774.138068954622, 10842.0, 10919.344839309666, 11030.393328367018, 11055.170862185369, 451.97740112994217, 463.6684770389188, 471.5355374955666, 475.2728325661743, 490.35273439060813, 5954.345022047572, 6116.327204007555, 6169.784057557964, 9861.506924653739, 10316.690499285034, 572510.0, 577706.0, 582676.0, 583399.0, 622645.0, 73309.26690733024, 76672.0, 76905.61547192228, 77684.0, 80399.0, 1161.4715304536417, 1206.0291465370285, 1209.8929479526312, 1211.4185191108318, 1217.34263497712, 15776.684466310839, 15795.447159349367, 15888.841111589198, 16049.839501604834, 16165.67668646597, 34427.4835877457, 35007.824960875034, 35765.82117089398, 35963.1009224761, 36161.27677446489, 44775.55224447714, 46683.53316466928, 46690.533094668615, 46759.29861052019, 48807.75596121997, 7222.205557388788, 7622.466427350254, 7678.61606919663, 7768.7669369918995, 7793.337566306927, 10708.73228169302, 10967.780644387227, 11258.83111753308, 11309.71725706864, 11475.885241147482, 9546.18857397129, 9882.85175722379, 9978.600855965971, 10049.196064314983, 10111.140553053074, 9684.903150968681, 10092.394456332644, 10193.643222487177, 10361.585536578452, 10424.947875260576, 10547.630832920811, 10550.0, 10579.62971296001, 10603.204759643211, 10736.355818650905, 7741.341985931259, 8007.919920800718, 8013.15861834499, 8024.638891249791, 8047.637856296364, 9390.974004017666, 9815.607375705178, 9841.704748857546, 10074.44590547527, 10487.475626218811], "unit": "score", "name": "jquery.html", "value": 8156.673604230811}, {"lowerIsBetter": false, "replicates": [1534.9232538373083, 1549.3802479008398, 1650.9504714858551, 1740.9477715668534, 1752.5005373468564, 8043.155468675793, 8135.837283254331, 8205.097439281673, 8274.958625206873, 8320.084790673021, 8237.794055148624, 8276.83446331073, 8308.70919517817, 8318.251357377834, 8359.164083591639, 2461.249318957717, 2491.028498885427, 2491.1405565080017, 2491.638712386712, 2496.750324967507, 2483.1681386735377, 2547.0957809977467, 2578.4843031393702, 2580.9225723228333, 2588.184721812623, 2022.5449273913325, 2044.0597325230412, 2339.1345202275097, 2457.041753716052, 2495.862727549984, 2409.3615191974054, 2438.1588352018525, 2444.6699695541142, 2452.0559584559896, 2459.274514018369, 2400.195934361991, 2454.1778504201116, 2454.631805229212, 2455.177515532299, 2456.066694656019, 8169.387295952827, 8235.38234632399, 8239.505629662239, 8274.875876861852, 8298.751037468886, 4848.903021939576, 4995.650304478688, 4998.975210081924, 5014.523620256106, 5026.974865125688, 3226.2740883301303, 3296.307775367152, 3336.08257729124, 3357.446021406465, 3393.694567488938, 1135.727425417902, 1151.1251448898813, 1155.895969362753, 1161.5644133449957, 1185.1822242652543, 11245.325280483115, 11489.368084755335, 11501.712457188554, 11505.13711471643, 11513.539458421654, 4471.038726673716, 4495.483019452805, 4509.436320459942, 4516.322551617283, 4547.772611369418, 8870.778230544289, 8922.910770892338, 8967.955160224288, 9025.0, 9311.72064838056, 5025.045241404122, 5050.217216331474, 5061.493850614909, 5072.340595722606, 5077.949220507821, 4619.976900115478, 4643.744594047293, 4660.580547750718, 4678.0, 4729.9054018920115, 3732.346839303111, 3761.435784632327, 3774.962250377516, 3787.8106094695154, 3803.5625903020955, 1135.1316243074054, 1159.8898104680043, 1169.1231576317762, 1175.488662431845, 1177.8645455772526, 1067.588978243382, 1072.1369297715257, 1083.0577397664083, 1267.499337761579, 1389.805427240187, 7342.229065948105, 7391.963040184764, 7463.0, 7499.475036747375, 7627.69489220436, 1189.452851688233, 1189.7025743564109, 1191.2257032928667, 1201.0331682995097, 1205.1021988618536, 5975.850603734854, 6001.729922153426, 6012.549058820518, 6035.1249068885645, 6065.514758819284, 9779.804403912025, 10282.0, 10344.32761870476, 10387.584496620051, 10469.476526173661, 10003.24975626831, 10163.644272450429, 10183.0, 10277.0, 10298.279120461646, 7687.846243075107, 7788.415868809749, 7791.415643826849, 7800.102988156435, 7848.0, 7396.334329910119, 7498.62506874665, 7503.88744168827, 7573.129090154703, 7574.697012119454, 8896.154865287788, 9059.592318345558, 9066.456012639263, 9149.176574108362, 9245.768855778659, 9234.492102934135, 9274.026227246311, 9296.0, 9299.814003719752, 9643.710688679352, 6879.346462086094, 7007.649617519001, 7061.293870612898, 7084.079069720903, 7100.0, 7921.603919803872, 8017.599120044091, 8058.113607503287, 8073.798155046171, 8084.231997960184, 7128.893066603901, 7388.0, 7388.778336649909, 7401.148867880047, 7562.886556701544, 6774.119364482585, 6844.939034449668, 6944.652767361713, 6973.4072603829245, 7001.299870012958, 7181.317774811385, 7192.748253811092, 7199.1361036675935, 7204.56772593646, 7251.854962900818, 6312.842178945563, 6361.522885783492, 6374.776882809079, 6376.075469056868, 6376.171097757262, 6668.966655166693, 6671.33286671329, 6806.285340039224, 6871.209810871814, 6910.343517365842], "unit": "score", "name": "mootools.html", "value": 4741.454359623934}, {"lowerIsBetter": false, "replicates": [358.1440357545466, 366.3095065800964, 368.94281386385086, 369.66175949006663, 377.5827710380028, 6216.222972128484, 6239.313675495698, 6295.811125666238, 6405.871882562346, 6434.549581529295, 6173.845653858656, 6266.279377871546, 6301.6849157542165, 6342.714577844008, 6371.299157092716, 4775.188218002939, 4832.0335932813405, 4856.538628830255, 4877.731724755137, 4884.706917584938, 4859.829905953292, 4880.341153944208, 4886.560209581137, 4895.0944075346, 4909.091818013661, 4658.86023419298, 4710.3405523226775, 4740.312654665088, 4765.976170119162, 4781.976090119544, 4743.976280118612, 4745.525447455244, 4752.049590081998, 4756.453007904101, 4756.476787553366, 4174.123434078847, 4199.391088292181, 4201.936970945439, 4218.725782824106, 4238.961454443681, 5893.723150240005, 5941.138534912414, 5942.316633587149, 5955.315138759055, 5978.342382337939, 5601.103823388238, 5634.943650563483, 5651.519620832193, 5667.319921609434, 5671.943280567183, 6697.196336439659, 6707.731690732365, 6709.127813384229, 6712.765053223163, 6757.290484499106, 4650.441946966385, 4660.557247061523, 4676.5089665584965, 4704.388429504177, 4711.4346278446465, 6883.036374907517, 6970.442364610819, 7036.577805331696, 7047.823804404879, 7065.081539399896, 4798.0, 4835.58897493717, 4841.104395686809, 4846.781894814671, 4848.660593758474, 4907.533784290486, 4912.312276281324, 4916.483769204254, 4919.631027672939, 4932.235503496964, 5560.944390556124, 5656.095024796013, 5668.801591944262, 5670.943290567124, 5673.375928647845, 6814.114165158498, 6838.692258848364, 6846.938724497711, 6854.485913556503, 6854.691538880663, 1683.2257161705509, 1714.562786489462, 1714.8285171482753, 1716.828317168273, 1720.5096547483906, 1139.5441823270758, 1149.0348107589664, 1157.288267715349, 1166.457597217281, 1174.1956759619688, 6403.967980160162, 6404.0467657364015, 6411.6153030818305, 6419.2938776735455, 6423.293437721847, 6843.726250949906, 6868.107146071079, 6875.243723190445, 6888.862222755517, 6895.482838787011, 6287.2769631492965, 6319.241690997018, 6382.553221274559, 6425.132607097982, 6432.2281326241155, 3714.53568303962, 3745.0824547985917, 3747.831347589365, 3747.8500859965843, 3750.7937063461227, 7124.786256412316, 7138.464615153885, 7144.0, 7153.4992550522, 7153.7138514459875, 6924.896126558106, 6986.615736134561, 7057.435405167575, 7110.466714996396, 7120.572765633975, 7064.399526040344, 7101.11236095488, 7115.252898445692, 7126.182823380109, 7148.39238664709, 6890.621015844176, 6912.447004239548, 6968.6864091115, 6972.651367431709, 6972.895406568804, 6692.6988285526295, 6806.965965170142, 6827.965860170667, 6832.0435139081565, 6842.657867106525, 7117.395021423237, 7131.144262688511, 7134.607596582237, 7138.714451421885, 7161.319674630901, 4791.089692958327, 4801.063792560417, 4820.30105634674, 4832.44426890912, 4833.927491087707, 6779.118714567075, 6881.587104773729, 6886.276940921131, 6893.414059804973, 6898.724051038103, 6633.270340262471, 6702.765403210864, 6704.229013663296, 6714.060031595678, 6716.462682985251, 6639.7012134455035, 6641.568298060611, 6644.435223006099, 6693.698783554654, 6718.865622687421, 6421.646809425526, 6549.672516374258, 6568.277489476058, 6575.178102737158, 6585.341465853568, 6700.631465269262, 6701.731930722912, 6718.126643536309, 6735.158105236846, 6740.73037078531, 6496.610203387623, 6516.989866570689, 6565.179352580927, 6568.638724870178, 6572.572782769104], "unit": "score", "name": "prototype.html", "value": 5068.095666631803}, {"lowerIsBetter": false, "replicates": [796.2276591706043, 819.9262066414024, 865.1132589096179, 878.0517041595078, 879.0989236033066, 13655.31723413829, 13693.794593081087, 13753.518626848063, 13820.101693389923, 13847.792283115748, 13119.803202951964, 13366.66583335417, 15481.0, 15569.922150389231, 15574.922125389385, 889.5818965086415, 906.4063038709655, 909.3407279722181, 910.1899309614448, 913.0276255787599, 900.918917297443, 909.9363044586881, 915.094056883687, 915.3089417489786, 918.347972939214, 951.7858481841599, 964.0552258786358, 966.5215718219491, 969.093897206111, 973.5764942250108, 949.5157469690473, 952.3333666433524, 956.5647630328253, 961.4375590279625, 963.2438535749438, 697.6023666510041, 704.2781149321935, 705.5801797930275, 706.5866468116159, 708.7802781137813, 13910.234937078456, 13972.790408143886, 14179.645508862257, 14331.78502322466, 14338.928305358511, 13042.804357934638, 13049.543265985645, 13161.144525605901, 13191.472341106344, 13751.862481375258, 11640.243384180001, 11748.236364636272, 11886.821697674543, 11968.281903085755, 12250.571230006906, 4529.932051019205, 4572.154151481986, 4599.264117741145, 4600.493945665974, 4650.558196971282, 53691.731541342044, 53935.19097213506, 54698.453015470135, 54929.0, 55080.724596377164, 11014.339139651647, 11097.778044439066, 11121.332720036662, 11135.164862635334, 11316.094712422986, 18822.71765923512, 19001.619967600847, 19052.0, 19080.33218837334, 19109.331173408864, 7926.286634202949, 7957.5225486471, 8145.104038555754, 8378.874316885252, 8638.956805215934, 4399.142167277414, 4430.601245887886, 4458.777061146994, 4488.461384633865, 4521.615662668644, 3214.164317277525, 3219.4526930421885, 3257.38109759145, 3266.3304022675293, 3282.638909719929, 565.926429564154, 567.9943200567941, 572.8796952639909, 577.9450952159622, 579.4408395897979, 580.3326174898816, 590.1649166429454, 595.5414330965133, 653.3792896748108, 687.2886562407883, 9056.411333263317, 9067.0, 9128.041555636695, 9257.490838003974, 9319.254459643213, 566.583561082604, 606.824021033904, 644.6841047886595, 647.6923461355818, 655.1777519213357, 4247.8088486018205, 4324.654027677841, 4362.629176519968, 4407.515173330931, 4454.0, 57167.42832571704, 59294.407055929754, 59777.402225978054, 60523.69738151281, 60531.394686053456, 50750.0, 53590.7320463403, 53722.0, 57339.0, 60319.39680603138, 48520.7573962135, 48881.26678099831, 49116.50883491191, 49227.75386123046, 49359.25961110586, 9567.856482152913, 9573.18627916607, 9654.806903862023, 9766.267529935141, 9900.50497475109, 33656.0, 34907.4763878537, 35246.471302930986, 35348.29303413866, 35401.291974160886, 44718.3292250623, 48569.5143048565, 48578.51421485881, 48978.26532601943, 49062.75468622634, 11562.88437115618, 11893.881061189277, 12058.276503409823, 12148.088893333212, 12222.388880556115, 13289.468421263042, 13609.795853062014, 13796.862031379958, 14076.859231407554, 14310.356033978704, 12615.558455454382, 12701.87298127007, 12828.935855321037, 12850.228986260854, 13311.334433278103, 11813.588320090197, 12124.75750485003, 12127.393630318626, 12177.391130443266, 12913.418896149507, 11788.882111179122, 12266.570670026505, 12280.26318420862, 12323.0, 12432.502699891904, 10023.949880250551, 10026.097651211427, 10321.896781032094, 10376.533056012346, 10703.090237329914, 10431.843522347323, 10839.945800270949, 10956.181238135912, 11041.889581104086, 11058.060064894253], "unit": "score", "name": "yui.html", "value": 6825.439078331963}], "name": "dromaeo_css", "value": 7183.590293472477}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 111.0, 112.0, 120.0, 112.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [157.0, 140.0, 153.0, 168.0, 128.0, 150.0, 150.0, 128.0, 169.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 162.0, 163.0, 163.0, 163.0, 159.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 167.0, 76.0, 75.0, 73.0, 76.0, 149.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 139.0, 95.0, 95.0, 96.0, 135.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 97.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 55.0, 59.0, 56.0, 58.0, 61.0, 62.0, 53.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 66.0, 66.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [89.0, 82.0, 85.0, 82.0, 85.0, 81.0, 83.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 108.0, 111.0, 111.0, 113.0, 116.0, 110.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.8}, {"lowerIsBetter": true, "replicates": [140.0, 136.0, 138.0, 137.0, 139.0, 137.0, 137.0, 143.0, 142.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 64.0, 66.0, 72.0, 70.0, 68.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1495.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [170.2127659574468], "unit": "score", "name": "DeltaBlue", "value": 388.4432500000001}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [924.2144177449168], "unit": "score", "name": "RayTrace", "value": 800.6680980000003}, {"lowerIsBetter": false, "replicates": [551.2679162072767], "unit": "score", "name": "Earley", "value": 1208.9638819999998}, {"lowerIsBetter": false, "replicates": [11235.955056179775], "unit": "score", "name": "Boyer", "value": 59.315206999999965}, {"lowerIsBetter": false, "replicates": [39403.846153846156], "unit": "score", "name": "RegExp", "value": 23.119189848706686}, {"lowerIsBetter": false, "replicates": [513.083632632119], "unit": "score", "name": "Splay", "value": 158.82595899999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22076.72454761345}]} 05:41:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22076.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7183.59"}}} 05:41:00 INFO - Return code: 0 05:41:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:41:00 INFO - # TBPL SUCCESS # 05:41:00 INFO - Running post-action listener: _resource_record_post_action 05:41:00 INFO - Running post-run listener: _resource_record_post_run 05:41:01 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497725440; Read time: 116; Write time: 499096 05:41:01 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 239243264; Read time: 0; Write time: 303548 05:41:01 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257961984; Read time: 116; Write time: 195504 05:41:01 INFO - Running post-run listener: _upload_blobber_files 05:41:01 INFO - Blob upload gear active. 05:41:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:41:01 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:41:01 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:41:01 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:41:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:41:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:02 INFO - (blobuploader) - INFO - Done attempting. 05:41:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:41:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:41:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:03 INFO - (blobuploader) - INFO - Done attempting. 05:41:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:03 INFO - Return code: 0 05:41:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:41:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/200b1c7196f8c202e11104661130b91c42408ead46b1e8bd75558ef1b3a34b1ae5cfb300161710cc60d089b397c485fa55e48a7897441c5e227d16238aad7482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e6c6f8ac8a707e574ecc6118f9492848477470b33b628e30e4e38ffe24c69bea4733b2b2dbd8f14f2aaca61670b879ed87ba8f7c8ef08deb633e0a3b1eedf9"} 05:41:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:41:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:41:03 INFO - Contents: 05:41:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/200b1c7196f8c202e11104661130b91c42408ead46b1e8bd75558ef1b3a34b1ae5cfb300161710cc60d089b397c485fa55e48a7897441c5e227d16238aad7482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e6c6f8ac8a707e574ecc6118f9492848477470b33b628e30e4e38ffe24c69bea4733b2b2dbd8f14f2aaca61670b879ed87ba8f7c8ef08deb633e0a3b1eedf9"} 05:41:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:03 INFO - Copying logs to upload dir... 05:41:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:41:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.044451 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-04 05:41:01.875417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 05:41:01.879906) ========= 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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 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/200b1c7196f8c202e11104661130b91c42408ead46b1e8bd75558ef1b3a34b1ae5cfb300161710cc60d089b397c485fa55e48a7897441c5e227d16238aad7482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e6c6f8ac8a707e574ecc6118f9492848477470b33b628e30e4e38ffe24c69bea4733b2b2dbd8f14f2aaca61670b879ed87ba8f7c8ef08deb633e0a3b1eedf9"} build_url:https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/RZkjc1P7SBSgxAvJSbnA1g/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/200b1c7196f8c202e11104661130b91c42408ead46b1e8bd75558ef1b3a34b1ae5cfb300161710cc60d089b397c485fa55e48a7897441c5e227d16238aad7482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e6c6f8ac8a707e574ecc6118f9492848477470b33b628e30e4e38ffe24c69bea4733b2b2dbd8f14f2aaca61670b879ed87ba8f7c8ef08deb633e0a3b1eedf9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 05:41:01.910205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:41:01.910622) ========= 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=33d5923976266a1c518c4bf7000001ab-1454591976.994353-28197485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 05:41:01.990877) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 05:41:01.991201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 05:41:01.994771) ========= ========= Total master_lag: 0.30 =========