builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1452732444.59 results: success (0) buildid: 20160113140011 builduid: c8432dcb4711438abd31ebe79bdb9c13 revision: ad1f85f172b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.590375) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.590773) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.591051) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006659 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.616875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.617186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.641201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.641468) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.698789) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.699047) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.699381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.699646) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 16:47:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.1M=0s 2016-01-13 16:47:25 (66.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092050 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.807482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.807759) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022790 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:24.857524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 16:47:24.857828) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad1f85f172b7 --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 ad1f85f172b7 --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=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 16:47:25,272 Setting DEBUG logging. 2016-01-13 16:47:25,272 attempt 1/10 2016-01-13 16:47:25,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad1f85f172b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 16:47:26,110 unpacking tar archive at: mozilla-central-ad1f85f172b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.170936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 16:47:26.042055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:26.042375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:26.049337) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:26.049611) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 16:47:26.050025) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 16:47:26.050318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:47:26 INFO - MultiFileLogger online at 20160113 16:47:26 in /builds/slave/test-pgo 16:47:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:47:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:47:26 INFO - {'append_to_log': False, 16:47:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:47:26 INFO - 'blob_upload_branch': 'Firefox', 16:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:47:26 INFO - 'branch': 'Firefox', 16:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:47:26 INFO - 'config_files': ('talos/linux_config.py',), 16:47:26 INFO - 'default_actions': ('clobber', 16:47:26 INFO - 'read-buildbot-config', 16:47:26 INFO - 'download-and-extract', 16:47:26 INFO - 'populate-webroot', 16:47:26 INFO - 'create-virtualenv', 16:47:26 INFO - 'install', 16:47:26 INFO - 'run-tests'), 16:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:47:26 INFO - 'download_minidump_stackwalk': True, 16:47:26 INFO - 'download_symbols': 'ondemand', 16:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:47:26 INFO - 'installer_path': 'installer.exe', 16:47:26 INFO - 'log_level': 'info', 16:47:26 INFO - 'log_name': 'talos', 16:47:26 INFO - 'log_to_console': True, 16:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:47:26 INFO - 'opt_config_files': (), 16:47:26 INFO - 'pip_index': False, 16:47:26 INFO - 'sps_profile': False, 16:47:26 INFO - 'sps_profile_interval': 0, 16:47:26 INFO - 'suite': 'dromaeojs-e10s', 16:47:26 INFO - 'system_bits': '32', 16:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:47:26 INFO - 'title': 'talos-linux64-ix-005', 16:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:47:26 INFO - 'use_talos_json': True, 16:47:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:47:26 INFO - 'work_dir': 'build'} 16:47:26 INFO - ##### 16:47:26 INFO - ##### Running clobber step. 16:47:26 INFO - ##### 16:47:26 INFO - Running pre-action listener: _resource_record_pre_action 16:47:26 INFO - Running main action method: clobber 16:47:26 INFO - rmtree: /builds/slave/test-pgo/build 16:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:47:27 INFO - Running post-action listener: _resource_record_post_action 16:47:27 INFO - ##### 16:47:27 INFO - ##### Running read-buildbot-config step. 16:47:27 INFO - ##### 16:47:27 INFO - Running pre-action listener: _resource_record_pre_action 16:47:27 INFO - Running main action method: read_buildbot_config 16:47:27 INFO - Using buildbot properties: 16:47:27 INFO - { 16:47:27 INFO - "project": "", 16:47:27 INFO - "product": "firefox", 16:47:27 INFO - "script_repo_revision": "production", 16:47:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:47:27 INFO - "repository": "", 16:47:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:47:27 INFO - "buildid": "20160113140011", 16:47:27 INFO - "stage_platform": "linux64-pgo", 16:47:27 INFO - "basedir": "/builds/slave/test-pgo", 16:47:27 INFO - "nightly_build": "True", 16:47:27 INFO - "buildnumber": 615, 16:47:27 INFO - "slavename": "talos-linux64-ix-005", 16:47:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:47:27 INFO - "platform": "ubuntu64_hw", 16:47:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:47:27 INFO - "branch": "mozilla-central", 16:47:27 INFO - "repo_path": "mozilla-central", 16:47:27 INFO - "revision": "ad1f85f172b7", 16:47:27 INFO - "pgo_build": "True", 16:47:27 INFO - "builduid": "c8432dcb4711438abd31ebe79bdb9c13", 16:47:27 INFO - "slavebuilddir": "test" 16:47:27 INFO - } 16:47:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:47:27 INFO - Running post-action listener: _resource_record_post_action 16:47:27 INFO - ##### 16:47:27 INFO - ##### Running download-and-extract step. 16:47:27 INFO - ##### 16:47:27 INFO - Running pre-action listener: _resource_record_pre_action 16:47:27 INFO - Running main action method: download_and_extract 16:47:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:47:27 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')]} 16:47:27 INFO - https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/test_packages.json 16:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/test_packages.json 16:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:47:29 INFO - Downloaded 1448 bytes. 16:47:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:47:29 INFO - Using the following test package requirements: 16:47:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:47:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:47:29 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:47:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'jsshell-linux-x86_64.zip'], 16:47:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:47:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:47:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:47:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:47:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:47:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:47:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:47:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:47: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')]} 16:47:29 INFO - https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:47:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:47:32 INFO - Downloaded 24028902 bytes. 16:47:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:47:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:47:33 INFO - Return code: 0 16:47:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:47:33 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')]} 16:47:33 INFO - https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:47:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:47:36 INFO - Downloaded 24028902 bytes. 16:47:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:47:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:47:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:47:37 INFO - Return code: 0 16:47:37 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')]} 16:47:37 INFO - https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:47:39 INFO - Downloaded 11132279 bytes. 16:47:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:47:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:47:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:47:39 INFO - Return code: 0 16:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:39 INFO - https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:47:44 INFO - Downloaded 55865184 bytes. 16:47:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:47:44 INFO - mkdir: /builds/slave/test-pgo/properties 16:47:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:47:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:47:44 INFO - Contents: 16:47:44 INFO - build_url:https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:47:44 INFO - Running post-action listener: _resource_record_post_action 16:47:44 INFO - Running post-action listener: set_extra_try_arguments 16:47:44 INFO - ##### 16:47:44 INFO - ##### Running populate-webroot step. 16:47:44 INFO - ##### 16:47:44 INFO - Running pre-action listener: _resource_record_pre_action 16:47:44 INFO - Running main action method: populate_webroot 16:47:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:47:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:47:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:47:44 INFO - '--tppagecycles', 16:47:44 INFO - '7'], 16:47:44 INFO - 'tests': ['tsvgm']}}, 16:47:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:47:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:47:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:47:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:47:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'tests': ['damp', 'tps']}, 16:47:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['damp', 'tps']}, 16:47:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:47:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:47:44 INFO - 'other': {'tests': ['a11yr', 16:47:44 INFO - 'ts_paint', 16:47:44 INFO - 'tpaint', 16:47:44 INFO - 'sessionrestore', 16:47:44 INFO - 'sessionrestore_no_auto_restore']}, 16:47:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['a11yr', 16:47:44 INFO - 'ts_paint', 16:47:44 INFO - 'tpaint', 16:47:44 INFO - 'sessionrestore', 16:47:44 INFO - 'sessionrestore_no_auto_restore']}, 16:47:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['a11yr', 16:47:44 INFO - 'ts_paint', 16:47:44 INFO - 'tpaint', 16:47:44 INFO - 'sessionrestore', 16:47:44 INFO - 'sessionrestore_no_auto_restore']}, 16:47:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['a11yr', 16:47:44 INFO - 'ts_paint', 16:47:44 INFO - 'tpaint', 16:47:44 INFO - 'sessionrestore', 16:47:44 INFO - 'sessionrestore_no_auto_restore']}, 16:47:44 INFO - 'other_l64': {'tests': ['a11yr', 16:47:44 INFO - 'ts_paint', 16:47:44 INFO - 'tpaint', 16:47:44 INFO - 'sessionrestore', 16:47:44 INFO - 'sessionrestore_no_auto_restore']}, 16:47:44 INFO - 'other_nol64': {'tests': ['a11yr', 16:47:44 INFO - 'ts_paint', 16:47:44 INFO - 'tpaint', 16:47:44 INFO - 'sessionrestore', 16:47:44 INFO - 'sessionrestore_no_auto_restore']}, 16:47:44 INFO - 'svgr': {'tests': ['tsvgx', 16:47:44 INFO - 'tsvgr_opacity', 16:47:44 INFO - 'tart', 16:47:44 INFO - 'tscrollx', 16:47:44 INFO - 'cart']}, 16:47:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['tsvgx', 16:47:44 INFO - 'tsvgr_opacity', 16:47:44 INFO - 'tart', 16:47:44 INFO - 'tscrollx', 16:47:44 INFO - 'cart']}, 16:47:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'tests': ['tp5o']}, 16:47:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'talos_options': ['--e10s'], 16:47:44 INFO - 'tests': ['tp5o']}, 16:47:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'talos_options': ['--xperf_path', 16:47:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:44 INFO - 'tests': ['tp5n']}, 16:47:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:44 INFO - 'talos_options': ['--e10s', 16:47:44 INFO - '--xperf_path', 16:47:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:44 INFO - 'tests': ['tp5n']}}, 16:47:44 INFO - 'talos.zip': {'path': '', 16:47:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:47:44 INFO - Running post-action listener: _resource_record_post_action 16:47:44 INFO - ##### 16:47:44 INFO - ##### Running create-virtualenv step. 16:47:44 INFO - ##### 16:47:44 INFO - Running pre-action listener: _resource_record_pre_action 16:47:44 INFO - Running main action method: create_virtualenv 16:47:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:47:44 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 16:47:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:47:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:47:44 INFO - Using real prefix '/usr' 16:47:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:47:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:46 INFO - Installing pip.................done. 16:47:46 INFO - Return code: 0 16:47:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:47:46 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')]} 16:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:46 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')]} 16:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:47:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:47:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:47:46 INFO - Using env: {'DISPLAY': ':0', 16:47:46 INFO - 'HOME': '/home/cltbld', 16:47:46 INFO - 'LANG': 'en_US.UTF-8', 16:47:46 INFO - 'LANGUAGE': 'en_US:en', 16:47:46 INFO - 'LOGNAME': 'cltbld', 16:47:46 INFO - 'MAIL': '/var/mail/cltbld', 16:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:46 INFO - 'MOZ_NO_REMOTE': '1', 16:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:46 INFO - 'NO_EM_RESTART': '1', 16:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:46 INFO - 'SHELL': '/bin/bash', 16:47:46 INFO - 'SHLVL': '1', 16:47:46 INFO - 'TERM': 'linux', 16:47:46 INFO - 'TMOUT': '86400', 16:47:46 INFO - 'USER': 'cltbld', 16:47:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:46 INFO - '_': '/tools/buildbot/bin/python'} 16:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:47 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 16:47:47 INFO - Cleaning up... 16:47:47 INFO - Return code: 0 16:47:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:47:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:47:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:47:47 INFO - Using env: {'DISPLAY': ':0', 16:47:47 INFO - 'HOME': '/home/cltbld', 16:47:47 INFO - 'LANG': 'en_US.UTF-8', 16:47:47 INFO - 'LANGUAGE': 'en_US:en', 16:47:47 INFO - 'LOGNAME': 'cltbld', 16:47:47 INFO - 'MAIL': '/var/mail/cltbld', 16:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:47 INFO - 'MOZ_NO_REMOTE': '1', 16:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:47 INFO - 'NO_EM_RESTART': '1', 16:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:47 INFO - 'SHELL': '/bin/bash', 16:47:47 INFO - 'SHLVL': '1', 16:47:47 INFO - 'TERM': 'linux', 16:47:47 INFO - 'TMOUT': '86400', 16:47:47 INFO - 'USER': 'cltbld', 16:47:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:47 INFO - '_': '/tools/buildbot/bin/python'} 16:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:47 INFO - Downloading/unpacking psutil>=0.7.1 16:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:47:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:47:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:49 INFO - Installing collected packages: psutil 16:47:49 INFO - Running setup.py install for psutil 16:47:49 INFO - building 'psutil._psutil_linux' extension 16:47:49 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 16:47:49 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 16:47:49 INFO - building 'psutil._psutil_posix' extension 16:47:49 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 16:47:49 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 16:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:49 INFO - Successfully installed psutil 16:47:49 INFO - Cleaning up... 16:47:49 INFO - Return code: 0 16:47:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:47:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:47:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:47:49 INFO - Using env: {'DISPLAY': ':0', 16:47:49 INFO - 'HOME': '/home/cltbld', 16:47:49 INFO - 'LANG': 'en_US.UTF-8', 16:47:49 INFO - 'LANGUAGE': 'en_US:en', 16:47:49 INFO - 'LOGNAME': 'cltbld', 16:47:49 INFO - 'MAIL': '/var/mail/cltbld', 16:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:49 INFO - 'MOZ_NO_REMOTE': '1', 16:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:49 INFO - 'NO_EM_RESTART': '1', 16:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:49 INFO - 'SHELL': '/bin/bash', 16:47:49 INFO - 'SHLVL': '1', 16:47:49 INFO - 'TERM': 'linux', 16:47:49 INFO - 'TMOUT': '86400', 16:47:49 INFO - 'USER': 'cltbld', 16:47:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:49 INFO - '_': '/tools/buildbot/bin/python'} 16:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:47:49 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 16:47:49 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 16:47:49 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 16:47:49 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 16:47:49 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 16:47:49 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 16:47:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:47:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:47:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:47:51 INFO - Installing collected packages: mozsystemmonitor 16:47:51 INFO - Running setup.py install for mozsystemmonitor 16:47:51 INFO - Successfully installed mozsystemmonitor 16:47:51 INFO - Cleaning up... 16:47:51 INFO - Return code: 0 16:47:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:47: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')]} 16:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:47:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:47:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:47:51 INFO - Using env: {'DISPLAY': ':0', 16:47:51 INFO - 'HOME': '/home/cltbld', 16:47:51 INFO - 'LANG': 'en_US.UTF-8', 16:47:51 INFO - 'LANGUAGE': 'en_US:en', 16:47:51 INFO - 'LOGNAME': 'cltbld', 16:47:51 INFO - 'MAIL': '/var/mail/cltbld', 16:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:51 INFO - 'MOZ_NO_REMOTE': '1', 16:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:51 INFO - 'NO_EM_RESTART': '1', 16:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:51 INFO - 'SHELL': '/bin/bash', 16:47:51 INFO - 'SHLVL': '1', 16:47:51 INFO - 'TERM': 'linux', 16:47:51 INFO - 'TMOUT': '86400', 16:47:51 INFO - 'USER': 'cltbld', 16:47:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:51 INFO - '_': '/tools/buildbot/bin/python'} 16:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:53 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:47:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:47:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:54 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 16:47:54 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 16:47:54 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 16:47:54 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 16:47:54 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 16:47:54 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 16:47:54 INFO - Downloading docopt-0.6.1.tar.gz 16:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:54 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:54 INFO - Running setup.py install for blobuploader 16:47:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:47:54 INFO - Running setup.py install for requests 16:47:55 INFO - Running setup.py install for docopt 16:47:55 INFO - Successfully installed blobuploader requests docopt 16:47:55 INFO - Cleaning up... 16:47:55 INFO - Return code: 0 16:47:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:47:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:55 INFO - Using env: {'DISPLAY': ':0', 16:47:55 INFO - 'HOME': '/home/cltbld', 16:47:55 INFO - 'LANG': 'en_US.UTF-8', 16:47:55 INFO - 'LANGUAGE': 'en_US:en', 16:47:55 INFO - 'LOGNAME': 'cltbld', 16:47:55 INFO - 'MAIL': '/var/mail/cltbld', 16:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:55 INFO - 'MOZ_NO_REMOTE': '1', 16:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:55 INFO - 'NO_EM_RESTART': '1', 16:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:55 INFO - 'SHELL': '/bin/bash', 16:47:55 INFO - 'SHLVL': '1', 16:47:55 INFO - 'TERM': 'linux', 16:47:55 INFO - 'TMOUT': '86400', 16:47:55 INFO - 'USER': 'cltbld', 16:47:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:55 INFO - '_': '/tools/buildbot/bin/python'} 16:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:55 INFO - Running setup.py (path:/tmp/pip-sgcb5D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:55 INFO - Running setup.py (path:/tmp/pip-WzFkUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:55 INFO - Running setup.py (path:/tmp/pip-NmnlF2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:55 INFO - Running setup.py (path:/tmp/pip-7Ql0NZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:55 INFO - Running setup.py (path:/tmp/pip-R2Um6t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:55 INFO - Running setup.py (path:/tmp/pip-R2X0sf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:55 INFO - Running setup.py (path:/tmp/pip-QBMu3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:55 INFO - Running setup.py (path:/tmp/pip-DWtmUG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:55 INFO - Running setup.py (path:/tmp/pip-odikHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:56 INFO - Running setup.py (path:/tmp/pip-vzppwI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:56 INFO - Running setup.py (path:/tmp/pip-1bsK6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:56 INFO - Running setup.py (path:/tmp/pip-FZpGvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:56 INFO - Running setup.py (path:/tmp/pip-LZHXqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:56 INFO - Running setup.py (path:/tmp/pip-75u9m7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:56 INFO - Running setup.py (path:/tmp/pip-iUKwpN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:56 INFO - Running setup.py (path:/tmp/pip-C2eBoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:56 INFO - Running setup.py (path:/tmp/pip-EygN9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:56 INFO - Running setup.py install for manifestparser 16:47:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:47:56 INFO - Running setup.py install for mozcrash 16:47:56 INFO - Running setup.py install for mozdebug 16:47:56 INFO - Running setup.py install for mozdevice 16:47:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Running setup.py install for mozfile 16:47:57 INFO - Running setup.py install for mozhttpd 16:47:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Running setup.py install for mozinfo 16:47:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Running setup.py install for mozInstall 16:47:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Running setup.py install for mozleak 16:47:57 INFO - Running setup.py install for mozlog 16:47:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Running setup.py install for moznetwork 16:47:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Running setup.py install for mozprocess 16:47:57 INFO - Running setup.py install for mozprofile 16:47:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:47:57 INFO - Running setup.py install for mozrunner 16:47:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:47:58 INFO - Running setup.py install for mozscreenshot 16:47:58 INFO - Running setup.py install for moztest 16:47:58 INFO - Running setup.py install for mozversion 16:47:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:47:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:58 INFO - Cleaning up... 16:47:58 INFO - Return code: 0 16:47:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47:58 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')]} 16:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:58 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')]} 16:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:47:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:47:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:58 INFO - Using env: {'DISPLAY': ':0', 16:47:58 INFO - 'HOME': '/home/cltbld', 16:47:58 INFO - 'LANG': 'en_US.UTF-8', 16:47:58 INFO - 'LANGUAGE': 'en_US:en', 16:47:58 INFO - 'LOGNAME': 'cltbld', 16:47:58 INFO - 'MAIL': '/var/mail/cltbld', 16:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:58 INFO - 'MOZ_NO_REMOTE': '1', 16:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:58 INFO - 'NO_EM_RESTART': '1', 16:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:58 INFO - 'SHELL': '/bin/bash', 16:47:58 INFO - 'SHLVL': '1', 16:47:58 INFO - 'TERM': 'linux', 16:47:58 INFO - 'TMOUT': '86400', 16:47:58 INFO - 'USER': 'cltbld', 16:47:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:58 INFO - '_': '/tools/buildbot/bin/python'} 16:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:58 INFO - Running setup.py (path:/tmp/pip-FzQYvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:58 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)) 16:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:58 INFO - Running setup.py (path:/tmp/pip-aKfyJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:58 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)) 16:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:58 INFO - Running setup.py (path:/tmp/pip-avDSBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:58 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)) 16:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:58 INFO - Running setup.py (path:/tmp/pip-hvX0G8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:58 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)) 16:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:58 INFO - Running setup.py (path:/tmp/pip-_O7ek1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:58 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)) 16:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:58 INFO - Running setup.py (path:/tmp/pip-nvvrMW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:59 INFO - Running setup.py (path:/tmp/pip-YNJQ96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:59 INFO - Running setup.py (path:/tmp/pip-chdoTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:59 INFO - Running setup.py (path:/tmp/pip-BSKg3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:59 INFO - Running setup.py (path:/tmp/pip-yPe04r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:59 INFO - Running setup.py (path:/tmp/pip-V__qZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:59 INFO - Running setup.py (path:/tmp/pip-5Q_o_c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:59 INFO - Running setup.py (path:/tmp/pip-kSwFNQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:59 INFO - Running setup.py (path:/tmp/pip-ufqoLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:59 INFO - Running setup.py (path:/tmp/pip-0xf6JY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:59 INFO - Running setup.py (path:/tmp/pip-Is0x7W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:59 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)) 16:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:59 INFO - Running setup.py (path:/tmp/pip-1oY5Ep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:59 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)) 16:47:59 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)) 16:47:59 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)) 16:47:59 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)) 16:47:59 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)) 16:47:59 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)) 16:47:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:01 INFO - Downloading blessings-1.5.1.tar.gz 16:48:01 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:48:01 INFO - Installing collected packages: blessings 16:48:01 INFO - Running setup.py install for blessings 16:48:01 INFO - Successfully installed blessings 16:48:01 INFO - Cleaning up... 16:48:01 INFO - Return code: 0 16:48:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:48:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:48:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:48:02 INFO - Reading from file tmpfile_stdout 16:48:02 INFO - Current package versions: 16:48:02 INFO - argparse == 1.2.1 16:48:02 INFO - blessings == 1.5.1 16:48:02 INFO - blobuploader == 1.2.4 16:48:02 INFO - docopt == 0.6.1 16:48:02 INFO - manifestparser == 1.1 16:48:02 INFO - mozInstall == 1.12 16:48:02 INFO - mozcrash == 0.16 16:48:02 INFO - mozdebug == 0.1 16:48:02 INFO - mozdevice == 0.48 16:48:02 INFO - mozfile == 1.2 16:48:02 INFO - mozhttpd == 0.7 16:48:02 INFO - mozinfo == 0.9 16:48:02 INFO - mozleak == 0.1 16:48:02 INFO - mozlog == 3.1 16:48:02 INFO - moznetwork == 0.27 16:48:02 INFO - mozprocess == 0.22 16:48:02 INFO - mozprofile == 0.28 16:48:02 INFO - mozrunner == 6.11 16:48:02 INFO - mozscreenshot == 0.1 16:48:02 INFO - mozsystemmonitor == 0.0 16:48:02 INFO - moztest == 0.7 16:48:02 INFO - mozversion == 1.4 16:48:02 INFO - psutil == 3.1.1 16:48:02 INFO - requests == 1.2.3 16:48:02 INFO - wsgiref == 0.1.2 16:48:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:48:02 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')]} 16:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:02 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')]} 16:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:48:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:48:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:48:02 INFO - Using env: {'DISPLAY': ':0', 16:48:02 INFO - 'HOME': '/home/cltbld', 16:48:02 INFO - 'LANG': 'en_US.UTF-8', 16:48:02 INFO - 'LANGUAGE': 'en_US:en', 16:48:02 INFO - 'LOGNAME': 'cltbld', 16:48:02 INFO - 'MAIL': '/var/mail/cltbld', 16:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:02 INFO - 'MOZ_NO_REMOTE': '1', 16:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:02 INFO - 'NO_EM_RESTART': '1', 16:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 16:48:02 INFO - 'SHELL': '/bin/bash', 16:48:02 INFO - 'SHLVL': '1', 16:48:02 INFO - 'TERM': 'linux', 16:48:02 INFO - 'TMOUT': '86400', 16:48:02 INFO - 'USER': 'cltbld', 16:48:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:02 INFO - '_': '/tools/buildbot/bin/python'} 16:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 INFO - Cleaning up... 16:48:02 INFO - Return code: 0 16:48:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:48:02 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')]} 16:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:02 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')]} 16:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:48:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:48:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:48:02 INFO - Using env: {'DISPLAY': ':0', 16:48:02 INFO - 'HOME': '/home/cltbld', 16:48:02 INFO - 'LANG': 'en_US.UTF-8', 16:48:02 INFO - 'LANGUAGE': 'en_US:en', 16:48:02 INFO - 'LOGNAME': 'cltbld', 16:48:02 INFO - 'MAIL': '/var/mail/cltbld', 16:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:02 INFO - 'MOZ_NO_REMOTE': '1', 16:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:02 INFO - 'NO_EM_RESTART': '1', 16:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 16:48:02 INFO - 'SHELL': '/bin/bash', 16:48:02 INFO - 'SHLVL': '1', 16:48:02 INFO - 'TERM': 'linux', 16:48:02 INFO - 'TMOUT': '86400', 16:48:02 INFO - 'USER': 'cltbld', 16:48:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:02 INFO - '_': '/tools/buildbot/bin/python'} 16:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:02 INFO - Downloading/unpacking jsonschema 16:48:02 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 16:48:02 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 16:48:02 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 16:48:02 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 16:48:02 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 16:48:02 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 16:48:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:48:04 INFO - Downloading/unpacking functools32 (from jsonschema) 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48:04 INFO - Downloading functools32-3.2.3-2.tar.gz 16:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:48:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:48:04 INFO - warning: no files found matching '*.txt' 16:48:04 INFO - no previously-included directories found matching 'build' 16:48:04 INFO - no previously-included directories found matching 'dist' 16:48:04 INFO - no previously-included directories found matching '.git*' 16:48:04 INFO - Installing collected packages: jsonschema, functools32 16:48:04 INFO - Running setup.py install for functools32 16:48:04 INFO - warning: no files found matching '*.txt' 16:48:04 INFO - no previously-included directories found matching 'build' 16:48:04 INFO - no previously-included directories found matching 'dist' 16:48:04 INFO - no previously-included directories found matching '.git*' 16:48:04 INFO - Successfully installed jsonschema functools32 16:48:04 INFO - Cleaning up... 16:48:04 INFO - Return code: 0 16:48:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:48: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')]} 16:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48: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')]} 16:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02a8d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', '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 16:48:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:48:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:48:04 INFO - Using env: {'DISPLAY': ':0', 16:48:04 INFO - 'HOME': '/home/cltbld', 16:48:04 INFO - 'LANG': 'en_US.UTF-8', 16:48:04 INFO - 'LANGUAGE': 'en_US:en', 16:48:04 INFO - 'LOGNAME': 'cltbld', 16:48:04 INFO - 'MAIL': '/var/mail/cltbld', 16:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:04 INFO - 'MOZ_NO_REMOTE': '1', 16:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:04 INFO - 'NO_EM_RESTART': '1', 16:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:48:04 INFO - 'SHELL': '/bin/bash', 16:48:04 INFO - 'SHLVL': '1', 16:48:04 INFO - 'TERM': 'linux', 16:48:04 INFO - 'TMOUT': '86400', 16:48:04 INFO - 'USER': 'cltbld', 16:48:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:04 INFO - '_': '/tools/buildbot/bin/python'} 16:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:05 INFO - Downloading/unpacking flake8 16:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:48:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:48:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:48:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:48:07 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 16:48:07 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 16:48:07 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 16:48:07 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 16:48:07 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 16:48:07 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 16:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:48:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:48:07 INFO - no previously-included directories found matching 'docs/_build' 16:48:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:48:07 INFO - Running setup.py install for pep8 16:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:48:07 INFO - no previously-included directories found matching 'docs/_build' 16:48:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:48:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:48:07 INFO - Cleaning up... 16:48:07 INFO - Return code: 0 16:48:07 INFO - Running post-action listener: _resource_record_post_action 16:48:07 INFO - Running post-action listener: _start_resource_monitoring 16:48:07 INFO - Starting resource monitoring. 16:48:07 INFO - ##### 16:48:07 INFO - ##### Running install step. 16:48:07 INFO - ##### 16:48:07 INFO - Running pre-action listener: _resource_record_pre_action 16:48:07 INFO - Running main action method: install 16:48:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:48:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:48:07 INFO - Reading from file tmpfile_stdout 16:48:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:48:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:48:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:48:07 INFO - Reading from file tmpfile_stdout 16:48:07 INFO - Output received: 16:48:07 INFO - Usage: mozinstall [options] installer 16:48:07 INFO - Options: 16:48:07 INFO - -h, --help show this help message and exit 16:48:07 INFO - -d DEST, --destination=DEST 16:48:07 INFO - Directory to install application into. [default: 16:48:07 INFO - "/builds/slave/test-pgo"] 16:48:07 INFO - --app=APP Application being installed. [default: firefox] 16:48:07 INFO - mkdir: /builds/slave/test-pgo/build/application 16:48:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:48:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:48:23 INFO - Reading from file tmpfile_stdout 16:48:23 INFO - Output received: 16:48:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:48:24 INFO - Running post-action listener: _resource_record_post_action 16:48:24 INFO - ##### 16:48:24 INFO - ##### Running run-tests step. 16:48:24 INFO - ##### 16:48:24 INFO - Running pre-action listener: _resource_record_pre_action 16:48:24 INFO - Running main action method: run_tests 16:48:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:48:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:48:24 INFO - Python 2.7.3 16:48:24 INFO - Return code: 0 16:48:24 INFO - grabbing minidump binary from tooltool 16:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:24 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 0x1c46840>, '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 0x1bb36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:48:24 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 16:48:24 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 16:48:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:48:24 INFO - Return code: 0 16:48:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:48:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:48:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:48:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:48:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:48:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:48:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:48:25 INFO - Return code: 0 16:48:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:48:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:48:25 INFO - Using env: {'DISPLAY': ':0', 16:48:25 INFO - 'HOME': '/home/cltbld', 16:48:25 INFO - 'LANG': 'en_US.UTF-8', 16:48:25 INFO - 'LANGUAGE': 'en_US:en', 16:48:25 INFO - 'LOGNAME': 'cltbld', 16:48:25 INFO - 'MAIL': '/var/mail/cltbld', 16:48:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:48:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:25 INFO - 'MOZ_NO_REMOTE': '1', 16:48:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:25 INFO - 'NO_EM_RESTART': '1', 16:48:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:48:25 INFO - 'PWD': '/builds/slave/test-pgo', 16:48:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:48:25 INFO - 'SHELL': '/bin/bash', 16:48:25 INFO - 'SHLVL': '1', 16:48:25 INFO - 'TERM': 'linux', 16:48:25 INFO - 'TMOUT': '86400', 16:48:25 INFO - 'USER': 'cltbld', 16:48:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792', 16:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:25 INFO - '_': '/tools/buildbot/bin/python'} 16:48:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:48:25 INFO - mozversion application_buildid: 20160113140011 16:48:25 INFO - mozversion application_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 16:48:25 INFO - mozversion application_display_name: Nightly 16:48:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:48:25 INFO - mozversion application_name: Firefox 16:48:25 INFO - mozversion application_remotingname: firefox 16:48:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:48:25 INFO - mozversion application_vendor: Mozilla 16:48:25 INFO - mozversion application_version: 46.0a1 16:48:25 INFO - mozversion platform_buildid: 20160113140011 16:48:25 INFO - mozversion platform_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 16:48:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:48:25 INFO - mozversion platform_version: 46.0a1 16:48:25 INFO - using testdate: 1452732505 16:48:25 INFO - actual date: 1452732505 16:48:25 INFO - starting webserver on 'localhost:53553' 16:48:25 INFO - SUITE-START | Running 3 tests 16:48:25 INFO - TEST-START | dromaeo_css 16:48:25 INFO - operating with platform_type : linux_ 16:48:25 INFO - Initialising browser for dromaeo_css test... 16:48:25 INFO - TEST-INFO | started process 6806 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUGAUfa/profile http://localhost:53553/getInfo.html) 16:48:28 INFO - PROCESS | 6806 | 16:48:28 INFO - PROCESS | 6806 | (process:6889): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:48:29 INFO - PROCESS | 6806 | __metrics Screen width/height:1600/1200 16:48:29 INFO - PROCESS | 6806 | colorDepth:24 16:48:29 INFO - PROCESS | 6806 | Browser inner width/height: 1024/670 16:48:29 INFO - PROCESS | 6806 | __metrics 16:48:29 INFO - PROCESS | 6806 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:48:30 INFO - TEST-INFO | 6806: exit 0 16:48:30 INFO - Browser initialized. 16:48:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:48:30 INFO - TEST-INFO | started process 6938 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUGAUfa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:31 INFO - PROCESS | 6938 | 16:48:31 INFO - PROCESS | 6938 | (process:6994): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:48:42 INFO - PROCESS | 6938 | RSS: Main: 150818816 16:48:42 INFO - PROCESS | 6938 | 16:49:32 INFO - PROCESS | 6938 | 1452732572044 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] 16:51:40 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:53553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53553/tests/dromaeo/cssquery-ext.html) 16:51:41 INFO - PROCESS | 6938 | RSS: Main: 155049984 16:51:41 INFO - PROCESS | 6938 | 16:54:43 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:53553/tests/dromaeo/cssquery-ext.html (next: http://localhost:53553/tests/dromaeo/cssquery-jquery.html) 16:54:44 INFO - PROCESS | 6938 | RSS: Main: 152887296 16:54:44 INFO - PROCESS | 6938 | 16:57:46 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:53553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53553/tests/dromaeo/cssquery-mootools.html) 16:57:46 INFO - PROCESS | 6938 | RSS: Main: 152150016 16:57:46 INFO - PROCESS | 6938 | 17:00:48 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:53553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53553/tests/dromaeo/cssquery-prototype.html) 17:00:49 INFO - PROCESS | 6938 | RSS: Main: 149807104 17:00:49 INFO - PROCESS | 6938 | 17:03:51 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:53553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53553/tests/dromaeo/cssquery-yui.html) 17:03:52 INFO - PROCESS | 6938 | RSS: Main: 150749184 17:03:52 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | Cycle 1(1): loaded http://localhost:53553/tests/dromaeo/cssquery-yui.html (next: http://localhost:53553/tests/dromaeo/cssquery-dojo.html) 17:06:54 INFO - PROCESS | 6938 | RSS: Main: 153907200 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | __start_tp_report 17:06:54 INFO - PROCESS | 6938 | _x_x_mozilla_page_load 17:06:54 INFO - PROCESS | 6938 | _x_x_mozilla_page_load_details 17:06:54 INFO - PROCESS | 6938 | |i|pagename|runs| 17:06:54 INFO - PROCESS | 6938 | |0;dojo.html;3121.4225368306866;3140.4190224808412;3167.8732850685974;3170.0331398923327;3175.269687971768;5018.749062546867;5096.235564665298;5097.5157360050825;5112.974435127824;5162.741862906859;5094.057599344114;5102.209157580572;5108.974455127728;5110.7444627768555;5116.513931176532;4652.999605084906;4687.296905464191;4774.928376074345;4826.420829500465;4830.130576496229;4790.784414701347;4830.154722923492;4836.51634836517;4837.250226214942;4837.371141751567;925.4207627772917;4689.273162659776;4704.952950470502;4734.313524538957;4777.665563410563;4761.523847615245;4762.904531957669;4780.282957556359;4789.952100478986;4800.831970881002;4831.734254615994;4846.030793841211;4849.102915960559;4868.294097355899;4872.78072486739;4879.4876537963355;4902.509749025105;4943.406791185045;4958.429780575244;4992.051510213048;5506.174073888908;5519.724013799334;5551.306086739158;5561.77752889884;5572.804951826666;5361.544268737162;5588.832335029955;5621.353544342372;5643.068893632546;5672.659640421588;5159.638825282194;5201.479852014768;5230.764615592308;5246.554042906319;5286.916182182644;5593.804216852391;5601.271834661468;5609.719514024282;5612.270404847425;5626.662400255997;5356.8660783479945;5424.403315635277;5523.061079616475;5541.307336582927;5572.749226284827;5501.642393244426;5503.3120859892515;5544.002079625626;5544.390117087117;5579.581531385081;5468.316460442445;5487.067198576252;5493.368262649767;5503.981763373788;5536.972315138479;5377.7311134443125;5478.780848766005;5490.56075513958;5506.256655351556;5550;4286.057067445157;4293.5706429356815;4301.935470967938;4338.609525142752;4349.739015659071;3857.286402015636;3867.323218436762;3888.475055867478;3905.6094390560716;3907.8241479133508;5071.518205770446;5080.034793389244;5111.795528178831;5138.049460849755;5171;5571.4428557143965;5573.386927437979;5591.133374326986;5591.860203494945;5605;5171.224316352502;5182.637215394886;5189.714565698847;5194.220866869924;5226.764795584208;4637.791299391535;4709.62323014158;4749.050189962021;4788.880277993078;4840.927386089212;5688.63023903445;5695.458931401593;5724.856878577985;5735.827925162252;5744.684042377626;5469.042917489503;5570.777168913198;5588.441155884379;5605.943940560543;5657.2079908811975;5605.775768969195;5633.8591535211945;5688.033034384247;5713.485786279255;5758.942410575841;5436.592255580768;5483.341998960151;5484.91772623403;5496.615236933376;5498.45015498447;5465.562754979513;5485.670859748428;5552.444755524415;5571.693556854412;5607.971960140173;5429.5656347492895;5446.346438427414;5452.154915988028;5486.423925487926;5513.669179849222;5391.568674506108;5396.1905714143195;5424.457554244544;5439.211314359475;5445.564354851682;5229.686218826882;5295.682259064469;5307.01820163271;5323.148296272578;5353.732313384393;5419.05166595852;5458;5474.452554744494;5481.369642491165;5508.9724551376985;5333.280007199133;5361.571074313967;5382.650127741685;5402.405735369028;5445.537129343892 17:06:54 INFO - PROCESS | 6938 | |1;ext.html;479.46060681733053;504.9394072711275;515.8426679862641;527.4119356917037;538.558382126656;28102.43795124096;35352.46971295429;35768.46347304786;35876;35886.64113358866;38960.80519597398;39815.800920995425;39922.40116398249;39929.8003509982;40081;8290.91709082909;8436.915630843705;8504.872426913602;8506.617202225914;8520.78698032551;8249.958750206271;8318;8349.373796965221;8353.33173346131;8509.574521273911;8625.913740862605;8634.611442485104;8663.263622592087;8670.479771213715;8696.739097827043;8358.373122015842;8584.012838523557;8603.913960860405;8614.310855131574;8619.65521379144;8349.165083491664;8552.743417697478;8561.828763424697;8568.914310856873;8573.657053717843;39908;40243.7987810062;40357.15714114325;40382;40409.19181616351;3318.734501239895;3348.598168219805;3420.452727563578;3505.684488396031;3666.7249956253386;29415.411691766043;29739.553906691417;29861.25346866324;30411.391772164432;30748.692513074806;3359.3617212729746;3365.6466071062678;3371.5448414463976;3405.5743032120986;3423.400904841668;267280;267652;267747.6612616944;267875;268304;41953.790231048646;42410.57589424128;57890.4210957885;58017.41982580205;58027.70986145042;40377.39433908494;40474.797626011685;40503.392449113286;40659.796701016894;40952;14027.438902443788;14090.365933533016;14101.576952691436;14150.150990940576;14179.078359906573;11728.413579321;11743.236689615147;11757.353345566076;11761.529538818522;11787.115966302561;14187.361568729431;14563;14636.926815365856;14641.707165856624;14651.853481465261;5671.149327600893;5676.4323567642905;5716.79991200306;5719.48524632785;5724.398938111522;906.6826610686207;943.5895385507326;987.8123156600223;1008.8738907636546;1027.7944411117805;29138.417231655247;33082.50376244358;33502.664973350446;33610.327793444;33940.66059339424;1001.639409812467;1040.0119886108228;1076.978460430787;1094.1848322999417;1136.6419577832955;15299.158546280061;16675.24961376741;16957.915210424115;16969;16976.57558561021;375233;378475;380343;381080;382464;55291.72354138284;55472.72263638656;55493;55539.72230138904;55718;1317.2557505009831;1318.723068155679;1333.2533781082625;1340.9061365704501;1343.8454577723687;29551.704482954894;30402.239944001576;30930.845345773127;30931;31334.216644584067;46926;47708;47772;47859.5214047869;47882.5211747892;286287;286684;287979;288200;288811;33041.33917321688;42949.570504294556;43128.35307470328;43166.56833431625;43834.34248486339;39890.40164397594;40118.59881401266;40408.79795601003;40427;40942.38586421266;36128;36251;36373;36388.81805591061;37639.62360376361;36274.27451451009;36781;37203.44194837025;37269;37475.625243748305;35388.82305588559;35723.82138089293;36320.636793631726;36341.27317453689;36591.085222868576;30670;31708.84145579257;32934.670653293164;33347;33513.83243083769;25426.618600720634;25926.22221333363;27087.59368609433;27346.726532734418;27443.451130976868 17:06:54 INFO - PROCESS | 6938 | |2;jquery.html;361.57153772779253;361.64739379105373;361.65461983805466;364.9087728067983;366.7835976773703;15524.611884702874;16184.919075404621;16841.663166736656;17444.302227910885;17702.822971770278;10909.23635345526;11233.606823761149;16329.918350408261;16451.095189764557;16463.91768041161;4776.211925032374;5108.66793658411;5126.487351264881;5131.153359695646;5139.768710408022;4587.7017993830295;4978.377702787152;5111.84664460065;5114.897702045957;5126.077306084903;5108.131617625013;5314.043472175007;5333.679979201241;5521.972390138064;5543.750531226105;5226.529612334889;5268.1834315681135;5291.100512912775;5302.522772950434;5571.609987300891;5333.57331413486;5370.301860758115;5374.408815030343;5375;5385.865353366158;13574.45702171912;18007;18647.53381165468;18758;18922;1961.205711686755;2057.5267688431745;2072.637288474511;2083.510035872697;2294.4837411582425;9310.53447327631;9687.951560242223;10639.734006649818;12143.574974875924;12767.61697149087;1729.3601367493982;1784.580623553464;1855.5546668799525;1893.214316058834;1928.344362916601;55282.89434211334;55944.44055559433;56733.43266567323;57495;57547.13679294814;10247.59009639621;10272.794544109076;10277.588896444058;10303.433311167957;10345;13344.198533197894;13349.399277032557;13417.463301468028;13451.46194152223;13458.663533411744;7701.537907725442;7721.691132354756;7723.497972631761;7739.419543534144;7747.961260193776;7335.523190992569;7342;7412.703491860373;7425.591592462359;7468.775936721907;4433.955660443355;4448.221561226773;4495.43807024122;4534.79593418297;4550.158220729109;1810.7555480010294;1845.9723104153447;1873.9318588404478;1906.6472702550072;1920.039980009995;894.0031864471068;925.6575067225169;927.2396634759433;941.2846236859899;974.4250891973628;14265.144091354552;15629;15709.607259818597;15971.44099956496;16031.438899638457;924.9861252081224;982.7395740128871;1007.7682133109279;1013.310948554975;1033.3076838518211;9434.386764860263;9662.56518456671;9668.516574171263;9752.609895604239;9810.558524866397;466198;468491;492322;517549;526520;70152;74106;75803.24196758072;76360.23639763643;77140;1091.858058452412;1095.6877289972479;1138.3113216504062;1158.3165932099932;1158.4497363752319;14352.21062841512;14487.85512144865;14655.413783448543;14775.113493190012;14978.625534361292;32453.51319730253;33212;33273.16817079592;33985;34515.13712157216;39728;39853.40219896646;40763.38854917119;40772.388414174406;41329.58670413258;7103;7184.533005354635;7235.565866048054;7280.126384833854;7297.890531642136;10379.169666426516;10613.257072005194;10734.67795966091;10982.725431864268;11123.72190695239;9369.559904029675;9683.66107186245;9849.704508864745;9860.802783944138;10054.557684163383;9550.95224523873;9719.611215551298;9857.704268871945;10001.449920254456;10171.186305095722;9674.75813104678;9948.204143668345;10166.898331016595;10178.541965611714;10295.330803497749;7545.6981720730555;7625.23747625233;7657.655405506877;7691.615419229128;7857.9214207857185;8809.11908809114;9186;9210.125038121369;9311.394759340621;9403.341766076583 17:06:54 INFO - PROCESS | 6938 | |3;mootools.html;1399.2653856725217;1422.8577142285774;1543.9150846703433;1690.2731825315125;1714.1086634949834;6843.213030501488;7011.333923277293;7020.5436646618;7021.508494405387;7187.317204865542;7154.177269613996;7212.45906557009;7256.891146632792;7288.125424949014;7288.708451661927;2248.4940888300125;2255.6052690779047;2256.1201131558623;2261.6381378979368;2284.5773531896652;2231.386368748591;2235.3294011796397;2266.172846910882;2281.235786011688;2284.577353189657;2163.9242626508076;2244.2257421189747;2245.5621153875;2254.199759085526;2266.048259730917;2237.284069097889;2249.7075380200467;2263.4567703751063;2263.841531092824;2269.217120093573;2226.209695558086;2234.497238121426;2237.1387015998794;2237.1722462688745;2238.6530087836413;7041.5775053496445;7064.894026589605;7076.115485564304;7082.822929426754;7090.929090709078;4350.282203436429;4442.444694413199;4468.463784345867;4470.307102399133;4472.552744725534;2869.583910333011;2908.7091290870953;2918.5768063630653;2932.1496765937854;2946.955795663067;955.6177528988391;959.8992105828927;960.6877764726491;985.3447457440793;986.4278718343344;9351.485668288242;9413.48225847578;9431.198348140417;9468;9490.810183796286;3905.882823515299;3938.5667576566557;3977.085270387827;3982.482277303932;3991.501062367204;7898.526088434713;7907.604619768988;7918;7940.0471943367165;7957.084935232522;4269.060806622538;4296.3555466680245;4298.484181898192;4315.4605674290715;4323.156984388014;3901.7463864848696;3920.9803950980063;3922.0391004204153;3950.4074388841905;3961.3067713150085;3315.8176300303717;3328.7669863109836;3334.8165850878436;3334.849931753077;3340.8997730068136;1004.8141093897652;1014.1683819268277;1022.3354819367471;1022.8516865054526;1026.820306446369;929.772205809581;980.0640388429033;1067.6156583629886;1140.321508702321;1336.5255334356164;6619.602823830585;6635.469162466991;6666.833329166712;6680.23177334603;6693.933060669428;604.4831668923008;611.0803241122082;612.8866159760458;615.7506209984963;739.6745432009899;4971.65198436106;4976.328195693607;5037.773300201499;5046.243063540425;5050.873728156826;8171.10117887032;8534.487930724177;8647.870281945776;8662.436941598902;8754.781130471789;8500.064992850781;8508.829823403497;8563.657453701906;8634.222919937236;8639.870401943976;6704.59772413647;6752.291009444036;6801.557898736566;6806;7016.543924644881;6624.006399039989;6627.1716035495565;6655.3344665535;6688.130543029375;6726.058351830649;7623.085229772463;7717.922820771945;7725.613719313899;7780.2219778021745;7887.566183859943;7731.34283585879;7901.960490197513;7925.564093974886;7976.7208147714555;7988.041435027834;6202.162708034358;6236;6240.7503699851495;6258.874822503615;6262.373762623702;6529.379708927644;6641.236257830411;6656.434203092791;6665.800025999228;6669.299723529154;6391.58454700443;6431.488600178861;6448.484121270381;6491.772787952399;6669.6665166740495;6284.24589049317;6293.622382657055;6351.587146835441;6357.332480089709;6400.423961843457;6395.776147834804;6426.742930282923;6451.387118223761;6466.547341686225;6528.836779080561;5937.703114844154;5978;5980.850478738066;6008.489278411384;6013.729382177725;6037.215162028908;6045.335013148638;6052.969735151472;6066.484348830399;6074.42292982166 17:06:54 INFO - PROCESS | 6938 | |4;prototype.html;336.39616887686606;340.2073169515029;340.29898409276876;348.1644054269753;349.13588867552795;6232.439080482755;6294.7482100715915;6307.495400367971;6327.48140446293;6495.480361571074;6288.308286088538;6339.556231063827;6344.016677415008;6350.364963503659;6357.2371315442215;4831.806727730886;4833.130036593412;4835.879103022417;4840.177169881111;4846.878828029292;4835.613150947934;4835.806567737286;4836.081144582536;4841.031793641286;4841.7337046462435;4697.271922851964;4781.760911954406;4781.760911954406;4791.089692958344;4791.3531673224015;4746.501617330166;4761;4771.332013518093;4791.496892826272;4792.832250871237;4152.418661387408;4156.168766246763;4160.313548264533;4163.458750362463;4164.333706606928;5972.910406343864;5998.01032829587;5998.160257563901;5999.850003749898;6002.399760023963;5463.808766693186;5602.579806514527;5605.831825045255;5607.214989901417;5613.242212301368;6713.362230588086;6720.260771315151;6741.696623651947;6744.527883048188;6754.5609535380045;4613.1696294666945;4619.769011549442;4620.838270660511;4626.444826620794;4627.444706635191;6733.831654208635;6919.342662447059;6956.582605043714;6989.93010069903;7013.82465438363;4615.976920115378;4660.930086048712;4661.114388266218;4664.486906440289;4673;4648.628109751212;4705.7647117644665;4709.95290047102;4718.339432479455;4735.579326202125;5481.095619222783;5484.396716361197;5485.040117979338;5487.204355368529;5490.423505531941;6574.539782215199;6751.493637977172;6761.966190169116;6769.458443324522;6775.898361524581;1637.9344826206818;1658.0549087020524;1672.105423598369;1682.7812384390195;1685.48592679234;1107.058999850121;1112.8497652816927;1115.9274647147909;1121.4897221764077;1133.4276190523897;6124.5100391968535;6126.632402055891;6136.662483563447;6140.263168419819;6144.07838824171;6819.693113809891;6836.726530938707;6860.211075726355;6880.967854821817;6892;6129.172561704113;6207.906881396782;6258.499320054385;6260.373962603794;6264.060390941304;3716.442533619979;3735.831887565066;3739.1586892948867;3739.85040598373;3745.3632882410056;7121.074260346122;7162.92837071633;7184.245654206337;7190.784276471714;7212.927870721225;6950.096487456598;7026.824329391704;7031;7042;7064.08166938305;7260.600666963368;7297.3432391084;7316.707331706779;7325.487215894943;7329.926700733031;6977.651117444006;6980.05769221169;6989.545679530815;6993.2657071006815;7021.122359705037;6813.523053386413;6874.793756187322;6921.861562768817;6923.653817309215;6934.514583979275;7248.89126663111;7288.198298187089;7291.125064992023;7295.52579082358;7316.122065352191;4717.811287548459;4744.074905393415;4754.667173297974;4759.405074365704;4759.571638552408;6873.759418420332;6963.303669632996;6971.407430368273;6992.30076992317;6999.545029573062;6797.728090876507;6798.52410331272;6799.2520822708475;6809.625470599165;6813.591184528944;6755.088063111613;6763.154605674291;6767.492438067066;6772.5936443813525;6777.390034896685;6521.934780652133;6600.60396376219;6617.305182955721;6652.135222421054;6655.733770649314;6766.15423072116;6774.729010839511;6808.7276508939085;6827.01008353776;6834.350736680008;6569.441597464078;6632.767853125118;6640.269570347161;6641.169853768279;6655.534112612071 17:06:54 INFO - PROCESS | 6938 | |5;yui.html;847.809242920343;854.4082404251201;858.0561382479269;860.2000139869921;875.7898104454929;13254.602361929146;13382.464701411931;13435.328233588307;13439.193648381104;13474.730505389898;12581.308028058453;14187.858121418783;14423;14449.5665130046;14450;780.4419839814532;800.8878756974028;806.6612022950375;811.3184924663282;818.443458448255;799.7680672604938;809.8542262392767;810.3800592546706;814.0597609760736;816.3265306122443;842.7640260727006;857.2670366836359;858.6779957515931;861.7156338408341;862.560094351882;839.1692224697566;848.4103548034119;851.05957916502;852.497026754218;852.6845067325067;627.1157667688583;627.2723640576909;627.7426255235378;628.1927722876082;629.8393909553081;14025.859741402557;14045.719085618333;14130;14144.151350918977;14153.433862645481;11930.761384772342;11998.220115692538;12220.938895305555;12264.754704905852;12500.374981250901;10700.30448020876;10724.571017159304;10770.838437423445;10795.78408431827;10800.081993030602;3299.9835000825083;3352.1284466039006;3365.697087262158;3469.410200265961;3471.9652803471895;49450;49627.25559116616;50100.49899501031;50149.749251253874;50211.74894125506;9622.278329125344;9702.466364349888;9917.950410247902;10004.299699021;10385.117265032406;17534.210960506807;17571.38500152514;17610.735838962424;17642.029688367005;17745.645087098444;7143.464240182007;7240.348368646847;7350.77947661571;7364.374028207662;7502.58735769527;4333.921866063226;4356.607905288539;4378.846740364072;4380.132581379255;4406.603405693503;2864.3841574061676;2872.023512005928;2875.09434528123;2885.870135843892;2890.7398334150025;531.0891820527813;535.2506490912675;539.0674133748637;540.1438719629352;547.1956224350199;505.6940550966686;535.2239253083045;603.8007457539002;663.3664850068174;706.1914108345915;7479.738209162653;7779.8833017504785;7978.082520510099;8001.799955001172;8211.384146189059;607.5746977116037;659.4295934017041;673.3670349871105;673.9562624254473;690.7340673840507;3833.8466461341236;3954.070793363557;3967.900802479903;4013.7993100344866;4064.7561146331313;57910.7104464475;58608.41391586115;58647.41352586505;58900.41099589035;58941.70529147413;51632.22551661728;52276.47723522716;52482.21276680853;52684;52691;46964;47247.52752472431;47252.29121563179;47892.521074788805;48096.759516202896;7631.275028872248;7646.65590048438;7705.075390953121;7760.30157285847;7835.882461762964;32621;32880.83559582187;32889.506657400634;33259.667403326624;33525.83237083799;37551;38406.23187536178;38534.80732596319;38543.80728096342;45013.77493112644;10424.426656533964;10447.582096716047;11035.944820275847;11160.441977901235;11307.830382544433;10610.469476525988;10841.67474975752;10899.073578745896;11058.502367393647;11321.7735645285;11332.433378330885;11474.082073434272;11675.065994720233;11680.707982300171;12048.638540843789;11779.96422182455;12214.08394370408;12538.122331436713;12629.368531573567;12642.810357844455;11444.771104578029;11647.825282620937;11895.583654572049;11921.82117268259;11943.641690749291;9493.715188544355;9798.461084640414;9871.851922221316;10127.240456965905;10130.290879638354;8605.2234659045;8825.735227943173;8891.510966896883;9513.809723805623;10108 17:06:54 INFO - PROCESS | 6938 | __end_tp_report 17:06:54 INFO - PROCESS | 6938 | __start_cc_report 17:06:54 INFO - PROCESS | 6938 | _x_x_mozilla_cycle_collect,312 17:06:54 INFO - PROCESS | 6938 | __end_cc_report 17:06:54 INFO - PROCESS | 6938 | __startTimestamp1452733614804__endTimestamp 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | ------- Summary: start ------- 17:06:54 INFO - PROCESS | 6938 | Number of tests: 6 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | [#0] dojo.html Cycles:165 Average:5130.19 Median:5361.57 stddev:638.54 (11.9%) stddev-sans-first:620.75 17:06:54 INFO - PROCESS | 6938 | Values: 3121.4 3140.4 3167.9 3170.0 3175.3 5018.7 5096.2 5097.5 5113.0 5162.7 5094.1 5102.2 5109.0 5110.7 5116.5 4653.0 4687.3 4774.9 4826.4 4830.1 4790.8 4830.2 4836.5 4837.3 4837.4 925.4 4689.3 4705.0 4734.3 4777.7 4761.5 4762.9 4780.3 4790.0 4800.8 4831.7 4846.0 4849.1 4868.3 4872.8 4879.5 4902.5 4943.4 4958.4 4992.1 5506.2 5519.7 5551.3 5561.8 5572.8 5361.5 5588.8 5621.4 5643.1 5672.7 5159.6 5201.5 5230.8 5246.6 5286.9 5593.8 5601.3 5609.7 5612.3 5626.7 5356.9 5424.4 5523.1 5541.3 5572.7 5501.6 5503.3 5544.0 5544.4 5579.6 5468.3 5487.1 5493.4 5504.0 5537.0 5377.7 5478.8 5490.6 5506.3 5550.0 4286.1 4293.6 4301.9 4338.6 4349.7 3857.3 3867.3 3888.5 3905.6 3907.8 5071.5 5080.0 5111.8 5138.0 5171.0 5571.4 5573.4 5591.1 5591.9 5605.0 5171.2 5182.6 5189.7 5194.2 5226.8 4637.8 4709.6 4749.1 4788.9 4840.9 5688.6 5695.5 5724.9 5735.8 5744.7 5469.0 5570.8 5588.4 5605.9 5657.2 5605.8 5633.9 5688.0 5713.5 5758.9 5436.6 5483.3 5484.9 5496.6 5498.5 5465.6 5485.7 5552.4 5571.7 5608.0 5429.6 5446.3 5452.2 5486.4 5513.7 5391.6 5396.2 5424.5 5439.2 5445.6 5229.7 5295.7 5307.0 5323.1 5353.7 5419.1 5458.0 5474.5 5481.4 5509.0 5333.3 5361.6 5382.7 5402.4 5445.5 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | [#1] ext.html Cycles:180 Average:47334.14 Median:36489.95 stddev:82754.93 (226.8%) stddev-sans-first:82912.30 17:06:54 INFO - PROCESS | 6938 | Values: 479.5 504.9 515.8 527.4 538.6 28102.4 35352.5 35768.5 35876.0 35886.6 38960.8 39815.8 39922.4 39929.8 40081.0 8290.9 8436.9 8504.9 8506.6 8520.8 8250.0 8318.0 8349.4 8353.3 8509.6 8625.9 8634.6 8663.3 8670.5 8696.7 8358.4 8584.0 8603.9 8614.3 8619.7 8349.2 8552.7 8561.8 8568.9 8573.7 39908.0 40243.8 40357.2 40382.0 40409.2 3318.7 3348.6 3420.5 3505.7 3666.7 29415.4 29739.6 29861.3 30411.4 30748.7 3359.4 3365.6 3371.5 3405.6 3423.4 267280.0 267652.0 267747.7 267875.0 268304.0 41953.8 42410.6 57890.4 58017.4 58027.7 40377.4 40474.8 40503.4 40659.8 40952.0 14027.4 14090.4 14101.6 14150.2 14179.1 11728.4 11743.2 11757.4 11761.5 11787.1 14187.4 14563.0 14636.9 14641.7 14651.9 5671.1 5676.4 5716.8 5719.5 5724.4 906.7 943.6 987.8 1008.9 1027.8 29138.4 33082.5 33502.7 33610.3 33940.7 1001.6 1040.0 1077.0 1094.2 1136.6 15299.2 16675.2 16957.9 16969.0 16976.6 375233.0 378475.0 380343.0 381080.0 382464.0 55291.7 55472.7 55493.0 55539.7 55718.0 1317.3 1318.7 1333.3 1340.9 1343.8 29551.7 30402.2 30930.8 30931.0 31334.2 46926.0 47708.0 47772.0 47859.5 47882.5 286287.0 286684.0 287979.0 288200.0 288811.0 33041.3 42949.6 43128.4 43166.6 43834.3 39890.4 40118.6 40408.8 40427.0 40942.4 36128.0 36251.0 36373.0 36388.8 37639.6 36274.3 36781.0 37203.4 37269.0 37475.6 35388.8 35723.8 36320.6 36341.3 36591.1 30670.0 31708.8 32934.7 33347.0 33513.8 25426.6 25926.2 27087.6 27346.7 27443.5 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | [#2] jquery.html Cycles:180 Average:26166.93 Median:4542.48 stddev:80918.84 (1781.4%) stddev-sans-first:81122.64 17:06:54 INFO - PROCESS | 6938 | Values: 361.6 361.6 361.7 364.9 366.8 15524.6 16184.9 16841.7 17444.3 17702.8 10909.2 11233.6 16329.9 16451.1 16463.9 4776.2 5108.7 5126.5 5131.2 5139.8 4587.7 4978.4 5111.8 5114.9 5126.1 5108.1 5314.0 5333.7 5522.0 5543.8 5226.5 5268.2 5291.1 5302.5 5571.6 5333.6 5370.3 5374.4 5375.0 5385.9 13574.5 18007.0 18647.5 18758.0 18922.0 1961.2 2057.5 2072.6 2083.5 2294.5 9310.5 9688.0 10639.7 12143.6 12767.6 1729.4 1784.6 1855.6 1893.2 1928.3 55282.9 55944.4 56733.4 57495.0 57547.1 10247.6 10272.8 10277.6 10303.4 10345.0 13344.2 13349.4 13417.5 13451.5 13458.7 7701.5 7721.7 7723.5 7739.4 7748.0 7335.5 7342.0 7412.7 7425.6 7468.8 4434.0 4448.2 4495.4 4534.8 4550.2 1810.8 1846.0 1873.9 1906.6 1920.0 894.0 925.7 927.2 941.3 974.4 14265.1 15629.0 15709.6 15971.4 16031.4 925.0 982.7 1007.8 1013.3 1033.3 9434.4 9662.6 9668.5 9752.6 9810.6 466198.0 468491.0 492322.0 517549.0 526520.0 70152.0 74106.0 75803.2 76360.2 77140.0 1091.9 1095.7 1138.3 1158.3 1158.4 14352.2 14487.9 14655.4 14775.1 14978.6 32453.5 33212.0 33273.2 33985.0 34515.1 39728.0 39853.4 40763.4 40772.4 41329.6 7103.0 7184.5 7235.6 7280.1 7297.9 10379.2 10613.3 10734.7 10982.7 11123.7 9369.6 9683.7 9849.7 9860.8 10054.6 9551.0 9719.6 9857.7 10001.4 10171.2 9674.8 9948.2 10166.9 10178.5 10295.3 7545.7 7625.2 7657.7 7691.6 7857.9 8809.1 9186.0 9210.1 9311.4 9403.3 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | [#3] mootools.html Cycles:180 Average:5005.52 Median:6260.62 stddev:2537.81 (40.5%) stddev-sans-first:2530.46 17:06:54 INFO - PROCESS | 6938 | Values: 1399.3 1422.9 1543.9 1690.3 1714.1 6843.2 7011.3 7020.5 7021.5 7187.3 7154.2 7212.5 7256.9 7288.1 7288.7 2248.5 2255.6 2256.1 2261.6 2284.6 2231.4 2235.3 2266.2 2281.2 2284.6 2163.9 2244.2 2245.6 2254.2 2266.0 2237.3 2249.7 2263.5 2263.8 2269.2 2226.2 2234.5 2237.1 2237.2 2238.7 7041.6 7064.9 7076.1 7082.8 7090.9 4350.3 4442.4 4468.5 4470.3 4472.6 2869.6 2908.7 2918.6 2932.1 2947.0 955.6 959.9 960.7 985.3 986.4 9351.5 9413.5 9431.2 9468.0 9490.8 3905.9 3938.6 3977.1 3982.5 3991.5 7898.5 7907.6 7918.0 7940.0 7957.1 4269.1 4296.4 4298.5 4315.5 4323.2 3901.7 3921.0 3922.0 3950.4 3961.3 3315.8 3328.8 3334.8 3334.8 3340.9 1004.8 1014.2 1022.3 1022.9 1026.8 929.8 980.1 1067.6 1140.3 1336.5 6619.6 6635.5 6666.8 6680.2 6693.9 604.5 611.1 612.9 615.8 739.7 4971.7 4976.3 5037.8 5046.2 5050.9 8171.1 8534.5 8647.9 8662.4 8754.8 8500.1 8508.8 8563.7 8634.2 8639.9 6704.6 6752.3 6801.6 6806.0 7016.5 6624.0 6627.2 6655.3 6688.1 6726.1 7623.1 7717.9 7725.6 7780.2 7887.6 7731.3 7902.0 7925.6 7976.7 7988.0 6202.2 6236.0 6240.8 6258.9 6262.4 6529.4 6641.2 6656.4 6665.8 6669.3 6391.6 6431.5 6448.5 6491.8 6669.7 6284.2 6293.6 6351.6 6357.3 6400.4 6395.8 6426.7 6451.4 6466.5 6528.8 5937.7 5978.0 5980.9 6008.5 6013.7 6037.2 6045.3 6053.0 6066.5 6074.4 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | [#4] prototype.html Cycles:180 Average:5598.37 Median:6276.18 stddev:1709.13 (27.2%) stddev-sans-first:1667.66 17:06:54 INFO - PROCESS | 6938 | Values: 336.4 340.2 340.3 348.2 349.1 6232.4 6294.7 6307.5 6327.5 6495.5 6288.3 6339.6 6344.0 6350.4 6357.2 4831.8 4833.1 4835.9 4840.2 4846.9 4835.6 4835.8 4836.1 4841.0 4841.7 4697.3 4781.8 4781.8 4791.1 4791.4 4746.5 4761.0 4771.3 4791.5 4792.8 4152.4 4156.2 4160.3 4163.5 4164.3 5972.9 5998.0 5998.2 5999.9 6002.4 5463.8 5602.6 5605.8 5607.2 5613.2 6713.4 6720.3 6741.7 6744.5 6754.6 4613.2 4619.8 4620.8 4626.4 4627.4 6733.8 6919.3 6956.6 6989.9 7013.8 4616.0 4660.9 4661.1 4664.5 4673.0 4648.6 4705.8 4710.0 4718.3 4735.6 5481.1 5484.4 5485.0 5487.2 5490.4 6574.5 6751.5 6762.0 6769.5 6775.9 1637.9 1658.1 1672.1 1682.8 1685.5 1107.1 1112.8 1115.9 1121.5 1133.4 6124.5 6126.6 6136.7 6140.3 6144.1 6819.7 6836.7 6860.2 6881.0 6892.0 6129.2 6207.9 6258.5 6260.4 6264.1 3716.4 3735.8 3739.2 3739.9 3745.4 7121.1 7162.9 7184.2 7190.8 7212.9 6950.1 7026.8 7031.0 7042.0 7064.1 7260.6 7297.3 7316.7 7325.5 7329.9 6977.7 6980.1 6989.5 6993.3 7021.1 6813.5 6874.8 6921.9 6923.7 6934.5 7248.9 7288.2 7291.1 7295.5 7316.1 4717.8 4744.1 4754.7 4759.4 4759.6 6873.8 6963.3 6971.4 6992.3 6999.5 6797.7 6798.5 6799.3 6809.6 6813.6 6755.1 6763.2 6767.5 6772.6 6777.4 6521.9 6600.6 6617.3 6652.1 6655.7 6766.2 6774.7 6808.7 6827.0 6834.4 6569.4 6632.8 6640.3 6641.2 6655.5 17:06:54 INFO - PROCESS | 6938 | 17:06:54 INFO - PROCESS | 6938 | [#5] yui.html Cycles:180 Average:13717.05 Median:47105.76 stddev:15984.89 (33.9%) stddev-sans-first:16000.51 17:06:54 INFO - PROCESS | 6938 | Values: 847.8 854.4 858.1 860.2 875.8 13254.6 13382.5 13435.3 13439.2 13474.7 12581.3 14187.9 14423.0 14449.6 14450.0 780.4 800.9 806.7 811.3 818.4 799.8 809.9 810.4 814.1 816.3 842.8 857.3 858.7 861.7 862.6 839.2 848.4 851.1 852.5 852.7 627.1 627.3 627.7 628.2 629.8 14025.9 14045.7 14130.0 14144.2 14153.4 11930.8 11998.2 12220.9 12264.8 12500.4 10700.3 10724.6 10770.8 10795.8 10800.1 3300.0 3352.1 3365.7 3469.4 3472.0 49450.0 49627.3 50100.5 50149.7 50211.7 9622.3 9702.5 9918.0 10004.3 10385.1 17534.2 17571.4 17610.7 17642.0 17745.6 7143.5 7240.3 7350.8 7364.4 7502.6 4333.9 4356.6 4378.8 4380.1 4406.6 2864.4 2872.0 2875.1 2885.9 2890.7 531.1 535.3 539.1 540.1 547.2 505.7 535.2 603.8 663.4 706.2 7479.7 7779.9 7978.1 8001.8 8211.4 607.6 659.4 673.4 674.0 690.7 3833.8 3954.1 3967.9 4013.8 4064.8 57910.7 58608.4 58647.4 58900.4 58941.7 51632.2 52276.5 52482.2 52684.0 52691.0 46964.0 47247.5 47252.3 47892.5 48096.8 7631.3 7646.7 7705.1 7760.3 7835.9 32621.0 32880.8 32889.5 33259.7 33525.8 37551.0 38406.2 38534.8 38543.8 45013.8 10424.4 10447.6 11035.9 11160.4 11307.8 10610.5 10841.7 10899.1 11058.5 11321.8 11332.4 11474.1 11675.1 11680.7 12048.6 11780.0 12214.1 12538.1 12629.4 12642.8 11444.8 11647.8 11895.6 11921.8 11943.6 9493.7 9798.5 9871.9 10127.2 10130.3 8605.2 8825.7 8891.5 9513.8 10108.0 17:06:54 INFO - PROCESS | 6938 | -------- Summary: end -------- 17:06:54 INFO - PROCESS | 6938 | 17:06:55 INFO - TEST-INFO | 6938: exit 0 17:06:55 INFO - TEST-OK | dromaeo_css | took 1110252ms 17:06:55 INFO - TEST-START | kraken 17:06:55 INFO - operating with platform_type : linux_ 17:06:55 INFO - Initialising browser for kraken test... 17:06:55 INFO - TEST-INFO | started process 7172 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8v3ooy/profile http://localhost:53553/getInfo.html) 17:06:58 INFO - PROCESS | 7172 | 17:06:58 INFO - PROCESS | 7172 | (process:7245): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:06:59 INFO - PROCESS | 7172 | __metrics Screen width/height:1600/1200 17:06:59 INFO - PROCESS | 7172 | colorDepth:24 17:06:59 INFO - PROCESS | 7172 | Browser inner width/height: 1024/670 17:06:59 INFO - PROCESS | 7172 | __metrics 17:06:59 INFO - PROCESS | 7172 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:07:00 INFO - TEST-INFO | 7172: exit 0 17:07:00 INFO - Browser initialized. 17:07:00 INFO - Running cycle 1/1 for kraken test... 17:07:00 INFO - TEST-INFO | started process 7294 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8v3ooy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:02 INFO - PROCESS | 7294 | 17:07:02 INFO - PROCESS | 7294 | (process:7354): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:07:12 INFO - PROCESS | 7294 | RSS: Main: 150941696 17:07:12 INFO - PROCESS | 7294 | 17:07:15 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53553/tests/kraken/driver.html?testName=audio-beat-detection) 17:07:15 INFO - PROCESS | 7294 | RSS: Main: 150761472 17:07:15 INFO - PROCESS | 7294 | 17:07:18 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53553/tests/kraken/driver.html?testName=audio-dft) 17:07:19 INFO - PROCESS | 7294 | RSS: Main: 155348992 17:07:19 INFO - PROCESS | 7294 | 17:07:21 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53553/tests/kraken/driver.html?testName=audio-fft) 17:07:22 INFO - PROCESS | 7294 | RSS: Main: 147456000 17:07:22 INFO - PROCESS | 7294 | 17:07:24 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53553/tests/kraken/driver.html?testName=audio-oscillator) 17:07:25 INFO - PROCESS | 7294 | RSS: Main: 148062208 17:07:25 INFO - PROCESS | 7294 | 17:07:27 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:07:27 INFO - PROCESS | 7294 | RSS: Main: 149082112 17:07:27 INFO - PROCESS | 7294 | 17:07:30 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53553/tests/kraken/driver.html?testName=imaging-darkroom) 17:07:31 INFO - PROCESS | 7294 | RSS: Main: 150036480 17:07:31 INFO - PROCESS | 7294 | 17:07:34 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53553/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:35 INFO - PROCESS | 7294 | RSS: Main: 150487040 17:07:35 INFO - PROCESS | 7294 | 17:07:38 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53553/tests/kraken/driver.html?testName=json-parse-financial) 17:07:38 INFO - PROCESS | 7294 | RSS: Main: 150802432 17:07:38 INFO - PROCESS | 7294 | 17:07:40 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:40 INFO - PROCESS | 7294 | RSS: Main: 148983808 17:07:40 INFO - PROCESS | 7294 | 17:07:42 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:43 INFO - PROCESS | 7294 | RSS: Main: 149426176 17:07:43 INFO - PROCESS | 7294 | 17:07:45 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:46 INFO - PROCESS | 7294 | RSS: Main: 150118400 17:07:46 INFO - PROCESS | 7294 | 17:07:48 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:49 INFO - PROCESS | 7294 | RSS: Main: 150659072 17:07:49 INFO - PROCESS | 7294 | 17:07:51 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:52 INFO - PROCESS | 7294 | RSS: Main: 150257664 17:07:52 INFO - PROCESS | 7294 | 17:07:53 INFO - PROCESS | 7294 | Cycle 1(1): loaded http://localhost:53553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53553/tests/kraken/driver.html?testName=ai-astar) 17:07:54 INFO - PROCESS | 7294 | RSS: Main: 150679552 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | __start_tp_report 17:07:54 INFO - PROCESS | 7294 | _x_x_mozilla_page_load 17:07:54 INFO - PROCESS | 7294 | _x_x_mozilla_page_load_details 17:07:54 INFO - PROCESS | 7294 | |i|pagename|runs| 17:07:54 INFO - PROCESS | 7294 | |0;ai-astar;113;107;113;111;114;121;111;110;112;113 17:07:54 INFO - PROCESS | 7294 | |1;audio-beat-detection;154;126;156;177;134;157;151;130;161;125 17:07:54 INFO - PROCESS | 7294 | |2;audio-dft;163;163;163;163;161;161;165;164;170;165 17:07:54 INFO - PROCESS | 7294 | |3;audio-fft;73;74;76;74;75;74;161;72;73;74 17:07:54 INFO - PROCESS | 7294 | |4;audio-oscillator;96;96;149;96;97;96;140;96;96;138 17:07:54 INFO - PROCESS | 7294 | |5;imaging-gaussian-blur;111;110;110;109;110;113;110;109;110;110 17:07:54 INFO - PROCESS | 7294 | |6;imaging-darkroom;147;147;147;147;147;147;150;147;148;146 17:07:54 INFO - PROCESS | 7294 | |7;imaging-desaturate;96;96;96;96;97;97;96;96;96;96 17:07:54 INFO - PROCESS | 7294 | |8;json-parse-financial;68;59;61;61;60;60;61;59;58;59 17:07:54 INFO - PROCESS | 7294 | |9;json-stringify-tinderbox;72;67;68;68;68;67;68;67;67;68 17:07:54 INFO - PROCESS | 7294 | |10;stanford-crypto-aes;81;81;84;84;84;84;86;83;83;83 17:07:54 INFO - PROCESS | 7294 | |11;stanford-crypto-ccm;118;119;120;124;123;119;121;127;124;118 17:07:54 INFO - PROCESS | 7294 | |12;stanford-crypto-pbkdf2;132;144;140;141;148;144;145;143;144;139 17:07:54 INFO - PROCESS | 7294 | |13;stanford-crypto-sha256-iterative;69;71;66;68;71;65;69;65;70;67 17:07:54 INFO - PROCESS | 7294 | __end_tp_report 17:07:54 INFO - PROCESS | 7294 | __start_cc_report 17:07:54 INFO - PROCESS | 7294 | _x_x_mozilla_cycle_collect,729 17:07:54 INFO - PROCESS | 7294 | __end_cc_report 17:07:54 INFO - PROCESS | 7294 | __startTimestamp1452733674151__endTimestamp 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | ------- Summary: start ------- 17:07:54 INFO - PROCESS | 7294 | Number of tests: 14 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:3.81 17:07:54 INFO - PROCESS | 7294 | Values: 113.0 107.0 113.0 111.0 114.0 121.0 111.0 110.0 112.0 113.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:155.00 stddev:17.40 (11.2%) stddev-sans-first:18.28 17:07:54 INFO - PROCESS | 7294 | Values: 154.0 126.0 156.0 177.0 134.0 157.0 151.0 130.0 161.0 125.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.57 (1.6%) stddev-sans-first:2.71 17:07:54 INFO - PROCESS | 7294 | Values: 163.0 163.0 163.0 163.0 161.0 161.0 165.0 164.0 170.0 165.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:27.57 (37.3%) stddev-sans-first:29.02 17:07:54 INFO - PROCESS | 7294 | Values: 73.0 74.0 76.0 74.0 75.0 74.0 161.0 72.0 73.0 74.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.48 (23.4%) stddev-sans-first:23.27 17:07:54 INFO - PROCESS | 7294 | Values: 96.0 96.0 149.0 96.0 97.0 96.0 140.0 96.0 96.0 138.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.14 (1.0%) stddev-sans-first:1.17 17:07:54 INFO - PROCESS | 7294 | Values: 111.0 110.0 110.0 109.0 110.0 113.0 110.0 109.0 110.0 110.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 17:07:54 INFO - PROCESS | 7294 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 150.0 147.0 148.0 146.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:07:54 INFO - PROCESS | 7294 | Values: 96.0 96.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.50 stddev:2.80 (4.6%) stddev-sans-first:1.09 17:07:54 INFO - PROCESS | 7294 | Values: 68.0 59.0 61.0 61.0 60.0 60.0 61.0 59.0 58.0 59.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:0.53 17:07:54 INFO - PROCESS | 7294 | Values: 72.0 67.0 68.0 68.0 68.0 67.0 68.0 67.0 67.0 68.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.49 (1.8%) stddev-sans-first:1.33 17:07:54 INFO - PROCESS | 7294 | Values: 81.0 81.0 84.0 84.0 84.0 84.0 86.0 83.0 83.0 83.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.00 stddev:3.06 (2.5%) stddev-sans-first:3.00 17:07:54 INFO - PROCESS | 7294 | Values: 118.0 119.0 120.0 124.0 123.0 119.0 121.0 127.0 124.0 118.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:144.00 stddev:4.37 (3.0%) stddev-sans-first:2.76 17:07:54 INFO - PROCESS | 7294 | Values: 132.0 144.0 140.0 141.0 148.0 144.0 145.0 143.0 144.0 139.0 17:07:54 INFO - PROCESS | 7294 | 17:07:54 INFO - PROCESS | 7294 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:2.28 (3.3%) stddev-sans-first:2.40 17:07:54 INFO - PROCESS | 7294 | Values: 69.0 71.0 66.0 68.0 71.0 65.0 69.0 65.0 70.0 67.0 17:07:54 INFO - PROCESS | 7294 | -------- Summary: end -------- 17:07:54 INFO - PROCESS | 7294 | 17:07:55 INFO - TEST-INFO | 7294: exit 0 17:07:55 INFO - TEST-OK | kraken | took 59601ms 17:07:55 INFO - TEST-START | v8_7 17:07:55 INFO - operating with platform_type : linux_ 17:07:55 INFO - Initialising browser for v8_7 test... 17:07:55 INFO - TEST-INFO | started process 7584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPQSfxF/profile http://localhost:53553/getInfo.html) 17:07:58 INFO - PROCESS | 7584 | 17:07:58 INFO - PROCESS | 7584 | (process:7655): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:07:59 INFO - PROCESS | 7584 | __metrics Screen width/height:1600/1200 17:07:59 INFO - PROCESS | 7584 | colorDepth:24 17:07:59 INFO - PROCESS | 7584 | Browser inner width/height: 1024/670 17:07:59 INFO - PROCESS | 7584 | __metrics 17:07:59 INFO - PROCESS | 7584 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:08:00 INFO - TEST-INFO | 7584: exit 0 17:08:00 INFO - Browser initialized. 17:08:00 INFO - Running cycle 1/1 for v8_7 test... 17:08:00 INFO - TEST-INFO | started process 7704 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPQSfxF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:01 INFO - PROCESS | 7704 | 17:08:01 INFO - PROCESS | 7704 | (process:7760): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:08:12 INFO - PROCESS | 7704 | RSS: Main: 150282240 17:08:12 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | Cycle 1(1): loaded http://localhost:53553/tests/v8_7/run.html (next: http://localhost:53553/tests/v8_7/run.html) 17:08:34 INFO - PROCESS | 7704 | RSS: Main: 146468864 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | __start_tp_report 17:08:34 INFO - PROCESS | 7704 | _x_x_mozilla_page_load 17:08:34 INFO - PROCESS | 7704 | _x_x_mozilla_page_load_details 17:08:34 INFO - PROCESS | 7704 | |i|pagename|runs| 17:08:34 INFO - PROCESS | 7704 | |0;Richards;167.50418760469012 17:08:34 INFO - PROCESS | 7704 | |1;DeltaBlue;187.89928598271325 17:08:34 INFO - PROCESS | 7704 | |2;Encrypt;278.8622420524261 17:08:34 INFO - PROCESS | 7704 | |3;Decrypt;5170.103092783505 17:08:34 INFO - PROCESS | 7704 | |4;RayTrace;1072.961373390558 17:08:34 INFO - PROCESS | 7704 | |5;Earley;706.2146892655368 17:08:34 INFO - PROCESS | 7704 | |6;Boyer;12345.67901234568 17:08:34 INFO - PROCESS | 7704 | |7;RegExp;41551.02040816326 17:08:34 INFO - PROCESS | 7704 | |8;Splay;580.3830528148578 17:08:34 INFO - PROCESS | 7704 | |9;NavierStokes;4868.9320388349515 17:08:34 INFO - PROCESS | 7704 | __end_tp_report 17:08:34 INFO - PROCESS | 7704 | __startTimestamp1452733714860__endTimestamp 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | ------- Summary: start ------- 17:08:34 INFO - PROCESS | 7704 | Number of tests: 10 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 167.5 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#1] DeltaBlue Cycles:1 Average:187.90 Median:187.90 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 187.9 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 278.9 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 5170.1 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 1073.0 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 706.2 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 12345.7 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#7] RegExp Cycles:1 Average:41551.02 Median:41551.02 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 41551.0 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#8] Splay Cycles:1 Average:580.38 Median:580.38 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 580.4 17:08:34 INFO - PROCESS | 7704 | 17:08:34 INFO - PROCESS | 7704 | [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 17:08:34 INFO - PROCESS | 7704 | Values: 4868.9 17:08:34 INFO - PROCESS | 7704 | -------- Summary: end -------- 17:08:34 INFO - PROCESS | 7704 | 17:08:35 INFO - TEST-INFO | 7704: exit 0 17:08:35 INFO - TEST-OK | v8_7 | took 40739ms 17:08:35 INFO - SUITE-END | took 1210s 17:08:35 INFO - Completed test suite (00:20:10) 17:08:35 INFO - Working with test: dromaeo_css 17:08:35 INFO - Generating results file: dromaeo_css 17:08:35 INFO - Working with test: kraken 17:08:35 INFO - Generating results file: kraken 17:08:35 INFO - javascript benchmark 17:08:35 INFO - Working with test: v8_7 17:08:35 INFO - Generating results file: v8_7 17:08:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:08:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 17:08:35 INFO - process_Request line: dromaeo_css 6772.55 graph.html#tests=[[72,1,43]] 17:08:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:08:36 INFO - process_Request line: kraken 1513.00 graph.html#tests=[[232,1,43]] 17:08:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:08:36 INFO - process_Request line: v8_7 20433.99 graph.html#tests=[[230,1,43]] 17:08:36 INFO - RETURN: dromaeo_css: 6772.55 17:08:36 INFO - RETURN: kraken: 1513.00 17:08:36 INFO - RETURN: v8_7: 20433.99 17:08:36 INFO - javascript benchmark 17:08:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.4225368306866, 3140.4190224808412, 3167.8732850685974, 3170.0331398923327, 3175.269687971768, 5018.749062546867, 5096.235564665298, 5097.5157360050825, 5112.974435127824, 5162.741862906859, 5094.057599344114, 5102.209157580572, 5108.974455127728, 5110.7444627768555, 5116.513931176532, 4652.999605084906, 4687.296905464191, 4774.928376074345, 4826.420829500465, 4830.130576496229, 4790.784414701347, 4830.154722923492, 4836.51634836517, 4837.250226214942, 4837.371141751567, 925.4207627772917, 4689.273162659776, 4704.952950470502, 4734.313524538957, 4777.665563410563, 4761.523847615245, 4762.904531957669, 4780.282957556359, 4789.952100478986, 4800.831970881002, 4831.734254615994, 4846.030793841211, 4849.102915960559, 4868.294097355899, 4872.78072486739, 4879.4876537963355, 4902.509749025105, 4943.406791185045, 4958.429780575244, 4992.051510213048, 5506.174073888908, 5519.724013799334, 5551.306086739158, 5561.77752889884, 5572.804951826666, 5361.544268737162, 5588.832335029955, 5621.353544342372, 5643.068893632546, 5672.659640421588, 5159.638825282194, 5201.479852014768, 5230.764615592308, 5246.554042906319, 5286.916182182644, 5593.804216852391, 5601.271834661468, 5609.719514024282, 5612.270404847425, 5626.662400255997, 5356.8660783479945, 5424.403315635277, 5523.061079616475, 5541.307336582927, 5572.749226284827, 5501.642393244426, 5503.3120859892515, 5544.002079625626, 5544.390117087117, 5579.581531385081, 5468.316460442445, 5487.067198576252, 5493.368262649767, 5503.981763373788, 5536.972315138479, 5377.7311134443125, 5478.780848766005, 5490.56075513958, 5506.256655351556, 5550.0, 4286.057067445157, 4293.5706429356815, 4301.935470967938, 4338.609525142752, 4349.739015659071, 3857.286402015636, 3867.323218436762, 3888.475055867478, 3905.6094390560716, 3907.8241479133508, 5071.518205770446, 5080.034793389244, 5111.795528178831, 5138.049460849755, 5171.0, 5571.4428557143965, 5573.386927437979, 5591.133374326986, 5591.860203494945, 5605.0, 5171.224316352502, 5182.637215394886, 5189.714565698847, 5194.220866869924, 5226.764795584208, 4637.791299391535, 4709.62323014158, 4749.050189962021, 4788.880277993078, 4840.927386089212, 5688.63023903445, 5695.458931401593, 5724.856878577985, 5735.827925162252, 5744.684042377626, 5469.042917489503, 5570.777168913198, 5588.441155884379, 5605.943940560543, 5657.2079908811975, 5605.775768969195, 5633.8591535211945, 5688.033034384247, 5713.485786279255, 5758.942410575841, 5436.592255580768, 5483.341998960151, 5484.91772623403, 5496.615236933376, 5498.45015498447, 5465.562754979513, 5485.670859748428, 5552.444755524415, 5571.693556854412, 5607.971960140173, 5429.5656347492895, 5446.346438427414, 5452.154915988028, 5486.423925487926, 5513.669179849222, 5391.568674506108, 5396.1905714143195, 5424.457554244544, 5439.211314359475, 5445.564354851682, 5229.686218826882, 5295.682259064469, 5307.01820163271, 5323.148296272578, 5353.732313384393, 5419.05166595852, 5458.0, 5474.452554744494, 5481.369642491165, 5508.9724551376985, 5333.280007199133, 5361.571074313967, 5382.650127741685, 5402.405735369028, 5445.537129343892], "unit": "score", "name": "dojo.html", "value": 5092.143139325617}, {"lowerIsBetter": false, "replicates": [479.46060681733053, 504.9394072711275, 515.8426679862641, 527.4119356917037, 538.558382126656, 28102.43795124096, 35352.46971295429, 35768.46347304786, 35876.0, 35886.64113358866, 38960.80519597398, 39815.800920995425, 39922.40116398249, 39929.8003509982, 40081.0, 8290.91709082909, 8436.915630843705, 8504.872426913602, 8506.617202225914, 8520.78698032551, 8249.958750206271, 8318.0, 8349.373796965221, 8353.33173346131, 8509.574521273911, 8625.913740862605, 8634.611442485104, 8663.263622592087, 8670.479771213715, 8696.739097827043, 8358.373122015842, 8584.012838523557, 8603.913960860405, 8614.310855131574, 8619.65521379144, 8349.165083491664, 8552.743417697478, 8561.828763424697, 8568.914310856873, 8573.657053717843, 39908.0, 40243.7987810062, 40357.15714114325, 40382.0, 40409.19181616351, 3318.734501239895, 3348.598168219805, 3420.452727563578, 3505.684488396031, 3666.7249956253386, 29415.411691766043, 29739.553906691417, 29861.25346866324, 30411.391772164432, 30748.692513074806, 3359.3617212729746, 3365.6466071062678, 3371.5448414463976, 3405.5743032120986, 3423.400904841668, 267280.0, 267652.0, 267747.6612616944, 267875.0, 268304.0, 41953.790231048646, 42410.57589424128, 57890.4210957885, 58017.41982580205, 58027.70986145042, 40377.39433908494, 40474.797626011685, 40503.392449113286, 40659.796701016894, 40952.0, 14027.438902443788, 14090.365933533016, 14101.576952691436, 14150.150990940576, 14179.078359906573, 11728.413579321, 11743.236689615147, 11757.353345566076, 11761.529538818522, 11787.115966302561, 14187.361568729431, 14563.0, 14636.926815365856, 14641.707165856624, 14651.853481465261, 5671.149327600893, 5676.4323567642905, 5716.79991200306, 5719.48524632785, 5724.398938111522, 906.6826610686207, 943.5895385507326, 987.8123156600223, 1008.8738907636546, 1027.7944411117805, 29138.417231655247, 33082.50376244358, 33502.664973350446, 33610.327793444, 33940.66059339424, 1001.639409812467, 1040.0119886108228, 1076.978460430787, 1094.1848322999417, 1136.6419577832955, 15299.158546280061, 16675.24961376741, 16957.915210424115, 16969.0, 16976.57558561021, 375233.0, 378475.0, 380343.0, 381080.0, 382464.0, 55291.72354138284, 55472.72263638656, 55493.0, 55539.72230138904, 55718.0, 1317.2557505009831, 1318.723068155679, 1333.2533781082625, 1340.9061365704501, 1343.8454577723687, 29551.704482954894, 30402.239944001576, 30930.845345773127, 30931.0, 31334.216644584067, 46926.0, 47708.0, 47772.0, 47859.5214047869, 47882.5211747892, 286287.0, 286684.0, 287979.0, 288200.0, 288811.0, 33041.33917321688, 42949.570504294556, 43128.35307470328, 43166.56833431625, 43834.34248486339, 39890.40164397594, 40118.59881401266, 40408.79795601003, 40427.0, 40942.38586421266, 36128.0, 36251.0, 36373.0, 36388.81805591061, 37639.62360376361, 36274.27451451009, 36781.0, 37203.44194837025, 37269.0, 37475.625243748305, 35388.82305588559, 35723.82138089293, 36320.636793631726, 36341.27317453689, 36591.085222868576, 30670.0, 31708.84145579257, 32934.670653293164, 33347.0, 33513.83243083769, 25426.618600720634, 25926.22221333363, 27087.59368609433, 27346.726532734418, 27443.451130976868], "unit": "score", "name": "ext.html", "value": 18012.67123668757}, {"lowerIsBetter": false, "replicates": [361.57153772779253, 361.64739379105373, 361.65461983805466, 364.9087728067983, 366.7835976773703, 15524.611884702874, 16184.919075404621, 16841.663166736656, 17444.302227910885, 17702.822971770278, 10909.23635345526, 11233.606823761149, 16329.918350408261, 16451.095189764557, 16463.91768041161, 4776.211925032374, 5108.66793658411, 5126.487351264881, 5131.153359695646, 5139.768710408022, 4587.7017993830295, 4978.377702787152, 5111.84664460065, 5114.897702045957, 5126.077306084903, 5108.131617625013, 5314.043472175007, 5333.679979201241, 5521.972390138064, 5543.750531226105, 5226.529612334889, 5268.1834315681135, 5291.100512912775, 5302.522772950434, 5571.609987300891, 5333.57331413486, 5370.301860758115, 5374.408815030343, 5375.0, 5385.865353366158, 13574.45702171912, 18007.0, 18647.53381165468, 18758.0, 18922.0, 1961.205711686755, 2057.5267688431745, 2072.637288474511, 2083.510035872697, 2294.4837411582425, 9310.53447327631, 9687.951560242223, 10639.734006649818, 12143.574974875924, 12767.61697149087, 1729.3601367493982, 1784.580623553464, 1855.5546668799525, 1893.214316058834, 1928.344362916601, 55282.89434211334, 55944.44055559433, 56733.43266567323, 57495.0, 57547.13679294814, 10247.59009639621, 10272.794544109076, 10277.588896444058, 10303.433311167957, 10345.0, 13344.198533197894, 13349.399277032557, 13417.463301468028, 13451.46194152223, 13458.663533411744, 7701.537907725442, 7721.691132354756, 7723.497972631761, 7739.419543534144, 7747.961260193776, 7335.523190992569, 7342.0, 7412.703491860373, 7425.591592462359, 7468.775936721907, 4433.955660443355, 4448.221561226773, 4495.43807024122, 4534.79593418297, 4550.158220729109, 1810.7555480010294, 1845.9723104153447, 1873.9318588404478, 1906.6472702550072, 1920.039980009995, 894.0031864471068, 925.6575067225169, 927.2396634759433, 941.2846236859899, 974.4250891973628, 14265.144091354552, 15629.0, 15709.607259818597, 15971.44099956496, 16031.438899638457, 924.9861252081224, 982.7395740128871, 1007.7682133109279, 1013.310948554975, 1033.3076838518211, 9434.386764860263, 9662.56518456671, 9668.516574171263, 9752.609895604239, 9810.558524866397, 466198.0, 468491.0, 492322.0, 517549.0, 526520.0, 70152.0, 74106.0, 75803.24196758072, 76360.23639763643, 77140.0, 1091.858058452412, 1095.6877289972479, 1138.3113216504062, 1158.3165932099932, 1158.4497363752319, 14352.21062841512, 14487.85512144865, 14655.413783448543, 14775.113493190012, 14978.625534361292, 32453.51319730253, 33212.0, 33273.16817079592, 33985.0, 34515.13712157216, 39728.0, 39853.40219896646, 40763.38854917119, 40772.388414174406, 41329.58670413258, 7103.0, 7184.533005354635, 7235.565866048054, 7280.126384833854, 7297.890531642136, 10379.169666426516, 10613.257072005194, 10734.67795966091, 10982.725431864268, 11123.72190695239, 9369.559904029675, 9683.66107186245, 9849.704508864745, 9860.802783944138, 10054.557684163383, 9550.95224523873, 9719.611215551298, 9857.704268871945, 10001.449920254456, 10171.186305095722, 9674.75813104678, 9948.204143668345, 10166.898331016595, 10178.541965611714, 10295.330803497749, 7545.6981720730555, 7625.23747625233, 7657.655405506877, 7691.615419229128, 7857.9214207857185, 8809.11908809114, 9186.0, 9210.125038121369, 9311.394759340621, 9403.341766076583], "unit": "score", "name": "jquery.html", "value": 8126.321230951191}, {"lowerIsBetter": false, "replicates": [1399.2653856725217, 1422.8577142285774, 1543.9150846703433, 1690.2731825315125, 1714.1086634949834, 6843.213030501488, 7011.333923277293, 7020.5436646618, 7021.508494405387, 7187.317204865542, 7154.177269613996, 7212.45906557009, 7256.891146632792, 7288.125424949014, 7288.708451661927, 2248.4940888300125, 2255.6052690779047, 2256.1201131558623, 2261.6381378979368, 2284.5773531896652, 2231.386368748591, 2235.3294011796397, 2266.172846910882, 2281.235786011688, 2284.577353189657, 2163.9242626508076, 2244.2257421189747, 2245.5621153875, 2254.199759085526, 2266.048259730917, 2237.284069097889, 2249.7075380200467, 2263.4567703751063, 2263.841531092824, 2269.217120093573, 2226.209695558086, 2234.497238121426, 2237.1387015998794, 2237.1722462688745, 2238.6530087836413, 7041.5775053496445, 7064.894026589605, 7076.115485564304, 7082.822929426754, 7090.929090709078, 4350.282203436429, 4442.444694413199, 4468.463784345867, 4470.307102399133, 4472.552744725534, 2869.583910333011, 2908.7091290870953, 2918.5768063630653, 2932.1496765937854, 2946.955795663067, 955.6177528988391, 959.8992105828927, 960.6877764726491, 985.3447457440793, 986.4278718343344, 9351.485668288242, 9413.48225847578, 9431.198348140417, 9468.0, 9490.810183796286, 3905.882823515299, 3938.5667576566557, 3977.085270387827, 3982.482277303932, 3991.501062367204, 7898.526088434713, 7907.604619768988, 7918.0, 7940.0471943367165, 7957.084935232522, 4269.060806622538, 4296.3555466680245, 4298.484181898192, 4315.4605674290715, 4323.156984388014, 3901.7463864848696, 3920.9803950980063, 3922.0391004204153, 3950.4074388841905, 3961.3067713150085, 3315.8176300303717, 3328.7669863109836, 3334.8165850878436, 3334.849931753077, 3340.8997730068136, 1004.8141093897652, 1014.1683819268277, 1022.3354819367471, 1022.8516865054526, 1026.820306446369, 929.772205809581, 980.0640388429033, 1067.6156583629886, 1140.321508702321, 1336.5255334356164, 6619.602823830585, 6635.469162466991, 6666.833329166712, 6680.23177334603, 6693.933060669428, 604.4831668923008, 611.0803241122082, 612.8866159760458, 615.7506209984963, 739.6745432009899, 4971.65198436106, 4976.328195693607, 5037.773300201499, 5046.243063540425, 5050.873728156826, 8171.10117887032, 8534.487930724177, 8647.870281945776, 8662.436941598902, 8754.781130471789, 8500.064992850781, 8508.829823403497, 8563.657453701906, 8634.222919937236, 8639.870401943976, 6704.59772413647, 6752.291009444036, 6801.557898736566, 6806.0, 7016.543924644881, 6624.006399039989, 6627.1716035495565, 6655.3344665535, 6688.130543029375, 6726.058351830649, 7623.085229772463, 7717.922820771945, 7725.613719313899, 7780.2219778021745, 7887.566183859943, 7731.34283585879, 7901.960490197513, 7925.564093974886, 7976.7208147714555, 7988.041435027834, 6202.162708034358, 6236.0, 6240.7503699851495, 6258.874822503615, 6262.373762623702, 6529.379708927644, 6641.236257830411, 6656.434203092791, 6665.800025999228, 6669.299723529154, 6391.58454700443, 6431.488600178861, 6448.484121270381, 6491.772787952399, 6669.6665166740495, 6284.24589049317, 6293.622382657055, 6351.587146835441, 6357.332480089709, 6400.423961843457, 6395.776147834804, 6426.742930282923, 6451.387118223761, 6466.547341686225, 6528.836779080561, 5937.703114844154, 5978.0, 5980.850478738066, 6008.489278411384, 6013.729382177725, 6037.215162028908, 6045.335013148638, 6052.969735151472, 6066.484348830399, 6074.42292982166], "unit": "score", "name": "mootools.html", "value": 4113.492297076829}, {"lowerIsBetter": false, "replicates": [336.39616887686606, 340.2073169515029, 340.29898409276876, 348.1644054269753, 349.13588867552795, 6232.439080482755, 6294.7482100715915, 6307.495400367971, 6327.48140446293, 6495.480361571074, 6288.308286088538, 6339.556231063827, 6344.016677415008, 6350.364963503659, 6357.2371315442215, 4831.806727730886, 4833.130036593412, 4835.879103022417, 4840.177169881111, 4846.878828029292, 4835.613150947934, 4835.806567737286, 4836.081144582536, 4841.031793641286, 4841.7337046462435, 4697.271922851964, 4781.760911954406, 4781.760911954406, 4791.089692958344, 4791.3531673224015, 4746.501617330166, 4761.0, 4771.332013518093, 4791.496892826272, 4792.832250871237, 4152.418661387408, 4156.168766246763, 4160.313548264533, 4163.458750362463, 4164.333706606928, 5972.910406343864, 5998.01032829587, 5998.160257563901, 5999.850003749898, 6002.399760023963, 5463.808766693186, 5602.579806514527, 5605.831825045255, 5607.214989901417, 5613.242212301368, 6713.362230588086, 6720.260771315151, 6741.696623651947, 6744.527883048188, 6754.5609535380045, 4613.1696294666945, 4619.769011549442, 4620.838270660511, 4626.444826620794, 4627.444706635191, 6733.831654208635, 6919.342662447059, 6956.582605043714, 6989.93010069903, 7013.82465438363, 4615.976920115378, 4660.930086048712, 4661.114388266218, 4664.486906440289, 4673.0, 4648.628109751212, 4705.7647117644665, 4709.95290047102, 4718.339432479455, 4735.579326202125, 5481.095619222783, 5484.396716361197, 5485.040117979338, 5487.204355368529, 5490.423505531941, 6574.539782215199, 6751.493637977172, 6761.966190169116, 6769.458443324522, 6775.898361524581, 1637.9344826206818, 1658.0549087020524, 1672.105423598369, 1682.7812384390195, 1685.48592679234, 1107.058999850121, 1112.8497652816927, 1115.9274647147909, 1121.4897221764077, 1133.4276190523897, 6124.5100391968535, 6126.632402055891, 6136.662483563447, 6140.263168419819, 6144.07838824171, 6819.693113809891, 6836.726530938707, 6860.211075726355, 6880.967854821817, 6892.0, 6129.172561704113, 6207.906881396782, 6258.499320054385, 6260.373962603794, 6264.060390941304, 3716.442533619979, 3735.831887565066, 3739.1586892948867, 3739.85040598373, 3745.3632882410056, 7121.074260346122, 7162.92837071633, 7184.245654206337, 7190.784276471714, 7212.927870721225, 6950.096487456598, 7026.824329391704, 7031.0, 7042.0, 7064.08166938305, 7260.600666963368, 7297.3432391084, 7316.707331706779, 7325.487215894943, 7329.926700733031, 6977.651117444006, 6980.05769221169, 6989.545679530815, 6993.2657071006815, 7021.122359705037, 6813.523053386413, 6874.793756187322, 6921.861562768817, 6923.653817309215, 6934.514583979275, 7248.89126663111, 7288.198298187089, 7291.125064992023, 7295.52579082358, 7316.122065352191, 4717.811287548459, 4744.074905393415, 4754.667173297974, 4759.405074365704, 4759.571638552408, 6873.759418420332, 6963.303669632996, 6971.407430368273, 6992.30076992317, 6999.545029573062, 6797.728090876507, 6798.52410331272, 6799.2520822708475, 6809.625470599165, 6813.591184528944, 6755.088063111613, 6763.154605674291, 6767.492438067066, 6772.5936443813525, 6777.390034896685, 6521.934780652133, 6600.60396376219, 6617.305182955721, 6652.135222421054, 6655.733770649314, 6766.15423072116, 6774.729010839511, 6808.7276508939085, 6827.01008353776, 6834.350736680008, 6569.441597464078, 6632.767853125118, 6640.269570347161, 6641.169853768279, 6655.534112612071], "unit": "score", "name": "prototype.html", "value": 5037.298325906018}, {"lowerIsBetter": false, "replicates": [847.809242920343, 854.4082404251201, 858.0561382479269, 860.2000139869921, 875.7898104454929, 13254.602361929146, 13382.464701411931, 13435.328233588307, 13439.193648381104, 13474.730505389898, 12581.308028058453, 14187.858121418783, 14423.0, 14449.5665130046, 14450.0, 780.4419839814532, 800.8878756974028, 806.6612022950375, 811.3184924663282, 818.443458448255, 799.7680672604938, 809.8542262392767, 810.3800592546706, 814.0597609760736, 816.3265306122443, 842.7640260727006, 857.2670366836359, 858.6779957515931, 861.7156338408341, 862.560094351882, 839.1692224697566, 848.4103548034119, 851.05957916502, 852.497026754218, 852.6845067325067, 627.1157667688583, 627.2723640576909, 627.7426255235378, 628.1927722876082, 629.8393909553081, 14025.859741402557, 14045.719085618333, 14130.0, 14144.151350918977, 14153.433862645481, 11930.761384772342, 11998.220115692538, 12220.938895305555, 12264.754704905852, 12500.374981250901, 10700.30448020876, 10724.571017159304, 10770.838437423445, 10795.78408431827, 10800.081993030602, 3299.9835000825083, 3352.1284466039006, 3365.697087262158, 3469.410200265961, 3471.9652803471895, 49450.0, 49627.25559116616, 50100.49899501031, 50149.749251253874, 50211.74894125506, 9622.278329125344, 9702.466364349888, 9917.950410247902, 10004.299699021, 10385.117265032406, 17534.210960506807, 17571.38500152514, 17610.735838962424, 17642.029688367005, 17745.645087098444, 7143.464240182007, 7240.348368646847, 7350.77947661571, 7364.374028207662, 7502.58735769527, 4333.921866063226, 4356.607905288539, 4378.846740364072, 4380.132581379255, 4406.603405693503, 2864.3841574061676, 2872.023512005928, 2875.09434528123, 2885.870135843892, 2890.7398334150025, 531.0891820527813, 535.2506490912675, 539.0674133748637, 540.1438719629352, 547.1956224350199, 505.6940550966686, 535.2239253083045, 603.8007457539002, 663.3664850068174, 706.1914108345915, 7479.738209162653, 7779.8833017504785, 7978.082520510099, 8001.799955001172, 8211.384146189059, 607.5746977116037, 659.4295934017041, 673.3670349871105, 673.9562624254473, 690.7340673840507, 3833.8466461341236, 3954.070793363557, 3967.900802479903, 4013.7993100344866, 4064.7561146331313, 57910.7104464475, 58608.41391586115, 58647.41352586505, 58900.41099589035, 58941.70529147413, 51632.22551661728, 52276.47723522716, 52482.21276680853, 52684.0, 52691.0, 46964.0, 47247.52752472431, 47252.29121563179, 47892.521074788805, 48096.759516202896, 7631.275028872248, 7646.65590048438, 7705.075390953121, 7760.30157285847, 7835.882461762964, 32621.0, 32880.83559582187, 32889.506657400634, 33259.667403326624, 33525.83237083799, 37551.0, 38406.23187536178, 38534.80732596319, 38543.80728096342, 45013.77493112644, 10424.426656533964, 10447.582096716047, 11035.944820275847, 11160.441977901235, 11307.830382544433, 10610.469476525988, 10841.67474975752, 10899.073578745896, 11058.502367393647, 11321.7735645285, 11332.433378330885, 11474.082073434272, 11675.065994720233, 11680.707982300171, 12048.638540843789, 11779.96422182455, 12214.08394370408, 12538.122331436713, 12629.368531573567, 12642.810357844455, 11444.771104578029, 11647.825282620937, 11895.583654572049, 11921.82117268259, 11943.641690749291, 9493.715188544355, 9798.461084640414, 9871.851922221316, 10127.240456965905, 10130.290879638354, 8605.2234659045, 8825.735227943173, 8891.510966896883, 9513.809723805623, 10108.0], "unit": "score", "name": "yui.html", "value": 6247.344925159938}], "name": "dromaeo_css", "value": 6772.556816891302}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 113.0, 111.0, 114.0, 121.0, 111.0, 110.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 156.0, 177.0, 134.0, 157.0, 151.0, 130.0, 161.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 163.0, 161.0, 161.0, 165.0, 164.0, 170.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 76.0, 74.0, 75.0, 74.0, 161.0, 72.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 96.0, 97.0, 96.0, 140.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 110.0, 113.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 150.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [68.0, 59.0, 61.0, 61.0, 60.0, 60.0, 61.0, 59.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [72.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 84.0, 84.0, 84.0, 84.0, 86.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 120.0, 124.0, 123.0, 119.0, 121.0, 127.0, 124.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [132.0, 144.0, 140.0, 141.0, 148.0, 144.0, 145.0, 143.0, 144.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 66.0, 68.0, 71.0, 65.0, 69.0, 65.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1512.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [187.89928598271325], "unit": "score", "name": "DeltaBlue", "value": 351.879996}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41551.02040816326], "unit": "score", "name": "RegExp", "value": 21.924491650294712}, {"lowerIsBetter": false, "replicates": [580.3830528148578], "unit": "score", "name": "Splay", "value": 140.40899300000004}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 20433.985692241124}]} 17:08:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20433.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1513.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6772.55"}}} 17:08:36 INFO - Return code: 0 17:08:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:08:36 INFO - # TBPL SUCCESS # 17:08:36 INFO - Running post-action listener: _resource_record_post_action 17:08:36 INFO - Running post-run listener: _resource_record_post_run 17:08:37 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 20480; Write bytes: 554266624; Read time: 24; Write time: 408356 17:08:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 239038464; Read time: 0; Write time: 197264 17:08:37 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 20480; Write bytes: 315228160; Read time: 24; Write time: 211092 17:08:37 INFO - Running post-run listener: _upload_blobber_files 17:08:37 INFO - Blob upload gear active. 17:08:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:08:37 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 17:08:37 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'] 17:08:37 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 17:08:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:38 INFO - (blobuploader) - INFO - Done attempting. 17:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:39 INFO - (blobuploader) - INFO - Done attempting. 17:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:08:39 INFO - Return code: 0 17:08:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01fab132760d5c4a41532ab05f285fed55f52edbad02cbdd6beec9a39c7b15f60268d80b150aab8eb60514b656a2f2ea74c809cc0e4bda1384062a19da24470a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/144362e8f3c8a81960c1f3cfd52610f0aac03c68b0cf82d23b2756d27c6ec875d779d84761ebe6cdfe58dee2f92057981ae147d233ead53318c5d26cd72135fc"} 17:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:08:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:08:39 INFO - Contents: 17:08:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01fab132760d5c4a41532ab05f285fed55f52edbad02cbdd6beec9a39c7b15f60268d80b150aab8eb60514b656a2f2ea74c809cc0e4bda1384062a19da24470a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/144362e8f3c8a81960c1f3cfd52610f0aac03c68b0cf82d23b2756d27c6ec875d779d84761ebe6cdfe58dee2f92057981ae147d233ead53318c5d26cd72135fc"} 17:08:39 INFO - Copying logs to upload dir... 17:08:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.031414 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 17:08:39.095100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 17:08:39.098465) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01fab132760d5c4a41532ab05f285fed55f52edbad02cbdd6beec9a39c7b15f60268d80b150aab8eb60514b656a2f2ea74c809cc0e4bda1384062a19da24470a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/144362e8f3c8a81960c1f3cfd52610f0aac03c68b0cf82d23b2756d27c6ec875d779d84761ebe6cdfe58dee2f92057981ae147d233ead53318c5d26cd72135fc"} build_url:https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/WQr8o1UGSLut_O4unX2mBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01fab132760d5c4a41532ab05f285fed55f52edbad02cbdd6beec9a39c7b15f60268d80b150aab8eb60514b656a2f2ea74c809cc0e4bda1384062a19da24470a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/144362e8f3c8a81960c1f3cfd52610f0aac03c68b0cf82d23b2756d27c6ec875d779d84761ebe6cdfe58dee2f92057981ae147d233ead53318c5d26cd72135fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 17:08:39.122969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 17:08:39.123313) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452731927.213113-1477433792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 17:08:39.208859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 17:08:39.209191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 17:08:39.209482) ========= ========= Total master_lag: 0.24 =========