builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1453776686.52 results: success (0) buildid: 20160125163025 builduid: 3b90ec9f862a4a82be49a12fe9cd01a4 revision: aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.519470) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.519933) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.520277) ========= 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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006467 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.547267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.547572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.569352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.569667) ========= 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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022419 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.622760) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.623543) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.624201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.624529) ========= 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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 18:51:26-- 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% 216M=0s 2016-01-25 18:51:26 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.807000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.807738) ========= 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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.138701 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.960313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:26.960710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3 --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 aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3 --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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 18:51:27,188 truncating revision to first 12 chars 2016-01-25 18:51:27,188 Setting DEBUG logging. 2016-01-25 18:51:27,188 attempt 1/10 2016-01-25 18:51:27,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aa90f482e16d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 18:51:27,470 unpacking tar archive at: mozilla-central-aa90f482e16d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:27.576650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:27.577064) ========= echo aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3'] 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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3 program finished with exit code 0 elapsedTime=0.004763 script_repo_revision: 'aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:27.628426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:27.628792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 18:51:27.639238) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-25 18:51:27.639554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:51:27 INFO - MultiFileLogger online at 20160125 18:51:27 in /builds/slave/test-pgo 18:51:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:51:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:51:27 INFO - {'append_to_log': False, 18:51:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:51:27 INFO - 'blob_upload_branch': 'Firefox', 18:51:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:51:27 INFO - 'branch': 'Firefox', 18:51:27 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:27 INFO - 'config_files': ('talos/linux_config.py',), 18:51:27 INFO - 'default_actions': ('clobber', 18:51:27 INFO - 'read-buildbot-config', 18:51:27 INFO - 'download-and-extract', 18:51:27 INFO - 'populate-webroot', 18:51:27 INFO - 'create-virtualenv', 18:51:27 INFO - 'install', 18:51:27 INFO - 'run-tests'), 18:51:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:27 INFO - 'download_minidump_stackwalk': True, 18:51:27 INFO - 'download_symbols': 'ondemand', 18:51:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:51:27 INFO - 'tooltool.py': '/tools/tooltool.py', 18:51:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:51:27 INFO - '/tools/misc-python/virtualenv.py')}, 18:51:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:27 INFO - 'installer_path': 'installer.exe', 18:51:27 INFO - 'log_level': 'info', 18:51:27 INFO - 'log_name': 'talos', 18:51:27 INFO - 'log_to_console': True, 18:51:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:51:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:51:27 INFO - 'opt_config_files': (), 18:51:27 INFO - 'pip_index': False, 18:51:27 INFO - 'sps_profile': False, 18:51:27 INFO - 'sps_profile_interval': 0, 18:51:27 INFO - 'suite': 'dromaeojs', 18:51:27 INFO - 'system_bits': '32', 18:51:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:27 INFO - 'title': 'talos-linux64-ix-020', 18:51:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:51:27 INFO - 'use_talos_json': True, 18:51:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:51:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:27 INFO - 'work_dir': 'build'} 18:51:27 INFO - ##### 18:51:27 INFO - ##### Running clobber step. 18:51:27 INFO - ##### 18:51:27 INFO - Running pre-action listener: _resource_record_pre_action 18:51:27 INFO - Running main action method: clobber 18:51:27 INFO - rmtree: /builds/slave/test-pgo/build 18:51:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:51:29 INFO - Running post-action listener: _resource_record_post_action 18:51:29 INFO - ##### 18:51:29 INFO - ##### Running read-buildbot-config step. 18:51:29 INFO - ##### 18:51:29 INFO - Running pre-action listener: _resource_record_pre_action 18:51:29 INFO - Running main action method: read_buildbot_config 18:51:29 INFO - Using buildbot properties: 18:51:29 INFO - { 18:51:29 INFO - "project": "", 18:51:29 INFO - "product": "firefox", 18:51:29 INFO - "script_repo_revision": "production", 18:51:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:51:29 INFO - "repository": "", 18:51:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:51:29 INFO - "buildid": "20160125163025", 18:51:29 INFO - "pgo_build": "True", 18:51:29 INFO - "basedir": "/builds/slave/test-pgo", 18:51:29 INFO - "buildnumber": 172, 18:51:29 INFO - "slavename": "talos-linux64-ix-020", 18:51:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:51:29 INFO - "platform": "ubuntu64_hw", 18:51:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:51:29 INFO - "branch": "mozilla-central", 18:51:29 INFO - "repo_path": "mozilla-central", 18:51:29 INFO - "revision": "aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3", 18:51:29 INFO - "stage_platform": "linux64-pgo", 18:51:29 INFO - "builduid": "3b90ec9f862a4a82be49a12fe9cd01a4", 18:51:29 INFO - "slavebuilddir": "test" 18:51:29 INFO - } 18:51:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 18:51:29 INFO - Running post-action listener: _resource_record_post_action 18:51:29 INFO - ##### 18:51:29 INFO - ##### Running download-and-extract step. 18:51:29 INFO - ##### 18:51:29 INFO - Running pre-action listener: _resource_record_pre_action 18:51:29 INFO - Running main action method: download_and_extract 18:51:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:29 INFO - https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:51:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/test_packages.json 18:51:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/test_packages.json 18:51:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:51:30 INFO - Downloaded 1448 bytes. 18:51:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:51:30 INFO - Using the following test package requirements: 18:51:30 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:51:30 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:51:30 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:51:30 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'jsshell-linux-x86_64.zip'], 18:51:30 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:51:30 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:51:30 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:51:30 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:51:30 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:51:30 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:51:30 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:51:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:51:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:51: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')]} 18:51:30 INFO - https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:35 INFO - Downloaded 22499146 bytes. 18:51:35 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'] 18:51:35 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 18:51:36 INFO - Return code: 0 18:51:36 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 18:51:36 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')]} 18:51:36 INFO - https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:40 INFO - Downloaded 22499146 bytes. 18:51:40 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'] 18:51:40 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 18:51:41 INFO - Return code: 0 18:51:41 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')]} 18:51:41 INFO - https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:42 INFO - Downloaded 10706572 bytes. 18:51:42 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'] 18:51:42 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 18:51:42 INFO - Return code: 0 18:51: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')]} 18:51:42 INFO - https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RM8vidEoST67ux0oxRkYMg/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 18:51:45 INFO - Downloaded 55987132 bytes. 18:51:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:51:45 INFO - mkdir: /builds/slave/test-pgo/properties 18:51:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:51:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:51:45 INFO - Contents: 18:51:45 INFO - build_url:https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:51:45 INFO - Running post-action listener: _resource_record_post_action 18:51:45 INFO - Running post-action listener: set_extra_try_arguments 18:51:45 INFO - ##### 18:51:45 INFO - ##### Running populate-webroot step. 18:51:45 INFO - ##### 18:51:45 INFO - Running pre-action listener: _resource_record_pre_action 18:51:45 INFO - Running main action method: populate_webroot 18:51:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:51:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:51:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:51:45 INFO - '--tppagecycles', 18:51:45 INFO - '7'], 18:51:45 INFO - 'tests': ['tsvgm']}}, 18:51:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:51:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:51:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:51:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:51:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'tests': ['damp', 'tps']}, 18:51:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['damp', 'tps']}, 18:51:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:51:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:51:45 INFO - 'other': {'tests': ['a11yr', 18:51:45 INFO - 'ts_paint', 18:51:45 INFO - 'tpaint', 18:51:45 INFO - 'sessionrestore', 18:51:45 INFO - 'sessionrestore_no_auto_restore']}, 18:51:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['a11yr', 18:51:45 INFO - 'ts_paint', 18:51:45 INFO - 'tpaint', 18:51:45 INFO - 'sessionrestore', 18:51:45 INFO - 'sessionrestore_no_auto_restore']}, 18:51:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['a11yr', 18:51:45 INFO - 'ts_paint', 18:51:45 INFO - 'tpaint', 18:51:45 INFO - 'sessionrestore', 18:51:45 INFO - 'sessionrestore_no_auto_restore']}, 18:51:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['a11yr', 18:51:45 INFO - 'ts_paint', 18:51:45 INFO - 'tpaint', 18:51:45 INFO - 'sessionrestore', 18:51:45 INFO - 'sessionrestore_no_auto_restore']}, 18:51:45 INFO - 'other_l64': {'tests': ['a11yr', 18:51:45 INFO - 'ts_paint', 18:51:45 INFO - 'tpaint', 18:51:45 INFO - 'sessionrestore', 18:51:45 INFO - 'sessionrestore_no_auto_restore']}, 18:51:45 INFO - 'other_nol64': {'tests': ['a11yr', 18:51:45 INFO - 'ts_paint', 18:51:45 INFO - 'tpaint', 18:51:45 INFO - 'sessionrestore', 18:51:45 INFO - 'sessionrestore_no_auto_restore']}, 18:51:45 INFO - 'svgr': {'tests': ['tsvgx', 18:51:45 INFO - 'tsvgr_opacity', 18:51:45 INFO - 'tart', 18:51:45 INFO - 'tscrollx', 18:51:45 INFO - 'cart']}, 18:51:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['tsvgx', 18:51:45 INFO - 'tsvgr_opacity', 18:51:45 INFO - 'tart', 18:51:45 INFO - 'tscrollx', 18:51:45 INFO - 'cart']}, 18:51:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'tests': ['tp5o']}, 18:51:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'talos_options': ['--e10s'], 18:51:45 INFO - 'tests': ['tp5o']}, 18:51:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'talos_options': ['--xperf_path', 18:51:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:45 INFO - 'tests': ['tp5n']}, 18:51:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:45 INFO - 'talos_options': ['--e10s', 18:51:45 INFO - '--xperf_path', 18:51:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:45 INFO - 'tests': ['tp5n']}}, 18:51:45 INFO - 'talos.zip': {'path': '', 18:51:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:51:45 INFO - Running post-action listener: _resource_record_post_action 18:51:45 INFO - ##### 18:51:45 INFO - ##### Running create-virtualenv step. 18:51:45 INFO - ##### 18:51:45 INFO - Running pre-action listener: _resource_record_pre_action 18:51:45 INFO - Running main action method: create_virtualenv 18:51:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:51:45 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 18:51:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:51:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:51:46 INFO - Using real prefix '/usr' 18:51:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:51:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:51:48 INFO - Installing pip.................done. 18:51:48 INFO - Return code: 0 18:51:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:51: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')]} 18:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:48 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:51:48 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 18:51:48 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 18:51:48 INFO - Using env: {'DISPLAY': ':0', 18:51:48 INFO - 'HOME': '/home/cltbld', 18:51:48 INFO - 'LANG': 'en_US.UTF-8', 18:51:48 INFO - 'LANGUAGE': 'en_US:en', 18:51:48 INFO - 'LOGNAME': 'cltbld', 18:51:48 INFO - 'MAIL': '/var/mail/cltbld', 18:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:48 INFO - 'MOZ_NO_REMOTE': '1', 18:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:48 INFO - 'NO_EM_RESTART': '1', 18:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:48 INFO - 'SHELL': '/bin/bash', 18:51:48 INFO - 'SHLVL': '1', 18:51:48 INFO - 'TERM': 'linux', 18:51:48 INFO - 'TMOUT': '86400', 18:51:48 INFO - 'USER': 'cltbld', 18:51:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:48 INFO - '_': '/tools/buildbot/bin/python'} 18:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:48 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 18:51:48 INFO - Cleaning up... 18:51:48 INFO - Return code: 0 18:51:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:51: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')]} 18:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:48 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:51:48 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 18:51:48 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 18:51:48 INFO - Using env: {'DISPLAY': ':0', 18:51:48 INFO - 'HOME': '/home/cltbld', 18:51:48 INFO - 'LANG': 'en_US.UTF-8', 18:51:48 INFO - 'LANGUAGE': 'en_US:en', 18:51:48 INFO - 'LOGNAME': 'cltbld', 18:51:48 INFO - 'MAIL': '/var/mail/cltbld', 18:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:48 INFO - 'MOZ_NO_REMOTE': '1', 18:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:48 INFO - 'NO_EM_RESTART': '1', 18:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:48 INFO - 'SHELL': '/bin/bash', 18:51:48 INFO - 'SHLVL': '1', 18:51:48 INFO - 'TERM': 'linux', 18:51:48 INFO - 'TMOUT': '86400', 18:51:48 INFO - 'USER': 'cltbld', 18:51:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:48 INFO - '_': '/tools/buildbot/bin/python'} 18:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:48 INFO - Downloading/unpacking psutil>=0.7.1 18:51:48 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 18:51:48 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 18:51:48 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 18:51:48 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 18:51:48 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 18:51:48 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 18:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:51:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:50 INFO - Installing collected packages: psutil 18:51:50 INFO - Running setup.py install for psutil 18:51:50 INFO - building 'psutil._psutil_linux' extension 18:51:50 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 18:51:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:51:51 INFO - building 'psutil._psutil_posix' extension 18:51:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:51:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:51:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:51 INFO - Successfully installed psutil 18:51:51 INFO - Cleaning up... 18:51:51 INFO - Return code: 0 18:51:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:51: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')]} 18:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:51 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:51:51 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 18:51:51 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 18:51:51 INFO - Using env: {'DISPLAY': ':0', 18:51:51 INFO - 'HOME': '/home/cltbld', 18:51:51 INFO - 'LANG': 'en_US.UTF-8', 18:51:51 INFO - 'LANGUAGE': 'en_US:en', 18:51:51 INFO - 'LOGNAME': 'cltbld', 18:51:51 INFO - 'MAIL': '/var/mail/cltbld', 18:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:51 INFO - 'MOZ_NO_REMOTE': '1', 18:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:51 INFO - 'NO_EM_RESTART': '1', 18:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:51 INFO - 'SHELL': '/bin/bash', 18:51:51 INFO - 'SHLVL': '1', 18:51:51 INFO - 'TERM': 'linux', 18:51:51 INFO - 'TMOUT': '86400', 18:51:51 INFO - 'USER': 'cltbld', 18:51:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:51 INFO - '_': '/tools/buildbot/bin/python'} 18:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:51:51 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 18:51:51 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 18:51:51 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 18:51:51 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 18:51:51 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 18:51:51 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 18:51:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:51:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:51:53 INFO - Installing collected packages: mozsystemmonitor 18:51:53 INFO - Running setup.py install for mozsystemmonitor 18:51:53 INFO - Successfully installed mozsystemmonitor 18:51:53 INFO - Cleaning up... 18:51:53 INFO - Return code: 0 18:51:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:53 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:51:53 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 18:51:53 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 18:51:53 INFO - Using env: {'DISPLAY': ':0', 18:51:53 INFO - 'HOME': '/home/cltbld', 18:51:53 INFO - 'LANG': 'en_US.UTF-8', 18:51:53 INFO - 'LANGUAGE': 'en_US:en', 18:51:53 INFO - 'LOGNAME': 'cltbld', 18:51:53 INFO - 'MAIL': '/var/mail/cltbld', 18:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:53 INFO - 'MOZ_NO_REMOTE': '1', 18:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:53 INFO - 'NO_EM_RESTART': '1', 18:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:53 INFO - 'SHELL': '/bin/bash', 18:51:53 INFO - 'SHLVL': '1', 18:51:53 INFO - 'TERM': 'linux', 18:51:53 INFO - 'TMOUT': '86400', 18:51:53 INFO - 'USER': 'cltbld', 18:51:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:53 INFO - '_': '/tools/buildbot/bin/python'} 18:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:53 INFO - Downloading/unpacking blobuploader==1.2.4 18:51:53 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 18:51:53 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 18:51:53 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 18:51:53 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 18:51:53 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 18:51:53 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 18:51:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:51:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:51:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:51: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 18:51: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 18:51: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 18:51: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 18:51: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 18:51: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 18:51:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:51:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:56 INFO - Downloading docopt-0.6.1.tar.gz 18:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:51:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:51:56 INFO - Running setup.py install for blobuploader 18:51:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:51:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:51:56 INFO - Running setup.py install for requests 18:51:56 INFO - Running setup.py install for docopt 18:51:56 INFO - Successfully installed blobuploader requests docopt 18:51:56 INFO - Cleaning up... 18:51:57 INFO - Return code: 0 18:51:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:51: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')]} 18:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:57 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:51:57 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 18:51:57 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 18:51:57 INFO - Using env: {'DISPLAY': ':0', 18:51:57 INFO - 'HOME': '/home/cltbld', 18:51:57 INFO - 'LANG': 'en_US.UTF-8', 18:51:57 INFO - 'LANGUAGE': 'en_US:en', 18:51:57 INFO - 'LOGNAME': 'cltbld', 18:51:57 INFO - 'MAIL': '/var/mail/cltbld', 18:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:57 INFO - 'MOZ_NO_REMOTE': '1', 18:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:57 INFO - 'NO_EM_RESTART': '1', 18:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:57 INFO - 'SHELL': '/bin/bash', 18:51:57 INFO - 'SHLVL': '1', 18:51:57 INFO - 'TERM': 'linux', 18:51:57 INFO - 'TMOUT': '86400', 18:51:57 INFO - 'USER': 'cltbld', 18:51:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:57 INFO - '_': '/tools/buildbot/bin/python'} 18:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:51:57 INFO - Running setup.py (path:/tmp/pip-7ijI4p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:51:57 INFO - Running setup.py (path:/tmp/pip-_vZo6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:51:57 INFO - Running setup.py (path:/tmp/pip-uxdNuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:51:57 INFO - Running setup.py (path:/tmp/pip-wlj0uD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:51:57 INFO - Running setup.py (path:/tmp/pip-hVIYKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:51:57 INFO - Running setup.py (path:/tmp/pip-AmDqcq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:51:57 INFO - Running setup.py (path:/tmp/pip-xHGoVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:51:57 INFO - Running setup.py (path:/tmp/pip-lBdXhO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:51:57 INFO - Running setup.py (path:/tmp/pip-O5c8ty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:51:57 INFO - Running setup.py (path:/tmp/pip-RSH4UK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:51:57 INFO - Running setup.py (path:/tmp/pip-sjAg4P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:51:58 INFO - Running setup.py (path:/tmp/pip-WWZU8T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:51:58 INFO - Running setup.py (path:/tmp/pip-zZxMyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:51:58 INFO - Running setup.py (path:/tmp/pip-ptjYNP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:51:58 INFO - Running setup.py (path:/tmp/pip-9OVeUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:51:58 INFO - Running setup.py (path:/tmp/pip-ZaW8iV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:51:58 INFO - Running setup.py (path:/tmp/pip-YlX8s6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:51:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:51:58 INFO - Running setup.py install for manifestparser 18:51:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:51:58 INFO - Running setup.py install for mozcrash 18:51:58 INFO - Running setup.py install for mozdebug 18:51:58 INFO - Running setup.py install for mozdevice 18:51:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:51:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:51:58 INFO - Running setup.py install for mozfile 18:51:59 INFO - Running setup.py install for mozhttpd 18:51:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Running setup.py install for mozinfo 18:51:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Running setup.py install for mozInstall 18:51:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Running setup.py install for mozleak 18:51:59 INFO - Running setup.py install for mozlog 18:51:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Running setup.py install for moznetwork 18:51:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Running setup.py install for mozprocess 18:51:59 INFO - Running setup.py install for mozprofile 18:51:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Running setup.py install for mozrunner 18:51:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:51:59 INFO - Running setup.py install for mozscreenshot 18:52:00 INFO - Running setup.py install for moztest 18:52:00 INFO - Running setup.py install for mozversion 18:52:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:52:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:52:00 INFO - Cleaning up... 18:52:00 INFO - Return code: 0 18:52:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:00 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:52:00 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 18:52:00 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 18:52:00 INFO - Using env: {'DISPLAY': ':0', 18:52:00 INFO - 'HOME': '/home/cltbld', 18:52:00 INFO - 'LANG': 'en_US.UTF-8', 18:52:00 INFO - 'LANGUAGE': 'en_US:en', 18:52:00 INFO - 'LOGNAME': 'cltbld', 18:52:00 INFO - 'MAIL': '/var/mail/cltbld', 18:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:00 INFO - 'MOZ_NO_REMOTE': '1', 18:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:00 INFO - 'NO_EM_RESTART': '1', 18:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:00 INFO - 'SHELL': '/bin/bash', 18:52:00 INFO - 'SHLVL': '1', 18:52:00 INFO - 'TERM': 'linux', 18:52:00 INFO - 'TMOUT': '86400', 18:52:00 INFO - 'USER': 'cltbld', 18:52:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:00 INFO - '_': '/tools/buildbot/bin/python'} 18:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:52:00 INFO - Running setup.py (path:/tmp/pip-UaxdtX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:52:00 INFO - Running setup.py (path:/tmp/pip-x8ZTxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:52:00 INFO - Running setup.py (path:/tmp/pip-zSv5xI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:52:00 INFO - Running setup.py (path:/tmp/pip-1s1lS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:52:00 INFO - Running setup.py (path:/tmp/pip-YV95OV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:52:00 INFO - Running setup.py (path:/tmp/pip-fmupN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:52:00 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)) 18:52:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:52:00 INFO - Running setup.py (path:/tmp/pip-4YRkBa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:52:01 INFO - Running setup.py (path:/tmp/pip-f8wQZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:52:01 INFO - Running setup.py (path:/tmp/pip-1H90uN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:52:01 INFO - Running setup.py (path:/tmp/pip-X9Vs3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:52:01 INFO - Running setup.py (path:/tmp/pip-FwRFCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:52:01 INFO - Running setup.py (path:/tmp/pip-isGc9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:52:01 INFO - Running setup.py (path:/tmp/pip-_POQDe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:52:01 INFO - Running setup.py (path:/tmp/pip-MQFI9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:52:01 INFO - Running setup.py (path:/tmp/pip-g1Bp7A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:52:01 INFO - Running setup.py (path:/tmp/pip-Rhqbnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:52:01 INFO - Running setup.py (path:/tmp/pip-1Ljwc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:52:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:03 INFO - Downloading blessings-1.6.tar.gz 18:52:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:52:03 INFO - Installing collected packages: blessings 18:52:03 INFO - Running setup.py install for blessings 18:52:03 INFO - Successfully installed blessings 18:52:03 INFO - Cleaning up... 18:52:03 INFO - Return code: 0 18:52:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:52:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:52:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:52:03 INFO - Reading from file tmpfile_stdout 18:52:03 INFO - Current package versions: 18:52:03 INFO - argparse == 1.2.1 18:52:03 INFO - blessings == 1.6 18:52:03 INFO - blobuploader == 1.2.4 18:52:03 INFO - docopt == 0.6.1 18:52:03 INFO - manifestparser == 1.1 18:52:03 INFO - mozInstall == 1.12 18:52:03 INFO - mozcrash == 0.16 18:52:03 INFO - mozdebug == 0.1 18:52:03 INFO - mozdevice == 0.48 18:52:03 INFO - mozfile == 1.2 18:52:03 INFO - mozhttpd == 0.7 18:52:03 INFO - mozinfo == 0.9 18:52:03 INFO - mozleak == 0.1 18:52:03 INFO - mozlog == 3.1 18:52:03 INFO - moznetwork == 0.27 18:52:03 INFO - mozprocess == 0.22 18:52:03 INFO - mozprofile == 0.28 18:52:03 INFO - mozrunner == 6.11 18:52:03 INFO - mozscreenshot == 0.1 18:52:03 INFO - mozsystemmonitor == 0.0 18:52:03 INFO - moztest == 0.7 18:52:03 INFO - mozversion == 1.4 18:52:03 INFO - psutil == 3.1.1 18:52:03 INFO - requests == 1.2.3 18:52:03 INFO - wsgiref == 0.1.2 18:52:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:03 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:52:03 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 18:52:03 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 18:52:03 INFO - Using env: {'DISPLAY': ':0', 18:52:03 INFO - 'HOME': '/home/cltbld', 18:52:03 INFO - 'LANG': 'en_US.UTF-8', 18:52:03 INFO - 'LANGUAGE': 'en_US:en', 18:52:03 INFO - 'LOGNAME': 'cltbld', 18:52:03 INFO - 'MAIL': '/var/mail/cltbld', 18:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:03 INFO - 'MOZ_NO_REMOTE': '1', 18:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:03 INFO - 'NO_EM_RESTART': '1', 18:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:03 INFO - 'SHELL': '/bin/bash', 18:52:03 INFO - 'SHLVL': '1', 18:52:03 INFO - 'TERM': 'linux', 18:52:03 INFO - 'TMOUT': '86400', 18:52:03 INFO - 'USER': 'cltbld', 18:52:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:03 INFO - '_': '/tools/buildbot/bin/python'} 18:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:52:04 INFO - Cleaning up... 18:52:04 INFO - Return code: 0 18:52:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:04 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:52:04 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 18:52:04 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 18:52:04 INFO - Using env: {'DISPLAY': ':0', 18:52:04 INFO - 'HOME': '/home/cltbld', 18:52:04 INFO - 'LANG': 'en_US.UTF-8', 18:52:04 INFO - 'LANGUAGE': 'en_US:en', 18:52:04 INFO - 'LOGNAME': 'cltbld', 18:52:04 INFO - 'MAIL': '/var/mail/cltbld', 18:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:04 INFO - 'MOZ_NO_REMOTE': '1', 18:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:04 INFO - 'NO_EM_RESTART': '1', 18:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:04 INFO - 'SHELL': '/bin/bash', 18:52:04 INFO - 'SHLVL': '1', 18:52:04 INFO - 'TERM': 'linux', 18:52:04 INFO - 'TMOUT': '86400', 18:52:04 INFO - 'USER': 'cltbld', 18:52:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:04 INFO - '_': '/tools/buildbot/bin/python'} 18:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:04 INFO - Downloading/unpacking jsonschema 18:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:52:06 INFO - Downloading/unpacking functools32 (from jsonschema) 18:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:52:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:52:06 INFO - warning: no files found matching '*.txt' 18:52:06 INFO - no previously-included directories found matching 'build' 18:52:06 INFO - no previously-included directories found matching 'dist' 18:52:06 INFO - no previously-included directories found matching '.git*' 18:52:06 INFO - Installing collected packages: jsonschema, functools32 18:52:06 INFO - Running setup.py install for functools32 18:52:06 INFO - warning: no files found matching '*.txt' 18:52:06 INFO - no previously-included directories found matching 'build' 18:52:06 INFO - no previously-included directories found matching 'dist' 18:52:06 INFO - no previously-included directories found matching '.git*' 18:52:06 INFO - Successfully installed jsonschema functools32 18:52:06 INFO - Cleaning up... 18:52:06 INFO - Return code: 0 18:52:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:06 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 0x7f8387255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, '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': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', '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 18:52:06 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 18:52:06 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 18:52:06 INFO - Using env: {'DISPLAY': ':0', 18:52:06 INFO - 'HOME': '/home/cltbld', 18:52:06 INFO - 'LANG': 'en_US.UTF-8', 18:52:06 INFO - 'LANGUAGE': 'en_US:en', 18:52:06 INFO - 'LOGNAME': 'cltbld', 18:52:06 INFO - 'MAIL': '/var/mail/cltbld', 18:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:06 INFO - 'MOZ_NO_REMOTE': '1', 18:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:06 INFO - 'NO_EM_RESTART': '1', 18:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:06 INFO - 'SHELL': '/bin/bash', 18:52:06 INFO - 'SHLVL': '1', 18:52:06 INFO - 'TERM': 'linux', 18:52:06 INFO - 'TMOUT': '86400', 18:52:06 INFO - 'USER': 'cltbld', 18:52:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:06 INFO - '_': '/tools/buildbot/bin/python'} 18:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:06 INFO - Downloading/unpacking flake8 18:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:52:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:52:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:52:09 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 18:52:09 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 18:52:09 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 18:52:09 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 18:52:09 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 18:52:09 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 18:52:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:52:09 INFO - no previously-included directories found matching 'docs/_build' 18:52:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:52:09 INFO - Running setup.py install for pep8 18:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:52:09 INFO - no previously-included directories found matching 'docs/_build' 18:52:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:52:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:52:09 INFO - Cleaning up... 18:52:09 INFO - Return code: 0 18:52:09 INFO - Running post-action listener: _resource_record_post_action 18:52:09 INFO - Running post-action listener: _start_resource_monitoring 18:52:09 INFO - Starting resource monitoring. 18:52:09 INFO - ##### 18:52:09 INFO - ##### Running install step. 18:52:09 INFO - ##### 18:52:09 INFO - Running pre-action listener: _resource_record_pre_action 18:52:09 INFO - Running main action method: install 18:52:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:52:09 INFO - Reading from file tmpfile_stdout 18:52:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:52:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:52:09 INFO - Reading from file tmpfile_stdout 18:52:09 INFO - Output received: 18:52:09 INFO - Usage: mozinstall [options] installer 18:52:09 INFO - Options: 18:52:09 INFO - -h, --help show this help message and exit 18:52:09 INFO - -d DEST, --destination=DEST 18:52:09 INFO - Directory to install application into. [default: 18:52:09 INFO - "/builds/slave/test-pgo"] 18:52:09 INFO - --app=APP Application being installed. [default: firefox] 18:52:09 INFO - mkdir: /builds/slave/test-pgo/build/application 18:52:09 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'] 18:52:09 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 18:52:25 INFO - Reading from file tmpfile_stdout 18:52:25 INFO - Output received: 18:52:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:52:25 INFO - Running post-action listener: _resource_record_post_action 18:52:25 INFO - ##### 18:52:25 INFO - ##### Running run-tests step. 18:52:25 INFO - ##### 18:52:25 INFO - Running pre-action listener: _resource_record_pre_action 18:52:25 INFO - Running main action method: run_tests 18:52:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:52:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:52:26 INFO - Python 2.7.3 18:52:26 INFO - Return code: 0 18:52:26 INFO - grabbing minidump binary from tooltool 18:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c68660>, '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 0x1c69560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c69a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:52:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:52:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:52:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:52:26 INFO - Return code: 0 18:52:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:52:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:52:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:52:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:52:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:52:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:52:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:52:27 INFO - Return code: 0 18:52:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 18:52:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 18:52:27 INFO - Using env: {'DISPLAY': ':0', 18:52:27 INFO - 'HOME': '/home/cltbld', 18:52:27 INFO - 'LANG': 'en_US.UTF-8', 18:52:27 INFO - 'LANGUAGE': 'en_US:en', 18:52:27 INFO - 'LOGNAME': 'cltbld', 18:52:27 INFO - 'MAIL': '/var/mail/cltbld', 18:52:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:52:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:27 INFO - 'MOZ_NO_REMOTE': '1', 18:52:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:27 INFO - 'NO_EM_RESTART': '1', 18:52:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:52:27 INFO - 'SHELL': '/bin/bash', 18:52:27 INFO - 'SHLVL': '1', 18:52:27 INFO - 'TERM': 'linux', 18:52:27 INFO - 'TMOUT': '86400', 18:52:27 INFO - 'USER': 'cltbld', 18:52:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964', 18:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:27 INFO - '_': '/tools/buildbot/bin/python'} 18:52:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:52:27 INFO - mozversion application_buildid: 20160125163025 18:52:27 INFO - mozversion application_changeset: aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3 18:52:27 INFO - mozversion application_display_name: Nightly 18:52:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:52:27 INFO - mozversion application_name: Firefox 18:52:27 INFO - mozversion application_remotingname: firefox 18:52:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:52:27 INFO - mozversion application_vendor: Mozilla 18:52:27 INFO - mozversion application_version: 47.0a1 18:52:27 INFO - mozversion platform_buildid: 20160125163025 18:52:27 INFO - mozversion platform_changeset: aa90f482e16db77cdb7dea84564ea1cbd8f7f6b3 18:52:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:52:27 INFO - mozversion platform_version: 47.0a1 18:52:27 INFO - using testdate: 1453776747 18:52:27 INFO - actual date: 1453776747 18:52:27 INFO - starting webserver on 'localhost:36823' 18:52:27 INFO - SUITE-START | Running 3 tests 18:52:27 INFO - TEST-START | dromaeo_css 18:52:27 INFO - operating with platform_type : linux_ 18:52:27 INFO - Initialising browser for dromaeo_css test... 18:52:27 INFO - TEST-INFO | started process 3508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphXpfBZ/profile http://localhost:36823/getInfo.html) 18:52:32 INFO - PROCESS | 3508 | __metrics Screen width/height:1600/1200 18:52:32 INFO - PROCESS | 3508 | colorDepth:24 18:52:32 INFO - PROCESS | 3508 | Browser inner width/height: 1024/697 18:52:32 INFO - PROCESS | 3508 | __metrics 18:52:32 INFO - PROCESS | 3508 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:52:32 INFO - PROCESS | 3508 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:52:33 INFO - TEST-INFO | 3508: exit 0 18:52:33 INFO - Browser initialized. 18:52:33 INFO - Running cycle 1/1 for dromaeo_css test... 18:52:33 INFO - TEST-INFO | started process 3600 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphXpfBZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:45 INFO - PROCESS | 3600 | RSS: Main: 147959808 18:52:45 INFO - PROCESS | 3600 | 18:53:37 INFO - PROCESS | 3600 | 1453776817041 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] 18:55:45 INFO - PROCESS | 3600 | Cycle 1(1): loaded http://localhost:36823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36823/tests/dromaeo/cssquery-ext.html) 18:55:46 INFO - PROCESS | 3600 | RSS: Main: 264978432 18:55:46 INFO - PROCESS | 3600 | 18:58:48 INFO - PROCESS | 3600 | Cycle 1(1): loaded http://localhost:36823/tests/dromaeo/cssquery-ext.html (next: http://localhost:36823/tests/dromaeo/cssquery-jquery.html) 18:58:49 INFO - PROCESS | 3600 | RSS: Main: 234835968 18:58:49 INFO - PROCESS | 3600 | 19:01:51 INFO - PROCESS | 3600 | Cycle 1(1): loaded http://localhost:36823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36823/tests/dromaeo/cssquery-mootools.html) 19:01:52 INFO - PROCESS | 3600 | RSS: Main: 229224448 19:01:52 INFO - PROCESS | 3600 | 19:04:54 INFO - PROCESS | 3600 | Cycle 1(1): loaded http://localhost:36823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36823/tests/dromaeo/cssquery-prototype.html) 19:04:54 INFO - PROCESS | 3600 | RSS: Main: 216211456 19:04:54 INFO - PROCESS | 3600 | 19:07:57 INFO - PROCESS | 3600 | Cycle 1(1): loaded http://localhost:36823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36823/tests/dromaeo/cssquery-yui.html) 19:07:57 INFO - PROCESS | 3600 | RSS: Main: 219095040 19:07:57 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | Cycle 1(1): loaded http://localhost:36823/tests/dromaeo/cssquery-yui.html (next: http://localhost:36823/tests/dromaeo/cssquery-dojo.html) 19:11:00 INFO - PROCESS | 3600 | RSS: Main: 414511104 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | __start_tp_report 19:11:00 INFO - PROCESS | 3600 | _x_x_mozilla_page_load 19:11:00 INFO - PROCESS | 3600 | _x_x_mozilla_page_load_details 19:11:00 INFO - PROCESS | 3600 | |i|pagename|runs| 19:11:00 INFO - PROCESS | 3600 | |0;dojo.html;3106.471899777038;3155.526670999351;3187.139472342466;3194.1056504178837;3218.839058047097;4982.053409852126;5068.417132029817;5080.949190508094;5123.1546794778815;5157.79368825247;5072.492750724926;5108.923366149511;5122.897542049157;5170;5201.791928322863;4629.375034370368;4662;4665.743384113873;4715.740634265114;4735.479097299294;4712.858614241578;4750.334953106568;4768.64235182361;4813.807447702087;4837.371141751567;4628.120657075162;4651.511591282934;4652.953470465302;4704.059188162381;4739.857804265877;4720.669553131283;4726.952730472685;4727.550882666142;4742.217534106868;4776.737279449629;4734.2425211966265;4740.525947405266;4741.217699079648;4757.333973243749;4771.522847715235;4895.510448955111;4942.777575009133;4998.925016124761;5001.624878134155;5062.063518249099;5445.101558242885;5510.779568817243;5555.8888822223325;5561.388247292794;5566.888662226733;5512.724363781795;5514.117741161395;5515.448455154493;5528.806491772809;5535.25274087997;5120.385553733576;5185.61107916904;5191.0656081905245;5195.960807838447;5250.947490525123;5436.565074794007;5489.094299440628;5582.665040097607;5653;5656.123300888369;5357.142857142916;5362.034833729888;5365.839024829262;5375.677459352373;5408.0535906216255;5366.275552800322;5454.809081682122;5466.726663666801;5471.753771080311;5516.91724624131;5364.168553874156;5442.265294185314;5444.6188766785945;5477.3427188737605;5536;5493.478119578634;5497.45025497455;5503.091989821714;5503.422140675251;5507.586930980113;4325.697201195949;4327.740335579875;4336.804843782037;4370;4370.409994650745;3800.600936901641;3812.7140464465274;3842.4044273137706;3864.961350386516;3886.5724770275247;5122.206058061007;5135.537801597874;5139.331886854759;5139.974300128551;5150.587952963754;5394.3796463406425;5533.750981205855;5534.1145416733125;5535.7785688572;5538.390777014525;5120.48795120485;5139.974300128475;5155.5617772489;5166.974165129151;5223.738813059332;4723.669343146015;4724.6456515760765;4725.054989002213;4747.667663263607;4786.928196077061;5534.584906132056;5642.520385767174;5713.457221563945;5721.113227449752;5724.885502289931;5482.39693633708;5523.171524271392;5531.225628411945;5544.528715059265;5580.441955804387;5649.209110724584;5660.575456840671;5668.178114173505;5668.518175954925;5669.262995810518;5284.471552844685;5370.892582148257;5381.1121165007335;5418.106012507892;5457.727113644222;5504.724763761716;5550.0564903965615;5550.38945715979;5555.833325000256;5561.054620714407;5368.141097424394;5380.192971054373;5403.9459605403445;5407.783688652567;5460.5904557159165;5234.842954711365;5298.920516192337;5353.304070470814;5381.946180538144;5387.730613469389;5241.89516209666;5268.157094864803;5285.392179899361;5286.735663216747;5317.415084340797;5362.249285100167;5384.015828287118;5389.649672771257;5393.8112166074;5430.891382172414;5209.505097015777;5256.763445645031;5270.077736396192;5291.7354132294;5295.232191332158 19:11:00 INFO - PROCESS | 3600 | |1;ext.html;513.1123156938496;520.2612290547422;526.9288646032785;546.7915905848076;553.0156321747291;28540.28649283769;29094.70905290949;35478.82260588697;36120.45819312706;36256.637433625656;38389.23221535575;39001.41497877534;39003.60996390035;39015;39096.21807563854;8301.377396695241;8376.706815261467;8432;8470.237678608924;8480.363972702042;8406.495610263373;8508.914910850905;8514.616842242083;8537.402381833273;8541.35939804514;8675.43609665373;8678;8704.347173961947;8760.94868615767;8788.296936245086;8540.06059333476;8654.09132041133;8702.260307873838;8724.956375218148;8744.169303916118;8588.22705956467;8730;8742.650293988232;8747.16901894319;8750.781230469225;38377;38753.61246387528;38876.22247555061;38876.416853747214;38915.610843891765;3004.1888690053565;3065.647450543194;3170.381775553768;3282.2122690554334;3495.580530336376;29238.56142157869;29330.853345733136;29673.516448961036;30120;30507.08478745619;3756.530433695788;3783.735138540303;3845.2309538092213;3891.5135608048995;3907.33575292201;248173;252254;252382;252397;254381.72809136022;51972.74013629908;53109;53149.20276195783;58528;58765;46085.53914460813;61992.380076199566;62525;62684.37315626877;63490.68254658697;14278.571642850731;14376.35306411214;14416;14444.855551444562;14449.855501445061;10508.42203678805;10508.684739457829;10510.579576816994;10528.526216320284;10580.100691441314;16651.50045498637;19509.272296953266;20184.394468165978;20295.695564566544;20368.185272589228;7269.055022847102;7513.549187048795;7517.473776835569;7556.924430755732;7563.546187228784;915.5834095486538;971.9805603887883;990.3909095905966;1007.9718686939281;1068.3589846092439;25907.481850363263;26152.940472151793;28052.579211311848;28332;28556.857215714204;1041.234692501011;1056.5140035583563;1072.6621114348955;1137.4824454873012;1140.1676775953601;14578.708425831635;14660.56018319452;14747.336369863382;14851.70296594062;14870.479533216501;309374;310039;311849;312155;313254;50221.74889125531;50395;50433.24350134751;50444.72998715067;50463.24305135426;1315.2371624457792;1318.3671837518045;1336.8262125923568;1337.2845527642664;1348.4067010515341;27224.727752722218;28122.71877281283;28149.296267593472;28320.15039548817;29078.854605727684;41152.794236028625;41399.37900931549;41448;42086.57913420827;42629;278293;285781;286490;287372;289701;28227.57658635081;28836.134915952556;28856.134315970554;28870.42259154847;28873.566896496148;38008.61991380051;39173.21653566856;39643.405348920365;39644.603553964094;39850.2029959405;33157.17107072342;33522.832385837915;33666.49500257449;35598.64401355953;36944.81527592345;33818.49272260869;34616.48075278923;35198.824005879804;36214.63785362113;36848.07879803026;31668.683313166573;31994.20014499656;32020.5196922051;32115.03654890357;32206.516902246953;26916.865415672797;29235.269118272212;31344.68655313509;32026.35947281088;32325.676743232267;23186.304410867702;24208.51582968366;24309;24694;24708.876455617607 19:11:00 INFO - PROCESS | 3600 | |2;jquery.html;353.74000109919206;358.0529499473891;358.353172523595;361.3387500873402;362.20134603199915;13676.93161534191;14041.508547200825;15647.687046259069;16639.334426622936;18044.097795110258;14612.342444589993;15236.923815380935;15616;15633.062016279031;15904.204789760495;5135.948640513603;5298.470152984709;5302.628815982883;5303.124984377573;5303.363596368441;3957.861474848381;4067.3288907330257;5154.716490593035;5234.947650523503;5584.776608935637;5714.599978001542;5738.626989245707;5748.367679555246;5765.855853603652;5766.942330576682;5014.674046186986;5195.974020129913;5214.556762675158;5214.817481388133;5220.791168353261;4800.135975524404;4947.975260123712;4960.751962401865;4965.131102057162;4988.775505102279;10930.672079837537;11318.717032074182;11327.376994265313;11535.942320288428;11719.824202636968;2057.907394167266;2088.8120069193847;2096.916123355064;2120.6606942889216;2288.7940085392393;8528.403011789178;8545.829083418297;8715.389922705413;8849.734507964771;8854.203121719012;1646.2427283449626;1758.7098128808732;1775.5649865782837;1803.558128258572;1818.7544681467964;47575.5242447578;48351.03297934057;52606;55529.72235138839;57307.140392894136;9584.28117891161;9937.900620993842;9938.055884690943;9969.850452243221;10016.899831001596;12862.935685321514;13051.086423950423;13118.934405327913;13172.60482185536;13178.538751143664;6965;7072.257412971564;7305.379042781423;7310.488265821342;7386.446016548673;6987.1266091738535;6992.79021629352;7027.859442811217;7030.121234845645;7040.0847889774;4325;4416.712913660602;4421.845235416745;4450.888727781767;4461.687681862239;1683.6043529770493;1747.737839324086;1785.9464216073538;1853.5458812590732;1885.9061744188339;895.8880139982502;926.536731634183;975.1321324021485;1005.5022763731853;1011.489197955028;13654.931725341508;15479;16677.842847988857;17288.567785805204;17523.649527009387;882.668999125328;950.8906475755376;952.6189524190379;991.0683957080322;1012.7569383347943;8991.82016359669;9085.227755640712;9130.31522635805;9202.493862837475;9328.207102396373;338079;342448;528386;539312;543292;61179.38820611737;61845.381546184864;63180.99999999908;64622.35377646257;68783;1075.9139268858473;1096.550414330121;1099.3074363151322;1112.6272698646044;1121.7532142928542;13388;13761.79357309621;13866.791998119834;14096.577102686935;14124.78812817788;29302.120936371943;29366.706332936395;29781.553276700433;29994.700053000062;30035.249118772204;38391.42412863865;38510;42079.15841683088;42086.57913420827;42234.78882605567;6591.604503729792;6670.76652317186;6696.7656132035145;6698.933010670026;6855.040294358694;9461.810763784824;9980.201583873128;9996.600135994478;10300.227482938959;10693.732656683334;8337.166283371615;8732.08313127138;8891.19979201875;8900.821983560421;8989.910100898907;9191.954040229755;9247.537623118682;9506.049395060438;9547.4748888809;9647.9035209647;8149.742424695372;8830.91169088301;8863.601137948937;8977.326700497359;9199.586018629312;7091.397231235403;7161.9641901790155;7213.350798427957;7248.492605517563;7344.265573442613;8234.300084492885;8802.515861627417;8988;9009.684661036832;9055.23030542385 19:11:00 INFO - PROCESS | 3600 | |3;mootools.html;1217.6468824041028;1487.278669845125;1506.1866592040299;1671.1226606031832;1808.5930665600242;6886.0703804986315;7586.962065189673;7671.6547755351;7727.2659097385795;7744.186860379664;7605.125410577772;7785.104712958011;7797.2202779722;7810.882836757439;7814.374850012;2009.4674911148484;2055.9486012849648;2056.259746491262;2311.9537609247805;2314.479242170515;2032.4512381656943;2036;2273.7044184256106;2323.4772176260376;2329.3710698111586;2206.5366273082673;2233.1625640384855;2235.228846048111;2235.474663454095;2239.9776002240014;2251.3358559225067;2253.8985745641403;2255.6954811100536;2263.0495192019393;2275.6472746724285;2220.9888950555305;2253.278950735765;2283.7944584987263;2284.3603790938396;2288.6795848581214;7737.651805668758;7802.921970780277;7826.060872695256;7858.567778772165;7892.0529536455415;4765.952340476586;4860.684055536414;4882;4888.657793954425;4891.608671306287;3047.085874237742;3056.526238433024;3136.623605167372;3139.3564319314714;3145.1350878508365;864.6627815152033;908.8046070094895;909.0000998901222;1646.9423570175106;1678.848903598682;10573.259871808976;10623.628173013985;10704.78590428187;10718.946405268001;10748.9788470096;4093.5087789465456;4190.245755763931;4200;4245.660347172219;4247.171801498678;8697.782555436039;8698.565071746387;8700.34747393948;8705.564721763887;8709.303255739525;4802.7838747255755;4803.207470767354;4838.419389673261;4854.101991131652;4857.319975203474;4437.267850804581;4470.307102399133;4470.955290447054;4471.932921006188;4478.57453541913;3318.3714316855558;3325.4513005353847;3335.8332083395735;3349.4473411886765;3365.6802603752603;983.6458874805064;1030.4847576211894;1045.513836066233;1066.8559744434558;1075.4891426572315;1302.337567086736;1308.6597484654058;1315.2568798628745;1333.7732585460494;1344.932753362328;7349;7354.632268386559;7601.923980760233;7613.847723045508;7613.9238607614325;1076.6554702495282;1080.9729756756144;1081.7025318037602;1090;1108.3405373802575;5721.256236689203;5853.970730146322;5859.589828711949;5865.941340586625;5865.970670146622;9258.120478554527;9474.099960503741;9703.5148242589;9714.368566043184;9761.316707830383;9612.423254604746;9634.518274086267;9676.177524910321;9684.70945871625;9744.951275243578;7336.7432139874845;7397.630118494054;7557.924420755832;7562.99999999989;7598.772036838904;7226.277372262942;7229.7469588564145;7263.527870688388;7272.7454539093;7279.927200727925;8312.667493300441;8502.36232282569;8639;8640.78398040054;8803.647854085764;8714.08502107295;8769.956150219208;8785.428947118417;8930;8944.284457243275;6725.899111513233;6839;6852.451803855779;6853;6858;7498.212687667935;7500.399968002437;7505.136909255505;7537.133229678657;7554.697812087455;5981.641101533922;6752.864942701217;6802.931970680428;6907.34380233877;6934.133233345832;6750.2237242715755;6797.864042719217;6802.489813264124;6913.688884000333;6917.377436030782;6495.837604059747;6524.119243902012;6546.672666366568;6547.901781473377;6593.80218593443;6139.693015349304;6152.415520525543;6194.5354098443695;6206.286277078194;6300.464460520724;6235.251769787473;6342.841428964128;6376.74493020274;6378.808635740936;6393.744250230125 19:11:00 INFO - PROCESS | 3600 | |4;prototype.html;336.3038510283713;345.78734078541686;347.2776624620788;352.92059286660486;355.090967124162;5771.451712087355;5783.363829978699;5811.767529298828;5813.5349172066235;5851.736671849766;5724.914126288109;5748.310202775662;5752.827415177541;5753.338366087901;5760.0783874580075;4477.149341625089;4482.731036137842;4482.775861206943;4494.213512635292;4508.211063063967;4279.0799978004725;4446.0441005183875;4474.082813023322;4475.664325175609;4476.843310484133;4408.691391602573;4420.248557745191;4427.424434823484;4431.135928493945;4432.3573081903105;4202.621764041251;4274.316109422478;4313.460817397825;4428.97785511072;4430.446194225738;3822.197338558906;3828.617138286149;3846.3845784674318;3846.615338466159;3873.0511024798825;5502.284702988626;5530.944690553083;5534.0315444797;5538.584606154514;5543.417941116165;4868.245421959567;4961.05739909416;4964.60283177345;5041.848744537633;5045.545900868903;6015.939840601625;6021.458068773832;6025.126356678301;6043.1841701370195;6065.393460653943;4217.536071032184;4226.535081141072;4238.766867822269;4240.045989652334;4241.639460645849;6315;6316;6338.425581430192;6379.649119298437;6448.64532450715;4247.490301163818;4257;4258.233517966796;4261.87214383569;4273.594008569181;4260.318349064135;4287.078278170208;4299.892502687458;4313.223619748475;4322.935155972663;5006.774695138727;5014.07239660664;5014.648974571745;5028.019536190481;5030.547250747451;6081.817545473555;6133.049377346519;6144.969275153596;6167.396476915945;6232.719527621268;1532.341093329879;1542.8071491063617;1545.3432291276163;1547.922603869802;1548.4735190035442;1024.9180065594735;1039.2413538117066;1042.3068659341604;1051.6476980211714;1059.1738444013681;5850.210221620112;5852.736626851802;5853.64878107315;5859.121131830174;5861.062230043172;6328.398802113792;6338.176037115146;6340.587861788969;6347.1114044033875;6355;5773;5829.446202610745;5833.88332233353;5835.416458354131;5845.649261044351;3308.93382132356;3416.555847739778;3418.8290585470627;3420.589529256505;3422.469517224834;6597.30728273534;6612.206535215709;6649.900251496231;6650.068990341356;6671.43292820106;6244.968775156095;6410.262819775692;6447.6131432114225;6468.676566171673;6474.255460622088;6439.774607888701;6617.239017512855;6639.3692599203;6646.468282537386;6660.600363978177;6375.904361434489;6415.679216039272;6429.7428102875365;6432.581882177644;6439.06633538125;6146.569740118149;6286.591371560834;6291.056341548804;6317.6209427434505;6358.713857876499;6657.201135863727;6660;6661.933380666132;6665.3001434850585;6679.298673639198;4321.2437823381415;4321.876312158798;4326.178026175016;4332.06860524976;4338.9349159762;6201.937980620317;6399.968000159969;6404.487640988803;6408.807735767934;6417.2299324081405;6242.438180563771;6252.656103914328;6257.1240026395435;6263.718132683949;6264.655443950626;6204.627722336674;6253.5622506424115;6298.11826344303;6301.117843501822;6309;6025.096235564701;6087.69561521931;6123.050927106306;6129.509639228941;6136.447719705248;6245.375462453719;6247.937520624918;6251;6252.843678908063;6258.749650014131;6099.786507472217;6100.725467354068;6107.541934354852;6111.052786817872;6124.877502449837 19:11:00 INFO - PROCESS | 3600 | |5;yui.html;826.4751882554577;827.3960009193285;837.3803385494734;839.3704721458906;841.3773807382535;12833.165844220131;13011.089223754341;13013.15414498057;13020.414081366338;13024.934875325622;12182.634520964362;12345.938270308636;12394.938025309883;13235.801462978063;13266.204027758316;666.257123307511;796.7649543384715;812.7033632724043;813.2639960835453;813.5810057820198;669.9363560461749;789.9960500197519;815.9428839981204;816.6365967144623;817.0562999735315;847.2840449819923;857.1257317536109;857.1557016338901;857.536930057768;857.6226460357423;680.7651360280695;697.5709938387905;832.696065935929;850.740524140137;853.0658928473312;627.05314974389;627.7081157261849;628.1990462160736;628.2398298059354;628.3622123544606;12394.81407778884;12880.677983050406;12886.935565322206;12890.935545322307;12914.031447641371;12508.74982500354;12812.359382030862;12907.419166137546;13007.219566826021;13047.934760326232;9640.373375730554;9683.854742178873;9706.70879873605;9817.5582098805;10155.796884062278;3561.3954693072474;3587.157018100744;3588.372034893909;3593.443016332473;3672.467492213614;44098.77950610258;44454;44462.33306500405;44540.55459445396;44543.554564454265;9050.140236677506;9378.812423751488;9473.47895865734;9758.75603109928;9784.510774461249;15922.92038539823;15938.681226375407;15952.92023539875;15967.44113956006;15995.120268385117;7166.856662866713;7201.675924583406;7230.13238411394;7277.053982982178;7488.775336739906;3987.302222111119;4134.359174327984;4194.6853985951175;4211.852585159566;4234.745915245096;3078.7998780079224;3100.8294543800307;3103.425866214712;3108.891188808381;3111.9066428007195;568.9601727879092;570.3611954610863;580.303635637237;587.4096532984408;603.2188316130621;471.0907947661047;552.4503119396227;615.5291202230297;618.7223383712619;632.4845251120414;7529.774106776806;7882.408819338572;7894.6842126314305;7939.563324017119;8001.799955001172;570.9669265425263;628.9495648026693;651.2478087808589;660.1088530483904;696.095076400677;3693.372126738461;3951.3677811550015;4033.51597808259;4053.148838743838;4060.127072679388;51122.48877511251;51419.74290128525;51827.48172518227;52012;52062.47937520652;46498.302525462146;46886.06227875423;46928.296075558894;47548.52451475441;47585.524144758805;42908.78545607314;43192.352114718306;43262.351064734685;43392.39645621273;43459.565404346184;7943.205679432011;8093.609968389829;8099.109097999098;8183.427160098736;8191.385646076687;31285.530717038808;31335.84332078325;32218.516722248718;32293;32348.029559113264;39758.80120599378;42399.15201695887;42636.36045459383;42642.78678606587;43036;8950.597223125105;9466.574004169692;9552.761180970532;9594.328397012421;9749.415035097632;10714.250002500063;10848.566057357933;10920.180986426209;10965.50655220533;10981.780364392827;10242.6415075472;10311.22665800083;10414.062734353642;10771.075026997087;10795.892041079489;9712.660056897974;10025.849612255675;10065.748356291151;10176.338537995303;10358.326708763907;7901.179711626088;9438.764030899283;9450.716478505656;9779.168770654289;10368;8804.823903521765;8871.822563548822;9037;9104.908950910407;9329.72010839676;8404.20160084791;8966.641334346554;9043.231325337158;9211.355205135844;9374.718758437259 19:11:00 INFO - PROCESS | 3600 | __end_tp_report 19:11:00 INFO - PROCESS | 3600 | __start_cc_report 19:11:00 INFO - PROCESS | 3600 | _x_x_mozilla_cycle_collect,899 19:11:00 INFO - PROCESS | 3600 | __end_cc_report 19:11:00 INFO - PROCESS | 3600 | __startTimestamp1453777860762__endTimestamp 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | ------- Summary: start ------- 19:11:00 INFO - PROCESS | 3600 | Number of tests: 6 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | [#0] dojo.html Cycles:165 Average:5114.34 Median:5285.39 stddev:535.64 (10.1%) stddev-sans-first:513.60 19:11:00 INFO - PROCESS | 3600 | Values: 3106.5 3155.5 3187.1 3194.1 3218.8 4982.1 5068.4 5080.9 5123.2 5157.8 5072.5 5108.9 5122.9 5170.0 5201.8 4629.4 4662.0 4665.7 4715.7 4735.5 4712.9 4750.3 4768.6 4813.8 4837.4 4628.1 4651.5 4653.0 4704.1 4739.9 4720.7 4727.0 4727.6 4742.2 4776.7 4734.2 4740.5 4741.2 4757.3 4771.5 4895.5 4942.8 4998.9 5001.6 5062.1 5445.1 5510.8 5555.9 5561.4 5566.9 5512.7 5514.1 5515.4 5528.8 5535.3 5120.4 5185.6 5191.1 5196.0 5250.9 5436.6 5489.1 5582.7 5653.0 5656.1 5357.1 5362.0 5365.8 5375.7 5408.1 5366.3 5454.8 5466.7 5471.8 5516.9 5364.2 5442.3 5444.6 5477.3 5536.0 5493.5 5497.5 5503.1 5503.4 5507.6 4325.7 4327.7 4336.8 4370.0 4370.4 3800.6 3812.7 3842.4 3865.0 3886.6 5122.2 5135.5 5139.3 5140.0 5150.6 5394.4 5533.8 5534.1 5535.8 5538.4 5120.5 5140.0 5155.6 5167.0 5223.7 4723.7 4724.6 4725.1 4747.7 4786.9 5534.6 5642.5 5713.5 5721.1 5724.9 5482.4 5523.2 5531.2 5544.5 5580.4 5649.2 5660.6 5668.2 5668.5 5669.3 5284.5 5370.9 5381.1 5418.1 5457.7 5504.7 5550.1 5550.4 5555.8 5561.1 5368.1 5380.2 5403.9 5407.8 5460.6 5234.8 5298.9 5353.3 5381.9 5387.7 5241.9 5268.2 5285.4 5286.7 5317.4 5362.2 5384.0 5389.6 5393.8 5430.9 5209.5 5256.8 5270.1 5291.7 5295.2 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | [#1] ext.html Cycles:180 Average:44348.48 Median:33742.49 stddev:74238.70 (220.0%) stddev-sans-first:74374.00 19:11:00 INFO - PROCESS | 3600 | Values: 513.1 520.3 526.9 546.8 553.0 28540.3 29094.7 35478.8 36120.5 36256.6 38389.2 39001.4 39003.6 39015.0 39096.2 8301.4 8376.7 8432.0 8470.2 8480.4 8406.5 8508.9 8514.6 8537.4 8541.4 8675.4 8678.0 8704.3 8760.9 8788.3 8540.1 8654.1 8702.3 8725.0 8744.2 8588.2 8730.0 8742.7 8747.2 8750.8 38377.0 38753.6 38876.2 38876.4 38915.6 3004.2 3065.6 3170.4 3282.2 3495.6 29238.6 29330.9 29673.5 30120.0 30507.1 3756.5 3783.7 3845.2 3891.5 3907.3 248173.0 252254.0 252382.0 252397.0 254381.7 51972.7 53109.0 53149.2 58528.0 58765.0 46085.5 61992.4 62525.0 62684.4 63490.7 14278.6 14376.4 14416.0 14444.9 14449.9 10508.4 10508.7 10510.6 10528.5 10580.1 16651.5 19509.3 20184.4 20295.7 20368.2 7269.1 7513.5 7517.5 7556.9 7563.5 915.6 972.0 990.4 1008.0 1068.4 25907.5 26152.9 28052.6 28332.0 28556.9 1041.2 1056.5 1072.7 1137.5 1140.2 14578.7 14660.6 14747.3 14851.7 14870.5 309374.0 310039.0 311849.0 312155.0 313254.0 50221.7 50395.0 50433.2 50444.7 50463.2 1315.2 1318.4 1336.8 1337.3 1348.4 27224.7 28122.7 28149.3 28320.2 29078.9 41152.8 41399.4 41448.0 42086.6 42629.0 278293.0 285781.0 286490.0 287372.0 289701.0 28227.6 28836.1 28856.1 28870.4 28873.6 38008.6 39173.2 39643.4 39644.6 39850.2 33157.2 33522.8 33666.5 35598.6 36944.8 33818.5 34616.5 35198.8 36214.6 36848.1 31668.7 31994.2 32020.5 32115.0 32206.5 26916.9 29235.3 31344.7 32026.4 32325.7 23186.3 24208.5 24309.0 24694.0 24708.9 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | [#2] jquery.html Cycles:180 Average:24207.27 Median:5205.27 stddev:76575.71 (1471.1%) stddev-sans-first:76769.57 19:11:00 INFO - PROCESS | 3600 | Values: 353.7 358.1 358.4 361.3 362.2 13676.9 14041.5 15647.7 16639.3 18044.1 14612.3 15236.9 15616.0 15633.1 15904.2 5135.9 5298.5 5302.6 5303.1 5303.4 3957.9 4067.3 5154.7 5234.9 5584.8 5714.6 5738.6 5748.4 5765.9 5766.9 5014.7 5196.0 5214.6 5214.8 5220.8 4800.1 4948.0 4960.8 4965.1 4988.8 10930.7 11318.7 11327.4 11535.9 11719.8 2057.9 2088.8 2096.9 2120.7 2288.8 8528.4 8545.8 8715.4 8849.7 8854.2 1646.2 1758.7 1775.6 1803.6 1818.8 47575.5 48351.0 52606.0 55529.7 57307.1 9584.3 9937.9 9938.1 9969.9 10016.9 12862.9 13051.1 13118.9 13172.6 13178.5 6965.0 7072.3 7305.4 7310.5 7386.4 6987.1 6992.8 7027.9 7030.1 7040.1 4325.0 4416.7 4421.8 4450.9 4461.7 1683.6 1747.7 1785.9 1853.5 1885.9 895.9 926.5 975.1 1005.5 1011.5 13654.9 15479.0 16677.8 17288.6 17523.6 882.7 950.9 952.6 991.1 1012.8 8991.8 9085.2 9130.3 9202.5 9328.2 338079.0 342448.0 528386.0 539312.0 543292.0 61179.4 61845.4 63181.0 64622.4 68783.0 1075.9 1096.6 1099.3 1112.6 1121.8 13388.0 13761.8 13866.8 14096.6 14124.8 29302.1 29366.7 29781.6 29994.7 30035.2 38391.4 38510.0 42079.2 42086.6 42234.8 6591.6 6670.8 6696.8 6698.9 6855.0 9461.8 9980.2 9996.6 10300.2 10693.7 8337.2 8732.1 8891.2 8900.8 8989.9 9192.0 9247.5 9506.0 9547.5 9647.9 8149.7 8830.9 8863.6 8977.3 9199.6 7091.4 7162.0 7213.4 7248.5 7344.3 8234.3 8802.5 8988.0 9009.7 9055.2 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | [#3] mootools.html Cycles:180 Average:5451.73 Median:6220.77 stddev:2836.50 (45.6%) stddev-sans-first:2826.60 19:11:00 INFO - PROCESS | 3600 | Values: 1217.6 1487.3 1506.2 1671.1 1808.6 6886.1 7587.0 7671.7 7727.3 7744.2 7605.1 7785.1 7797.2 7810.9 7814.4 2009.5 2055.9 2056.3 2312.0 2314.5 2032.5 2036.0 2273.7 2323.5 2329.4 2206.5 2233.2 2235.2 2235.5 2240.0 2251.3 2253.9 2255.7 2263.0 2275.6 2221.0 2253.3 2283.8 2284.4 2288.7 7737.7 7802.9 7826.1 7858.6 7892.1 4766.0 4860.7 4882.0 4888.7 4891.6 3047.1 3056.5 3136.6 3139.4 3145.1 864.7 908.8 909.0 1646.9 1678.8 10573.3 10623.6 10704.8 10718.9 10749.0 4093.5 4190.2 4200.0 4245.7 4247.2 8697.8 8698.6 8700.3 8705.6 8709.3 4802.8 4803.2 4838.4 4854.1 4857.3 4437.3 4470.3 4471.0 4471.9 4478.6 3318.4 3325.5 3335.8 3349.4 3365.7 983.6 1030.5 1045.5 1066.9 1075.5 1302.3 1308.7 1315.3 1333.8 1344.9 7349.0 7354.6 7601.9 7613.8 7613.9 1076.7 1081.0 1081.7 1090.0 1108.3 5721.3 5854.0 5859.6 5865.9 5866.0 9258.1 9474.1 9703.5 9714.4 9761.3 9612.4 9634.5 9676.2 9684.7 9745.0 7336.7 7397.6 7557.9 7563.0 7598.8 7226.3 7229.7 7263.5 7272.7 7279.9 8312.7 8502.4 8639.0 8640.8 8803.6 8714.1 8770.0 8785.4 8930.0 8944.3 6725.9 6839.0 6852.5 6853.0 6858.0 7498.2 7500.4 7505.1 7537.1 7554.7 5981.6 6752.9 6802.9 6907.3 6934.1 6750.2 6797.9 6802.5 6913.7 6917.4 6495.8 6524.1 6546.7 6547.9 6593.8 6139.7 6152.4 6194.5 6206.3 6300.5 6235.3 6342.8 6376.7 6378.8 6393.7 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | [#4] prototype.html Cycles:180 Average:5138.25 Median:5831.66 stddev:1564.63 (26.8%) stddev-sans-first:1526.94 19:11:00 INFO - PROCESS | 3600 | Values: 336.3 345.8 347.3 352.9 355.1 5771.5 5783.4 5811.8 5813.5 5851.7 5724.9 5748.3 5752.8 5753.3 5760.1 4477.1 4482.7 4482.8 4494.2 4508.2 4279.1 4446.0 4474.1 4475.7 4476.8 4408.7 4420.2 4427.4 4431.1 4432.4 4202.6 4274.3 4313.5 4429.0 4430.4 3822.2 3828.6 3846.4 3846.6 3873.1 5502.3 5530.9 5534.0 5538.6 5543.4 4868.2 4961.1 4964.6 5041.8 5045.5 6015.9 6021.5 6025.1 6043.2 6065.4 4217.5 4226.5 4238.8 4240.0 4241.6 6315.0 6316.0 6338.4 6379.6 6448.6 4247.5 4257.0 4258.2 4261.9 4273.6 4260.3 4287.1 4299.9 4313.2 4322.9 5006.8 5014.1 5014.6 5028.0 5030.5 6081.8 6133.0 6145.0 6167.4 6232.7 1532.3 1542.8 1545.3 1547.9 1548.5 1024.9 1039.2 1042.3 1051.6 1059.2 5850.2 5852.7 5853.6 5859.1 5861.1 6328.4 6338.2 6340.6 6347.1 6355.0 5773.0 5829.4 5833.9 5835.4 5845.6 3308.9 3416.6 3418.8 3420.6 3422.5 6597.3 6612.2 6649.9 6650.1 6671.4 6245.0 6410.3 6447.6 6468.7 6474.3 6439.8 6617.2 6639.4 6646.5 6660.6 6375.9 6415.7 6429.7 6432.6 6439.1 6146.6 6286.6 6291.1 6317.6 6358.7 6657.2 6660.0 6661.9 6665.3 6679.3 4321.2 4321.9 4326.2 4332.1 4338.9 6201.9 6400.0 6404.5 6408.8 6417.2 6242.4 6252.7 6257.1 6263.7 6264.7 6204.6 6253.6 6298.1 6301.1 6309.0 6025.1 6087.7 6123.1 6129.5 6136.4 6245.4 6247.9 6251.0 6252.8 6258.7 6099.8 6100.7 6107.5 6111.1 6124.9 19:11:00 INFO - PROCESS | 3600 | 19:11:00 INFO - PROCESS | 3600 | [#5] yui.html Cycles:180 Average:12773.21 Median:52037.24 stddev:14628.92 (28.1%) stddev-sans-first:14642.44 19:11:00 INFO - PROCESS | 3600 | Values: 826.5 827.4 837.4 839.4 841.4 12833.2 13011.1 13013.2 13020.4 13024.9 12182.6 12345.9 12394.9 13235.8 13266.2 666.3 796.8 812.7 813.3 813.6 669.9 790.0 815.9 816.6 817.1 847.3 857.1 857.2 857.5 857.6 680.8 697.6 832.7 850.7 853.1 627.1 627.7 628.2 628.2 628.4 12394.8 12880.7 12886.9 12890.9 12914.0 12508.7 12812.4 12907.4 13007.2 13047.9 9640.4 9683.9 9706.7 9817.6 10155.8 3561.4 3587.2 3588.4 3593.4 3672.5 44098.8 44454.0 44462.3 44540.6 44543.6 9050.1 9378.8 9473.5 9758.8 9784.5 15922.9 15938.7 15952.9 15967.4 15995.1 7166.9 7201.7 7230.1 7277.1 7488.8 3987.3 4134.4 4194.7 4211.9 4234.7 3078.8 3100.8 3103.4 3108.9 3111.9 569.0 570.4 580.3 587.4 603.2 471.1 552.5 615.5 618.7 632.5 7529.8 7882.4 7894.7 7939.6 8001.8 571.0 628.9 651.2 660.1 696.1 3693.4 3951.4 4033.5 4053.1 4060.1 51122.5 51419.7 51827.5 52012.0 52062.5 46498.3 46886.1 46928.3 47548.5 47585.5 42908.8 43192.4 43262.4 43392.4 43459.6 7943.2 8093.6 8099.1 8183.4 8191.4 31285.5 31335.8 32218.5 32293.0 32348.0 39758.8 42399.2 42636.4 42642.8 43036.0 8950.6 9466.6 9552.8 9594.3 9749.4 10714.3 10848.6 10920.2 10965.5 10981.8 10242.6 10311.2 10414.1 10771.1 10795.9 9712.7 10025.8 10065.7 10176.3 10358.3 7901.2 9438.8 9450.7 9779.2 10368.0 8804.8 8871.8 9037.0 9104.9 9329.7 8404.2 8966.6 9043.2 9211.4 9374.7 19:11:00 INFO - PROCESS | 3600 | -------- Summary: end -------- 19:11:00 INFO - PROCESS | 3600 | 19:11:01 INFO - TEST-INFO | 3600: exit 0 19:11:01 INFO - TEST-OK | dromaeo_css | took 1114010ms 19:11:01 INFO - TEST-START | kraken 19:11:01 INFO - operating with platform_type : linux_ 19:11:01 INFO - Initialising browser for kraken test... 19:11:01 INFO - TEST-INFO | started process 3800 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6L984j/profile http://localhost:36823/getInfo.html) 19:11:05 INFO - PROCESS | 3800 | __metrics Screen width/height:1600/1200 19:11:05 INFO - PROCESS | 3800 | colorDepth:24 19:11:05 INFO - PROCESS | 3800 | Browser inner width/height: 1024/697 19:11:05 INFO - PROCESS | 3800 | __metrics 19:11:05 INFO - PROCESS | 3800 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:11:06 INFO - PROCESS | 3800 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:11:07 INFO - TEST-INFO | 3800: exit 0 19:11:07 INFO - Browser initialized. 19:11:07 INFO - Running cycle 1/1 for kraken test... 19:11:07 INFO - TEST-INFO | started process 3883 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6L984j/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:19 INFO - PROCESS | 3883 | RSS: Main: 148344832 19:11:19 INFO - PROCESS | 3883 | 19:11:21 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36823/tests/kraken/driver.html?testName=audio-beat-detection) 19:11:22 INFO - PROCESS | 3883 | RSS: Main: 185966592 19:11:22 INFO - PROCESS | 3883 | 19:11:24 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36823/tests/kraken/driver.html?testName=audio-dft) 19:11:25 INFO - PROCESS | 3883 | RSS: Main: 177696768 19:11:25 INFO - PROCESS | 3883 | 19:11:28 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36823/tests/kraken/driver.html?testName=audio-fft) 19:11:28 INFO - PROCESS | 3883 | RSS: Main: 164085760 19:11:28 INFO - PROCESS | 3883 | 19:11:30 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36823/tests/kraken/driver.html?testName=audio-oscillator) 19:11:31 INFO - PROCESS | 3883 | RSS: Main: 165240832 19:11:31 INFO - PROCESS | 3883 | 19:11:33 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:11:34 INFO - PROCESS | 3883 | RSS: Main: 167456768 19:11:34 INFO - PROCESS | 3883 | 19:11:37 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36823/tests/kraken/driver.html?testName=imaging-darkroom) 19:11:37 INFO - PROCESS | 3883 | RSS: Main: 167198720 19:11:37 INFO - PROCESS | 3883 | 19:11:41 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36823/tests/kraken/driver.html?testName=imaging-desaturate) 19:11:41 INFO - PROCESS | 3883 | RSS: Main: 169308160 19:11:41 INFO - PROCESS | 3883 | 19:11:44 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36823/tests/kraken/driver.html?testName=json-parse-financial) 19:11:45 INFO - PROCESS | 3883 | RSS: Main: 167600128 19:11:45 INFO - PROCESS | 3883 | 19:11:46 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:11:47 INFO - PROCESS | 3883 | RSS: Main: 181108736 19:11:47 INFO - PROCESS | 3883 | 19:11:48 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:11:49 INFO - PROCESS | 3883 | RSS: Main: 178073600 19:11:49 INFO - PROCESS | 3883 | 19:11:51 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:11:52 INFO - PROCESS | 3883 | RSS: Main: 191668224 19:11:52 INFO - PROCESS | 3883 | 19:11:54 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:11:55 INFO - PROCESS | 3883 | RSS: Main: 199393280 19:11:55 INFO - PROCESS | 3883 | 19:11:57 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:11:58 INFO - PROCESS | 3883 | RSS: Main: 198524928 19:11:58 INFO - PROCESS | 3883 | 19:11:59 INFO - PROCESS | 3883 | Cycle 1(1): loaded http://localhost:36823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36823/tests/kraken/driver.html?testName=ai-astar) 19:12:00 INFO - PROCESS | 3883 | RSS: Main: 258666496 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | __start_tp_report 19:12:00 INFO - PROCESS | 3883 | _x_x_mozilla_page_load 19:12:00 INFO - PROCESS | 3883 | _x_x_mozilla_page_load_details 19:12:00 INFO - PROCESS | 3883 | |i|pagename|runs| 19:12:00 INFO - PROCESS | 3883 | |0;ai-astar;111;110;107;109;110;111;109;110;105;109 19:12:00 INFO - PROCESS | 3883 | |1;audio-beat-detection;151;128;151;165;136;156;152;131;169;126 19:12:00 INFO - PROCESS | 3883 | |2;audio-dft;162;162;162;160;163;162;160;168;162;160 19:12:00 INFO - PROCESS | 3883 | |3;audio-fft;73;75;94;94;72;72;75;130;95;73 19:12:00 INFO - PROCESS | 3883 | |4;audio-oscillator;96;96;139;96;96;96;144;95;97;140 19:12:00 INFO - PROCESS | 3883 | |5;imaging-gaussian-blur;118;116;115;114;115;115;115;115;115;114 19:12:00 INFO - PROCESS | 3883 | |6;imaging-darkroom;145;145;146;146;146;145;146;145;145;145 19:12:00 INFO - PROCESS | 3883 | |7;imaging-desaturate;96;96;95;96;96;96;95;96;96;96 19:12:00 INFO - PROCESS | 3883 | |8;json-parse-financial;58;56;58;57;56;57;56;56;57;54 19:12:00 INFO - PROCESS | 3883 | |9;json-stringify-tinderbox;67;66;66;66;68;68;67;67;68;68 19:12:00 INFO - PROCESS | 3883 | |10;stanford-crypto-aes;81;83;84;90;83;82;83;81;83;82 19:12:00 INFO - PROCESS | 3883 | |11;stanford-crypto-ccm;122;120;115;129;114;114;114;124;117;116 19:12:00 INFO - PROCESS | 3883 | |12;stanford-crypto-pbkdf2;144;143;144;143;144;137;148;144;149;147 19:12:00 INFO - PROCESS | 3883 | |13;stanford-crypto-sha256-iterative;70;69;68;69;66;69;66;70;67;68 19:12:00 INFO - PROCESS | 3883 | __end_tp_report 19:12:00 INFO - PROCESS | 3883 | __start_cc_report 19:12:00 INFO - PROCESS | 3883 | _x_x_mozilla_cycle_collect,960 19:12:00 INFO - PROCESS | 3883 | __end_cc_report 19:12:00 INFO - PROCESS | 3883 | __startTimestamp1453777920174__endTimestamp 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | ------- Summary: start ------- 19:12:00 INFO - PROCESS | 3883 | Number of tests: 14 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.85 (1.7%) stddev-sans-first:1.83 19:12:00 INFO - PROCESS | 3883 | Values: 111.0 110.0 107.0 109.0 110.0 111.0 109.0 110.0 105.0 109.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:151.50 stddev:15.36 (10.1%) stddev-sans-first:16.20 19:12:00 INFO - PROCESS | 3883 | Values: 151.0 128.0 151.0 165.0 136.0 156.0 152.0 131.0 169.0 126.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.33 (1.4%) stddev-sans-first:2.47 19:12:00 INFO - PROCESS | 3883 | Values: 162.0 162.0 162.0 160.0 163.0 162.0 160.0 168.0 162.0 160.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#3] audio-fft Cycles:10 Average:85.30 Median:75.00 stddev:18.60 (24.8%) stddev-sans-first:19.18 19:12:00 INFO - PROCESS | 3883 | Values: 73.0 75.0 94.0 94.0 72.0 72.0 75.0 130.0 95.0 73.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:21.78 (22.7%) stddev-sans-first:22.54 19:12:00 INFO - PROCESS | 3883 | Values: 96.0 96.0 139.0 96.0 96.0 96.0 144.0 95.0 97.0 140.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.14 (1.0%) stddev-sans-first:0.60 19:12:00 INFO - PROCESS | 3883 | Values: 118.0 116.0 115.0 114.0 115.0 115.0 115.0 115.0 115.0 114.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:12:00 INFO - PROCESS | 3883 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:12:00 INFO - PROCESS | 3883 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.18 (2.1%) stddev-sans-first:1.12 19:12:00 INFO - PROCESS | 3883 | Values: 58.0 56.0 58.0 57.0 56.0 57.0 56.0 56.0 57.0 54.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 19:12:00 INFO - PROCESS | 3883 | Values: 67.0 66.0 66.0 66.0 68.0 68.0 67.0 67.0 68.0 68.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.57 (3.1%) stddev-sans-first:2.60 19:12:00 INFO - PROCESS | 3883 | Values: 81.0 83.0 84.0 90.0 83.0 82.0 83.0 81.0 83.0 82.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.50 stddev:5.13 (4.3%) stddev-sans-first:5.28 19:12:00 INFO - PROCESS | 3883 | Values: 122.0 120.0 115.0 129.0 114.0 114.0 114.0 124.0 117.0 116.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:144.00 stddev:3.33 (2.3%) stddev-sans-first:3.54 19:12:00 INFO - PROCESS | 3883 | Values: 144.0 143.0 144.0 143.0 144.0 137.0 148.0 144.0 149.0 147.0 19:12:00 INFO - PROCESS | 3883 | 19:12:00 INFO - PROCESS | 3883 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.41 19:12:00 INFO - PROCESS | 3883 | Values: 70.0 69.0 68.0 69.0 66.0 69.0 66.0 70.0 67.0 68.0 19:12:00 INFO - PROCESS | 3883 | -------- Summary: end -------- 19:12:00 INFO - PROCESS | 3883 | 19:12:01 INFO - TEST-INFO | 3883: exit 0 19:12:01 INFO - TEST-OK | kraken | took 59935ms 19:12:01 INFO - TEST-START | v8_7 19:12:01 INFO - operating with platform_type : linux_ 19:12:01 INFO - Initialising browser for v8_7 test... 19:12:01 INFO - TEST-INFO | started process 4129 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJiCXqM/profile http://localhost:36823/getInfo.html) 19:12:06 INFO - PROCESS | 4129 | __metrics Screen width/height:1600/1200 19:12:06 INFO - PROCESS | 4129 | colorDepth:24 19:12:06 INFO - PROCESS | 4129 | Browser inner width/height: 1024/697 19:12:06 INFO - PROCESS | 4129 | __metrics 19:12:06 INFO - PROCESS | 4129 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:12:06 INFO - PROCESS | 4129 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:07 INFO - TEST-INFO | 4129: exit 0 19:12:07 INFO - Browser initialized. 19:12:07 INFO - Running cycle 1/1 for v8_7 test... 19:12:07 INFO - TEST-INFO | started process 4212 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJiCXqM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:18 INFO - PROCESS | 4212 | RSS: Main: 148664320 19:12:18 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | Cycle 1(1): loaded http://localhost:36823/tests/v8_7/run.html (next: http://localhost:36823/tests/v8_7/run.html) 19:12:41 INFO - PROCESS | 4212 | RSS: Main: 489107456 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | __start_tp_report 19:12:41 INFO - PROCESS | 4212 | _x_x_mozilla_page_load 19:12:41 INFO - PROCESS | 4212 | _x_x_mozilla_page_load_details 19:12:41 INFO - PROCESS | 4212 | |i|pagename|runs| 19:12:41 INFO - PROCESS | 4212 | |0;Richards;168.03898504453034 19:12:41 INFO - PROCESS | 4212 | |1;DeltaBlue;189.14318138831095 19:12:41 INFO - PROCESS | 4212 | |2;Encrypt;275.2546105147261 19:12:41 INFO - PROCESS | 4212 | |3;Decrypt;5296.2962962962965 19:12:41 INFO - PROCESS | 4212 | |4;RayTrace;1120.9406494960806 19:12:41 INFO - PROCESS | 4212 | |5;Earley;771.604938271605 19:12:41 INFO - PROCESS | 4212 | |6;Boyer;12345.67901234568 19:12:41 INFO - PROCESS | 4212 | |7;RegExp;43127.65957446808 19:12:41 INFO - PROCESS | 4212 | |8;Splay;946.969696969697 19:12:41 INFO - PROCESS | 4212 | |9;NavierStokes;4822.115384615385 19:12:41 INFO - PROCESS | 4212 | __end_tp_report 19:12:41 INFO - PROCESS | 4212 | __startTimestamp1453777961601__endTimestamp 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | ------- Summary: start ------- 19:12:41 INFO - PROCESS | 4212 | Number of tests: 10 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 168.0 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#1] DeltaBlue Cycles:1 Average:189.14 Median:189.14 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 189.1 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#2] Encrypt Cycles:1 Average:275.25 Median:275.25 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 275.3 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#3] Decrypt Cycles:1 Average:5296.30 Median:5296.30 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 5296.3 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#4] RayTrace Cycles:1 Average:1120.94 Median:1120.94 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 1120.9 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#5] Earley Cycles:1 Average:771.60 Median:771.60 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 771.6 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 12345.7 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#7] RegExp Cycles:1 Average:43127.66 Median:43127.66 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 43127.7 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#8] Splay Cycles:1 Average:946.97 Median:946.97 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 947.0 19:12:41 INFO - PROCESS | 4212 | 19:12:41 INFO - PROCESS | 4212 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 19:12:41 INFO - PROCESS | 4212 | Values: 4822.1 19:12:41 INFO - PROCESS | 4212 | -------- Summary: end -------- 19:12:41 INFO - PROCESS | 4212 | 19:12:42 INFO - TEST-INFO | 4212: exit 0 19:12:42 INFO - TEST-OK | v8_7 | took 41141ms 19:12:42 INFO - SUITE-END | took 1215s 19:12:42 INFO - Completed test suite (00:20:15) 19:12:42 INFO - Working with test: dromaeo_css 19:12:42 INFO - Generating results file: dromaeo_css 19:12:42 INFO - Working with test: kraken 19:12:42 INFO - Generating results file: kraken 19:12:42 INFO - javascript benchmark 19:12:42 INFO - Working with test: v8_7 19:12:42 INFO - Generating results file: v8_7 19:12:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 19:12:42 INFO - process_Request line: dromaeo_css 6639.05 graph.html#tests=[[72,1,35]] 19:12:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:42 INFO - process_Request line: kraken 1506.70 graph.html#tests=[[232,1,35]] 19:12:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:42 INFO - process_Request line: v8_7 19115.56 graph.html#tests=[[230,1,35]] 19:12:42 INFO - RETURN: dromaeo_css: 6639.05 19:12:42 INFO - RETURN: kraken: 1506.70 19:12:42 INFO - RETURN: v8_7: 19115.56 19:12:42 INFO - javascript benchmark 19:12:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3106.471899777038, 3155.526670999351, 3187.139472342466, 3194.1056504178837, 3218.839058047097, 4982.053409852126, 5068.417132029817, 5080.949190508094, 5123.1546794778815, 5157.79368825247, 5072.492750724926, 5108.923366149511, 5122.897542049157, 5170.0, 5201.791928322863, 4629.375034370368, 4662.0, 4665.743384113873, 4715.740634265114, 4735.479097299294, 4712.858614241578, 4750.334953106568, 4768.64235182361, 4813.807447702087, 4837.371141751567, 4628.120657075162, 4651.511591282934, 4652.953470465302, 4704.059188162381, 4739.857804265877, 4720.669553131283, 4726.952730472685, 4727.550882666142, 4742.217534106868, 4776.737279449629, 4734.2425211966265, 4740.525947405266, 4741.217699079648, 4757.333973243749, 4771.522847715235, 4895.510448955111, 4942.777575009133, 4998.925016124761, 5001.624878134155, 5062.063518249099, 5445.101558242885, 5510.779568817243, 5555.8888822223325, 5561.388247292794, 5566.888662226733, 5512.724363781795, 5514.117741161395, 5515.448455154493, 5528.806491772809, 5535.25274087997, 5120.385553733576, 5185.61107916904, 5191.0656081905245, 5195.960807838447, 5250.947490525123, 5436.565074794007, 5489.094299440628, 5582.665040097607, 5653.0, 5656.123300888369, 5357.142857142916, 5362.034833729888, 5365.839024829262, 5375.677459352373, 5408.0535906216255, 5366.275552800322, 5454.809081682122, 5466.726663666801, 5471.753771080311, 5516.91724624131, 5364.168553874156, 5442.265294185314, 5444.6188766785945, 5477.3427188737605, 5536.0, 5493.478119578634, 5497.45025497455, 5503.091989821714, 5503.422140675251, 5507.586930980113, 4325.697201195949, 4327.740335579875, 4336.804843782037, 4370.0, 4370.409994650745, 3800.600936901641, 3812.7140464465274, 3842.4044273137706, 3864.961350386516, 3886.5724770275247, 5122.206058061007, 5135.537801597874, 5139.331886854759, 5139.974300128551, 5150.587952963754, 5394.3796463406425, 5533.750981205855, 5534.1145416733125, 5535.7785688572, 5538.390777014525, 5120.48795120485, 5139.974300128475, 5155.5617772489, 5166.974165129151, 5223.738813059332, 4723.669343146015, 4724.6456515760765, 4725.054989002213, 4747.667663263607, 4786.928196077061, 5534.584906132056, 5642.520385767174, 5713.457221563945, 5721.113227449752, 5724.885502289931, 5482.39693633708, 5523.171524271392, 5531.225628411945, 5544.528715059265, 5580.441955804387, 5649.209110724584, 5660.575456840671, 5668.178114173505, 5668.518175954925, 5669.262995810518, 5284.471552844685, 5370.892582148257, 5381.1121165007335, 5418.106012507892, 5457.727113644222, 5504.724763761716, 5550.0564903965615, 5550.38945715979, 5555.833325000256, 5561.054620714407, 5368.141097424394, 5380.192971054373, 5403.9459605403445, 5407.783688652567, 5460.5904557159165, 5234.842954711365, 5298.920516192337, 5353.304070470814, 5381.946180538144, 5387.730613469389, 5241.89516209666, 5268.157094864803, 5285.392179899361, 5286.735663216747, 5317.415084340797, 5362.249285100167, 5384.015828287118, 5389.649672771257, 5393.8112166074, 5430.891382172414, 5209.505097015777, 5256.763445645031, 5270.077736396192, 5291.7354132294, 5295.232191332158], "unit": "score", "name": "dojo.html", "value": 5081.791101158092}, {"lowerIsBetter": false, "replicates": [513.1123156938496, 520.2612290547422, 526.9288646032785, 546.7915905848076, 553.0156321747291, 28540.28649283769, 29094.70905290949, 35478.82260588697, 36120.45819312706, 36256.637433625656, 38389.23221535575, 39001.41497877534, 39003.60996390035, 39015.0, 39096.21807563854, 8301.377396695241, 8376.706815261467, 8432.0, 8470.237678608924, 8480.363972702042, 8406.495610263373, 8508.914910850905, 8514.616842242083, 8537.402381833273, 8541.35939804514, 8675.43609665373, 8678.0, 8704.347173961947, 8760.94868615767, 8788.296936245086, 8540.06059333476, 8654.09132041133, 8702.260307873838, 8724.956375218148, 8744.169303916118, 8588.22705956467, 8730.0, 8742.650293988232, 8747.16901894319, 8750.781230469225, 38377.0, 38753.61246387528, 38876.22247555061, 38876.416853747214, 38915.610843891765, 3004.1888690053565, 3065.647450543194, 3170.381775553768, 3282.2122690554334, 3495.580530336376, 29238.56142157869, 29330.853345733136, 29673.516448961036, 30120.0, 30507.08478745619, 3756.530433695788, 3783.735138540303, 3845.2309538092213, 3891.5135608048995, 3907.33575292201, 248173.0, 252254.0, 252382.0, 252397.0, 254381.72809136022, 51972.74013629908, 53109.0, 53149.20276195783, 58528.0, 58765.0, 46085.53914460813, 61992.380076199566, 62525.0, 62684.37315626877, 63490.68254658697, 14278.571642850731, 14376.35306411214, 14416.0, 14444.855551444562, 14449.855501445061, 10508.42203678805, 10508.684739457829, 10510.579576816994, 10528.526216320284, 10580.100691441314, 16651.50045498637, 19509.272296953266, 20184.394468165978, 20295.695564566544, 20368.185272589228, 7269.055022847102, 7513.549187048795, 7517.473776835569, 7556.924430755732, 7563.546187228784, 915.5834095486538, 971.9805603887883, 990.3909095905966, 1007.9718686939281, 1068.3589846092439, 25907.481850363263, 26152.940472151793, 28052.579211311848, 28332.0, 28556.857215714204, 1041.234692501011, 1056.5140035583563, 1072.6621114348955, 1137.4824454873012, 1140.1676775953601, 14578.708425831635, 14660.56018319452, 14747.336369863382, 14851.70296594062, 14870.479533216501, 309374.0, 310039.0, 311849.0, 312155.0, 313254.0, 50221.74889125531, 50395.0, 50433.24350134751, 50444.72998715067, 50463.24305135426, 1315.2371624457792, 1318.3671837518045, 1336.8262125923568, 1337.2845527642664, 1348.4067010515341, 27224.727752722218, 28122.71877281283, 28149.296267593472, 28320.15039548817, 29078.854605727684, 41152.794236028625, 41399.37900931549, 41448.0, 42086.57913420827, 42629.0, 278293.0, 285781.0, 286490.0, 287372.0, 289701.0, 28227.57658635081, 28836.134915952556, 28856.134315970554, 28870.42259154847, 28873.566896496148, 38008.61991380051, 39173.21653566856, 39643.405348920365, 39644.603553964094, 39850.2029959405, 33157.17107072342, 33522.832385837915, 33666.49500257449, 35598.64401355953, 36944.81527592345, 33818.49272260869, 34616.48075278923, 35198.824005879804, 36214.63785362113, 36848.07879803026, 31668.683313166573, 31994.20014499656, 32020.5196922051, 32115.03654890357, 32206.516902246953, 26916.865415672797, 29235.269118272212, 31344.68655313509, 32026.35947281088, 32325.676743232267, 23186.304410867702, 24208.51582968366, 24309.0, 24694.0, 24708.876455617607], "unit": "score", "name": "ext.html", "value": 17689.75670713638}, {"lowerIsBetter": false, "replicates": [353.74000109919206, 358.0529499473891, 358.353172523595, 361.3387500873402, 362.20134603199915, 13676.93161534191, 14041.508547200825, 15647.687046259069, 16639.334426622936, 18044.097795110258, 14612.342444589993, 15236.923815380935, 15616.0, 15633.062016279031, 15904.204789760495, 5135.948640513603, 5298.470152984709, 5302.628815982883, 5303.124984377573, 5303.363596368441, 3957.861474848381, 4067.3288907330257, 5154.716490593035, 5234.947650523503, 5584.776608935637, 5714.599978001542, 5738.626989245707, 5748.367679555246, 5765.855853603652, 5766.942330576682, 5014.674046186986, 5195.974020129913, 5214.556762675158, 5214.817481388133, 5220.791168353261, 4800.135975524404, 4947.975260123712, 4960.751962401865, 4965.131102057162, 4988.775505102279, 10930.672079837537, 11318.717032074182, 11327.376994265313, 11535.942320288428, 11719.824202636968, 2057.907394167266, 2088.8120069193847, 2096.916123355064, 2120.6606942889216, 2288.7940085392393, 8528.403011789178, 8545.829083418297, 8715.389922705413, 8849.734507964771, 8854.203121719012, 1646.2427283449626, 1758.7098128808732, 1775.5649865782837, 1803.558128258572, 1818.7544681467964, 47575.5242447578, 48351.03297934057, 52606.0, 55529.72235138839, 57307.140392894136, 9584.28117891161, 9937.900620993842, 9938.055884690943, 9969.850452243221, 10016.899831001596, 12862.935685321514, 13051.086423950423, 13118.934405327913, 13172.60482185536, 13178.538751143664, 6965.0, 7072.257412971564, 7305.379042781423, 7310.488265821342, 7386.446016548673, 6987.1266091738535, 6992.79021629352, 7027.859442811217, 7030.121234845645, 7040.0847889774, 4325.0, 4416.712913660602, 4421.845235416745, 4450.888727781767, 4461.687681862239, 1683.6043529770493, 1747.737839324086, 1785.9464216073538, 1853.5458812590732, 1885.9061744188339, 895.8880139982502, 926.536731634183, 975.1321324021485, 1005.5022763731853, 1011.489197955028, 13654.931725341508, 15479.0, 16677.842847988857, 17288.567785805204, 17523.649527009387, 882.668999125328, 950.8906475755376, 952.6189524190379, 991.0683957080322, 1012.7569383347943, 8991.82016359669, 9085.227755640712, 9130.31522635805, 9202.493862837475, 9328.207102396373, 338079.0, 342448.0, 528386.0, 539312.0, 543292.0, 61179.38820611737, 61845.381546184864, 63180.99999999908, 64622.35377646257, 68783.0, 1075.9139268858473, 1096.550414330121, 1099.3074363151322, 1112.6272698646044, 1121.7532142928542, 13388.0, 13761.79357309621, 13866.791998119834, 14096.577102686935, 14124.78812817788, 29302.120936371943, 29366.706332936395, 29781.553276700433, 29994.700053000062, 30035.249118772204, 38391.42412863865, 38510.0, 42079.15841683088, 42086.57913420827, 42234.78882605567, 6591.604503729792, 6670.76652317186, 6696.7656132035145, 6698.933010670026, 6855.040294358694, 9461.810763784824, 9980.201583873128, 9996.600135994478, 10300.227482938959, 10693.732656683334, 8337.166283371615, 8732.08313127138, 8891.19979201875, 8900.821983560421, 8989.910100898907, 9191.954040229755, 9247.537623118682, 9506.049395060438, 9547.4748888809, 9647.9035209647, 8149.742424695372, 8830.91169088301, 8863.601137948937, 8977.326700497359, 9199.586018629312, 7091.397231235403, 7161.9641901790155, 7213.350798427957, 7248.492605517563, 7344.265573442613, 8234.300084492885, 8802.515861627417, 8988.0, 9009.684661036832, 9055.23030542385], "unit": "score", "name": "jquery.html", "value": 7678.416805442631}, {"lowerIsBetter": false, "replicates": [1217.6468824041028, 1487.278669845125, 1506.1866592040299, 1671.1226606031832, 1808.5930665600242, 6886.0703804986315, 7586.962065189673, 7671.6547755351, 7727.2659097385795, 7744.186860379664, 7605.125410577772, 7785.104712958011, 7797.2202779722, 7810.882836757439, 7814.374850012, 2009.4674911148484, 2055.9486012849648, 2056.259746491262, 2311.9537609247805, 2314.479242170515, 2032.4512381656943, 2036.0, 2273.7044184256106, 2323.4772176260376, 2329.3710698111586, 2206.5366273082673, 2233.1625640384855, 2235.228846048111, 2235.474663454095, 2239.9776002240014, 2251.3358559225067, 2253.8985745641403, 2255.6954811100536, 2263.0495192019393, 2275.6472746724285, 2220.9888950555305, 2253.278950735765, 2283.7944584987263, 2284.3603790938396, 2288.6795848581214, 7737.651805668758, 7802.921970780277, 7826.060872695256, 7858.567778772165, 7892.0529536455415, 4765.952340476586, 4860.684055536414, 4882.0, 4888.657793954425, 4891.608671306287, 3047.085874237742, 3056.526238433024, 3136.623605167372, 3139.3564319314714, 3145.1350878508365, 864.6627815152033, 908.8046070094895, 909.0000998901222, 1646.9423570175106, 1678.848903598682, 10573.259871808976, 10623.628173013985, 10704.78590428187, 10718.946405268001, 10748.9788470096, 4093.5087789465456, 4190.245755763931, 4200.0, 4245.660347172219, 4247.171801498678, 8697.782555436039, 8698.565071746387, 8700.34747393948, 8705.564721763887, 8709.303255739525, 4802.7838747255755, 4803.207470767354, 4838.419389673261, 4854.101991131652, 4857.319975203474, 4437.267850804581, 4470.307102399133, 4470.955290447054, 4471.932921006188, 4478.57453541913, 3318.3714316855558, 3325.4513005353847, 3335.8332083395735, 3349.4473411886765, 3365.6802603752603, 983.6458874805064, 1030.4847576211894, 1045.513836066233, 1066.8559744434558, 1075.4891426572315, 1302.337567086736, 1308.6597484654058, 1315.2568798628745, 1333.7732585460494, 1344.932753362328, 7349.0, 7354.632268386559, 7601.923980760233, 7613.847723045508, 7613.9238607614325, 1076.6554702495282, 1080.9729756756144, 1081.7025318037602, 1090.0, 1108.3405373802575, 5721.256236689203, 5853.970730146322, 5859.589828711949, 5865.941340586625, 5865.970670146622, 9258.120478554527, 9474.099960503741, 9703.5148242589, 9714.368566043184, 9761.316707830383, 9612.423254604746, 9634.518274086267, 9676.177524910321, 9684.70945871625, 9744.951275243578, 7336.7432139874845, 7397.630118494054, 7557.924420755832, 7562.99999999989, 7598.772036838904, 7226.277372262942, 7229.7469588564145, 7263.527870688388, 7272.7454539093, 7279.927200727925, 8312.667493300441, 8502.36232282569, 8639.0, 8640.78398040054, 8803.647854085764, 8714.08502107295, 8769.956150219208, 8785.428947118417, 8930.0, 8944.284457243275, 6725.899111513233, 6839.0, 6852.451803855779, 6853.0, 6858.0, 7498.212687667935, 7500.399968002437, 7505.136909255505, 7537.133229678657, 7554.697812087455, 5981.641101533922, 6752.864942701217, 6802.931970680428, 6907.34380233877, 6934.133233345832, 6750.2237242715755, 6797.864042719217, 6802.489813264124, 6913.688884000333, 6917.377436030782, 6495.837604059747, 6524.119243902012, 6546.672666366568, 6547.901781473377, 6593.80218593443, 6139.693015349304, 6152.415520525543, 6194.5354098443695, 6206.286277078194, 6300.464460520724, 6235.251769787473, 6342.841428964128, 6376.74493020274, 6378.808635740936, 6393.744250230125], "unit": "score", "name": "mootools.html", "value": 4485.208987796978}, {"lowerIsBetter": false, "replicates": [336.3038510283713, 345.78734078541686, 347.2776624620788, 352.92059286660486, 355.090967124162, 5771.451712087355, 5783.363829978699, 5811.767529298828, 5813.5349172066235, 5851.736671849766, 5724.914126288109, 5748.310202775662, 5752.827415177541, 5753.338366087901, 5760.0783874580075, 4477.149341625089, 4482.731036137842, 4482.775861206943, 4494.213512635292, 4508.211063063967, 4279.0799978004725, 4446.0441005183875, 4474.082813023322, 4475.664325175609, 4476.843310484133, 4408.691391602573, 4420.248557745191, 4427.424434823484, 4431.135928493945, 4432.3573081903105, 4202.621764041251, 4274.316109422478, 4313.460817397825, 4428.97785511072, 4430.446194225738, 3822.197338558906, 3828.617138286149, 3846.3845784674318, 3846.615338466159, 3873.0511024798825, 5502.284702988626, 5530.944690553083, 5534.0315444797, 5538.584606154514, 5543.417941116165, 4868.245421959567, 4961.05739909416, 4964.60283177345, 5041.848744537633, 5045.545900868903, 6015.939840601625, 6021.458068773832, 6025.126356678301, 6043.1841701370195, 6065.393460653943, 4217.536071032184, 4226.535081141072, 4238.766867822269, 4240.045989652334, 4241.639460645849, 6315.0, 6316.0, 6338.425581430192, 6379.649119298437, 6448.64532450715, 4247.490301163818, 4257.0, 4258.233517966796, 4261.87214383569, 4273.594008569181, 4260.318349064135, 4287.078278170208, 4299.892502687458, 4313.223619748475, 4322.935155972663, 5006.774695138727, 5014.07239660664, 5014.648974571745, 5028.019536190481, 5030.547250747451, 6081.817545473555, 6133.049377346519, 6144.969275153596, 6167.396476915945, 6232.719527621268, 1532.341093329879, 1542.8071491063617, 1545.3432291276163, 1547.922603869802, 1548.4735190035442, 1024.9180065594735, 1039.2413538117066, 1042.3068659341604, 1051.6476980211714, 1059.1738444013681, 5850.210221620112, 5852.736626851802, 5853.64878107315, 5859.121131830174, 5861.062230043172, 6328.398802113792, 6338.176037115146, 6340.587861788969, 6347.1114044033875, 6355.0, 5773.0, 5829.446202610745, 5833.88332233353, 5835.416458354131, 5845.649261044351, 3308.93382132356, 3416.555847739778, 3418.8290585470627, 3420.589529256505, 3422.469517224834, 6597.30728273534, 6612.206535215709, 6649.900251496231, 6650.068990341356, 6671.43292820106, 6244.968775156095, 6410.262819775692, 6447.6131432114225, 6468.676566171673, 6474.255460622088, 6439.774607888701, 6617.239017512855, 6639.3692599203, 6646.468282537386, 6660.600363978177, 6375.904361434489, 6415.679216039272, 6429.7428102875365, 6432.581882177644, 6439.06633538125, 6146.569740118149, 6286.591371560834, 6291.056341548804, 6317.6209427434505, 6358.713857876499, 6657.201135863727, 6660.0, 6661.933380666132, 6665.3001434850585, 6679.298673639198, 4321.2437823381415, 4321.876312158798, 4326.178026175016, 4332.06860524976, 4338.9349159762, 6201.937980620317, 6399.968000159969, 6404.487640988803, 6408.807735767934, 6417.2299324081405, 6242.438180563771, 6252.656103914328, 6257.1240026395435, 6263.718132683949, 6264.655443950626, 6204.627722336674, 6253.5622506424115, 6298.11826344303, 6301.117843501822, 6309.0, 6025.096235564701, 6087.69561521931, 6123.050927106306, 6129.509639228941, 6136.447719705248, 6245.375462453719, 6247.937520624918, 6251.0, 6252.843678908063, 6258.749650014131, 6099.786507472217, 6100.725467354068, 6107.541934354852, 6111.052786817872, 6124.877502449837], "unit": "score", "name": "prototype.html", "value": 4637.270435959738}, {"lowerIsBetter": false, "replicates": [826.4751882554577, 827.3960009193285, 837.3803385494734, 839.3704721458906, 841.3773807382535, 12833.165844220131, 13011.089223754341, 13013.15414498057, 13020.414081366338, 13024.934875325622, 12182.634520964362, 12345.938270308636, 12394.938025309883, 13235.801462978063, 13266.204027758316, 666.257123307511, 796.7649543384715, 812.7033632724043, 813.2639960835453, 813.5810057820198, 669.9363560461749, 789.9960500197519, 815.9428839981204, 816.6365967144623, 817.0562999735315, 847.2840449819923, 857.1257317536109, 857.1557016338901, 857.536930057768, 857.6226460357423, 680.7651360280695, 697.5709938387905, 832.696065935929, 850.740524140137, 853.0658928473312, 627.05314974389, 627.7081157261849, 628.1990462160736, 628.2398298059354, 628.3622123544606, 12394.81407778884, 12880.677983050406, 12886.935565322206, 12890.935545322307, 12914.031447641371, 12508.74982500354, 12812.359382030862, 12907.419166137546, 13007.219566826021, 13047.934760326232, 9640.373375730554, 9683.854742178873, 9706.70879873605, 9817.5582098805, 10155.796884062278, 3561.3954693072474, 3587.157018100744, 3588.372034893909, 3593.443016332473, 3672.467492213614, 44098.77950610258, 44454.0, 44462.33306500405, 44540.55459445396, 44543.554564454265, 9050.140236677506, 9378.812423751488, 9473.47895865734, 9758.75603109928, 9784.510774461249, 15922.92038539823, 15938.681226375407, 15952.92023539875, 15967.44113956006, 15995.120268385117, 7166.856662866713, 7201.675924583406, 7230.13238411394, 7277.053982982178, 7488.775336739906, 3987.302222111119, 4134.359174327984, 4194.6853985951175, 4211.852585159566, 4234.745915245096, 3078.7998780079224, 3100.8294543800307, 3103.425866214712, 3108.891188808381, 3111.9066428007195, 568.9601727879092, 570.3611954610863, 580.303635637237, 587.4096532984408, 603.2188316130621, 471.0907947661047, 552.4503119396227, 615.5291202230297, 618.7223383712619, 632.4845251120414, 7529.774106776806, 7882.408819338572, 7894.6842126314305, 7939.563324017119, 8001.799955001172, 570.9669265425263, 628.9495648026693, 651.2478087808589, 660.1088530483904, 696.095076400677, 3693.372126738461, 3951.3677811550015, 4033.51597808259, 4053.148838743838, 4060.127072679388, 51122.48877511251, 51419.74290128525, 51827.48172518227, 52012.0, 52062.47937520652, 46498.302525462146, 46886.06227875423, 46928.296075558894, 47548.52451475441, 47585.524144758805, 42908.78545607314, 43192.352114718306, 43262.351064734685, 43392.39645621273, 43459.565404346184, 7943.205679432011, 8093.609968389829, 8099.109097999098, 8183.427160098736, 8191.385646076687, 31285.530717038808, 31335.84332078325, 32218.516722248718, 32293.0, 32348.029559113264, 39758.80120599378, 42399.15201695887, 42636.36045459383, 42642.78678606587, 43036.0, 8950.597223125105, 9466.574004169692, 9552.761180970532, 9594.328397012421, 9749.415035097632, 10714.250002500063, 10848.566057357933, 10920.180986426209, 10965.50655220533, 10981.780364392827, 10242.6415075472, 10311.22665800083, 10414.062734353642, 10771.075026997087, 10795.892041079489, 9712.660056897974, 10025.849612255675, 10065.748356291151, 10176.338537995303, 10358.326708763907, 7901.179711626088, 9438.764030899283, 9450.716478505656, 9779.168770654289, 10368.0, 8804.823903521765, 8871.822563548822, 9037.0, 9104.908950910407, 9329.72010839676, 8404.20160084791, 8966.641334346554, 9043.231325337158, 9211.355205135844, 9374.718758437259], "unit": "score", "name": "yui.html", "value": 5964.052020517347}], "name": "dromaeo_css", "value": 6639.046473408009}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 107.0, 109.0, 110.0, 111.0, 109.0, 110.0, 105.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 151.0, 165.0, 136.0, 156.0, 152.0, 131.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 160.0, 163.0, 162.0, 160.0, 168.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 94.0, 94.0, 72.0, 72.0, 75.0, 130.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 96.0, 96.0, 96.0, 144.0, 95.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 58.0, 57.0, 56.0, 57.0, 56.0, 56.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 66.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 84.0, 90.0, 83.0, 82.0, 83.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 115.0, 129.0, 114.0, 114.0, 114.0, 124.0, 117.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [144.0, 143.0, 144.0, 143.0, 144.0, 137.0, 148.0, 144.0, 149.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 66.0, 69.0, 66.0, 70.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1506.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [189.14318138831095], "unit": "score", "name": "DeltaBlue", "value": 349.565866}, {"lowerIsBetter": false, "replicates": [275.2546105147261], "unit": "score", "name": "Encrypt", "value": 967.0355730000003}, {"lowerIsBetter": false, "replicates": [5296.2962962962965], "unit": "score", "name": "Decrypt", "value": 50.25795104895107}, {"lowerIsBetter": false, "replicates": [1120.9406494960806], "unit": "score", "name": "RayTrace", "value": 660.1500269730271}, {"lowerIsBetter": false, "replicates": [771.604938271605], "unit": "score", "name": "Earley", "value": 863.7360479999996}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [43127.65957446808], "unit": "score", "name": "RegExp", "value": 21.122987173162304}, {"lowerIsBetter": false, "replicates": [946.969696969697], "unit": "score", "name": "Splay", "value": 86.05449600000004}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19115.55788069793}]} 19:12:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19115.56"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1506.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6639.05"}}} 19:12:42 INFO - Return code: 0 19:12:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:12:42 INFO - # TBPL SUCCESS # 19:12:42 INFO - Running post-action listener: _resource_record_post_action 19:12:42 INFO - Running post-run listener: _resource_record_post_run 19:12:43 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 24576; Write bytes: 548499456; Read time: 656; Write time: 1283236 19:12:43 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 236339200; Read time: 0; Write time: 730604 19:12:43 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 24576; Write bytes: 312098816; Read time: 656; Write time: 552600 19:12:43 INFO - Running post-run listener: _upload_blobber_files 19:12:43 INFO - Blob upload gear active. 19:12:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:12:43 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:12:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:12:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:12:44 INFO - (blobuploader) - INFO - Open directory for files ... 19:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:12:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:45 INFO - (blobuploader) - INFO - Done attempting. 19:12:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:12:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:46 INFO - (blobuploader) - INFO - Done attempting. 19:12:46 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:46 INFO - Return code: 0 19:12:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:12:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:12:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa98f21be72cd696165b6eb20b96bad06f78903d9527d8018beeb3f460f82ad8afbea8b6ef9c3a7e02c6758aaa2fb0f50138c502b15a175177a58d814ce30f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6876506e5855fc0d81ff0e849d892f47b5fe8ebee38650b33a5fbada0c13c57c9978b360f1208f2f3c4aa511a3ab6c4fcd764af5dcf77903b38176386a7edc11"} 19:12:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:12:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:12:46 INFO - Contents: 19:12:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa98f21be72cd696165b6eb20b96bad06f78903d9527d8018beeb3f460f82ad8afbea8b6ef9c3a7e02c6758aaa2fb0f50138c502b15a175177a58d814ce30f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6876506e5855fc0d81ff0e849d892f47b5fe8ebee38650b33a5fbada0c13c57c9978b360f1208f2f3c4aa511a3ab6c4fcd764af5dcf77903b38176386a7edc11"} 19:12:46 INFO - Running post-run listener: copy_logs_to_upload_dir 19:12:46 INFO - Copying logs to upload dir... 19:12:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:12:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.681476 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-25 19:12:46.315198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 19:12:46.318592) ========= 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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa98f21be72cd696165b6eb20b96bad06f78903d9527d8018beeb3f460f82ad8afbea8b6ef9c3a7e02c6758aaa2fb0f50138c502b15a175177a58d814ce30f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6876506e5855fc0d81ff0e849d892f47b5fe8ebee38650b33a5fbada0c13c57c9978b360f1208f2f3c4aa511a3ab6c4fcd764af5dcf77903b38176386a7edc11"} build_url:https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/RM8vidEoST67ux0oxRkYMg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa98f21be72cd696165b6eb20b96bad06f78903d9527d8018beeb3f460f82ad8afbea8b6ef9c3a7e02c6758aaa2fb0f50138c502b15a175177a58d814ce30f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6876506e5855fc0d81ff0e849d892f47b5fe8ebee38650b33a5fbada0c13c57c9978b360f1208f2f3c4aa511a3ab6c4fcd764af5dcf77903b38176386a7edc11"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 19:12:46.343173) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:12:46.343552) ========= 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=af724c981e2a0f424dbabf99000001e7-1453771832.177967-1508420964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 19:12:46.427922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 19:12:46.428233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 19:12:46.428497) ========= ========= Total master_lag: 0.23 =========