builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1453989613.93 results: success (0) buildid: 20160128030208 builduid: 39b27016497340c39510ceec0a698967 revision: 0ecd7d72f232304da046b352c457e039e35ceed7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.934112) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.934872) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.935378) ========= 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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006440 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.968790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.969334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.009139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.009393) ========= 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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.058730) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.059091) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.059512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.059837) ========= 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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-28 06:00:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-28 06:00:15 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.191311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.191634) ========= 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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.245732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.246073) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ecd7d72f232304da046b352c457e039e35ceed7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ecd7d72f232304da046b352c457e039e35ceed7 --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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-28 06:00:15,209 truncating revision to first 12 chars 2016-01-28 06:00:15,209 Setting DEBUG logging. 2016-01-28 06:00:15,209 attempt 1/10 2016-01-28 06:00:15,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ecd7d72f232?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-28 06:00:15,475 unpacking tar archive at: mozilla-central-0ecd7d72f232/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.828616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.828963) ========= echo 0ecd7d72f232304da046b352c457e039e35ceed7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0ecd7d72f232304da046b352c457e039e35ceed7'] 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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0ecd7d72f232304da046b352c457e039e35ceed7 program finished with exit code 0 elapsedTime=0.003341 script_repo_revision: '0ecd7d72f232304da046b352c457e039e35ceed7' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.876142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.876463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:14.886523) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-28 06:00:14.886884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:15 INFO - MultiFileLogger online at 20160128 06:00:15 in /builds/slave/test-pgo 06:00:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:00:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:00:15 INFO - {'append_to_log': False, 06:00:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:00:15 INFO - 'blob_upload_branch': 'Firefox', 06:00:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:00:15 INFO - 'branch': 'Firefox', 06:00:15 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:15 INFO - 'config_files': ('talos/linux_config.py',), 06:00:15 INFO - 'default_actions': ('clobber', 06:00:15 INFO - 'read-buildbot-config', 06:00:15 INFO - 'download-and-extract', 06:00:15 INFO - 'populate-webroot', 06:00:15 INFO - 'create-virtualenv', 06:00:15 INFO - 'install', 06:00:15 INFO - 'run-tests'), 06:00:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:15 INFO - 'download_minidump_stackwalk': True, 06:00:15 INFO - 'download_symbols': 'ondemand', 06:00:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:15 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:15 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:15 INFO - 'installer_path': 'installer.exe', 06:00:15 INFO - 'log_level': 'info', 06:00:15 INFO - 'log_name': 'talos', 06:00:15 INFO - 'log_to_console': True, 06:00:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:15 INFO - 'opt_config_files': (), 06:00:15 INFO - 'pip_index': False, 06:00:15 INFO - 'sps_profile': False, 06:00:15 INFO - 'sps_profile_interval': 0, 06:00:15 INFO - 'suite': 'dromaeojs-e10s', 06:00:15 INFO - 'system_bits': '32', 06:00:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:15 INFO - 'title': 'talos-linux64-ix-025', 06:00:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:15 INFO - 'use_talos_json': True, 06:00:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:00:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:15 INFO - 'work_dir': 'build'} 06:00:15 INFO - ##### 06:00:15 INFO - ##### Running clobber step. 06:00:15 INFO - ##### 06:00:15 INFO - Running pre-action listener: _resource_record_pre_action 06:00:15 INFO - Running main action method: clobber 06:00:15 INFO - rmtree: /builds/slave/test-pgo/build 06:00:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:00:16 INFO - Running post-action listener: _resource_record_post_action 06:00:16 INFO - ##### 06:00:16 INFO - ##### Running read-buildbot-config step. 06:00:16 INFO - ##### 06:00:16 INFO - Running pre-action listener: _resource_record_pre_action 06:00:16 INFO - Running main action method: read_buildbot_config 06:00:16 INFO - Using buildbot properties: 06:00:16 INFO - { 06:00:16 INFO - "project": "", 06:00:16 INFO - "product": "firefox", 06:00:16 INFO - "script_repo_revision": "production", 06:00:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:00:16 INFO - "repository": "", 06:00:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:00:16 INFO - "buildid": "20160128030208", 06:00:16 INFO - "stage_platform": "linux64-pgo", 06:00:16 INFO - "basedir": "/builds/slave/test-pgo", 06:00:16 INFO - "nightly_build": "True", 06:00:16 INFO - "buildnumber": 333, 06:00:16 INFO - "slavename": "talos-linux64-ix-025", 06:00:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:00:16 INFO - "platform": "ubuntu64_hw", 06:00:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:00:16 INFO - "branch": "mozilla-central", 06:00:16 INFO - "repo_path": "mozilla-central", 06:00:16 INFO - "revision": "0ecd7d72f232304da046b352c457e039e35ceed7", 06:00:16 INFO - "pgo_build": "True", 06:00:16 INFO - "builduid": "39b27016497340c39510ceec0a698967", 06:00:16 INFO - "slavebuilddir": "test" 06:00:16 INFO - } 06:00:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:00:16 INFO - Running post-action listener: _resource_record_post_action 06:00:16 INFO - ##### 06:00:16 INFO - ##### Running download-and-extract step. 06:00:16 INFO - ##### 06:00:16 INFO - Running pre-action listener: _resource_record_pre_action 06:00:16 INFO - Running main action method: download_and_extract 06:00:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:16 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json 06:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json 06:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:00:24 INFO - Downloaded 1448 bytes. 06:00:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:00:24 INFO - Using the following test package requirements: 06:00:24 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:00:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'jsshell-linux-x86_64.zip'], 06:00:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:24 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00:24 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')]} 06:00:24 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:29 INFO - Downloaded 22503314 bytes. 06:00:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:00:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:00:30 INFO - Return code: 0 06:00:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:00:30 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')]} 06:00:30 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:31 INFO - Downloaded 22503314 bytes. 06:00:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:00:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:00:32 INFO - Return code: 0 06:00: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')]} 06:00:32 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:00:33 INFO - Downloaded 10706572 bytes. 06:00:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:00:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:00:34 INFO - Return code: 0 06:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:34 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:00:36 INFO - Downloaded 55991278 bytes. 06:00:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:36 INFO - mkdir: /builds/slave/test-pgo/properties 06:00:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:00:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:00:36 INFO - Contents: 06:00:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:36 INFO - Running post-action listener: _resource_record_post_action 06:00:36 INFO - Running post-action listener: set_extra_try_arguments 06:00:36 INFO - ##### 06:00:36 INFO - ##### Running populate-webroot step. 06:00:36 INFO - ##### 06:00:36 INFO - Running pre-action listener: _resource_record_pre_action 06:00:36 INFO - Running main action method: populate_webroot 06:00:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:36 INFO - '--tppagecycles', 06:00:36 INFO - '7'], 06:00:36 INFO - 'tests': ['tsvgm']}}, 06:00:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:00:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'tests': ['damp', 'tps']}, 06:00:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['damp', 'tps']}, 06:00:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:00:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:36 INFO - 'other': {'tests': ['a11yr', 06:00:36 INFO - 'ts_paint', 06:00:36 INFO - 'tpaint', 06:00:36 INFO - 'sessionrestore', 06:00:36 INFO - 'sessionrestore_no_auto_restore']}, 06:00:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['a11yr', 06:00:36 INFO - 'ts_paint', 06:00:36 INFO - 'tpaint', 06:00:36 INFO - 'sessionrestore', 06:00:36 INFO - 'sessionrestore_no_auto_restore']}, 06:00:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['a11yr', 06:00:36 INFO - 'ts_paint', 06:00:36 INFO - 'tpaint', 06:00:36 INFO - 'sessionrestore', 06:00:36 INFO - 'sessionrestore_no_auto_restore']}, 06:00:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['a11yr', 06:00:36 INFO - 'ts_paint', 06:00:36 INFO - 'tpaint', 06:00:36 INFO - 'sessionrestore', 06:00:36 INFO - 'sessionrestore_no_auto_restore']}, 06:00:36 INFO - 'other_l64': {'tests': ['a11yr', 06:00:36 INFO - 'ts_paint', 06:00:36 INFO - 'tpaint', 06:00:36 INFO - 'sessionrestore', 06:00:36 INFO - 'sessionrestore_no_auto_restore']}, 06:00:36 INFO - 'other_nol64': {'tests': ['a11yr', 06:00:36 INFO - 'ts_paint', 06:00:36 INFO - 'tpaint', 06:00:36 INFO - 'sessionrestore', 06:00:36 INFO - 'sessionrestore_no_auto_restore']}, 06:00:36 INFO - 'svgr': {'tests': ['tsvgx', 06:00:36 INFO - 'tsvgr_opacity', 06:00:36 INFO - 'tart', 06:00:36 INFO - 'tscrollx', 06:00:36 INFO - 'cart']}, 06:00:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['tsvgx', 06:00:36 INFO - 'tsvgr_opacity', 06:00:36 INFO - 'tart', 06:00:36 INFO - 'tscrollx', 06:00:36 INFO - 'cart']}, 06:00:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'tests': ['tp5o']}, 06:00:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'talos_options': ['--e10s'], 06:00:36 INFO - 'tests': ['tp5o']}, 06:00:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'talos_options': ['--xperf_path', 06:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:36 INFO - 'tests': ['tp5n']}, 06:00:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:36 INFO - 'talos_options': ['--e10s', 06:00:36 INFO - '--xperf_path', 06:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:36 INFO - 'tests': ['tp5n']}}, 06:00:36 INFO - 'talos.zip': {'path': '', 06:00:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:36 INFO - Running post-action listener: _resource_record_post_action 06:00:36 INFO - ##### 06:00:36 INFO - ##### Running create-virtualenv step. 06:00:36 INFO - ##### 06:00:36 INFO - Running pre-action listener: _resource_record_pre_action 06:00:36 INFO - Running main action method: create_virtualenv 06:00:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:00:36 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 06:00:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:00:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:37 INFO - Using real prefix '/usr' 06:00:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:00:37 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:39 INFO - Installing pip.................done. 06:00:39 INFO - Return code: 0 06:00:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:39 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:39 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 06:00:39 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 06:00:39 INFO - Using env: {'DISPLAY': ':0', 06:00:39 INFO - 'HOME': '/home/cltbld', 06:00:39 INFO - 'LANG': 'en_US.UTF-8', 06:00:39 INFO - 'LANGUAGE': 'en_US:en', 06:00:39 INFO - 'LOGNAME': 'cltbld', 06:00:39 INFO - 'MAIL': '/var/mail/cltbld', 06:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:39 INFO - 'MOZ_NO_REMOTE': '1', 06:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:39 INFO - 'NO_EM_RESTART': '1', 06:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:39 INFO - 'SHELL': '/bin/bash', 06:00:39 INFO - 'SHLVL': '1', 06:00:39 INFO - 'TERM': 'linux', 06:00:39 INFO - 'TMOUT': '86400', 06:00:39 INFO - 'USER': 'cltbld', 06:00:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:39 INFO - '_': '/tools/buildbot/bin/python'} 06:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:39 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 06:00:39 INFO - Cleaning up... 06:00:39 INFO - Return code: 0 06:00:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:39 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:39 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 06:00:39 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 06:00:39 INFO - Using env: {'DISPLAY': ':0', 06:00:39 INFO - 'HOME': '/home/cltbld', 06:00:39 INFO - 'LANG': 'en_US.UTF-8', 06:00:39 INFO - 'LANGUAGE': 'en_US:en', 06:00:39 INFO - 'LOGNAME': 'cltbld', 06:00:39 INFO - 'MAIL': '/var/mail/cltbld', 06:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:39 INFO - 'MOZ_NO_REMOTE': '1', 06:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:39 INFO - 'NO_EM_RESTART': '1', 06:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:39 INFO - 'SHELL': '/bin/bash', 06:00:39 INFO - 'SHLVL': '1', 06:00:39 INFO - 'TERM': 'linux', 06:00:39 INFO - 'TMOUT': '86400', 06:00:39 INFO - 'USER': 'cltbld', 06:00:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:39 INFO - '_': '/tools/buildbot/bin/python'} 06:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:39 INFO - Downloading/unpacking psutil>=0.7.1 06:00:39 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 06:00:39 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 06:00:39 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 06:00:39 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 06:00:39 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 06:00:39 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 06:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:41 INFO - Installing collected packages: psutil 06:00:41 INFO - Running setup.py install for psutil 06:00:41 INFO - building 'psutil._psutil_linux' extension 06:00:41 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 06:00:42 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 06:00:42 INFO - building 'psutil._psutil_posix' extension 06:00:42 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 06:00:42 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 06:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:42 INFO - Successfully installed psutil 06:00:42 INFO - Cleaning up... 06:00:42 INFO - Return code: 0 06:00:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:00:42 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')]} 06:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:42 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')]} 06:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:42 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:42 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 06:00:42 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 06:00:42 INFO - Using env: {'DISPLAY': ':0', 06:00:42 INFO - 'HOME': '/home/cltbld', 06:00:42 INFO - 'LANG': 'en_US.UTF-8', 06:00:42 INFO - 'LANGUAGE': 'en_US:en', 06:00:42 INFO - 'LOGNAME': 'cltbld', 06:00:42 INFO - 'MAIL': '/var/mail/cltbld', 06:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:42 INFO - 'MOZ_NO_REMOTE': '1', 06:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:42 INFO - 'NO_EM_RESTART': '1', 06:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:42 INFO - 'SHELL': '/bin/bash', 06:00:42 INFO - 'SHLVL': '1', 06:00:42 INFO - 'TERM': 'linux', 06:00:42 INFO - 'TMOUT': '86400', 06:00:42 INFO - 'USER': 'cltbld', 06:00:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:42 INFO - '_': '/tools/buildbot/bin/python'} 06:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00:42 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 06:00:42 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 06:00:42 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 06:00:42 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 06:00:42 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 06:00:42 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 06:00:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:00:44 INFO - Installing collected packages: mozsystemmonitor 06:00:44 INFO - Running setup.py install for mozsystemmonitor 06:00:44 INFO - Successfully installed mozsystemmonitor 06:00:44 INFO - Cleaning up... 06:00:44 INFO - Return code: 0 06:00:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:44 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:44 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 06:00:44 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 06:00:44 INFO - Using env: {'DISPLAY': ':0', 06:00:44 INFO - 'HOME': '/home/cltbld', 06:00:44 INFO - 'LANG': 'en_US.UTF-8', 06:00:44 INFO - 'LANGUAGE': 'en_US:en', 06:00:44 INFO - 'LOGNAME': 'cltbld', 06:00:44 INFO - 'MAIL': '/var/mail/cltbld', 06:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:44 INFO - 'MOZ_NO_REMOTE': '1', 06:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:44 INFO - 'NO_EM_RESTART': '1', 06:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:44 INFO - 'SHELL': '/bin/bash', 06:00:44 INFO - 'SHLVL': '1', 06:00:44 INFO - 'TERM': 'linux', 06:00:44 INFO - 'TMOUT': '86400', 06:00:44 INFO - 'USER': 'cltbld', 06:00:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:44 INFO - '_': '/tools/buildbot/bin/python'} 06:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:44 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:44 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 06:00:44 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 06:00:44 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 06:00:44 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 06:00:44 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 06:00:44 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 06:00:46 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:46 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 06:00:46 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 06:00:46 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 06:00:46 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 06:00:46 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 06:00:46 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 06:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:00:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:47 INFO - Downloading docopt-0.6.1.tar.gz 06:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:47 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:47 INFO - Running setup.py install for blobuploader 06:00:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:00:47 INFO - Running setup.py install for requests 06:00:47 INFO - Running setup.py install for docopt 06:00:48 INFO - Successfully installed blobuploader requests docopt 06:00:48 INFO - Cleaning up... 06:00:48 INFO - Return code: 0 06:00:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:00:48 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')]} 06:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:48 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')]} 06:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:48 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:48 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 06:00:48 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 06:00:48 INFO - Using env: {'DISPLAY': ':0', 06:00:48 INFO - 'HOME': '/home/cltbld', 06:00:48 INFO - 'LANG': 'en_US.UTF-8', 06:00:48 INFO - 'LANGUAGE': 'en_US:en', 06:00:48 INFO - 'LOGNAME': 'cltbld', 06:00:48 INFO - 'MAIL': '/var/mail/cltbld', 06:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:48 INFO - 'MOZ_NO_REMOTE': '1', 06:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:48 INFO - 'NO_EM_RESTART': '1', 06:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:48 INFO - 'SHELL': '/bin/bash', 06:00:48 INFO - 'SHLVL': '1', 06:00:48 INFO - 'TERM': 'linux', 06:00:48 INFO - 'TMOUT': '86400', 06:00:48 INFO - 'USER': 'cltbld', 06:00:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:48 INFO - '_': '/tools/buildbot/bin/python'} 06:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:48 INFO - Running setup.py (path:/tmp/pip-dSdRJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:48 INFO - Running setup.py (path:/tmp/pip-ZGUxGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:48 INFO - Running setup.py (path:/tmp/pip-DLu3fW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:48 INFO - Running setup.py (path:/tmp/pip-xGTAQT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:48 INFO - Running setup.py (path:/tmp/pip-QkT81x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:48 INFO - Running setup.py (path:/tmp/pip-BdLHhE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:48 INFO - Running setup.py (path:/tmp/pip-c7wG87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:48 INFO - Running setup.py (path:/tmp/pip-5wsW1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:48 INFO - Running setup.py (path:/tmp/pip-Kq7VDQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:48 INFO - Running setup.py (path:/tmp/pip-lJfP5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:49 INFO - Running setup.py (path:/tmp/pip-CRAZAx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:49 INFO - Running setup.py (path:/tmp/pip-LrMFY1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:49 INFO - Running setup.py (path:/tmp/pip-WYyoCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:49 INFO - Running setup.py (path:/tmp/pip-uFZLj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:49 INFO - Running setup.py (path:/tmp/pip-i9Qvfe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:49 INFO - Running setup.py (path:/tmp/pip-NQCz3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:49 INFO - Running setup.py (path:/tmp/pip-UnWKQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:49 INFO - Running setup.py install for manifestparser 06:00:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:00:49 INFO - Running setup.py install for mozcrash 06:00:49 INFO - Running setup.py install for mozdebug 06:00:49 INFO - Running setup.py install for mozdevice 06:00:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:00:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:00:49 INFO - Running setup.py install for mozfile 06:00:50 INFO - Running setup.py install for mozhttpd 06:00:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Running setup.py install for mozinfo 06:00:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Running setup.py install for mozInstall 06:00:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Running setup.py install for mozleak 06:00:50 INFO - Running setup.py install for mozlog 06:00:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Running setup.py install for moznetwork 06:00:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Running setup.py install for mozprocess 06:00:50 INFO - Running setup.py install for mozprofile 06:00:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Running setup.py install for mozrunner 06:00:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:00:50 INFO - Running setup.py install for mozscreenshot 06:00:51 INFO - Running setup.py install for moztest 06:00:51 INFO - Running setup.py install for mozversion 06:00:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:00:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:51 INFO - Cleaning up... 06:00:51 INFO - Return code: 0 06:00:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:51 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:51 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 06:00:51 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 06:00:51 INFO - Using env: {'DISPLAY': ':0', 06:00:51 INFO - 'HOME': '/home/cltbld', 06:00:51 INFO - 'LANG': 'en_US.UTF-8', 06:00:51 INFO - 'LANGUAGE': 'en_US:en', 06:00:51 INFO - 'LOGNAME': 'cltbld', 06:00:51 INFO - 'MAIL': '/var/mail/cltbld', 06:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:51 INFO - 'MOZ_NO_REMOTE': '1', 06:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:51 INFO - 'NO_EM_RESTART': '1', 06:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:51 INFO - 'SHELL': '/bin/bash', 06:00:51 INFO - 'SHLVL': '1', 06:00:51 INFO - 'TERM': 'linux', 06:00:51 INFO - 'TMOUT': '86400', 06:00:51 INFO - 'USER': 'cltbld', 06:00:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:51 INFO - '_': '/tools/buildbot/bin/python'} 06:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:51 INFO - Running setup.py (path:/tmp/pip-XMC3tk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:51 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)) 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:51 INFO - Running setup.py (path:/tmp/pip-WTfSxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:51 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)) 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:51 INFO - Running setup.py (path:/tmp/pip-jeVjKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:51 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)) 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:51 INFO - Running setup.py (path:/tmp/pip-3pwa5T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:51 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)) 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:51 INFO - Running setup.py (path:/tmp/pip-Geh0Dm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:51 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)) 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:51 INFO - Running setup.py (path:/tmp/pip-ArTDVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:51 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)) 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:51 INFO - Running setup.py (path:/tmp/pip-tPcXlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:52 INFO - Running setup.py (path:/tmp/pip-g5d5Q_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:52 INFO - Running setup.py (path:/tmp/pip-rdIqoA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:52 INFO - Running setup.py (path:/tmp/pip-Cyam_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:52 INFO - Running setup.py (path:/tmp/pip-kIb_mw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:52 INFO - Running setup.py (path:/tmp/pip-73YpjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:52 INFO - Running setup.py (path:/tmp/pip-pNJ4zV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:52 INFO - Running setup.py (path:/tmp/pip-tBLId3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:52 INFO - Running setup.py (path:/tmp/pip-J_71Rn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:52 INFO - Running setup.py (path:/tmp/pip-U5yt0_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:52 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)) 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:52 INFO - Running setup.py (path:/tmp/pip-Vpl4BT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:54 INFO - Downloading blessings-1.6.tar.gz 06:00:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:54 INFO - Installing collected packages: blessings 06:00:54 INFO - Running setup.py install for blessings 06:00:54 INFO - Successfully installed blessings 06:00:54 INFO - Cleaning up... 06:00:54 INFO - Return code: 0 06:00:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:00:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:00:54 INFO - Reading from file tmpfile_stdout 06:00:54 INFO - Current package versions: 06:00:54 INFO - argparse == 1.2.1 06:00:54 INFO - blessings == 1.6 06:00:54 INFO - blobuploader == 1.2.4 06:00:54 INFO - docopt == 0.6.1 06:00:54 INFO - manifestparser == 1.1 06:00:54 INFO - mozInstall == 1.12 06:00:54 INFO - mozcrash == 0.16 06:00:54 INFO - mozdebug == 0.1 06:00:54 INFO - mozdevice == 0.48 06:00:54 INFO - mozfile == 1.2 06:00:54 INFO - mozhttpd == 0.7 06:00:54 INFO - mozinfo == 0.9 06:00:54 INFO - mozleak == 0.1 06:00:54 INFO - mozlog == 3.1 06:00:54 INFO - moznetwork == 0.27 06:00:54 INFO - mozprocess == 0.22 06:00:54 INFO - mozprofile == 0.28 06:00:54 INFO - mozrunner == 6.11 06:00:54 INFO - mozscreenshot == 0.1 06:00:54 INFO - mozsystemmonitor == 0.0 06:00:54 INFO - moztest == 0.7 06:00:54 INFO - mozversion == 1.4 06:00:54 INFO - psutil == 3.1.1 06:00:54 INFO - requests == 1.2.3 06:00:54 INFO - wsgiref == 0.1.2 06:00:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:00:54 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')]} 06:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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')]} 06:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:54 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 06:00:54 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 06:00:54 INFO - Using env: {'DISPLAY': ':0', 06:00:54 INFO - 'HOME': '/home/cltbld', 06:00:54 INFO - 'LANG': 'en_US.UTF-8', 06:00:54 INFO - 'LANGUAGE': 'en_US:en', 06:00:54 INFO - 'LOGNAME': 'cltbld', 06:00:54 INFO - 'MAIL': '/var/mail/cltbld', 06:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:54 INFO - 'MOZ_NO_REMOTE': '1', 06:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:54 INFO - 'NO_EM_RESTART': '1', 06:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:54 INFO - 'SHELL': '/bin/bash', 06:00:54 INFO - 'SHLVL': '1', 06:00:54 INFO - 'TERM': 'linux', 06:00:54 INFO - 'TMOUT': '86400', 06:00:54 INFO - 'USER': 'cltbld', 06:00:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:54 INFO - '_': '/tools/buildbot/bin/python'} 06:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 INFO - Cleaning up... 06:00:55 INFO - Return code: 0 06:00:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:00:55 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')]} 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:55 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')]} 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:55 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:55 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 06:00:55 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 06:00:55 INFO - Using env: {'DISPLAY': ':0', 06:00:55 INFO - 'HOME': '/home/cltbld', 06:00:55 INFO - 'LANG': 'en_US.UTF-8', 06:00:55 INFO - 'LANGUAGE': 'en_US:en', 06:00:55 INFO - 'LOGNAME': 'cltbld', 06:00:55 INFO - 'MAIL': '/var/mail/cltbld', 06:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:55 INFO - 'MOZ_NO_REMOTE': '1', 06:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:55 INFO - 'NO_EM_RESTART': '1', 06:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:55 INFO - 'SHELL': '/bin/bash', 06:00:55 INFO - 'SHLVL': '1', 06:00:55 INFO - 'TERM': 'linux', 06:00:55 INFO - 'TMOUT': '86400', 06:00:55 INFO - 'USER': 'cltbld', 06:00:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:55 INFO - '_': '/tools/buildbot/bin/python'} 06:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:55 INFO - Downloading/unpacking jsonschema 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:00:57 INFO - Downloading/unpacking functools32 (from jsonschema) 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - Downloading functools32-3.2.3-2.tar.gz 06:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:00:57 INFO - warning: no files found matching '*.txt' 06:00:57 INFO - no previously-included directories found matching 'build' 06:00:57 INFO - no previously-included directories found matching 'dist' 06:00:57 INFO - no previously-included directories found matching '.git*' 06:00:57 INFO - Installing collected packages: jsonschema, functools32 06:00:57 INFO - Running setup.py install for functools32 06:00:57 INFO - warning: no files found matching '*.txt' 06:00:57 INFO - no previously-included directories found matching 'build' 06:00:57 INFO - no previously-included directories found matching 'dist' 06:00:57 INFO - no previously-included directories found matching '.git*' 06:00:57 INFO - Successfully installed jsonschema functools32 06:00:57 INFO - Cleaning up... 06:00:57 INFO - Return code: 0 06:00:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:57 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 0x7ff6d1cebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d63630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, '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': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', '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 06:00:57 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 06:00:57 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 06:00:57 INFO - Using env: {'DISPLAY': ':0', 06:00:57 INFO - 'HOME': '/home/cltbld', 06:00:57 INFO - 'LANG': 'en_US.UTF-8', 06:00:57 INFO - 'LANGUAGE': 'en_US:en', 06:00:57 INFO - 'LOGNAME': 'cltbld', 06:00:57 INFO - 'MAIL': '/var/mail/cltbld', 06:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:57 INFO - 'MOZ_NO_REMOTE': '1', 06:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:57 INFO - 'NO_EM_RESTART': '1', 06:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:57 INFO - 'SHELL': '/bin/bash', 06:00:57 INFO - 'SHLVL': '1', 06:00:57 INFO - 'TERM': 'linux', 06:00:57 INFO - 'TMOUT': '86400', 06:00:57 INFO - 'USER': 'cltbld', 06:00:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:57 INFO - '_': '/tools/buildbot/bin/python'} 06:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:57 INFO - Downloading/unpacking flake8 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:00:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:00:59 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 06:00:59 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 06:00:59 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 06:00:59 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 06:00:59 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 06:00:59 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 06:00:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:00:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:00:59 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 06:00:59 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 06:00:59 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 06:00:59 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 06:00:59 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 06:00:59 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 06:01:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:00 INFO - no previously-included directories found matching 'docs/_build' 06:01:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:01:00 INFO - Running setup.py install for pep8 06:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:00 INFO - no previously-included directories found matching 'docs/_build' 06:01:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:01:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:01:00 INFO - Cleaning up... 06:01:00 INFO - Return code: 0 06:01:00 INFO - Running post-action listener: _resource_record_post_action 06:01:00 INFO - Running post-action listener: _start_resource_monitoring 06:01:00 INFO - Starting resource monitoring. 06:01:00 INFO - ##### 06:01:00 INFO - ##### Running install step. 06:01:00 INFO - ##### 06:01:00 INFO - Running pre-action listener: _resource_record_pre_action 06:01:00 INFO - Running main action method: install 06:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:01:00 INFO - Reading from file tmpfile_stdout 06:01:00 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:01:00 INFO - Reading from file tmpfile_stdout 06:01:00 INFO - Output received: 06:01:00 INFO - Usage: mozinstall [options] installer 06:01:00 INFO - Options: 06:01:00 INFO - -h, --help show this help message and exit 06:01:00 INFO - -d DEST, --destination=DEST 06:01:00 INFO - Directory to install application into. [default: 06:01:00 INFO - "/builds/slave/test-pgo"] 06:01:00 INFO - --app=APP Application being installed. [default: firefox] 06:01:00 INFO - mkdir: /builds/slave/test-pgo/build/application 06:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:01:16 INFO - Reading from file tmpfile_stdout 06:01:16 INFO - Output received: 06:01:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:01:16 INFO - Running post-action listener: _resource_record_post_action 06:01:16 INFO - ##### 06:01:16 INFO - ##### Running run-tests step. 06:01:16 INFO - ##### 06:01:16 INFO - Running pre-action listener: _resource_record_pre_action 06:01:16 INFO - Running main action method: run_tests 06:01:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:01:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:01:16 INFO - Python 2.7.3 06:01:16 INFO - Return code: 0 06:01:16 INFO - grabbing minidump binary from tooltool 06:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:16 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 0x1df4840>, '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 0x1d616b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d61b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:01:17 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 06:01:17 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 06:01:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:17 INFO - Return code: 0 06:01:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:01:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:01:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:01:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:01:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:01:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:01:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:01:18 INFO - Return code: 0 06:01:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 06:01:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 06:01:18 INFO - Using env: {'DISPLAY': ':0', 06:01:18 INFO - 'HOME': '/home/cltbld', 06:01:18 INFO - 'LANG': 'en_US.UTF-8', 06:01:18 INFO - 'LANGUAGE': 'en_US:en', 06:01:18 INFO - 'LOGNAME': 'cltbld', 06:01:18 INFO - 'MAIL': '/var/mail/cltbld', 06:01:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:01:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:18 INFO - 'MOZ_NO_REMOTE': '1', 06:01:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:18 INFO - 'NO_EM_RESTART': '1', 06:01:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:01:18 INFO - 'SHELL': '/bin/bash', 06:01:18 INFO - 'SHLVL': '1', 06:01:18 INFO - 'TERM': 'linux', 06:01:18 INFO - 'TMOUT': '86400', 06:01:18 INFO - 'USER': 'cltbld', 06:01:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373', 06:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:18 INFO - '_': '/tools/buildbot/bin/python'} 06:01:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 06:01:18 INFO - mozversion application_buildid: 20160128030208 06:01:18 INFO - mozversion application_changeset: 0ecd7d72f232304da046b352c457e039e35ceed7 06:01:18 INFO - mozversion application_display_name: Nightly 06:01:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:18 INFO - mozversion application_name: Firefox 06:01:18 INFO - mozversion application_remotingname: firefox 06:01:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:01:18 INFO - mozversion application_vendor: Mozilla 06:01:18 INFO - mozversion application_version: 47.0a1 06:01:18 INFO - mozversion platform_buildid: 20160128030208 06:01:18 INFO - mozversion platform_changeset: 0ecd7d72f232304da046b352c457e039e35ceed7 06:01:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:01:18 INFO - mozversion platform_version: 47.0a1 06:01:18 INFO - using testdate: 1453989678 06:01:18 INFO - actual date: 1453989678 06:01:18 INFO - starting webserver on 'localhost:37821' 06:01:18 INFO - SUITE-START | Running 3 tests 06:01:18 INFO - TEST-START | dromaeo_css 06:01:18 INFO - operating with platform_type : linux_ 06:01:18 INFO - Initialising browser for dromaeo_css test... 06:01:18 INFO - TEST-INFO | started process 18174 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJhh5Ys/profile http://localhost:37821/getInfo.html) 06:01:21 INFO - PROCESS | 18174 | 06:01:21 INFO - PROCESS | 18174 | (process:18257): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:01:22 INFO - PROCESS | 18174 | __metrics Screen width/height:1600/1200 06:01:22 INFO - PROCESS | 18174 | colorDepth:24 06:01:22 INFO - PROCESS | 18174 | Browser inner width/height: 1024/697 06:01:22 INFO - PROCESS | 18174 | __metrics 06:01:23 INFO - PROCESS | 18174 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:01:23 INFO - TEST-INFO | 18174: exit 0 06:01:23 INFO - Browser initialized. 06:01:23 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:23 INFO - TEST-INFO | started process 18306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJhh5Ys/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:25 INFO - PROCESS | 18306 | 06:01:25 INFO - PROCESS | 18306 | (process:18367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:01:35 INFO - PROCESS | 18306 | RSS: Main: 151818240 06:01:35 INFO - PROCESS | 18306 | 06:02:25 INFO - PROCESS | 18306 | 1453989745419 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] 06:04:33 INFO - PROCESS | 18306 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37821/tests/dromaeo/cssquery-ext.html) 06:04:34 INFO - PROCESS | 18306 | RSS: Main: 160808960 06:04:34 INFO - PROCESS | 18306 | 06:07:36 INFO - PROCESS | 18306 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-ext.html (next: http://localhost:37821/tests/dromaeo/cssquery-jquery.html) 06:07:37 INFO - PROCESS | 18306 | RSS: Main: 156438528 06:07:37 INFO - PROCESS | 18306 | 06:10:39 INFO - PROCESS | 18306 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37821/tests/dromaeo/cssquery-mootools.html) 06:10:39 INFO - PROCESS | 18306 | RSS: Main: 156057600 06:10:39 INFO - PROCESS | 18306 | 06:13:41 INFO - PROCESS | 18306 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37821/tests/dromaeo/cssquery-prototype.html) 06:13:42 INFO - PROCESS | 18306 | RSS: Main: 153874432 06:13:42 INFO - PROCESS | 18306 | 06:16:44 INFO - PROCESS | 18306 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37821/tests/dromaeo/cssquery-yui.html) 06:16:45 INFO - PROCESS | 18306 | RSS: Main: 155963392 06:16:45 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | Cycle 1(1): loaded http://localhost:37821/tests/dromaeo/cssquery-yui.html (next: http://localhost:37821/tests/dromaeo/cssquery-dojo.html) 06:19:47 INFO - PROCESS | 18306 | RSS: Main: 158396416 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | __start_tp_report 06:19:47 INFO - PROCESS | 18306 | _x_x_mozilla_page_load 06:19:47 INFO - PROCESS | 18306 | _x_x_mozilla_page_load_details 06:19:47 INFO - PROCESS | 18306 | |i|pagename|runs| 06:19:47 INFO - PROCESS | 18306 | |0;dojo.html;3092.165115418837;3116.657167711551;3137.670544592818;3158.478850989587;3159.984200078999;5004.649674522785;5037.5718063964605;5046.0412521620865;5072.163093089641;5085.364329458813;5025.296458495814;5057.721825299607;5181.015607034661;5188.195829646402;5209.86975325617;4637;4691.765411729417;4737.265723812815;4820.25286080658;4829.637777166709;4788.736619485927;4797.976010119962;4814.590759785422;4823.975880120594;4913.754312284389;4711.29330600411;4725.243960966229;4762.380890484214;4770.2606096055;4770.642201834841;4649.256119020974;4685.976570117162;4692.436907571113;4702.741349225791;4711.4346278446465;4649.651276154302;4660.487346391894;4660.743659098748;4671.836485723017;4717.811287548494;4825.324454576362;4878.780454879539;4993.251012348177;4996.400431948153;5131.255967884673;5537.889242215133;5606.691631960241;5610.382857885629;5627.127795191711;5632.817108407239;5629.240052592889;5665.886682266373;5676.829695109153;5677.261955945742;5709.0580054290995;5157.7936882524655;5205;5208.557272631793;5271.947280527223;5331.86670333237;5631.746571404296;5634.267545219177;5644.153376993402;5648.774049037993;5687.40282270364;5432.239486471897;5439.809606663748;5463.098588732894;5467.781288748405;5524.226608274845;5486.835394938158;5504.504594586507;5562.193481945176;5589.580781441408;5589.692566908859;5415.512603865593;5423.810166644149;5536.86157846049;5592.636478628876;5628.521575666033;5427.6472029317965;5436.320459942507;5445.047116754552;5446.645968012146;5447.182922561568;4192.05678722285;4257.254980378483;4261.808218630169;4273.209456250604;4292.656587472995;3880.864169754045;3891.883243502643;3917.6474117329576;3920.098377373163;3940.2710498557285;5196.92204616931;5216.817411390583;5224.320838290998;5229.47705229474;5230.372355317386;5345.278387417727;5485.259489968803;5511.200875872976;5558.916616250759;5632.577556683265;5213.113770658922;5218.895622087537;5262.92105618416;5268.078086334876;5285.894282114336;4636.165490211727;4653.627709783209;4674.953250467452;4686.859394218179;4720.268358404453;5617.578681598897;5685.204071430003;5694.316681998104;5717.285339332583;5797.565182611321;5421.5391691706645;5422.701751403711;5423;5428.755705993319;5429.837104886859;5735.36910939788;5779.335376431764;5780.508656764054;5806.361300257053;5826.300843898759;5377.489138531833;5399.4060653327315;5427.05026620332;5434.945650543444;5444.754986025559;5313.096773548429;5376.327959005124;5449.427810080043;5566.415526369673;5611.354694210055;5435.83692489226;5439.945600543944;5467.316585426822;5474.452554744653;5482.890342193214;5427.050266203478;5461;5464.836054918359;5476.423994702684;5549.722513874371;5188.299579556711;5258.631895767413;5363.731813409392;5404.486573775485;5482.780688772405;5489.478499542537;5521.944780552143;5549.278593782944;5557.41647127062;5557.583181261502;5374.516293533601;5412.161115027177;5412.161115027177;5424.864378390414;5466 06:19:47 INFO - PROCESS | 18306 | |1;ext.html;493.14439447558505;521.846055413653;524.7848382163313;529.1375058654395;540.4352451687987;27904.162875113754;28683.282917927037;35712.642873571254;36014.45978310327;36259.27481450376;39077.41383879237;39432.80283598578;39522.20955580887;39600;39748.80125599375;8338.91661083389;8517.36119791018;8545.487270763742;8563.486190828571;8603.655853765842;8306.792330191733;8426.199511046472;8428.620712067941;8431.662733490653;8475.321974242046;8708.825823483527;8715.869261961076;8774.64901403943;8795.164459376381;8806.075362086985;8580.699675511358;8598.87101693475;8639.52482613456;8666.739997800076;8686.478811271343;8422.28410585101;8649.567521623894;8657.307415406753;8673.392862499628;8695.826083478358;38749.61250387516;38844.41733374001;38901.41647875284;39200.607993919984;39204.41193382073;2748.1343376836235;2983.5077212259953;3123.8281894495794;3608.729345299113;3679.4664773607947;29186.416271674447;29539.70460295391;29643.407131857457;30063;30169.245768855733;3826.885193444173;3878.2243551289853;3930.803459827026;3939.5075615548058;3994.1428472490343;259551;259759;260944;261168.9999999981;261321;51292.48707512952;52485.47514524882;55971;56358.43641563532;56447.15329269982;61092.38907610867;61647.6917615418;61803;62057.37942620516;62145;14768.778468322984;15062.849371506145;15151.772723409158;15216.467423640119;15234.238288085551;11039.83440248397;11041.889581104086;11127.221094523306;11145.665630031112;11152.275102118336;19276;19339.4198174055;19359.51601209981;19845.30541431043;19938.30215942435;6861.416779573792;6962.094927659372;7048.400885924754;7150.177729561063;7153.248908864598;826.5040975414703;837.5100566168737;861.328164032056;998.9300748947504;1082.5507414423084;27987.169604893374;28214.43571128566;28324.150275491767;28627.856860715565;28651.997180098595;962.8266911955775;975.3221511049752;995.8804943406838;1072.8605281313535;1082.7293176705823;14640.853591463949;14642.853571464362;14665.780013299809;14940.850591493945;14962.40150393972;318916;320774;321854;323025;325315;50636.74681626568;50705.746471267405;50763.23855142176;51115.48884511182;51124.74437627788;1247.0709321555498;1263.3556885988028;1264.8861602455822;1269.149669721289;1269.225772278909;26671.33321666896;27666.861665692348;27882.58176127319;28323.716762832108;28372.85813570919;45866.312005320615;45893.54106458893;46280.768596156806;46282.30576541287;46612.76693616646;300484;301972;302276;303459;303518;31463;31905;32071.839640801645;32154;32178.35643287168;37400;37935.62064379321;38226.42660360041;38232.426513601764;38260.808695956344;30726;31322.21694457657;31921.521177182825;32005.519917201727;32373.676263237066;32458.83770581132;33006.834965825015;34399.656003439646;35005.299894002485;35254.29491410106;31057.844710777204;31427.37145257128;31547.684523155393;31643.683563164075;31680.049598512083;28005.579916301678;28764.963619815586;29342;29461.85269073641;29742.702572973994;22182.55634887261;22328.88835555812;22344.329670109273;22415.551688966454;22469.66295505536 06:19:47 INFO - PROCESS | 18306 | |2;jquery.html;349.97725147865384;351.9331327047862;356.3727839003353;356.4407553763977;357.53698959847003;14140.434382624708;14583.635409114777;15410.152441615706;16148.192590370492;17568.73646895296;14369.928150359234;14604.050736702133;14635.414583416677;14780.187089710089;14953.551393458187;5036.672616279949;5098.84703458895;5195.610329225305;5230.581553475732;5240.947590524103;5176.456472070435;6008.579399442041;6238.282597501277;6281.152044473984;6288.779892703757;6028.27660680719;6195.2565692117005;6242.719077641517;6275.309715931244;6277.968610156966;6011.278646562397;6217.347178546278;6255.437010669061;6478.967605161991;6504.739810407578;5827.650340979555;5972.850678733023;5995.490383317423;6029.336772954972;6039.184710064129;20649.58700825975;20667.276645317343;20968.89515552428;22091.116355345766;22215.66676499854;1945.387203031055;2152.2359562355296;2168.8807115608633;2199.615067363221;2351.413445210255;13049.739005219843;13140.802887956688;13187.802182967263;13614.523491677744;13836.377363018688;1972.1716878910893;1993.1728332741895;2030.4314791858155;2063.009755317456;2116.354511873878;63225.36774632241;63560;66004.3399566003;66473;66585;14632.179043540955;14875.553733388017;14911.925440372728;14924.179170145746;15595.688086238439;22861;22909.656355154686;23020.194293199656;23140.768592314198;23255.53488930212;8640.13598640131;8763.430377025474;8765.298776097898;8781.692640757543;8854.77863053416;7327.560346379234;7358.632068396559;7364.079490063742;7398.741044063432;7413.66638501258;6694.364035416627;6983.196932352845;7244.963775181091;7363.7422690205585;7527.774166775005;2916.6645835728737;3021.305099827052;3063.5557844112477;3097.969020309813;3104.2704964333366;830.4892491117919;834.6285902773329;926.379325851681;932.4778124250441;952.88722842963;15683.843161568466;15718.842811571967;15751.68496630084;16062.196890155445;16591.336346546243;852.0712423458336;858.3948316436897;877.4998250996871;892.5537231384308;904.6155383961922;7796.84406311882;7962.442629016029;8550.914490855137;9399;9451.102145296185;491811;500380;501920;518517;526397;72839.2716072843;75426;75552.62223688846;76598.23401766023;76949;1100.2408338246585;1106.115107913666;1135.1089394825024;1162.2271189658782;1163.7265242667966;14518.20149891766;14661.340239689453;14932.104073755609;14972.176530290939;15010.924945375204;33431.83284083564;34388.82805586056;34490.82754586211;34718.305633887685;35282.47076293909;42021;42075.36886946637;43020.13959720851;43107;44712.552874470835;6956.582605043714;7171.139463264233;7259.854802903807;7271.091113610799;7407.740729074457;10746.785064298827;10820.837687434538;11032.779344413228;11106.389148596905;11210.159238057015;9156.404833685789;9392.436453812794;10235.130013948898;10282.845757313797;10302.072813446826;2917.8103423278267;4372.928632485062;7416.517926334771;10350.223733219887;10454.163666906477;3062.341596556751;8168.080501082122;9648.469334186688;10072.647457338959;10395.220358472994;7461.403087753075;7501.549907005598;7525.887111693439;7573.2805383488485;7575.242475752601;7689.307962283421;9400.905990940004;9618.615255389706;9662.613495460102;9684.854727178958 06:19:47 INFO - PROCESS | 18306 | |3;mootools.html;1422.6372275069857;1435.892308076894;1557.5015994881635;1716.210543150151;1717.5276798880307;6761.459083273338;6913.239543650207;7359.411247100233;7576.924230757691;7590.848183036343;7112.751053713121;7121.679524421401;7212.098487689039;7215.675294611742;7287.672054757535;2220.8334374921865;2255.706758121442;2263.7396699379533;2273.4998300373973;2279.4985103277254;2221.466847956495;2252.3017864462067;2292.381057114578;2295.254042436215;2298.0577963035157;2223.9332820015343;2239.0484044281197;2240.2271216430304;2240.372695645222;2259.2318611672026;2245.2366195493446;2249.5388445368662;2251.964096515605;2266.2408093288686;2274.3290729234914;2239.0931672672596;2251.4596496840804;2264.445210923318;2265.8074063704603;2266.048259730917;7556.584387858666;7560;7577.355924746348;7579.317861392501;7587;4375.606195442394;4444.711093778894;4459.175052615245;4463.285874260103;4470.910581788378;2892.913212603625;2948.1155653304136;2951.1736713720193;2968.9257768555744;2971.643402791679;892.0722448653393;904.5025236120108;933.2021121940778;941.7316064921464;954.1031430455349;10299.22755793311;10480.161587073017;10492.16062714981;10500.842487362695;10539.63111291101;4042.3734321180264;4054.3107671695884;4060.959390406117;4070.0842310479907;4076.4496792932573;9016.692579575925;9056.184943355129;9111.589978450986;9124.635014599342;9133.132352426508;4538.455385353713;4539.137563862855;4576.222042252825;4585.633149348044;4594.081183763261;3773.396256598931;3828.5405751310022;4037.8384864605086;4116.794160291974;4175.603317684815;3598.2803439312243;3656.433252845813;3668.101315177745;3673.173535954389;3712.6472985066375;1168.2756690851556;1179.9587014454453;1181.3502573584667;1181.6750393641646;1181.8581770187632;1214.2350319298962;1220.267839296415;1235.6725467751053;1235.9505619775289;1251.343044901434;6777.695003724844;6781.321867813179;6864.828379290558;7068.823279418056;7251.456140789462;1089.6004466065924;1093.6172339681048;1095.9726006849892;1102.1843835561626;1124.8818874018275;5598.888022239533;5669.34802497718;5725.971370143206;5731.914021289684;5753.683547404933;8742.650293988168;9155.908440915638;9166.495842728715;9191.402558833654;9274.860877086849;9111.316651251183;9120.954395228115;9135.995040545535;9178.21985131258;9180.770480738034;6889.345512176335;7012.158540975116;7038.190608080034;7063.57618542889;7116.466265030143;7019.894701579378;7044.718211271492;7088;7100.4319654428555;7117.395021423237;7834.725784597512;8028.959855200686;8176.754697359089;8198.344132469507;8267.793305167419;8366.494031074464;8398.286145677686;8429.831403371776;8463.36524760633;8503.319734421108;6489.318621544859;6510.7721229756735;6600.075989361397;6662.866742665216;6743.123393958754;6899.586024838526;6919.169699636076;6956.930430695831;6967.79096627102;6972;6486.837829054122;6632.1709786276715;6684.6991885364305;6734.4612431004425;6803.693833777393;6416.422521973045;6459.450946669585;6536.607803531803;6649.767258145942;6666.933330666631;6236.251649802053;6239.282482514569;6251.843703907257;6269.279032911274;6340.048992651139;5694.1458781183155;5703.600747947604;5704.543636509153;5707.229524014205;5723.456271654186;5845.386234445322;5911.793087241926;5913.142594323885;5917.37867523921;5921.703914804329 06:19:47 INFO - PROCESS | 18306 | |4;prototype.html;338.78148594156767;342.028638666188;343.81262212094407;346.6931765387632;349.08365540456316;6230.906536401952;6268.279147897993;6291.591046581969;6321.304656487789;6393.584417012891;6182.6290422574675;6255.468285195764;6310.58981166225;6388.744450221997;6402.9679851600795;4711.670183087168;4737.549932756383;4739.976300118495;4745.430548334205;4755.500672429397;4728.0307536955015;4743.478217396084;4746.928796068062;4751.002289519205;4754.690945088575;4617.261238201889;4676.041411510632;4679.204535229002;4679.74261415622;4693.6010439112715;4667.603253723438;4669.626429885618;4677.906441871143;4678.953210467903;4712.175369310391;4026.4765580474646;4033.4353190553347;4038.45480860086;4042.393640953851;4049.97975010126;6010.429009244115;6011;6016.2479690038745;6018.909716354258;6020.729067191987;5308.124159513675;5435.1847222916485;5437.238786569884;5438.483344082306;5447.836564903059;6569.441597464173;6626.966865165643;6628.2046154461295;6631.403173714389;6634.933650663528;4441.133978874121;4447.666425018104;4456.17560751262;4456.799444025027;4486.282194848808;6847.417969472601;6892.104671215406;6981.650917454158;6987.231404545496;6993.685284162174;4632.837850675211;4642.141203877226;4645.39609850724;4653.511381304982;4678.976605116953;4691.085238378551;4698.8355407560575;4706.458757242961;4707.95292047082;4715.575598196178;5473.7263136843;5480.561555075585;5482.862928426821;5484.588655850747;5491.615586908958;6495.837604059936;6676.399124078759;6719.798406047827;6738.258791532928;6751.729930802811;1608.2360878582579;1638.131790151198;1641.2778377513855;1644.7779549760628;1647.4975132584436;1077.1813421799488;1090.7818436312612;1090.8200146975819;1093.316677076827;1097.2483848563759;6166.229221347332;6166.630002199792;6185.443310102112;6219.284782250099;6244.812655620339;6700.6984685688285;6713.731450742013;6721.395074443323;6739.494537909676;6758.189017317855;6130.264368275746;6234.5635805494085;6239.937600624026;6248.625082495065;6272.749090036347;3676.117731744362;3676.852925882988;3694.7967861767324;3695.593484716679;3702.20402613434;7083;7096.503244772816;7099.148102227766;7106;7106.182788979334;6778.932210677929;6898.448124150056;6899.068625735562;6948.409385202314;6987.056747339146;7026.332498412643;7071.398931090915;7076.823079423056;7090;7098.538594991309;6726.7981960541265;6743.561668491532;6763.932360676527;6770.086038384755;6777.559458635173;6535.901961470487;6683.097781799394;6686.732530698912;6701.765438209639;6721.1598550181225;7052.647367631495;7067.0459487968465;7088.751893683696;7092.113485814273;7096.822579435556;4583.289590113538;4634.540119862233;4638.605718513829;4640.211164102178;4643.558861908114;6673.998900165014;6693.832654183684;6778.93221067783;6781.050652908695;6921.757738479129;6700.564463309869;6766;6769.830754231184;6781.220159681699;6795.592264464148;6732.057511948429;6734.764283250062;6742;6783.966080169567;6846.075779769866;6513.218413790375;6605.867882642417;6634.170728658918;6637.900431493628;6654.500912431684;6802.489813264124;6803.421709154777;6809.38715515606;6812.931870681428;6833.4191593715095;6551.72241412939;6589.275179730322;6621.867562648817;6623.072769812134;6654.201495820533 06:19:47 INFO - PROCESS | 18306 | |5;yui.html;617.5152505283351;618.9319174890765;628.1927722876105;657.871715015572;773.9458237923347;12661.620151395462;12685.682857928556;12758.489660413585;12788.744225115504;12797.936010319958;13627.523036693718;14140.717185656307;14155;14185.78721319181;14242.074265172756;760.0233699695892;770.6300975531748;777.6850375597878;789.7512283630666;790.9920900790976;786.6578038553248;790.7667238164755;791.6041979010495;792.8572856885759;793.9682412703485;810.8094597769519;816;818.0306336990685;818.4966245758845;820.27405745915;808.5593351623379;810.1048341582525;817.1338381315794;818.3085292927467;819.2503858969036;599.3886236039216;601.4286427893519;602.3554796367888;603.8369640197166;604.1421181921681;13386.330683465885;13423.597292081156;13462.326883655778;13473.258970756604;13505.86494135056;11942.880571194351;12092.576759813364;12249.326287054208;12498;12706.174098683648;9919.553620087114;9980.30137890348;10008.89991100087;10080.294379393445;10200.94899525505;3445.3970555152746;3490.6683865032783;3519.8768043118366;3520.119970007498;3538.327717733622;46247.30629040567;47389.5261047392;47648.523514765104;48021;48129.278060829114;9622.085901839455;9642.132208101304;9734.123928846439;9761.51192440375;9767.609295628237;16431.424900128437;16432.67134657324;16455.506334809976;16501.257443415074;16584.336626534805;6512.544121911421;6844.931550684529;6973.79078627642;7110.360067593838;7116.928830711627;3948.940765888514;3981;3995.220931918248;4165.854195103157;4221.91556168881;2879.1938257287993;2913.286244869978;2918.6643535993207;2921.576371426131;2938.4270067337093;561.357245953381;574.0757380617202;583.2883881664362;587.4742105815271;595.87188754418;518.5851318944829;536.1502019299376;559.8488408129782;562.9577781666392;593.7595273914071;7471.215522370073;7487.513311634726;7608.543487390774;7792.142864284924;7828.686852525949;453.29512607894384;532.5686194182724;533.4265664410774;549.5933009572967;585.0814221671934;3618.475321078429;3630.221191616089;3709.6104908984707;3881.80590970456;4061.1268577256033;54735.72632136894;54832.451675483535;56068.43931560714;58061.4193858056;58192;44414;44449;44494.11011779811;44538.554614454086;45449.772751136035;43991.340129898075;44267.77866110649;44414.555854441685;45687.31469027967;45948;7671.846563068819;7706.422018348759;7931.5637639928045;7935.722249721232;8359.289460395934;32914.34171316608;33739.49390759091;34471.82764086164;35177.82411087928;35240;42716.78641606772;43340.13319733651;43783;44322.55677443184;46324.53675463202;9876.407415554802;10378.532966016397;10407.167426606005;10434.113100386552;10518.474076296308;11030.669079927615;11557.364344961108;11646.650600481998;11817.113716471127;11865.525378984745;9977.529430480341;10032.247581431568;10053.095221430107;10098.872849515581;10288.897111028793;10252.38485690861;10318.122959548522;10391.37651740898;10540.631077912236;10628.309159904582;9443.480608566595;9835.590714770831;9920.156786673213;10014.749631259278;10380.844287335545;8840.24857887061;8857.981332146628;8915.50964696922;9143.908560914306;9175.128362805523;7924.960375198087;8055.275025247756;8066.314363278952;8562.871556926526;8574.871376929226 06:19:47 INFO - PROCESS | 18306 | __end_tp_report 06:19:47 INFO - PROCESS | 18306 | __start_cc_report 06:19:47 INFO - PROCESS | 18306 | _x_x_mozilla_cycle_collect,292 06:19:47 INFO - PROCESS | 18306 | __end_cc_report 06:19:47 INFO - PROCESS | 18306 | __startTimestamp1453990787780__endTimestamp 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | ------- Summary: start ------- 06:19:47 INFO - PROCESS | 18306 | Number of tests: 6 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | [#0] dojo.html Cycles:165 Average:5149.32 Median:5377.49 stddev:563.19 (10.5%) stddev-sans-first:541.30 06:19:47 INFO - PROCESS | 18306 | Values: 3092.2 3116.7 3137.7 3158.5 3160.0 5004.6 5037.6 5046.0 5072.2 5085.4 5025.3 5057.7 5181.0 5188.2 5209.9 4637.0 4691.8 4737.3 4820.3 4829.6 4788.7 4798.0 4814.6 4824.0 4913.8 4711.3 4725.2 4762.4 4770.3 4770.6 4649.3 4686.0 4692.4 4702.7 4711.4 4649.7 4660.5 4660.7 4671.8 4717.8 4825.3 4878.8 4993.3 4996.4 5131.3 5537.9 5606.7 5610.4 5627.1 5632.8 5629.2 5665.9 5676.8 5677.3 5709.1 5157.8 5205.0 5208.6 5271.9 5331.9 5631.7 5634.3 5644.2 5648.8 5687.4 5432.2 5439.8 5463.1 5467.8 5524.2 5486.8 5504.5 5562.2 5589.6 5589.7 5415.5 5423.8 5536.9 5592.6 5628.5 5427.6 5436.3 5445.0 5446.6 5447.2 4192.1 4257.3 4261.8 4273.2 4292.7 3880.9 3891.9 3917.6 3920.1 3940.3 5196.9 5216.8 5224.3 5229.5 5230.4 5345.3 5485.3 5511.2 5558.9 5632.6 5213.1 5218.9 5262.9 5268.1 5285.9 4636.2 4653.6 4675.0 4686.9 4720.3 5617.6 5685.2 5694.3 5717.3 5797.6 5421.5 5422.7 5423.0 5428.8 5429.8 5735.4 5779.3 5780.5 5806.4 5826.3 5377.5 5399.4 5427.1 5434.9 5444.8 5313.1 5376.3 5449.4 5566.4 5611.4 5435.8 5439.9 5467.3 5474.5 5482.9 5427.1 5461.0 5464.8 5476.4 5549.7 5188.3 5258.6 5363.7 5404.5 5482.8 5489.5 5521.9 5549.3 5557.4 5557.6 5374.5 5412.2 5412.2 5424.9 5466.0 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | [#1] ext.html Cycles:180 Average:45425.47 Median:34702.48 stddev:77530.96 (223.4%) stddev-sans-first:77675.05 06:19:47 INFO - PROCESS | 18306 | Values: 493.1 521.8 524.8 529.1 540.4 27904.2 28683.3 35712.6 36014.5 36259.3 39077.4 39432.8 39522.2 39600.0 39748.8 8338.9 8517.4 8545.5 8563.5 8603.7 8306.8 8426.2 8428.6 8431.7 8475.3 8708.8 8715.9 8774.6 8795.2 8806.1 8580.7 8598.9 8639.5 8666.7 8686.5 8422.3 8649.6 8657.3 8673.4 8695.8 38749.6 38844.4 38901.4 39200.6 39204.4 2748.1 2983.5 3123.8 3608.7 3679.5 29186.4 29539.7 29643.4 30063.0 30169.2 3826.9 3878.2 3930.8 3939.5 3994.1 259551.0 259759.0 260944.0 261169.0 261321.0 51292.5 52485.5 55971.0 56358.4 56447.2 61092.4 61647.7 61803.0 62057.4 62145.0 14768.8 15062.8 15151.8 15216.5 15234.2 11039.8 11041.9 11127.2 11145.7 11152.3 19276.0 19339.4 19359.5 19845.3 19938.3 6861.4 6962.1 7048.4 7150.2 7153.2 826.5 837.5 861.3 998.9 1082.6 27987.2 28214.4 28324.2 28627.9 28652.0 962.8 975.3 995.9 1072.9 1082.7 14640.9 14642.9 14665.8 14940.9 14962.4 318916.0 320774.0 321854.0 323025.0 325315.0 50636.7 50705.7 50763.2 51115.5 51124.7 1247.1 1263.4 1264.9 1269.1 1269.2 26671.3 27666.9 27882.6 28323.7 28372.9 45866.3 45893.5 46280.8 46282.3 46612.8 300484.0 301972.0 302276.0 303459.0 303518.0 31463.0 31905.0 32071.8 32154.0 32178.4 37400.0 37935.6 38226.4 38232.4 38260.8 30726.0 31322.2 31921.5 32005.5 32373.7 32458.8 33006.8 34399.7 35005.3 35254.3 31057.8 31427.4 31547.7 31643.7 31680.0 28005.6 28765.0 29342.0 29461.9 29742.7 22182.6 22328.9 22344.3 22415.6 22469.7 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | [#2] jquery.html Cycles:180 Average:27551.80 Median:496095.50 stddev:83064.55 (16.7%) stddev-sans-first:83272.45 06:19:47 INFO - PROCESS | 18306 | Values: 350.0 351.9 356.4 356.4 357.5 14140.4 14583.6 15410.2 16148.2 17568.7 14369.9 14604.1 14635.4 14780.2 14953.6 5036.7 5098.8 5195.6 5230.6 5240.9 5176.5 6008.6 6238.3 6281.2 6288.8 6028.3 6195.3 6242.7 6275.3 6278.0 6011.3 6217.3 6255.4 6479.0 6504.7 5827.7 5972.9 5995.5 6029.3 6039.2 20649.6 20667.3 20968.9 22091.1 22215.7 1945.4 2152.2 2168.9 2199.6 2351.4 13049.7 13140.8 13187.8 13614.5 13836.4 1972.2 1993.2 2030.4 2063.0 2116.4 63225.4 63560.0 66004.3 66473.0 66585.0 14632.2 14875.6 14911.9 14924.2 15595.7 22861.0 22909.7 23020.2 23140.8 23255.5 8640.1 8763.4 8765.3 8781.7 8854.8 7327.6 7358.6 7364.1 7398.7 7413.7 6694.4 6983.2 7245.0 7363.7 7527.8 2916.7 3021.3 3063.6 3098.0 3104.3 830.5 834.6 926.4 932.5 952.9 15683.8 15718.8 15751.7 16062.2 16591.3 852.1 858.4 877.5 892.6 904.6 7796.8 7962.4 8550.9 9399.0 9451.1 491811.0 500380.0 501920.0 518517.0 526397.0 72839.3 75426.0 75552.6 76598.2 76949.0 1100.2 1106.1 1135.1 1162.2 1163.7 14518.2 14661.3 14932.1 14972.2 15010.9 33431.8 34388.8 34490.8 34718.3 35282.5 42021.0 42075.4 43020.1 43107.0 44712.6 6956.6 7171.1 7259.9 7271.1 7407.7 10746.8 10820.8 11032.8 11106.4 11210.2 9156.4 9392.4 10235.1 10282.8 10302.1 2917.8 4372.9 7416.5 10350.2 10454.2 3062.3 8168.1 9648.5 10072.6 10395.2 7461.4 7501.5 7525.9 7573.3 7575.2 7689.3 9400.9 9618.6 9662.6 9684.9 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | [#3] mootools.html Cycles:180 Average:5240.92 Median:5878.59 stddev:2706.17 (46.0%) stddev-sans-first:2698.54 06:19:47 INFO - PROCESS | 18306 | Values: 1422.6 1435.9 1557.5 1716.2 1717.5 6761.5 6913.2 7359.4 7576.9 7590.8 7112.8 7121.7 7212.1 7215.7 7287.7 2220.8 2255.7 2263.7 2273.5 2279.5 2221.5 2252.3 2292.4 2295.3 2298.1 2223.9 2239.0 2240.2 2240.4 2259.2 2245.2 2249.5 2252.0 2266.2 2274.3 2239.1 2251.5 2264.4 2265.8 2266.0 7556.6 7560.0 7577.4 7579.3 7587.0 4375.6 4444.7 4459.2 4463.3 4470.9 2892.9 2948.1 2951.2 2968.9 2971.6 892.1 904.5 933.2 941.7 954.1 10299.2 10480.2 10492.2 10500.8 10539.6 4042.4 4054.3 4061.0 4070.1 4076.4 9016.7 9056.2 9111.6 9124.6 9133.1 4538.5 4539.1 4576.2 4585.6 4594.1 3773.4 3828.5 4037.8 4116.8 4175.6 3598.3 3656.4 3668.1 3673.2 3712.6 1168.3 1180.0 1181.4 1181.7 1181.9 1214.2 1220.3 1235.7 1236.0 1251.3 6777.7 6781.3 6864.8 7068.8 7251.5 1089.6 1093.6 1096.0 1102.2 1124.9 5598.9 5669.3 5726.0 5731.9 5753.7 8742.7 9155.9 9166.5 9191.4 9274.9 9111.3 9121.0 9136.0 9178.2 9180.8 6889.3 7012.2 7038.2 7063.6 7116.5 7019.9 7044.7 7088.0 7100.4 7117.4 7834.7 8029.0 8176.8 8198.3 8267.8 8366.5 8398.3 8429.8 8463.4 8503.3 6489.3 6510.8 6600.1 6662.9 6743.1 6899.6 6919.2 6956.9 6967.8 6972.0 6486.8 6632.2 6684.7 6734.5 6803.7 6416.4 6459.5 6536.6 6649.8 6666.9 6236.3 6239.3 6251.8 6269.3 6340.0 5694.1 5703.6 5704.5 5707.2 5723.5 5845.4 5911.8 5913.1 5917.4 5921.7 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | [#4] prototype.html Cycles:180 Average:5524.43 Median:6252.05 stddev:1690.78 (27.0%) stddev-sans-first:1650.11 06:19:47 INFO - PROCESS | 18306 | Values: 338.8 342.0 343.8 346.7 349.1 6230.9 6268.3 6291.6 6321.3 6393.6 6182.6 6255.5 6310.6 6388.7 6403.0 4711.7 4737.5 4740.0 4745.4 4755.5 4728.0 4743.5 4746.9 4751.0 4754.7 4617.3 4676.0 4679.2 4679.7 4693.6 4667.6 4669.6 4677.9 4679.0 4712.2 4026.5 4033.4 4038.5 4042.4 4050.0 6010.4 6011.0 6016.2 6018.9 6020.7 5308.1 5435.2 5437.2 5438.5 5447.8 6569.4 6627.0 6628.2 6631.4 6634.9 4441.1 4447.7 4456.2 4456.8 4486.3 6847.4 6892.1 6981.7 6987.2 6993.7 4632.8 4642.1 4645.4 4653.5 4679.0 4691.1 4698.8 4706.5 4708.0 4715.6 5473.7 5480.6 5482.9 5484.6 5491.6 6495.8 6676.4 6719.8 6738.3 6751.7 1608.2 1638.1 1641.3 1644.8 1647.5 1077.2 1090.8 1090.8 1093.3 1097.2 6166.2 6166.6 6185.4 6219.3 6244.8 6700.7 6713.7 6721.4 6739.5 6758.2 6130.3 6234.6 6239.9 6248.6 6272.7 3676.1 3676.9 3694.8 3695.6 3702.2 7083.0 7096.5 7099.1 7106.0 7106.2 6778.9 6898.4 6899.1 6948.4 6987.1 7026.3 7071.4 7076.8 7090.0 7098.5 6726.8 6743.6 6763.9 6770.1 6777.6 6535.9 6683.1 6686.7 6701.8 6721.2 7052.6 7067.0 7088.8 7092.1 7096.8 4583.3 4634.5 4638.6 4640.2 4643.6 6674.0 6693.8 6778.9 6781.1 6921.8 6700.6 6766.0 6769.8 6781.2 6795.6 6732.1 6734.8 6742.0 6784.0 6846.1 6513.2 6605.9 6634.2 6637.9 6654.5 6802.5 6803.4 6809.4 6812.9 6833.4 6551.7 6589.3 6621.9 6623.1 6654.2 06:19:47 INFO - PROCESS | 18306 | 06:19:47 INFO - PROCESS | 18306 | [#5] yui.html Cycles:180 Average:13139.06 Median:47519.02 stddev:15351.22 (32.3%) stddev-sans-first:15365.48 06:19:47 INFO - PROCESS | 18306 | Values: 617.5 618.9 628.2 657.9 773.9 12661.6 12685.7 12758.5 12788.7 12797.9 13627.5 14140.7 14155.0 14185.8 14242.1 760.0 770.6 777.7 789.8 791.0 786.7 790.8 791.6 792.9 794.0 810.8 816.0 818.0 818.5 820.3 808.6 810.1 817.1 818.3 819.3 599.4 601.4 602.4 603.8 604.1 13386.3 13423.6 13462.3 13473.3 13505.9 11942.9 12092.6 12249.3 12498.0 12706.2 9919.6 9980.3 10008.9 10080.3 10200.9 3445.4 3490.7 3519.9 3520.1 3538.3 46247.3 47389.5 47648.5 48021.0 48129.3 9622.1 9642.1 9734.1 9761.5 9767.6 16431.4 16432.7 16455.5 16501.3 16584.3 6512.5 6844.9 6973.8 7110.4 7116.9 3948.9 3981.0 3995.2 4165.9 4221.9 2879.2 2913.3 2918.7 2921.6 2938.4 561.4 574.1 583.3 587.5 595.9 518.6 536.2 559.8 563.0 593.8 7471.2 7487.5 7608.5 7792.1 7828.7 453.3 532.6 533.4 549.6 585.1 3618.5 3630.2 3709.6 3881.8 4061.1 54735.7 54832.5 56068.4 58061.4 58192.0 44414.0 44449.0 44494.1 44538.6 45449.8 43991.3 44267.8 44414.6 45687.3 45948.0 7671.8 7706.4 7931.6 7935.7 8359.3 32914.3 33739.5 34471.8 35177.8 35240.0 42716.8 43340.1 43783.0 44322.6 46324.5 9876.4 10378.5 10407.2 10434.1 10518.5 11030.7 11557.4 11646.7 11817.1 11865.5 9977.5 10032.2 10053.1 10098.9 10288.9 10252.4 10318.1 10391.4 10540.6 10628.3 9443.5 9835.6 9920.2 10014.7 10380.8 8840.2 8858.0 8915.5 9143.9 9175.1 7925.0 8055.3 8066.3 8562.9 8574.9 06:19:47 INFO - PROCESS | 18306 | -------- Summary: end -------- 06:19:47 INFO - PROCESS | 18306 | 06:19:48 INFO - TEST-INFO | 18306: exit 0 06:19:48 INFO - TEST-OK | dromaeo_css | took 1110143ms 06:19:48 INFO - TEST-START | kraken 06:19:48 INFO - operating with platform_type : linux_ 06:19:48 INFO - Initialising browser for kraken test... 06:19:48 INFO - TEST-INFO | started process 18552 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCYWZ47/profile http://localhost:37821/getInfo.html) 06:19:51 INFO - PROCESS | 18552 | 06:19:51 INFO - PROCESS | 18552 | (process:18625): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:19:52 INFO - PROCESS | 18552 | __metrics Screen width/height:1600/1200 06:19:52 INFO - PROCESS | 18552 | colorDepth:24 06:19:52 INFO - PROCESS | 18552 | Browser inner width/height: 1024/697 06:19:52 INFO - PROCESS | 18552 | __metrics 06:19:52 INFO - PROCESS | 18552 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:19:53 INFO - TEST-INFO | 18552: exit 0 06:19:53 INFO - Browser initialized. 06:19:53 INFO - Running cycle 1/1 for kraken test... 06:19:53 INFO - TEST-INFO | started process 18674 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCYWZ47/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:55 INFO - PROCESS | 18674 | 06:19:55 INFO - PROCESS | 18674 | (process:18731): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:20:05 INFO - PROCESS | 18674 | RSS: Main: 150589440 06:20:05 INFO - PROCESS | 18674 | 06:20:08 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:08 INFO - PROCESS | 18674 | RSS: Main: 155033600 06:20:08 INFO - PROCESS | 18674 | 06:20:11 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-dft) 06:20:12 INFO - PROCESS | 18674 | RSS: Main: 157495296 06:20:12 INFO - PROCESS | 18674 | 06:20:14 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-fft) 06:20:15 INFO - PROCESS | 18674 | RSS: Main: 152911872 06:20:15 INFO - PROCESS | 18674 | 06:20:17 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37821/tests/kraken/driver.html?testName=audio-oscillator) 06:20:18 INFO - PROCESS | 18674 | RSS: Main: 153370624 06:20:18 INFO - PROCESS | 18674 | 06:20:20 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37821/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:21 INFO - PROCESS | 18674 | RSS: Main: 153915392 06:20:21 INFO - PROCESS | 18674 | 06:20:24 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37821/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:24 INFO - PROCESS | 18674 | RSS: Main: 153382912 06:20:24 INFO - PROCESS | 18674 | 06:20:28 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37821/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:28 INFO - PROCESS | 18674 | RSS: Main: 153878528 06:20:28 INFO - PROCESS | 18674 | 06:20:31 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37821/tests/kraken/driver.html?testName=json-parse-financial) 06:20:32 INFO - PROCESS | 18674 | RSS: Main: 154583040 06:20:32 INFO - PROCESS | 18674 | 06:20:33 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37821/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:34 INFO - PROCESS | 18674 | RSS: Main: 153956352 06:20:34 INFO - PROCESS | 18674 | 06:20:36 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:36 INFO - PROCESS | 18674 | RSS: Main: 154669056 06:20:36 INFO - PROCESS | 18674 | 06:20:38 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:39 INFO - PROCESS | 18674 | RSS: Main: 153079808 06:20:39 INFO - PROCESS | 18674 | 06:20:41 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:42 INFO - PROCESS | 18674 | RSS: Main: 154906624 06:20:42 INFO - PROCESS | 18674 | 06:20:45 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:45 INFO - PROCESS | 18674 | RSS: Main: 155389952 06:20:45 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | Cycle 1(1): loaded http://localhost:37821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37821/tests/kraken/driver.html?testName=ai-astar) 06:20:47 INFO - PROCESS | 18674 | RSS: Main: 156061696 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | __start_tp_report 06:20:47 INFO - PROCESS | 18674 | _x_x_mozilla_page_load 06:20:47 INFO - PROCESS | 18674 | _x_x_mozilla_page_load_details 06:20:47 INFO - PROCESS | 18674 | |i|pagename|runs| 06:20:47 INFO - PROCESS | 18674 | |0;ai-astar;112;108;111;113;112;123;110;111;112;112 06:20:47 INFO - PROCESS | 18674 | |1;audio-beat-detection;155;127;155;172;127;156;150;131;172;130 06:20:47 INFO - PROCESS | 18674 | |2;audio-dft;163;163;165;164;162;162;165;167;162;161 06:20:47 INFO - PROCESS | 18674 | |3;audio-fft;77;73;72;73;73;144;72;73;73;77 06:20:47 INFO - PROCESS | 18674 | |4;audio-oscillator;95;97;138;95;97;95;142;97;95;145 06:20:47 INFO - PROCESS | 18674 | |5;imaging-gaussian-blur;120;116;116;115;115;115;116;115;116;115 06:20:47 INFO - PROCESS | 18674 | |6;imaging-darkroom;146;147;146;147;147;147;147;148;148;147 06:20:47 INFO - PROCESS | 18674 | |7;imaging-desaturate;97;97;96;96;97;96;97;96;96;96 06:20:47 INFO - PROCESS | 18674 | |8;json-parse-financial;57;57;57;57;57;58;62;62;66;54 06:20:47 INFO - PROCESS | 18674 | |9;json-stringify-tinderbox;67;68;67;68;68;68;67;69;67;68 06:20:47 INFO - PROCESS | 18674 | |10;stanford-crypto-aes;84;84;85;83;89;84;83;84;84;91 06:20:47 INFO - PROCESS | 18674 | |11;stanford-crypto-ccm;117;115;115;122;134;120;126;119;123;113 06:20:47 INFO - PROCESS | 18674 | |12;stanford-crypto-pbkdf2;134;147;160;145;146;137;143;141;156;130 06:20:47 INFO - PROCESS | 18674 | |13;stanford-crypto-sha256-iterative;69;69;69;69;70;70;72;67;71;69 06:20:47 INFO - PROCESS | 18674 | __end_tp_report 06:20:47 INFO - PROCESS | 18674 | __start_cc_report 06:20:47 INFO - PROCESS | 18674 | _x_x_mozilla_cycle_collect,736 06:20:47 INFO - PROCESS | 18674 | __end_cc_report 06:20:47 INFO - PROCESS | 18674 | __startTimestamp1453990847555__endTimestamp 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | ------- Summary: start ------- 06:20:47 INFO - PROCESS | 18674 | Number of tests: 14 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:4.22 06:20:47 INFO - PROCESS | 18674 | Values: 112.0 108.0 111.0 113.0 112.0 123.0 110.0 111.0 112.0 112.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:155.00 stddev:17.67 (11.4%) stddev-sans-first:18.53 06:20:47 INFO - PROCESS | 18674 | Values: 155.0 127.0 155.0 172.0 127.0 156.0 150.0 131.0 172.0 130.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 06:20:47 INFO - PROCESS | 18674 | Values: 163.0 163.0 165.0 164.0 162.0 162.0 165.0 167.0 162.0 161.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#3] audio-fft Cycles:10 Average:80.70 Median:73.00 stddev:22.32 (30.6%) stddev-sans-first:23.63 06:20:47 INFO - PROCESS | 18674 | Values: 77.0 73.0 72.0 73.0 73.0 144.0 72.0 73.0 73.0 77.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.00 stddev:22.21 (23.4%) stddev-sans-first:22.92 06:20:47 INFO - PROCESS | 18674 | Values: 95.0 97.0 138.0 95.0 97.0 95.0 142.0 97.0 95.0 145.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.00 stddev:1.52 (1.3%) stddev-sans-first:0.53 06:20:47 INFO - PROCESS | 18674 | Values: 120.0 116.0 116.0 115.0 115.0 115.0 116.0 115.0 116.0 115.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 06:20:47 INFO - PROCESS | 18674 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:20:47 INFO - PROCESS | 18674 | Values: 97.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.50 stddev:3.53 (6.1%) stddev-sans-first:3.69 06:20:47 INFO - PROCESS | 18674 | Values: 57.0 57.0 57.0 57.0 57.0 58.0 62.0 62.0 66.0 54.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 06:20:47 INFO - PROCESS | 18674 | Values: 67.0 68.0 67.0 68.0 68.0 68.0 67.0 69.0 67.0 68.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:2.69 (3.2%) stddev-sans-first:2.82 06:20:47 INFO - PROCESS | 18674 | Values: 84.0 84.0 85.0 83.0 89.0 84.0 83.0 84.0 84.0 91.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:121.00 stddev:6.26 (5.2%) stddev-sans-first:6.51 06:20:47 INFO - PROCESS | 18674 | Values: 117.0 115.0 115.0 122.0 134.0 120.0 126.0 119.0 123.0 113.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:145.50 stddev:9.24 (6.4%) stddev-sans-first:9.08 06:20:47 INFO - PROCESS | 18674 | Values: 134.0 147.0 160.0 145.0 146.0 137.0 143.0 141.0 156.0 130.0 06:20:47 INFO - PROCESS | 18674 | 06:20:47 INFO - PROCESS | 18674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.35 (1.9%) stddev-sans-first:1.42 06:20:47 INFO - PROCESS | 18674 | Values: 69.0 69.0 69.0 69.0 70.0 70.0 72.0 67.0 71.0 69.0 06:20:47 INFO - PROCESS | 18674 | -------- Summary: end -------- 06:20:47 INFO - PROCESS | 18674 | 06:20:48 INFO - TEST-INFO | 18674: exit 0 06:20:48 INFO - TEST-OK | kraken | took 60069ms 06:20:48 INFO - TEST-START | v8_7 06:20:48 INFO - operating with platform_type : linux_ 06:20:48 INFO - Initialising browser for v8_7 test... 06:20:48 INFO - TEST-INFO | started process 18959 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqYpob6/profile http://localhost:37821/getInfo.html) 06:20:52 INFO - PROCESS | 18959 | 06:20:52 INFO - PROCESS | 18959 | (process:19031): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:20:52 INFO - PROCESS | 18959 | __metrics Screen width/height:1600/1200 06:20:52 INFO - PROCESS | 18959 | colorDepth:24 06:20:52 INFO - PROCESS | 18959 | Browser inner width/height: 1024/697 06:20:52 INFO - PROCESS | 18959 | __metrics 06:20:53 INFO - PROCESS | 18959 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:20:53 INFO - TEST-INFO | 18959: exit 0 06:20:53 INFO - Browser initialized. 06:20:53 INFO - Running cycle 1/1 for v8_7 test... 06:20:53 INFO - TEST-INFO | started process 19080 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqYpob6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:55 INFO - PROCESS | 19080 | 06:20:55 INFO - PROCESS | 19080 | (process:19140): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:21:05 INFO - PROCESS | 19080 | RSS: Main: 150470656 06:21:05 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | Cycle 1(1): loaded http://localhost:37821/tests/v8_7/run.html (next: http://localhost:37821/tests/v8_7/run.html) 06:21:28 INFO - PROCESS | 19080 | RSS: Main: 149950464 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | __start_tp_report 06:21:28 INFO - PROCESS | 19080 | _x_x_mozilla_page_load 06:21:28 INFO - PROCESS | 19080 | _x_x_mozilla_page_load_details 06:21:28 INFO - PROCESS | 19080 | |i|pagename|runs| 06:21:28 INFO - PROCESS | 19080 | |0;Richards;170.44486108743823 06:21:28 INFO - PROCESS | 19080 | |1;DeltaBlue;189.14318138831095 06:21:28 INFO - PROCESS | 19080 | |2;Encrypt;272.7768685215494 06:21:28 INFO - PROCESS | 19080 | |3;Decrypt;5196.891191709845 06:21:28 INFO - PROCESS | 19080 | |4;RayTrace;1074.1138560687432 06:21:28 INFO - PROCESS | 19080 | |5;Earley;744.047619047619 06:21:28 INFO - PROCESS | 19080 | |6;Boyer;13051.28205128205 06:21:28 INFO - PROCESS | 19080 | |7;RegExp;40823.529411764706 06:21:28 INFO - PROCESS | 19080 | |8;Splay;583.0429732868757 06:21:28 INFO - PROCESS | 19080 | |9;NavierStokes;4830.917874396136 06:21:28 INFO - PROCESS | 19080 | __end_tp_report 06:21:28 INFO - PROCESS | 19080 | __startTimestamp1453990888526__endTimestamp 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | ------- Summary: start ------- 06:21:28 INFO - PROCESS | 19080 | Number of tests: 10 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#0] Richards Cycles:1 Average:170.44 Median:170.44 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 170.4 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#1] DeltaBlue Cycles:1 Average:189.14 Median:189.14 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 189.1 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#2] Encrypt Cycles:1 Average:272.78 Median:272.78 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 272.8 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 5196.9 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 1074.1 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#5] Earley Cycles:1 Average:744.05 Median:744.05 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 744.0 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#6] Boyer Cycles:1 Average:13051.28 Median:13051.28 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 13051.3 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#7] RegExp Cycles:1 Average:40823.53 Median:40823.53 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 40823.5 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#8] Splay Cycles:1 Average:583.04 Median:583.04 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 583.0 06:21:28 INFO - PROCESS | 19080 | 06:21:28 INFO - PROCESS | 19080 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:21:28 INFO - PROCESS | 19080 | Values: 4830.9 06:21:28 INFO - PROCESS | 19080 | -------- Summary: end -------- 06:21:28 INFO - PROCESS | 19080 | 06:21:29 INFO - TEST-INFO | 19080: exit 0 06:21:29 INFO - TEST-OK | v8_7 | took 40867ms 06:21:29 INFO - SUITE-END | took 1211s 06:21:29 INFO - Completed test suite (00:20:11) 06:21:29 INFO - Working with test: dromaeo_css 06:21:29 INFO - Generating results file: dromaeo_css 06:21:29 INFO - Working with test: kraken 06:21:29 INFO - Generating results file: kraken 06:21:29 INFO - javascript benchmark 06:21:29 INFO - Working with test: v8_7 06:21:29 INFO - Generating results file: v8_7 06:21:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:21:29 INFO - process_Request line: dromaeo_css 6821.48 graph.html#tests=[[72,1,43]] 06:21:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:29 INFO - process_Request line: kraken 1518.20 graph.html#tests=[[232,1,43]] 06:21:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:29 INFO - process_Request line: v8_7 20240.86 graph.html#tests=[[230,1,43]] 06:21:29 INFO - RETURN: dromaeo_css: 6821.48 06:21:29 INFO - RETURN: kraken: 1518.20 06:21:29 INFO - RETURN: v8_7: 20240.86 06:21:29 INFO - javascript benchmark 06:21:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3092.165115418837, 3116.657167711551, 3137.670544592818, 3158.478850989587, 3159.984200078999, 5004.649674522785, 5037.5718063964605, 5046.0412521620865, 5072.163093089641, 5085.364329458813, 5025.296458495814, 5057.721825299607, 5181.015607034661, 5188.195829646402, 5209.86975325617, 4637.0, 4691.765411729417, 4737.265723812815, 4820.25286080658, 4829.637777166709, 4788.736619485927, 4797.976010119962, 4814.590759785422, 4823.975880120594, 4913.754312284389, 4711.29330600411, 4725.243960966229, 4762.380890484214, 4770.2606096055, 4770.642201834841, 4649.256119020974, 4685.976570117162, 4692.436907571113, 4702.741349225791, 4711.4346278446465, 4649.651276154302, 4660.487346391894, 4660.743659098748, 4671.836485723017, 4717.811287548494, 4825.324454576362, 4878.780454879539, 4993.251012348177, 4996.400431948153, 5131.255967884673, 5537.889242215133, 5606.691631960241, 5610.382857885629, 5627.127795191711, 5632.817108407239, 5629.240052592889, 5665.886682266373, 5676.829695109153, 5677.261955945742, 5709.0580054290995, 5157.7936882524655, 5205.0, 5208.557272631793, 5271.947280527223, 5331.86670333237, 5631.746571404296, 5634.267545219177, 5644.153376993402, 5648.774049037993, 5687.40282270364, 5432.239486471897, 5439.809606663748, 5463.098588732894, 5467.781288748405, 5524.226608274845, 5486.835394938158, 5504.504594586507, 5562.193481945176, 5589.580781441408, 5589.692566908859, 5415.512603865593, 5423.810166644149, 5536.86157846049, 5592.636478628876, 5628.521575666033, 5427.6472029317965, 5436.320459942507, 5445.047116754552, 5446.645968012146, 5447.182922561568, 4192.05678722285, 4257.254980378483, 4261.808218630169, 4273.209456250604, 4292.656587472995, 3880.864169754045, 3891.883243502643, 3917.6474117329576, 3920.098377373163, 3940.2710498557285, 5196.92204616931, 5216.817411390583, 5224.320838290998, 5229.47705229474, 5230.372355317386, 5345.278387417727, 5485.259489968803, 5511.200875872976, 5558.916616250759, 5632.577556683265, 5213.113770658922, 5218.895622087537, 5262.92105618416, 5268.078086334876, 5285.894282114336, 4636.165490211727, 4653.627709783209, 4674.953250467452, 4686.859394218179, 4720.268358404453, 5617.578681598897, 5685.204071430003, 5694.316681998104, 5717.285339332583, 5797.565182611321, 5421.5391691706645, 5422.701751403711, 5423.0, 5428.755705993319, 5429.837104886859, 5735.36910939788, 5779.335376431764, 5780.508656764054, 5806.361300257053, 5826.300843898759, 5377.489138531833, 5399.4060653327315, 5427.05026620332, 5434.945650543444, 5444.754986025559, 5313.096773548429, 5376.327959005124, 5449.427810080043, 5566.415526369673, 5611.354694210055, 5435.83692489226, 5439.945600543944, 5467.316585426822, 5474.452554744653, 5482.890342193214, 5427.050266203478, 5461.0, 5464.836054918359, 5476.423994702684, 5549.722513874371, 5188.299579556711, 5258.631895767413, 5363.731813409392, 5404.486573775485, 5482.780688772405, 5489.478499542537, 5521.944780552143, 5549.278593782944, 5557.41647127062, 5557.583181261502, 5374.516293533601, 5412.161115027177, 5412.161115027177, 5424.864378390414, 5466.0], "unit": "score", "name": "dojo.html", "value": 5113.672439170606}, {"lowerIsBetter": false, "replicates": [493.14439447558505, 521.846055413653, 524.7848382163313, 529.1375058654395, 540.4352451687987, 27904.162875113754, 28683.282917927037, 35712.642873571254, 36014.45978310327, 36259.27481450376, 39077.41383879237, 39432.80283598578, 39522.20955580887, 39600.0, 39748.80125599375, 8338.91661083389, 8517.36119791018, 8545.487270763742, 8563.486190828571, 8603.655853765842, 8306.792330191733, 8426.199511046472, 8428.620712067941, 8431.662733490653, 8475.321974242046, 8708.825823483527, 8715.869261961076, 8774.64901403943, 8795.164459376381, 8806.075362086985, 8580.699675511358, 8598.87101693475, 8639.52482613456, 8666.739997800076, 8686.478811271343, 8422.28410585101, 8649.567521623894, 8657.307415406753, 8673.392862499628, 8695.826083478358, 38749.61250387516, 38844.41733374001, 38901.41647875284, 39200.607993919984, 39204.41193382073, 2748.1343376836235, 2983.5077212259953, 3123.8281894495794, 3608.729345299113, 3679.4664773607947, 29186.416271674447, 29539.70460295391, 29643.407131857457, 30063.0, 30169.245768855733, 3826.885193444173, 3878.2243551289853, 3930.803459827026, 3939.5075615548058, 3994.1428472490343, 259551.0, 259759.0, 260944.0, 261168.9999999981, 261321.0, 51292.48707512952, 52485.47514524882, 55971.0, 56358.43641563532, 56447.15329269982, 61092.38907610867, 61647.6917615418, 61803.0, 62057.37942620516, 62145.0, 14768.778468322984, 15062.849371506145, 15151.772723409158, 15216.467423640119, 15234.238288085551, 11039.83440248397, 11041.889581104086, 11127.221094523306, 11145.665630031112, 11152.275102118336, 19276.0, 19339.4198174055, 19359.51601209981, 19845.30541431043, 19938.30215942435, 6861.416779573792, 6962.094927659372, 7048.400885924754, 7150.177729561063, 7153.248908864598, 826.5040975414703, 837.5100566168737, 861.328164032056, 998.9300748947504, 1082.5507414423084, 27987.169604893374, 28214.43571128566, 28324.150275491767, 28627.856860715565, 28651.997180098595, 962.8266911955775, 975.3221511049752, 995.8804943406838, 1072.8605281313535, 1082.7293176705823, 14640.853591463949, 14642.853571464362, 14665.780013299809, 14940.850591493945, 14962.40150393972, 318916.0, 320774.0, 321854.0, 323025.0, 325315.0, 50636.74681626568, 50705.746471267405, 50763.23855142176, 51115.48884511182, 51124.74437627788, 1247.0709321555498, 1263.3556885988028, 1264.8861602455822, 1269.149669721289, 1269.225772278909, 26671.33321666896, 27666.861665692348, 27882.58176127319, 28323.716762832108, 28372.85813570919, 45866.312005320615, 45893.54106458893, 46280.768596156806, 46282.30576541287, 46612.76693616646, 300484.0, 301972.0, 302276.0, 303459.0, 303518.0, 31463.0, 31905.0, 32071.839640801645, 32154.0, 32178.35643287168, 37400.0, 37935.62064379321, 38226.42660360041, 38232.426513601764, 38260.808695956344, 30726.0, 31322.21694457657, 31921.521177182825, 32005.519917201727, 32373.676263237066, 32458.83770581132, 33006.834965825015, 34399.656003439646, 35005.299894002485, 35254.29491410106, 31057.844710777204, 31427.37145257128, 31547.684523155393, 31643.683563164075, 31680.049598512083, 28005.579916301678, 28764.963619815586, 29342.0, 29461.85269073641, 29742.702572973994, 22182.55634887261, 22328.88835555812, 22344.329670109273, 22415.551688966454, 22469.66295505536], "unit": "score", "name": "ext.html", "value": 17669.12907145694}, {"lowerIsBetter": false, "replicates": [349.97725147865384, 351.9331327047862, 356.3727839003353, 356.4407553763977, 357.53698959847003, 14140.434382624708, 14583.635409114777, 15410.152441615706, 16148.192590370492, 17568.73646895296, 14369.928150359234, 14604.050736702133, 14635.414583416677, 14780.187089710089, 14953.551393458187, 5036.672616279949, 5098.84703458895, 5195.610329225305, 5230.581553475732, 5240.947590524103, 5176.456472070435, 6008.579399442041, 6238.282597501277, 6281.152044473984, 6288.779892703757, 6028.27660680719, 6195.2565692117005, 6242.719077641517, 6275.309715931244, 6277.968610156966, 6011.278646562397, 6217.347178546278, 6255.437010669061, 6478.967605161991, 6504.739810407578, 5827.650340979555, 5972.850678733023, 5995.490383317423, 6029.336772954972, 6039.184710064129, 20649.58700825975, 20667.276645317343, 20968.89515552428, 22091.116355345766, 22215.66676499854, 1945.387203031055, 2152.2359562355296, 2168.8807115608633, 2199.615067363221, 2351.413445210255, 13049.739005219843, 13140.802887956688, 13187.802182967263, 13614.523491677744, 13836.377363018688, 1972.1716878910893, 1993.1728332741895, 2030.4314791858155, 2063.009755317456, 2116.354511873878, 63225.36774632241, 63560.0, 66004.3399566003, 66473.0, 66585.0, 14632.179043540955, 14875.553733388017, 14911.925440372728, 14924.179170145746, 15595.688086238439, 22861.0, 22909.656355154686, 23020.194293199656, 23140.768592314198, 23255.53488930212, 8640.13598640131, 8763.430377025474, 8765.298776097898, 8781.692640757543, 8854.77863053416, 7327.560346379234, 7358.632068396559, 7364.079490063742, 7398.741044063432, 7413.66638501258, 6694.364035416627, 6983.196932352845, 7244.963775181091, 7363.7422690205585, 7527.774166775005, 2916.6645835728737, 3021.305099827052, 3063.5557844112477, 3097.969020309813, 3104.2704964333366, 830.4892491117919, 834.6285902773329, 926.379325851681, 932.4778124250441, 952.88722842963, 15683.843161568466, 15718.842811571967, 15751.68496630084, 16062.196890155445, 16591.336346546243, 852.0712423458336, 858.3948316436897, 877.4998250996871, 892.5537231384308, 904.6155383961922, 7796.84406311882, 7962.442629016029, 8550.914490855137, 9399.0, 9451.102145296185, 491811.0, 500380.0, 501920.0, 518517.0, 526397.0, 72839.2716072843, 75426.0, 75552.62223688846, 76598.23401766023, 76949.0, 1100.2408338246585, 1106.115107913666, 1135.1089394825024, 1162.2271189658782, 1163.7265242667966, 14518.20149891766, 14661.340239689453, 14932.104073755609, 14972.176530290939, 15010.924945375204, 33431.83284083564, 34388.82805586056, 34490.82754586211, 34718.305633887685, 35282.47076293909, 42021.0, 42075.36886946637, 43020.13959720851, 43107.0, 44712.552874470835, 6956.582605043714, 7171.139463264233, 7259.854802903807, 7271.091113610799, 7407.740729074457, 10746.785064298827, 10820.837687434538, 11032.779344413228, 11106.389148596905, 11210.159238057015, 9156.404833685789, 9392.436453812794, 10235.130013948898, 10282.845757313797, 10302.072813446826, 2917.8103423278267, 4372.928632485062, 7416.517926334771, 10350.223733219887, 10454.163666906477, 3062.341596556751, 8168.080501082122, 9648.469334186688, 10072.647457338959, 10395.220358472994, 7461.403087753075, 7501.549907005598, 7525.887111693439, 7573.2805383488485, 7575.242475752601, 7689.307962283421, 9400.905990940004, 9618.615255389706, 9662.613495460102, 9684.854727178958], "unit": "score", "name": "jquery.html", "value": 8734.761360086311}, {"lowerIsBetter": false, "replicates": [1422.6372275069857, 1435.892308076894, 1557.5015994881635, 1716.210543150151, 1717.5276798880307, 6761.459083273338, 6913.239543650207, 7359.411247100233, 7576.924230757691, 7590.848183036343, 7112.751053713121, 7121.679524421401, 7212.098487689039, 7215.675294611742, 7287.672054757535, 2220.8334374921865, 2255.706758121442, 2263.7396699379533, 2273.4998300373973, 2279.4985103277254, 2221.466847956495, 2252.3017864462067, 2292.381057114578, 2295.254042436215, 2298.0577963035157, 2223.9332820015343, 2239.0484044281197, 2240.2271216430304, 2240.372695645222, 2259.2318611672026, 2245.2366195493446, 2249.5388445368662, 2251.964096515605, 2266.2408093288686, 2274.3290729234914, 2239.0931672672596, 2251.4596496840804, 2264.445210923318, 2265.8074063704603, 2266.048259730917, 7556.584387858666, 7560.0, 7577.355924746348, 7579.317861392501, 7587.0, 4375.606195442394, 4444.711093778894, 4459.175052615245, 4463.285874260103, 4470.910581788378, 2892.913212603625, 2948.1155653304136, 2951.1736713720193, 2968.9257768555744, 2971.643402791679, 892.0722448653393, 904.5025236120108, 933.2021121940778, 941.7316064921464, 954.1031430455349, 10299.22755793311, 10480.161587073017, 10492.16062714981, 10500.842487362695, 10539.63111291101, 4042.3734321180264, 4054.3107671695884, 4060.959390406117, 4070.0842310479907, 4076.4496792932573, 9016.692579575925, 9056.184943355129, 9111.589978450986, 9124.635014599342, 9133.132352426508, 4538.455385353713, 4539.137563862855, 4576.222042252825, 4585.633149348044, 4594.081183763261, 3773.396256598931, 3828.5405751310022, 4037.8384864605086, 4116.794160291974, 4175.603317684815, 3598.2803439312243, 3656.433252845813, 3668.101315177745, 3673.173535954389, 3712.6472985066375, 1168.2756690851556, 1179.9587014454453, 1181.3502573584667, 1181.6750393641646, 1181.8581770187632, 1214.2350319298962, 1220.267839296415, 1235.6725467751053, 1235.9505619775289, 1251.343044901434, 6777.695003724844, 6781.321867813179, 6864.828379290558, 7068.823279418056, 7251.456140789462, 1089.6004466065924, 1093.6172339681048, 1095.9726006849892, 1102.1843835561626, 1124.8818874018275, 5598.888022239533, 5669.34802497718, 5725.971370143206, 5731.914021289684, 5753.683547404933, 8742.650293988168, 9155.908440915638, 9166.495842728715, 9191.402558833654, 9274.860877086849, 9111.316651251183, 9120.954395228115, 9135.995040545535, 9178.21985131258, 9180.770480738034, 6889.345512176335, 7012.158540975116, 7038.190608080034, 7063.57618542889, 7116.466265030143, 7019.894701579378, 7044.718211271492, 7088.0, 7100.4319654428555, 7117.395021423237, 7834.725784597512, 8028.959855200686, 8176.754697359089, 8198.344132469507, 8267.793305167419, 8366.494031074464, 8398.286145677686, 8429.831403371776, 8463.36524760633, 8503.319734421108, 6489.318621544859, 6510.7721229756735, 6600.075989361397, 6662.866742665216, 6743.123393958754, 6899.586024838526, 6919.169699636076, 6956.930430695831, 6967.79096627102, 6972.0, 6486.837829054122, 6632.1709786276715, 6684.6991885364305, 6734.4612431004425, 6803.693833777393, 6416.422521973045, 6459.450946669585, 6536.607803531803, 6649.767258145942, 6666.933330666631, 6236.251649802053, 6239.282482514569, 6251.843703907257, 6269.279032911274, 6340.048992651139, 5694.1458781183155, 5703.600747947604, 5704.543636509153, 5707.229524014205, 5723.456271654186, 5845.386234445322, 5911.793087241926, 5913.142594323885, 5917.37867523921, 5921.703914804329], "unit": "score", "name": "mootools.html", "value": 4335.209611889617}, {"lowerIsBetter": false, "replicates": [338.78148594156767, 342.028638666188, 343.81262212094407, 346.6931765387632, 349.08365540456316, 6230.906536401952, 6268.279147897993, 6291.591046581969, 6321.304656487789, 6393.584417012891, 6182.6290422574675, 6255.468285195764, 6310.58981166225, 6388.744450221997, 6402.9679851600795, 4711.670183087168, 4737.549932756383, 4739.976300118495, 4745.430548334205, 4755.500672429397, 4728.0307536955015, 4743.478217396084, 4746.928796068062, 4751.002289519205, 4754.690945088575, 4617.261238201889, 4676.041411510632, 4679.204535229002, 4679.74261415622, 4693.6010439112715, 4667.603253723438, 4669.626429885618, 4677.906441871143, 4678.953210467903, 4712.175369310391, 4026.4765580474646, 4033.4353190553347, 4038.45480860086, 4042.393640953851, 4049.97975010126, 6010.429009244115, 6011.0, 6016.2479690038745, 6018.909716354258, 6020.729067191987, 5308.124159513675, 5435.1847222916485, 5437.238786569884, 5438.483344082306, 5447.836564903059, 6569.441597464173, 6626.966865165643, 6628.2046154461295, 6631.403173714389, 6634.933650663528, 4441.133978874121, 4447.666425018104, 4456.17560751262, 4456.799444025027, 4486.282194848808, 6847.417969472601, 6892.104671215406, 6981.650917454158, 6987.231404545496, 6993.685284162174, 4632.837850675211, 4642.141203877226, 4645.39609850724, 4653.511381304982, 4678.976605116953, 4691.085238378551, 4698.8355407560575, 4706.458757242961, 4707.95292047082, 4715.575598196178, 5473.7263136843, 5480.561555075585, 5482.862928426821, 5484.588655850747, 5491.615586908958, 6495.837604059936, 6676.399124078759, 6719.798406047827, 6738.258791532928, 6751.729930802811, 1608.2360878582579, 1638.131790151198, 1641.2778377513855, 1644.7779549760628, 1647.4975132584436, 1077.1813421799488, 1090.7818436312612, 1090.8200146975819, 1093.316677076827, 1097.2483848563759, 6166.229221347332, 6166.630002199792, 6185.443310102112, 6219.284782250099, 6244.812655620339, 6700.6984685688285, 6713.731450742013, 6721.395074443323, 6739.494537909676, 6758.189017317855, 6130.264368275746, 6234.5635805494085, 6239.937600624026, 6248.625082495065, 6272.749090036347, 3676.117731744362, 3676.852925882988, 3694.7967861767324, 3695.593484716679, 3702.20402613434, 7083.0, 7096.503244772816, 7099.148102227766, 7106.0, 7106.182788979334, 6778.932210677929, 6898.448124150056, 6899.068625735562, 6948.409385202314, 6987.056747339146, 7026.332498412643, 7071.398931090915, 7076.823079423056, 7090.0, 7098.538594991309, 6726.7981960541265, 6743.561668491532, 6763.932360676527, 6770.086038384755, 6777.559458635173, 6535.901961470487, 6683.097781799394, 6686.732530698912, 6701.765438209639, 6721.1598550181225, 7052.647367631495, 7067.0459487968465, 7088.751893683696, 7092.113485814273, 7096.822579435556, 4583.289590113538, 4634.540119862233, 4638.605718513829, 4640.211164102178, 4643.558861908114, 6673.998900165014, 6693.832654183684, 6778.93221067783, 6781.050652908695, 6921.757738479129, 6700.564463309869, 6766.0, 6769.830754231184, 6781.220159681699, 6795.592264464148, 6732.057511948429, 6734.764283250062, 6742.0, 6783.966080169567, 6846.075779769866, 6513.218413790375, 6605.867882642417, 6634.170728658918, 6637.900431493628, 6654.500912431684, 6802.489813264124, 6803.421709154777, 6809.38715515606, 6812.931870681428, 6833.4191593715095, 6551.72241412939, 6589.275179730322, 6621.867562648817, 6623.072769812134, 6654.201495820533], "unit": "score", "name": "prototype.html", "value": 4969.68847405934}, {"lowerIsBetter": false, "replicates": [617.5152505283351, 618.9319174890765, 628.1927722876105, 657.871715015572, 773.9458237923347, 12661.620151395462, 12685.682857928556, 12758.489660413585, 12788.744225115504, 12797.936010319958, 13627.523036693718, 14140.717185656307, 14155.0, 14185.78721319181, 14242.074265172756, 760.0233699695892, 770.6300975531748, 777.6850375597878, 789.7512283630666, 790.9920900790976, 786.6578038553248, 790.7667238164755, 791.6041979010495, 792.8572856885759, 793.9682412703485, 810.8094597769519, 816.0, 818.0306336990685, 818.4966245758845, 820.27405745915, 808.5593351623379, 810.1048341582525, 817.1338381315794, 818.3085292927467, 819.2503858969036, 599.3886236039216, 601.4286427893519, 602.3554796367888, 603.8369640197166, 604.1421181921681, 13386.330683465885, 13423.597292081156, 13462.326883655778, 13473.258970756604, 13505.86494135056, 11942.880571194351, 12092.576759813364, 12249.326287054208, 12498.0, 12706.174098683648, 9919.553620087114, 9980.30137890348, 10008.89991100087, 10080.294379393445, 10200.94899525505, 3445.3970555152746, 3490.6683865032783, 3519.8768043118366, 3520.119970007498, 3538.327717733622, 46247.30629040567, 47389.5261047392, 47648.523514765104, 48021.0, 48129.278060829114, 9622.085901839455, 9642.132208101304, 9734.123928846439, 9761.51192440375, 9767.609295628237, 16431.424900128437, 16432.67134657324, 16455.506334809976, 16501.257443415074, 16584.336626534805, 6512.544121911421, 6844.931550684529, 6973.79078627642, 7110.360067593838, 7116.928830711627, 3948.940765888514, 3981.0, 3995.220931918248, 4165.854195103157, 4221.91556168881, 2879.1938257287993, 2913.286244869978, 2918.6643535993207, 2921.576371426131, 2938.4270067337093, 561.357245953381, 574.0757380617202, 583.2883881664362, 587.4742105815271, 595.87188754418, 518.5851318944829, 536.1502019299376, 559.8488408129782, 562.9577781666392, 593.7595273914071, 7471.215522370073, 7487.513311634726, 7608.543487390774, 7792.142864284924, 7828.686852525949, 453.29512607894384, 532.5686194182724, 533.4265664410774, 549.5933009572967, 585.0814221671934, 3618.475321078429, 3630.221191616089, 3709.6104908984707, 3881.80590970456, 4061.1268577256033, 54735.72632136894, 54832.451675483535, 56068.43931560714, 58061.4193858056, 58192.0, 44414.0, 44449.0, 44494.11011779811, 44538.554614454086, 45449.772751136035, 43991.340129898075, 44267.77866110649, 44414.555854441685, 45687.31469027967, 45948.0, 7671.846563068819, 7706.422018348759, 7931.5637639928045, 7935.722249721232, 8359.289460395934, 32914.34171316608, 33739.49390759091, 34471.82764086164, 35177.82411087928, 35240.0, 42716.78641606772, 43340.13319733651, 43783.0, 44322.55677443184, 46324.53675463202, 9876.407415554802, 10378.532966016397, 10407.167426606005, 10434.113100386552, 10518.474076296308, 11030.669079927615, 11557.364344961108, 11646.650600481998, 11817.113716471127, 11865.525378984745, 9977.529430480341, 10032.247581431568, 10053.095221430107, 10098.872849515581, 10288.897111028793, 10252.38485690861, 10318.122959548522, 10391.37651740898, 10540.631077912236, 10628.309159904582, 9443.480608566595, 9835.590714770831, 9920.156786673213, 10014.749631259278, 10380.844287335545, 8840.24857887061, 8857.981332146628, 8915.50964696922, 9143.908560914306, 9175.128362805523, 7924.960375198087, 8055.275025247756, 8066.314363278952, 8562.871556926526, 8574.871376929226], "unit": "score", "name": "yui.html", "value": 5925.10387963857}], "name": "dromaeo_css", "value": 6821.481976434403}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 113.0, 112.0, 123.0, 110.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 155.0, 172.0, 127.0, 156.0, 150.0, 131.0, 172.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 165.0, 164.0, 162.0, 162.0, 165.0, 167.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 72.0, 73.0, 73.0, 144.0, 72.0, 73.0, 73.0, 77.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 138.0, 95.0, 97.0, 95.0, 142.0, 97.0, 95.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 115.0, 115.0, 115.0, 116.0, 115.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 62.0, 62.0, 66.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 83.0, 89.0, 84.0, 83.0, 84.0, 84.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 115.0, 122.0, 134.0, 120.0, 126.0, 119.0, 123.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [134.0, 147.0, 160.0, 145.0, 146.0, 137.0, 143.0, 141.0, 156.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 72.0, 67.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1518.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.44486108743823], "unit": "score", "name": "Richards", "value": 207.11683399999993}, {"lowerIsBetter": false, "replicates": [189.14318138831095], "unit": "score", "name": "DeltaBlue", "value": 349.565866}, {"lowerIsBetter": false, "replicates": [272.7768685215494], "unit": "score", "name": "Encrypt", "value": 975.8195460000002}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [744.047619047619], "unit": "score", "name": "Earley", "value": 895.7262720000001}, {"lowerIsBetter": false, "replicates": [13051.28205128205], "unit": "score", "name": "Boyer", "value": 51.064944990176855}, {"lowerIsBetter": false, "replicates": [40823.529411764706], "unit": "score", "name": "RegExp", "value": 22.315194524495666}, {"lowerIsBetter": false, "replicates": [583.0429732868757], "unit": "score", "name": "Splay", "value": 139.76842828685258}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20240.855907768517}]} 06:21:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20240.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1518.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6821.48"}}} 06:21:29 INFO - Return code: 0 06:21:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:21:30 INFO - # TBPL SUCCESS # 06:21:30 INFO - Running post-action listener: _resource_record_post_action 06:21:30 INFO - Running post-run listener: _resource_record_post_run 06:21:31 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 550490112; Read time: 0; Write time: 525848 06:21:31 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235773952; Read time: 0; Write time: 313256 06:21:31 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 314118144; Read time: 0; Write time: 212592 06:21:31 INFO - Running post-run listener: _upload_blobber_files 06:21:31 INFO - Blob upload gear active. 06:21:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:21:31 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 06:21:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:21:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:21:31 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:21:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:21:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:32 INFO - (blobuploader) - INFO - Done attempting. 06:21:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:21:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:21:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:33 INFO - (blobuploader) - INFO - Done attempting. 06:21:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:33 INFO - Return code: 0 06:21:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:21:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6af7c9b144e2477f25051d4f4eeb72e93c8801059741b15e1bfe2d529a37ddb023aee896bafa9fdba7cab5a046194c6ac8425bd5b0dcbf9142ea66c2f28a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f61ed5932db91983d10dd672822aacca381bc2d7ce130c9917e7acac809fe0f0bd99f0e7ba2fe073f95d81c9344ddc0366a1c61353745a8f533588446cab837d"} 06:21:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:21:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:21:33 INFO - Contents: 06:21:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6af7c9b144e2477f25051d4f4eeb72e93c8801059741b15e1bfe2d529a37ddb023aee896bafa9fdba7cab5a046194c6ac8425bd5b0dcbf9142ea66c2f28a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f61ed5932db91983d10dd672822aacca381bc2d7ce130c9917e7acac809fe0f0bd99f0e7ba2fe073f95d81c9344ddc0366a1c61353745a8f533588446cab837d"} 06:21:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:33 INFO - Copying logs to upload dir... 06:21:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:21:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.431247 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-28 06:21:32.321438) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:32.324963) ========= 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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6af7c9b144e2477f25051d4f4eeb72e93c8801059741b15e1bfe2d529a37ddb023aee896bafa9fdba7cab5a046194c6ac8425bd5b0dcbf9142ea66c2f28a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f61ed5932db91983d10dd672822aacca381bc2d7ce130c9917e7acac809fe0f0bd99f0e7ba2fe073f95d81c9344ddc0366a1c61353745a8f533588446cab837d"} build_url:https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011522 build_url: 'https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6af7c9b144e2477f25051d4f4eeb72e93c8801059741b15e1bfe2d529a37ddb023aee896bafa9fdba7cab5a046194c6ac8425bd5b0dcbf9142ea66c2f28a0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f61ed5932db91983d10dd672822aacca381bc2d7ce130c9917e7acac809fe0f0bd99f0e7ba2fe073f95d81c9344ddc0366a1c61353745a8f533588446cab837d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:32.350038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:32.350365) ========= 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=232498196343f89f466a4a9a000001c8-1453988638.901188-1508669373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:32.434464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 06:21:32.434780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 06:21:32.435085) ========= ========= Total master_lag: 0.28 =========