builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1451995172.64 results: success (0) buildid: 20160105013028 builduid: 6397892ff4244e00a60cbf3b74e9eeb6 revision: e4c738873db5e3dec1b74f2f7ad555c7274ec32b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.644890) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.645441) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.645792) ========= 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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005126 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.668799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.669177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.682504) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.682839) ========= 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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.732649) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.733053) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.733504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.733847) ========= 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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 03:59:33-- 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% 16.6M=0.001s 2016-01-05 03:59:33 (16.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.909594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.910010) ========= 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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014212 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:32.960303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 03:59:32.960712) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e4c738873db5e3dec1b74f2f7ad555c7274ec32b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e4c738873db5e3dec1b74f2f7ad555c7274ec32b --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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 03:59:33,367 truncating revision to first 12 chars 2016-01-05 03:59:33,367 Setting DEBUG logging. 2016-01-05 03:59:33,367 attempt 1/10 2016-01-05 03:59:33,368 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e4c738873db5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 03:59:34,249 unpacking tar archive at: mozilla-inbound-e4c738873db5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.150317 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 03:59:34.126459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:34.126847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:34.136389) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:34.136883) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 03:59:34.137479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-05 03:59:34.137870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:34 INFO - MultiFileLogger online at 20160105 03:59:34 in /builds/slave/test-pgo 03:59:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:59:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:59:34 INFO - {'append_to_log': False, 03:59:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:59:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:59:34 INFO - 'branch': 'Mozilla-Inbound', 03:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:34 INFO - 'config_files': ('talos/linux_config.py',), 03:59:34 INFO - 'default_actions': ('clobber', 03:59:34 INFO - 'read-buildbot-config', 03:59:34 INFO - 'download-and-extract', 03:59:34 INFO - 'populate-webroot', 03:59:34 INFO - 'create-virtualenv', 03:59:34 INFO - 'install', 03:59:34 INFO - 'run-tests'), 03:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:34 INFO - 'download_minidump_stackwalk': True, 03:59:34 INFO - 'download_symbols': 'ondemand', 03:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:34 INFO - 'installer_path': 'installer.exe', 03:59:34 INFO - 'log_level': 'info', 03:59:34 INFO - 'log_name': 'talos', 03:59:34 INFO - 'log_to_console': True, 03:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:34 INFO - 'opt_config_files': (), 03:59:34 INFO - 'pip_index': False, 03:59:34 INFO - 'sps_profile': False, 03:59:34 INFO - 'sps_profile_interval': 0, 03:59:34 INFO - 'suite': 'dromaeojs', 03:59:34 INFO - 'system_bits': '32', 03:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:34 INFO - 'title': 'talos-linux64-ix-023', 03:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:34 INFO - 'use_talos_json': True, 03:59:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:34 INFO - 'work_dir': 'build'} 03:59:34 INFO - ##### 03:59:34 INFO - ##### Running clobber step. 03:59:34 INFO - ##### 03:59:34 INFO - Running pre-action listener: _resource_record_pre_action 03:59:34 INFO - Running main action method: clobber 03:59:34 INFO - rmtree: /builds/slave/test-pgo/build 03:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:59:35 INFO - Running post-action listener: _resource_record_post_action 03:59:35 INFO - ##### 03:59:35 INFO - ##### Running read-buildbot-config step. 03:59:35 INFO - ##### 03:59:35 INFO - Running pre-action listener: _resource_record_pre_action 03:59:35 INFO - Running main action method: read_buildbot_config 03:59:35 INFO - Using buildbot properties: 03:59:35 INFO - { 03:59:35 INFO - "project": "", 03:59:35 INFO - "product": "firefox", 03:59:35 INFO - "script_repo_revision": "production", 03:59:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:59:35 INFO - "repository": "", 03:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:59:35 INFO - "buildid": "20160105013028", 03:59:35 INFO - "pgo_build": "True", 03:59:35 INFO - "basedir": "/builds/slave/test-pgo", 03:59:35 INFO - "buildnumber": 1408, 03:59:35 INFO - "slavename": "talos-linux64-ix-023", 03:59:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:35 INFO - "platform": "ubuntu64_hw", 03:59:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:59:35 INFO - "branch": "mozilla-inbound", 03:59:35 INFO - "repo_path": "integration/mozilla-inbound", 03:59:35 INFO - "revision": "e4c738873db5e3dec1b74f2f7ad555c7274ec32b", 03:59:35 INFO - "stage_platform": "linux64-pgo", 03:59:35 INFO - "builduid": "6397892ff4244e00a60cbf3b74e9eeb6", 03:59:35 INFO - "slavebuilddir": "test" 03:59:35 INFO - } 03:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:59:35 INFO - Running post-action listener: _resource_record_post_action 03:59:35 INFO - ##### 03:59:35 INFO - ##### Running download-and-extract step. 03:59:35 INFO - ##### 03:59:35 INFO - Running pre-action listener: _resource_record_pre_action 03:59:35 INFO - Running main action method: download_and_extract 03:59:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:35 INFO - https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/test_packages.json 03:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/test_packages.json 03:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:59:35 INFO - Downloaded 1302 bytes. 03:59:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:59:35 INFO - Using the following test package requirements: 03:59:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:35 INFO - u'jsshell-linux-x86_64.zip'], 03:59:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:59:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:59:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:35 INFO - https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:36 INFO - Downloaded 24051224 bytes. 03:59: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 03:59:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59: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 03:59:37 INFO - Return code: 0 03:59:37 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 03:59: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')]} 03:59:37 INFO - https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:38 INFO - Downloaded 24051224 bytes. 03:59:38 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 03:59:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:59:38 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 03:59:40 INFO - Return code: 0 03:59:40 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')]} 03:59:40 INFO - https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:41 INFO - Downloaded 11132285 bytes. 03:59:41 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 03:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:59:41 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 03:59:41 INFO - Return code: 0 03:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:41 INFO - https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abvXWGz-TqynAPFKixJlOA/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 03:59:42 INFO - Downloaded 54993080 bytes. 03:59:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:59:42 INFO - mkdir: /builds/slave/test-pgo/properties 03:59:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:59:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:59:42 INFO - Contents: 03:59:42 INFO - build_url:https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:59:42 INFO - Running post-action listener: _resource_record_post_action 03:59:42 INFO - Running post-action listener: set_extra_try_arguments 03:59:42 INFO - ##### 03:59:42 INFO - ##### Running populate-webroot step. 03:59:42 INFO - ##### 03:59:42 INFO - Running pre-action listener: _resource_record_pre_action 03:59:42 INFO - Running main action method: populate_webroot 03:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:42 INFO - '--tppagecycles', 03:59:42 INFO - '7'], 03:59:42 INFO - 'tests': ['tsvgm']}}, 03:59:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:59:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:59:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:59:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'tests': ['damp', 'tps']}, 03:59:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['damp', 'tps']}, 03:59:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:42 INFO - 'other': {'tests': ['a11yr', 03:59:42 INFO - 'ts_paint', 03:59:42 INFO - 'tpaint', 03:59:42 INFO - 'sessionrestore', 03:59:42 INFO - 'sessionrestore_no_auto_restore']}, 03:59:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['a11yr', 03:59:42 INFO - 'ts_paint', 03:59:42 INFO - 'tpaint', 03:59:42 INFO - 'sessionrestore', 03:59:42 INFO - 'sessionrestore_no_auto_restore']}, 03:59:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['a11yr', 03:59:42 INFO - 'ts_paint', 03:59:42 INFO - 'tpaint', 03:59:42 INFO - 'sessionrestore', 03:59:42 INFO - 'sessionrestore_no_auto_restore']}, 03:59:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['a11yr', 03:59:42 INFO - 'ts_paint', 03:59:42 INFO - 'tpaint', 03:59:42 INFO - 'sessionrestore', 03:59:42 INFO - 'sessionrestore_no_auto_restore']}, 03:59:42 INFO - 'other_l64': {'tests': ['a11yr', 03:59:42 INFO - 'ts_paint', 03:59:42 INFO - 'tpaint', 03:59:42 INFO - 'sessionrestore', 03:59:42 INFO - 'sessionrestore_no_auto_restore']}, 03:59:42 INFO - 'other_nol64': {'tests': ['a11yr', 03:59:42 INFO - 'ts_paint', 03:59:42 INFO - 'tpaint', 03:59:42 INFO - 'sessionrestore', 03:59:42 INFO - 'sessionrestore_no_auto_restore']}, 03:59:42 INFO - 'svgr': {'tests': ['tsvgx', 03:59:42 INFO - 'tsvgr_opacity', 03:59:42 INFO - 'tart', 03:59:42 INFO - 'tscrollx', 03:59:42 INFO - 'cart']}, 03:59:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['tsvgx', 03:59:42 INFO - 'tsvgr_opacity', 03:59:42 INFO - 'tart', 03:59:42 INFO - 'tscrollx', 03:59:42 INFO - 'cart']}, 03:59:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'tests': ['tp5o']}, 03:59:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'talos_options': ['--e10s'], 03:59:42 INFO - 'tests': ['tp5o']}, 03:59:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'talos_options': ['--xperf_path', 03:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:42 INFO - 'tests': ['tp5n']}, 03:59:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:42 INFO - 'talos_options': ['--e10s', 03:59:42 INFO - '--xperf_path', 03:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:42 INFO - 'tests': ['tp5n']}}, 03:59:42 INFO - 'talos.zip': {'path': '', 03:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:42 INFO - Running post-action listener: _resource_record_post_action 03:59:42 INFO - ##### 03:59:42 INFO - ##### Running create-virtualenv step. 03:59:42 INFO - ##### 03:59:42 INFO - Running pre-action listener: _resource_record_pre_action 03:59:42 INFO - Running main action method: create_virtualenv 03:59:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:59:42 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 03:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:59:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:42 INFO - Using real prefix '/usr' 03:59:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:59:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:45 INFO - Installing pip.................done. 03:59:45 INFO - Return code: 0 03:59:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:59:45 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')]} 03:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 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')]} 03:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 03:59:45 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 03:59:45 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 03:59:45 INFO - Using env: {'DISPLAY': ':0', 03:59:45 INFO - 'HOME': '/home/cltbld', 03:59:45 INFO - 'LANG': 'en_US.UTF-8', 03:59:45 INFO - 'LANGUAGE': 'en_US:en', 03:59:45 INFO - 'LOGNAME': 'cltbld', 03:59:45 INFO - 'MAIL': '/var/mail/cltbld', 03:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:45 INFO - 'MOZ_NO_REMOTE': '1', 03:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:45 INFO - 'NO_EM_RESTART': '1', 03:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:45 INFO - 'SHELL': '/bin/bash', 03:59:45 INFO - 'SHLVL': '1', 03:59:45 INFO - 'TERM': 'linux', 03:59:45 INFO - 'TMOUT': '86400', 03:59:45 INFO - 'USER': 'cltbld', 03:59:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 03:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:45 INFO - '_': '/tools/buildbot/bin/python'} 03:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:45 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 03:59:45 INFO - Cleaning up... 03:59:45 INFO - Return code: 0 03:59:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:59:45 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')]} 03:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 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')]} 03:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 03:59:45 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 03:59:45 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 03:59:45 INFO - Using env: {'DISPLAY': ':0', 03:59:45 INFO - 'HOME': '/home/cltbld', 03:59:45 INFO - 'LANG': 'en_US.UTF-8', 03:59:45 INFO - 'LANGUAGE': 'en_US:en', 03:59:45 INFO - 'LOGNAME': 'cltbld', 03:59:45 INFO - 'MAIL': '/var/mail/cltbld', 03:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:45 INFO - 'MOZ_NO_REMOTE': '1', 03:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:45 INFO - 'NO_EM_RESTART': '1', 03:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:45 INFO - 'SHELL': '/bin/bash', 03:59:45 INFO - 'SHLVL': '1', 03:59:45 INFO - 'TERM': 'linux', 03:59:45 INFO - 'TMOUT': '86400', 03:59:45 INFO - 'USER': 'cltbld', 03:59:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 03:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:45 INFO - '_': '/tools/buildbot/bin/python'} 03:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:45 INFO - Downloading/unpacking psutil>=0.7.1 03:59:45 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 03:59:45 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 03:59:45 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 03:59:45 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 03:59:45 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 03:59:45 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 03:59:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:59:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:59:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:47 INFO - Installing collected packages: psutil 03:59:47 INFO - Running setup.py install for psutil 03:59:47 INFO - building 'psutil._psutil_linux' extension 03:59:47 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 03:59:47 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 03:59:47 INFO - building 'psutil._psutil_posix' extension 03:59:47 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 03:59:47 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 03:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:47 INFO - Successfully installed psutil 03:59:47 INFO - Cleaning up... 03:59:47 INFO - Return code: 0 03:59:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:59: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')]} 03:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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', '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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 03:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:59: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 mozsystemmonitor==0.0.0 03:59:47 INFO - Using env: {'DISPLAY': ':0', 03:59:47 INFO - 'HOME': '/home/cltbld', 03:59:47 INFO - 'LANG': 'en_US.UTF-8', 03:59:47 INFO - 'LANGUAGE': 'en_US:en', 03:59:47 INFO - 'LOGNAME': 'cltbld', 03:59:47 INFO - 'MAIL': '/var/mail/cltbld', 03:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:47 INFO - 'MOZ_NO_REMOTE': '1', 03:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:47 INFO - 'NO_EM_RESTART': '1', 03:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:47 INFO - 'SHELL': '/bin/bash', 03:59:47 INFO - 'SHLVL': '1', 03:59:47 INFO - 'TERM': 'linux', 03:59:47 INFO - 'TMOUT': '86400', 03:59:47 INFO - 'USER': 'cltbld', 03:59:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 03:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:47 INFO - '_': '/tools/buildbot/bin/python'} 03:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:59:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:59:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:59:49 INFO - Installing collected packages: mozsystemmonitor 03:59:49 INFO - Running setup.py install for mozsystemmonitor 03:59:49 INFO - Successfully installed mozsystemmonitor 03:59:49 INFO - Cleaning up... 03:59:50 INFO - Return code: 0 03:59:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:50 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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 03:59:50 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 03:59:50 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 03:59:50 INFO - Using env: {'DISPLAY': ':0', 03:59:50 INFO - 'HOME': '/home/cltbld', 03:59:50 INFO - 'LANG': 'en_US.UTF-8', 03:59:50 INFO - 'LANGUAGE': 'en_US:en', 03:59:50 INFO - 'LOGNAME': 'cltbld', 03:59:50 INFO - 'MAIL': '/var/mail/cltbld', 03:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:50 INFO - 'MOZ_NO_REMOTE': '1', 03:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:50 INFO - 'NO_EM_RESTART': '1', 03:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:50 INFO - 'SHELL': '/bin/bash', 03:59:50 INFO - 'SHLVL': '1', 03:59:50 INFO - 'TERM': 'linux', 03:59:50 INFO - 'TMOUT': '86400', 03:59:50 INFO - 'USER': 'cltbld', 03:59:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 03:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:50 INFO - '_': '/tools/buildbot/bin/python'} 03:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:59:50 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 03:59:50 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 03:59:50 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 03:59:50 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 03:59:50 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 03:59:50 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 03:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:59:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:59:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:52 INFO - Downloading docopt-0.6.1.tar.gz 03:59:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:59:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:52 INFO - Running setup.py install for blobuploader 03:59:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:59:52 INFO - Running setup.py install for requests 03:59:53 INFO - Running setup.py install for docopt 03:59:53 INFO - Successfully installed blobuploader requests docopt 03:59:53 INFO - Cleaning up... 03:59:53 INFO - Return code: 0 03:59:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:53 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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 03:59:53 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 03:59:53 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 03:59:53 INFO - Using env: {'DISPLAY': ':0', 03:59:53 INFO - 'HOME': '/home/cltbld', 03:59:53 INFO - 'LANG': 'en_US.UTF-8', 03:59:53 INFO - 'LANGUAGE': 'en_US:en', 03:59:53 INFO - 'LOGNAME': 'cltbld', 03:59:53 INFO - 'MAIL': '/var/mail/cltbld', 03:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:53 INFO - 'MOZ_NO_REMOTE': '1', 03:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:53 INFO - 'NO_EM_RESTART': '1', 03:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:53 INFO - 'SHELL': '/bin/bash', 03:59:53 INFO - 'SHLVL': '1', 03:59:53 INFO - 'TERM': 'linux', 03:59:53 INFO - 'TMOUT': '86400', 03:59:53 INFO - 'USER': 'cltbld', 03:59:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 03:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:53 INFO - '_': '/tools/buildbot/bin/python'} 03:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:59:53 INFO - Running setup.py (path:/tmp/pip-qX7e0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:59:53 INFO - Running setup.py (path:/tmp/pip-b6NmLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:59:53 INFO - Running setup.py (path:/tmp/pip-MtI9TU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:59:53 INFO - Running setup.py (path:/tmp/pip-_KmX7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:59:53 INFO - Running setup.py (path:/tmp/pip-c615_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:59:53 INFO - Running setup.py (path:/tmp/pip-Es1VOc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:59:53 INFO - Running setup.py (path:/tmp/pip-QbGhpa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:59:53 INFO - Running setup.py (path:/tmp/pip-zXbWmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:59:53 INFO - Running setup.py (path:/tmp/pip-wI5cH4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:59:54 INFO - Running setup.py (path:/tmp/pip-eI7cgz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:59:54 INFO - Running setup.py (path:/tmp/pip-jYd8Sr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:59:54 INFO - Running setup.py (path:/tmp/pip-61IzMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:59:54 INFO - Running setup.py (path:/tmp/pip-097gLb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:59:54 INFO - Running setup.py (path:/tmp/pip-ombGYH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:59:54 INFO - Running setup.py (path:/tmp/pip-hhu986-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:59:54 INFO - Running setup.py (path:/tmp/pip-7fZCfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:59:54 INFO - Running setup.py (path:/tmp/pip-pFeVQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:59:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:54 INFO - Running setup.py install for manifestparser 03:59:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:59:54 INFO - Running setup.py install for mozcrash 03:59:54 INFO - Running setup.py install for mozdebug 03:59:54 INFO - Running setup.py install for mozdevice 03:59:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Running setup.py install for mozfile 03:59:55 INFO - Running setup.py install for mozhttpd 03:59:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Running setup.py install for mozinfo 03:59:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Running setup.py install for mozInstall 03:59:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Running setup.py install for mozleak 03:59:55 INFO - Running setup.py install for mozlog 03:59:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Running setup.py install for moznetwork 03:59:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Running setup.py install for mozprocess 03:59:55 INFO - Running setup.py install for mozprofile 03:59:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:59:55 INFO - Running setup.py install for mozrunner 03:59:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:59:56 INFO - Running setup.py install for mozscreenshot 03:59:56 INFO - Running setup.py install for moztest 03:59:56 INFO - Running setup.py install for mozversion 03:59:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:59:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:56 INFO - Cleaning up... 03:59:56 INFO - Return code: 0 03:59:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:56 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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 03:59:56 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 03:59:56 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 03:59:56 INFO - Using env: {'DISPLAY': ':0', 03:59:56 INFO - 'HOME': '/home/cltbld', 03:59:56 INFO - 'LANG': 'en_US.UTF-8', 03:59:56 INFO - 'LANGUAGE': 'en_US:en', 03:59:56 INFO - 'LOGNAME': 'cltbld', 03:59:56 INFO - 'MAIL': '/var/mail/cltbld', 03:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:56 INFO - 'MOZ_NO_REMOTE': '1', 03:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:56 INFO - 'NO_EM_RESTART': '1', 03:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:56 INFO - 'SHELL': '/bin/bash', 03:59:56 INFO - 'SHLVL': '1', 03:59:56 INFO - 'TERM': 'linux', 03:59:56 INFO - 'TMOUT': '86400', 03:59:56 INFO - 'USER': 'cltbld', 03:59:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 03:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:56 INFO - '_': '/tools/buildbot/bin/python'} 03:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:59:56 INFO - Running setup.py (path:/tmp/pip-GHDbXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:59:56 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)) 03:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:59:56 INFO - Running setup.py (path:/tmp/pip-yGGxTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:59:56 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)) 03:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:59:56 INFO - Running setup.py (path:/tmp/pip-4rzwhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:59:56 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)) 03:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:59:56 INFO - Running setup.py (path:/tmp/pip-UBDzMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 03:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:59:56 INFO - Running setup.py (path:/tmp/pip-k3S2j8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:59:56 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)) 03:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:59:56 INFO - Running setup.py (path:/tmp/pip-9kN_uc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:59:57 INFO - Running setup.py (path:/tmp/pip-xaYa8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:59:57 INFO - Running setup.py (path:/tmp/pip-n2uNsk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:59:57 INFO - Running setup.py (path:/tmp/pip-l6qSZm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:59:57 INFO - Running setup.py (path:/tmp/pip-oIq61H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:59:57 INFO - Running setup.py (path:/tmp/pip-m6WQoF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:59:57 INFO - Running setup.py (path:/tmp/pip-eK3zpe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:59:57 INFO - Running setup.py (path:/tmp/pip-7qenFT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:59:57 INFO - Running setup.py (path:/tmp/pip-u1qVTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:59:57 INFO - Running setup.py (path:/tmp/pip-nfonKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:59:57 INFO - Running setup.py (path:/tmp/pip-7ue604-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:59:57 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)) 03:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:59:57 INFO - Running setup.py (path:/tmp/pip-QTx3tZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:59:57 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)) 03:59:57 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)) 03:59:57 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)) 03:59:57 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)) 03:59:57 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:57 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - Downloading blessings-1.5.1.tar.gz 03:59:59 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 03:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:59 INFO - Installing collected packages: blessings 03:59:59 INFO - Running setup.py install for blessings 03:59:59 INFO - Successfully installed blessings 03:59:59 INFO - Cleaning up... 03:59:59 INFO - Return code: 0 03:59:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:59:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:59:59 INFO - Reading from file tmpfile_stdout 03:59:59 INFO - Current package versions: 03:59:59 INFO - argparse == 1.2.1 03:59:59 INFO - blessings == 1.5.1 03:59:59 INFO - blobuploader == 1.2.4 03:59:59 INFO - docopt == 0.6.1 03:59:59 INFO - manifestparser == 1.1 03:59:59 INFO - mozInstall == 1.12 03:59:59 INFO - mozcrash == 0.16 03:59:59 INFO - mozdebug == 0.1 03:59:59 INFO - mozdevice == 0.47 03:59:59 INFO - mozfile == 1.2 03:59:59 INFO - mozhttpd == 0.7 03:59:59 INFO - mozinfo == 0.9 03:59:59 INFO - mozleak == 0.1 03:59:59 INFO - mozlog == 3.1 03:59:59 INFO - moznetwork == 0.27 03:59:59 INFO - mozprocess == 0.22 03:59:59 INFO - mozprofile == 0.28 03:59:59 INFO - mozrunner == 6.11 03:59:59 INFO - mozscreenshot == 0.1 03:59:59 INFO - mozsystemmonitor == 0.0 03:59:59 INFO - moztest == 0.7 03:59:59 INFO - mozversion == 1.4 03:59:59 INFO - psutil == 3.1.1 03:59:59 INFO - requests == 1.2.3 03:59:59 INFO - wsgiref == 0.1.2 03:59:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:59:59 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')]} 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:59 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')]} 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:59 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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 03:59:59 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 03:59:59 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 03:59:59 INFO - Using env: {'DISPLAY': ':0', 03:59:59 INFO - 'HOME': '/home/cltbld', 03:59:59 INFO - 'LANG': 'en_US.UTF-8', 03:59:59 INFO - 'LANGUAGE': 'en_US:en', 03:59:59 INFO - 'LOGNAME': 'cltbld', 03:59:59 INFO - 'MAIL': '/var/mail/cltbld', 03:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:59 INFO - 'MOZ_NO_REMOTE': '1', 03:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:59 INFO - 'NO_EM_RESTART': '1', 03:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:59 INFO - 'SHELL': '/bin/bash', 03:59:59 INFO - 'SHLVL': '1', 03:59:59 INFO - 'TERM': 'linux', 03:59:59 INFO - 'TMOUT': '86400', 03:59:59 INFO - 'USER': 'cltbld', 03:59:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 03:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:59 INFO - '_': '/tools/buildbot/bin/python'} 04:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 INFO - Cleaning up... 04:00:00 INFO - Return code: 0 04:00:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 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 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 04:00:00 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 04:00:00 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 04:00:00 INFO - Using env: {'DISPLAY': ':0', 04:00:00 INFO - 'HOME': '/home/cltbld', 04:00:00 INFO - 'LANG': 'en_US.UTF-8', 04:00:00 INFO - 'LANGUAGE': 'en_US:en', 04:00:00 INFO - 'LOGNAME': 'cltbld', 04:00:00 INFO - 'MAIL': '/var/mail/cltbld', 04:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:00 INFO - 'MOZ_NO_REMOTE': '1', 04:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:00 INFO - 'NO_EM_RESTART': '1', 04:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:00 INFO - 'SHELL': '/bin/bash', 04:00:00 INFO - 'SHLVL': '1', 04:00:00 INFO - 'TERM': 'linux', 04:00:00 INFO - 'TMOUT': '86400', 04:00:00 INFO - 'USER': 'cltbld', 04:00:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 04:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:00 INFO - '_': '/tools/buildbot/bin/python'} 04:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:00 INFO - Downloading/unpacking jsonschema 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:02 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 04:00:02 INFO - Downloading/unpacking functools32 (from jsonschema) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:02 INFO - warning: no files found matching '*.txt' 04:00:02 INFO - no previously-included directories found matching 'build' 04:00:02 INFO - no previously-included directories found matching 'dist' 04:00:02 INFO - no previously-included directories found matching '.git*' 04:00:02 INFO - Installing collected packages: jsonschema, functools32 04:00:02 INFO - Running setup.py install for functools32 04:00:02 INFO - warning: no files found matching '*.txt' 04:00:02 INFO - no previously-included directories found matching 'build' 04:00:02 INFO - no previously-included directories found matching 'dist' 04:00:02 INFO - no previously-included directories found matching '.git*' 04:00:02 INFO - Successfully installed jsonschema functools32 04:00:02 INFO - Cleaning up... 04:00:02 INFO - Return code: 0 04:00:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:00: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')]} 04:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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')]} 04:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f235d2e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, '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': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', '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 04:00: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', 'flake8'] in /builds/slave/test-pgo/build 04:00: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 flake8 04:00:02 INFO - Using env: {'DISPLAY': ':0', 04:00:02 INFO - 'HOME': '/home/cltbld', 04:00:02 INFO - 'LANG': 'en_US.UTF-8', 04:00:02 INFO - 'LANGUAGE': 'en_US:en', 04:00:02 INFO - 'LOGNAME': 'cltbld', 04:00:02 INFO - 'MAIL': '/var/mail/cltbld', 04:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:02 INFO - 'MOZ_NO_REMOTE': '1', 04:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:02 INFO - 'NO_EM_RESTART': '1', 04:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:02 INFO - 'SHELL': '/bin/bash', 04:00:02 INFO - 'SHLVL': '1', 04:00:02 INFO - 'TERM': 'linux', 04:00:02 INFO - 'TMOUT': '86400', 04:00:02 INFO - 'USER': 'cltbld', 04:00:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 04:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:02 INFO - '_': '/tools/buildbot/bin/python'} 04:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:02 INFO - Downloading/unpacking flake8 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:00:04 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 04:00:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:00:04 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 04:00:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:04 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 04:00:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00: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 04:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:00:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:05 INFO - no previously-included directories found matching 'docs/_build' 04:00:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:00:05 INFO - Running setup.py install for pep8 04:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:05 INFO - no previously-included directories found matching 'docs/_build' 04:00:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:00:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:00:05 INFO - Cleaning up... 04:00:05 INFO - Return code: 0 04:00:05 INFO - Running post-action listener: _resource_record_post_action 04:00:05 INFO - Running post-action listener: _start_resource_monitoring 04:00:05 INFO - Starting resource monitoring. 04:00:05 INFO - ##### 04:00:05 INFO - ##### Running install step. 04:00:05 INFO - ##### 04:00:05 INFO - Running pre-action listener: _resource_record_pre_action 04:00:05 INFO - Running main action method: install 04:00:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:00:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:00:05 INFO - Reading from file tmpfile_stdout 04:00:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:00:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:00:05 INFO - Reading from file tmpfile_stdout 04:00:05 INFO - Output received: 04:00:05 INFO - Usage: mozinstall [options] installer 04:00:05 INFO - Options: 04:00:05 INFO - -h, --help show this help message and exit 04:00:05 INFO - -d DEST, --destination=DEST 04:00:05 INFO - Directory to install application into. [default: 04:00:05 INFO - "/builds/slave/test-pgo"] 04:00:05 INFO - --app=APP Application being installed. [default: firefox] 04:00:05 INFO - mkdir: /builds/slave/test-pgo/build/application 04:00:05 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'] 04:00:05 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 04:00:21 INFO - Reading from file tmpfile_stdout 04:00:21 INFO - Output received: 04:00:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:00:21 INFO - Running post-action listener: _resource_record_post_action 04:00:21 INFO - ##### 04:00:21 INFO - ##### Running run-tests step. 04:00:21 INFO - ##### 04:00:21 INFO - Running pre-action listener: _resource_record_pre_action 04:00:21 INFO - Running main action method: run_tests 04:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:00:21 INFO - Python 2.7.3 04:00:21 INFO - Return code: 0 04:00:21 INFO - grabbing minidump binary from tooltool 04:00:21 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')]} 04:00:21 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 0xf197f0>, '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 0xe852d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe85760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:00:21 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 04:00:21 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 04:00:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:21 INFO - Return code: 0 04:00:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:00:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:00:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:00:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:00:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:00:22 INFO - Return code: 0 04:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:00:22 INFO - Using env: {'DISPLAY': ':0', 04:00:22 INFO - 'HOME': '/home/cltbld', 04:00:22 INFO - 'LANG': 'en_US.UTF-8', 04:00:22 INFO - 'LANGUAGE': 'en_US:en', 04:00:22 INFO - 'LOGNAME': 'cltbld', 04:00:22 INFO - 'MAIL': '/var/mail/cltbld', 04:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:22 INFO - 'MOZ_NO_REMOTE': '1', 04:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:22 INFO - 'NO_EM_RESTART': '1', 04:00:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:00:22 INFO - 'SHELL': '/bin/bash', 04:00:22 INFO - 'SHLVL': '1', 04:00:22 INFO - 'TERM': 'linux', 04:00:22 INFO - 'TMOUT': '86400', 04:00:22 INFO - 'USER': 'cltbld', 04:00:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063', 04:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:22 INFO - '_': '/tools/buildbot/bin/python'} 04:00:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:00:22 INFO - mozversion application_buildid: 20160105013028 04:00:22 INFO - mozversion application_changeset: e4c738873db5e3dec1b74f2f7ad555c7274ec32b 04:00:22 INFO - mozversion application_display_name: Nightly 04:00:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:22 INFO - mozversion application_name: Firefox 04:00:22 INFO - mozversion application_remotingname: firefox 04:00:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:00:22 INFO - mozversion application_vendor: Mozilla 04:00:22 INFO - mozversion application_version: 46.0a1 04:00:22 INFO - mozversion platform_buildid: 20160105013028 04:00:22 INFO - mozversion platform_changeset: e4c738873db5e3dec1b74f2f7ad555c7274ec32b 04:00:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:00:22 INFO - mozversion platform_version: 46.0a1 04:00:22 INFO - using testdate: 1451995222 04:00:22 INFO - actual date: 1451995222 04:00:22 INFO - starting webserver on 'localhost:43734' 04:00:22 INFO - SUITE-START | Running 3 tests 04:00:22 INFO - TEST-START | dromaeo_css 04:00:22 INFO - operating with platform_type : linux_ 04:00:22 INFO - Initialising browser for dromaeo_css test... 04:00:22 INFO - TEST-INFO | started process 682 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUu3vwk/profile http://localhost:43734/getInfo.html) 04:00:26 INFO - PROCESS | 682 | __metrics Screen width/height:1600/1200 04:00:26 INFO - PROCESS | 682 | colorDepth:24 04:00:26 INFO - PROCESS | 682 | Browser inner width/height: 1024/697 04:00:26 INFO - PROCESS | 682 | __metrics 04:00:26 INFO - PROCESS | 682 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:00:26 INFO - PROCESS | 682 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:00:27 INFO - TEST-INFO | 682: exit 0 04:00:27 INFO - Browser initialized. 04:00:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:27 INFO - TEST-INFO | started process 777 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUu3vwk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:39 INFO - PROCESS | 777 | RSS: Main: 150130688 04:00:39 INFO - PROCESS | 777 | 04:01:31 INFO - PROCESS | 777 | 1451995291175 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] 04:03:39 INFO - PROCESS | 777 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43734/tests/dromaeo/cssquery-ext.html) 04:03:40 INFO - PROCESS | 777 | RSS: Main: 239263744 04:03:40 INFO - PROCESS | 777 | 04:06:42 INFO - PROCESS | 777 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-ext.html (next: http://localhost:43734/tests/dromaeo/cssquery-jquery.html) 04:06:43 INFO - PROCESS | 777 | RSS: Main: 240283648 04:06:43 INFO - PROCESS | 777 | 04:09:45 INFO - PROCESS | 777 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43734/tests/dromaeo/cssquery-mootools.html) 04:09:46 INFO - PROCESS | 777 | RSS: Main: 231124992 04:09:46 INFO - PROCESS | 777 | 04:12:47 INFO - PROCESS | 777 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43734/tests/dromaeo/cssquery-prototype.html) 04:12:48 INFO - PROCESS | 777 | RSS: Main: 217419776 04:12:48 INFO - PROCESS | 777 | 04:15:51 INFO - PROCESS | 777 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43734/tests/dromaeo/cssquery-yui.html) 04:15:51 INFO - PROCESS | 777 | RSS: Main: 220889088 04:15:51 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-yui.html (next: http://localhost:43734/tests/dromaeo/cssquery-dojo.html) 04:18:54 INFO - PROCESS | 777 | RSS: Main: 281182208 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | __start_tp_report 04:18:54 INFO - PROCESS | 777 | _x_x_mozilla_page_load 04:18:54 INFO - PROCESS | 777 | _x_x_mozilla_page_load_details 04:18:54 INFO - PROCESS | 777 | |i|pagename|runs| 04:18:54 INFO - PROCESS | 777 | |0;dojo.html;3095.8297293648848;3133.6396314423846;3135.3102317490157;3173.984519829907;3204.663510331415;5099.898002039957;5213.635045546808;5222.843314700555;5227.634065615403;5287.365516138064;5184.662996905198;5221.843344699656;5227.660202086861;5280.287161233232;5326.733663316838;4732.787024583902;4738.076075165344;4760.3811504504365;4775.832845850396;4865.14859899518;4818.325434439182;4839.975800121012;4851.9810839723705;4889.584385327252;4930.728809915453;4663.836765713184;4705.223638099709;4759.976200119012;4813.56677898989;4817.421909370881;4787.186178349689;4796.880077998043;4810.8316208932865;4815.566599006072;4820.855374338776;4752.643551733634;4756.28655701644;4764.976175119137;4766.189747742857;4801.831935882262;4944.456109827916;5015.348004759395;5034.320366750479;5046;5099.541041306263;5598.356189038272;5600.1599760035915;5608.943910560883;5612.214289999403;5617.101263797814;5648.265725455664;5657.717114144276;5658.886822263573;5665.49010589049;5668.376478587352;5161.974190129025;5217.243499692561;5253.605979551549;5255.816046438356;5280.260763493114;5818.243628328375;5835.095560188178;5863;5868.794592189253;5874.471297583153;5568.053430916673;5568.081266591048;5569.832905012856;5570.387257401682;5572.888542229214;5535.7785688572;5568.749406276727;5620.606557540933;5651.321841378978;5656.490915817596;5573.331200255914;5632.690202038927;5637.802676906289;5642.23829782974;5685.976524225679;5578.079616863172;5593.049181639131;5594.300712410949;5595.4124816894455;5596.4123767003875;4234.9364759528635;4345.891352716208;4346.47842258931;4351.3472979053395;4387.780610969438;3906.7851268180525;3907.3357529219534;3949.4865667463046;3949.881503554898;3951.5258169019326;5195.48045195485;5222.764975576109;5266.34170728659;5294.205869119586;5301.390340110859;5624.29696287964;5644.8024319148635;5648.491635752802;5653.378128405872;5653.660780353192;5251.422343542207;5266.1574148136115;5269.973650131725;5271.103912334912;5319.8138065168305;4677.204875171161;4779.522047795263;4814.566688998007;4821.2045012573235;4862.756862156878;5755.942440575541;5783.450572195635;5804.680742559115;5805.622634528742;5805.8548536286935;5471.2887324647545;5605.523530499871;5611.298587676541;5622.971885140548;5656.321241451053;5704.885902281848;5772.797952071657;5789.623674461147;5876.382979787061;5925.05199168131;5549.611527193058;5557.638753481173;5558.305211848519;5567.137093750475;5571.665700057847;5508.862278443071;5633.887322253614;5636.689982051026;5641.887162256814;5642.689652069175;5467.644603100945;5473.863153421196;5474.343078830566;5516.227728118147;5530.889382212253;5464.153056276284;5465.754041068241;5468.7539060741565;5472.2065300531995;5485.725713714378;5215.869603259949;5304.257403963526;5380.112281473513;5393.6224464287125;5440.129579267298;5425.620206585501;5487.862803429786;5494.230807686847;5503.449655034625;5550.278463799842;5370.865728356823;5397.163439666858;5401.540869026177;5405.702686352289;5438.211459338453 04:18:54 INFO - PROCESS | 777 | |1;ext.html;513.1558586125823;522.9111051121309;525.5322762741162;541.8564080518662;547.8602956246159;28334.149975500743;35836.641633583655;36305.27389452209;36308.092297692536;36383.454248186295;40362;40923.386149207785;40924;40930.38604420936;40946.11011953867;7384.889226661604;7457.403407727396;8378.12029736878;8547.05982341945;8548.230659240668;10060.195184385268;10265.794684106313;10268.435236062014;10270.589176432934;10280.331778434378;9818.11636952674;9877.604895804196;9916.90083099167;9923.354981926188;9929.602815887356;7564.659590318422;7645.350145237661;9911;10030.398176109456;10278.383297002129;9700.466474343908;9744.95127524365;9811.411315321104;9855.408675479423;9860.457674827881;36449.453258201145;36819.81590092032;36850.262994739955;36881.15594220305;36913.261734765154;3187.8406079696156;3240.7893486923276;3321.9003429897143;3516.49010893419;3762.7742335459684;28262.434751305063;28508.714912850814;28675.283117922012;30356;31080.222994425094;3944.921101577981;3965.306071437487;3971.225611005855;4000.5399379071487;4111.527174374955;259058;260478;260992;261168.6941565299;262723;48624.75687621539;49334.75332623314;55912;56261.718691406284;59766.02339765988;57513.712431437576;57663.711681441324;57816.42183578195;57933.420665793645;57956.71021644865;15794.684106317809;16269.267882945296;16278.186090695417;16391.03307603095;16396.590085247964;12271.079669024859;12410.131290809557;12476.126671133115;12605.621831345074;12614.936925315315;18920.33778817735;19048.90475547641;19156.32952846644;19177.52056198606;19210;7217.603031833194;7413.925860741431;7450.254974502506;7461.253874612496;7560.319571238615;903.2818908967387;909.9044600316871;953.814006268771;1043.7390652336917;1055.5380797595385;29031.85484072566;30033.549496757565;30704.232394189876;30847.69152308493;31018.68981310203;1005.0401866217744;1020.806046851096;1046.0951277145214;1121.125522092769;1172.3903570143648;13963.162210267417;14048.789268160986;14112.223827689575;14156.929215353857;14252.358643861051;307453;308424;310320;312840;313639;49525;49663.50336496589;49696.50303496991;49860.50139498631;49952.75023624858;1337.404854839587;1343.603636927109;1367.0840536840342;1367.5623800383783;1374.5051781358702;25919.22242332733;27085.864570677022;27345.72654273432;27497;28889.133326000254;42565.57434425616;43006.35490467708;43559.34660980151;48312.275315869585;49300.26049609187;193988;194162;195060;195274;196001;26970.32574185661;28638.713612864438;28893.133206003855;29132.27169320784;29160.27099322534;31877.840610796797;35063.948081557595;40064.59935400609;40937.181256375305;41254.38118428166;34789.62547506761;34842.47736284009;35178.12054698653;35841.641583584875;36178.27643447169;34166.82916585401;34286.82856585701;34343.82828085843;34635.307293853475;34722.82638586892;34201.144971375914;34486;34867.4769878447;36836.26327473489;36981.26037479182;32414.675853242108;34346.80521556657;34497.82751086329;34625.30749385049;34911.476327854594;25594.74405255998;25598.61602075933;25834.741652583234;25885.352866178495;25949.740502595487 04:18:54 INFO - PROCESS | 777 | |2;jquery.html;350.84396912174384;357.619135620564;357.95167652366956;358.546438754975;360.90616439725665;13450.260235687034;13750.449982000708;15533.844661553396;15733.921330393361;16081;15700.842991570082;16012.279447424864;16757.581060473494;16775.664486710288;16789.061914165035;5189.6107791915565;5512.779488820463;5521.282233309664;5521.613487055908;5533.6403133796375;4045.858394956177;4133.256013917494;5457.181422786594;5707.14392841073;5918.348981612019;5815.185873977646;5838.503727183194;5846.093855452412;5863.941360586382;5871.500922421599;5738;5992.3408425072985;6015.157877897098;6022.066579680157;6024.698765061729;5255.527002569749;5256.605754568384;5260.368755749335;5280;5287.233351164098;12440.688982775413;12446.06654500907;16172.595685107848;19143.234270629157;19721.21115155392;2103.684447332897;2114.95770084599;2119.973240169482;2148.677698345245;2237.5301186750803;9098.454092754457;9249.630014799468;9403.62385504579;11370.260933039408;11680.247962805563;1677.6728537935107;1763.4268862619572;1817.7091665333614;1886.311496303853;1886.962260754791;56594.43405565933;60172.39827601756;60766;61875.07187392148;62963.685181574256;10141.543630536644;10255.846162307571;10270.486475676187;10274;10344.689659310232;13634.590962271148;13641.658958525917;13648.112872663245;13653;13661.316934153252;7658.578778167254;7887.487313324616;7906.802329941797;7930.5638189898955;7933.603319834101;7792.376609871197;7821.100573434014;7821.100573434128;7878.054633444023;7899.407544434075;4243.957560424356;4347.673924455678;4473.977630111829;4503.144402563503;4522.525134860793;1625.8699304055647;1667.483080245128;1814.5735752098246;1854.2212270846278;1856.8487537726696;855.5978690015683;930.6835675870101;989.9109080182674;1001.8447140693204;1035.4563853976572;14946.850531494763;16335.26491307894;16704.498865034067;17230.827691723174;17522.12389380526;923.7598224461689;926.5876684875301;948.6757444261586;948.8529277961927;964.3490643815396;9500.23998080152;9547.90452095484;10066.748331291776;10197.592096316064;10222.948885255526;554631;556636;569009.8594084368;570283;570337;78190;79666;82170;82245;82401;1030.8196065688473;1050.6007717067466;1052.2476429353048;1167.4688016952437;1193.7015746063485;15198.772018419511;15639.452619158275;15890.920545397661;15997.520074397788;16059.598510036874;34030.65969340275;34352.141196470286;34833.47749783806;34989.47515787316;35186.648133518334;41777;42487;43049.354259686756;43926.560734393526;46384.91267892886;9094.59074341643;9411.10594493522;9549;9558.665446709332;9573.473458959545;11142.052925501423;11172.664820055412;11274.718132046437;12603.18079324841;12713.364331783188;14124.2937853109;14327.78508322397;14334.713305734036;14440.422383104979;15115;14467.49363772305;14676.55970320892;14727.92636036813;14739.705205896036;14816.703665926405;14087;14381.9280903599;14493;14504.202268875313;14900.254987250812;8967.910320896708;9045.276377889884;9422.905770942478;9581.664641737785;9764.902350976683;9288.117628825521;13262.602121936357;14039.50861719835;14349.64125896861;14500.85499144995 04:18:54 INFO - PROCESS | 777 | |3;mootools.html;1303.328785675378;1442.6177063078283;1443.5741456270403;1595.744680851064;1805.2147315917568;6716.899246511306;7280.817979550514;7393.999999999994;7397.075365579302;7410.851782964338;7208.387287080592;7408.111026676806;7420.072490938633;7421.925780742191;7423.480356375056;2225.1544413122992;2260.3219034289646;2265.3090807303765;2268.875211863347;2269.909203631853;2224.254874617005;2253.966190507144;2289.1186893046215;2290.9312720618323;2295.621222498286;2229.3423440085135;2242.0471299697647;2250.8199344052437;2251.223327951854;2278.54429114177;2202.053117159621;2220.400491867195;2244.2818298144603;2247.5954328220914;2252.6395776675736;2233.3188377544843;2260.028187879211;2260.5930932432157;2261.694671219397;2262.3326118794994;6490.967545162292;6591.967040164816;7382.7046918123215;7455.142658594223;7470.140933792629;4355.695101342907;4453.755043472608;4467.24056910326;4482.170798402306;4486.955130448719;2891.551809469536;2894.8986785462407;2971.0492642354457;2972.7027297270315;3018.7132222439054;958.108958668438;967.9516024198762;976.7851072763981;993.9105480506789;1021.6168936648756;10349.534270957825;10374.740631484197;10402.47987600617;10404.739881502946;10432.947835260851;4126.546079931205;4174.165166966619;4193.1404062167185;4232.809523571446;4237.449131612871;8924.330675199386;8934.463932164092;8945.821083578292;8960.238379737795;8960.910390896008;4600;4657.301404789308;4658.114958157939;4661.813527458931;4662.650301227422;4210.6841986851105;4253.3194688849635;4257.57424257578;4257.638100761408;4258.701890867672;3438.4670376091744;3475.687188153028;3491.6857482826667;3493.2314890724;3523.2601153757996;1119.9776004479866;1129.2885482146196;1130.2540323386525;1132.4451019000794;1134.5235001299475;1279.5073896549895;1305.092960392537;1317.4071667749552;1340.6246251049722;1345.2869978911192;7069.929300706927;7109.786706398816;7152.749653762094;7153.141623005273;7161.92838071623;481.87712133406455;491.9458859525449;493.64210947063094;496.18873142412417;501.3557578511668;5243.501867322599;5587.636803607753;5635.859103522363;5650.124230744241;5652.802151924663;8258.339332853357;8458.788530286793;8654.480731156025;8687.044425113232;8690.04409514953;8368.707095251759;8378.706745263886;8391.538465384463;8408.369372297102;8458.450200736932;6850.417714494224;6963.059986901805;6964;7014.859702805916;7017.789466316019;6633;6656.2345330287635;6668.299828517936;6668.333166683293;6710.899336510054;7823.687052517836;7904.723334683258;7929.444938854225;7966.920330796618;8089.312408445113;8193.426460147732;8208.261256486945;8319.542425166674;8333.37499687538;8367.163283671583;6474.223093228843;6627.602343859191;6635.867282654416;6639.203295604559;6639.800805975829;7119.572825630272;7156;7160;7160.641967901688;7166.928330716834;6580.736770529125;6608.669566521751;6616.735330586723;6694.430973367318;6745.920652695545;6504.089427480251;6521.64130972801;6568.7372505099265;6582.8354291143105;6625.701843416961;6563.7702680405955;6565.967170164118;6600.8349791255605;6603.9009414859775;6635.734570617315;6291.02489114188;6322.873542529215;6325.620462772248;6331.303556608861;6333.20834895638;6190.969045154746;6227.844303892439;6237.033259844731;6239.4696450800375;6241.095041218907 04:18:54 INFO - PROCESS | 777 | |4;prototype.html;327.8573820388131;330.97352211823056;332.3170883833721;336.5927228054055;340.63381864495676;5763.855903602402;5853.209816674747;5905.291365036196;5910.2316698829145;5932.169496270526;5740.425957404257;5864.384239654839;5878.23582934219;5886.911696324559;5893.086571581412;4556.635469162459;4556.84051058213;4564;4566.977165114178;4570.063137056895;4361.760103194339;4453.332000199964;4454.53227411122;4464.776761161929;4555.954440455603;4426.490953540336;4469.955300447003;4505;4507.72953622782;4508.61676757476;4491.438570178728;4496.64026877849;4497.437820272466;4501.4598248210095;4519.5480451954545;3991.521017477892;3993.0815912340327;3994.9201015979515;3995.220931918277;4003.73975691582;5518.696471694096;5649.293838270216;5656.4060773618585;5683.687397193153;5691.800786972478;5206.895862082775;5212.035773381898;5212.895742085175;5214.4524824893215;5218.947810521884;5986.401359864022;6249.437550620466;6254.312025677217;6258.374162583751;6261.436470717612;4197.790110494494;4217.177650358181;4324.048709283952;4328.199283132631;4329.415528903589;6443.742250309982;6483.7730679425995;6486.2216534016225;6510.479161667103;6530.575512591667;4420.889477763081;4427.889302767457;4430.933535996963;4432.844850430284;4434.17967675981;4418.734875907456;4441.511433742286;4488.326750987313;4494.10117976406;4510.661700372485;5166.829931428734;5229.555487783581;5231.110711179109;5234.084035293885;5234.712090834964;6239.688015599202;6264.248290205204;6273.592216505913;6281.842953926189;6283.214598175228;1563.2574527099537;1586.7857839191793;1588.0709784775804;1588.7458006718869;1592.418767149982;1053.4364115198332;1056.8995945385177;1061.2677252695614;1077.1436707817304;1084.815581351172;5957.523398128226;5978;5981.850453738692;5984.850378740479;5985.042393217064;6464.838379040468;6467.935320646828;6473.676316184172;6473.870522589522;6481.254655714559;5962.3739507351975;5962.821115366546;5974;5981.431763982415;5981.431763982502;3419.076849250688;3517.700995415418;3533.222691007974;3535.098549869767;3536.8408421620575;6775.356341147583;6777.661116944133;6779.830504237433;6786;6790.354916282945;6699.665016749143;6707.094542236833;6712.328767123248;6714.093597364391;6714.194296684429;6599;6755.628440435823;6757.628330441873;6767.39093481589;6769.492288078315;6292.842678933063;6399.55203135776;6483.610983340826;6502.869942601216;6508;6317.210348706411;6459.063435801876;6472.546921715435;6485.481161507162;6490.740370385321;6735.595864248161;6738.898916516158;6740.831479213059;6744.5616034957575;6755.290694477009;4313.008008158204;4414.580614841585;4455.955440445684;4471.038726673781;4485.394471746403;6451.870962580816;6502.187226596676;6509.576877502947;6511.2512061113575;6523.054157147092;6315.684215789101;6317.96841015792;6324.557280990287;6327.367263273636;6328.177336946167;6195.876082478235;6299;6302.590331628429;6305.495560355253;6310.842228944313;6180.165677633462;6183.505319574333;6184.536159788124;6200.689965501617;6200.968995155175;6276.6547839869245;6329.303776584664;6331.461825744679;6334.873302534015;6336.081268216175;6075.179850720273;6137.815865524041;6171.166892469639;6194.163787888578;6208.2860471044605 04:18:54 INFO - PROCESS | 777 | |5;yui.html;800.9759707208782;821.1378053044302;839.0853969173603;853.7865533616588;867.4838471109689;13313.467461301549;13520.121192122506;13553.119047261922;13553.254570998604;13581.18512889226;12829.550965716178;12945.805812912813;12964.48142074316;12964.93517532411;14531.346089425975;826.409117481001;838.7609531283586;840.1724301562986;841.2386789955101;841.3437518735396;835.0355339582792;846.6147902704255;846.8137009857852;848.0755975986174;849.6176720475811;863.386995233385;872.707642939616;875.0724232313736;875.5490922175085;876.6931573949099;868.8001759595297;872.3544577012965;873.8252349530088;874.4753148111114;880.4541184465672;641.2529403245213;641.9582727122722;642.9196350456193;643.4273496587994;643.5109316919176;14211.147331160164;14292.142471451747;14361.281935903267;14369.353379097965;14452.638684032878;12096.758064838654;12150.756984860342;12209.877901220963;12251.57119500822;12679.809802852964;10335.379877207317;10369.274150809446;10408.115310198567;10656.254062215648;10767.6231331903;3444.156181735466;3474.6351633078666;3491.284286721216;3590.6588874056924;3596.352656521825;43682.12635747299;44324.77837610791;45743.54256457426;47649;48880.26679599809;9178.21985131258;9259.72220833376;9264.490453025013;9481.668141615148;9910.35582687123;17534.03562804058;17543.035133067548;17551.82448175502;17905.10474476271;18145;7137.1435427749;7467.3652739516665;7581.6209189540305;7659.885101723478;7682.1549629540705;4065.6950728695465;4069.2675318442966;4081.918361632751;4149.937750933738;4151.335786274181;3020.7281344679086;3072.9692703072683;3075.4617941860083;3077.415291094685;3080.4455198064566;547.4443439908496;548.7201527221146;549.2228496677237;556.7605929450294;565.2651552981108;539.5090467674476;547.3896605285158;573.4552175433272;656.4026735670517;657.6514447342915;8842;8858.512781797062;8917.955410222907;8925.776855578533;9035.819283614292;565.1325215793737;646.4828137489989;686.2705980928033;691.1533371619726;719.7013239505546;4025.6980726445636;4038.8586399475876;4056.350983842571;4140.15126898985;4244.1723863846255;53125.46874531283;53485.1977220342;54383.45616543863;54548;55974;43521;45482;47715.28427073597;48850.26724599134;49047.50952490501;37940.43089353662;40452.59547404547;43626.34560481595;43870.34194487021;44934;9027.4132181408;9051.637934482547;9152.267818574364;9178;9199.816003680024;33869;34673.82663086769;34933.47599786056;35081.824590877906;35138.29723405569;39059.6094039056;42677.14645707131;43095.35356969585;43272.783636081615;43353.783231083646;9506.334556580972;11237.157213208879;11272;11330.433478326215;11538.82691759641;12213.511459541518;12274.263544187377;12372.505099795908;12560.874391255971;12923.612291631267;11561.479599432218;11736.06111511094;11892.702682432662;12170.513179472722;12297.139200255897;10777.515011824644;10859.51132199037;11136.832947505633;11239.55041798319;11340.546378144782;11448.599299024494;11785.233959792586;11785.646430607096;12159.696007599881;12176.208546444454;9514.571844267162;9673.467959262309;9760.219182465244;9867.40795552269;9968.900310996798;8793.560321984003;9187.265018798347;9605.18355939753;9787.706368808947;9826.803463930824 04:18:54 INFO - PROCESS | 777 | __end_tp_report 04:18:54 INFO - PROCESS | 777 | __start_cc_report 04:18:54 INFO - PROCESS | 777 | _x_x_mozilla_cycle_collect,838 04:18:54 INFO - PROCESS | 777 | __end_cc_report 04:18:54 INFO - PROCESS | 777 | __startTimestamp1451996334515__endTimestamp 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | ------- Summary: start ------- 04:18:54 INFO - PROCESS | 777 | Number of tests: 6 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | [#0] dojo.html Cycles:165 Average:5217.25 Median:5405.70 stddev:573.48 (10.6%) stddev-sans-first:550.56 04:18:54 INFO - PROCESS | 777 | Values: 3095.8 3133.6 3135.3 3174.0 3204.7 5099.9 5213.6 5222.8 5227.6 5287.4 5184.7 5221.8 5227.7 5280.3 5326.7 4732.8 4738.1 4760.4 4775.8 4865.1 4818.3 4840.0 4852.0 4889.6 4930.7 4663.8 4705.2 4760.0 4813.6 4817.4 4787.2 4796.9 4810.8 4815.6 4820.9 4752.6 4756.3 4765.0 4766.2 4801.8 4944.5 5015.3 5034.3 5046.0 5099.5 5598.4 5600.2 5608.9 5612.2 5617.1 5648.3 5657.7 5658.9 5665.5 5668.4 5162.0 5217.2 5253.6 5255.8 5280.3 5818.2 5835.1 5863.0 5868.8 5874.5 5568.1 5568.1 5569.8 5570.4 5572.9 5535.8 5568.7 5620.6 5651.3 5656.5 5573.3 5632.7 5637.8 5642.2 5686.0 5578.1 5593.0 5594.3 5595.4 5596.4 4234.9 4345.9 4346.5 4351.3 4387.8 3906.8 3907.3 3949.5 3949.9 3951.5 5195.5 5222.8 5266.3 5294.2 5301.4 5624.3 5644.8 5648.5 5653.4 5653.7 5251.4 5266.2 5270.0 5271.1 5319.8 4677.2 4779.5 4814.6 4821.2 4862.8 5755.9 5783.5 5804.7 5805.6 5805.9 5471.3 5605.5 5611.3 5623.0 5656.3 5704.9 5772.8 5789.6 5876.4 5925.1 5549.6 5557.6 5558.3 5567.1 5571.7 5508.9 5633.9 5636.7 5641.9 5642.7 5467.6 5473.9 5474.3 5516.2 5530.9 5464.2 5465.8 5468.8 5472.2 5485.7 5215.9 5304.3 5380.1 5393.6 5440.1 5425.6 5487.9 5494.2 5503.4 5550.3 5370.9 5397.2 5401.5 5405.7 5438.2 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | [#1] ext.html Cycles:180 Average:42549.57 Median:34491.91 stddev:67721.80 (196.3%) stddev-sans-first:67838.23 04:18:54 INFO - PROCESS | 777 | Values: 513.2 522.9 525.5 541.9 547.9 28334.1 35836.6 36305.3 36308.1 36383.5 40362.0 40923.4 40924.0 40930.4 40946.1 7384.9 7457.4 8378.1 8547.1 8548.2 10060.2 10265.8 10268.4 10270.6 10280.3 9818.1 9877.6 9916.9 9923.4 9929.6 7564.7 7645.4 9911.0 10030.4 10278.4 9700.5 9745.0 9811.4 9855.4 9860.5 36449.5 36819.8 36850.3 36881.2 36913.3 3187.8 3240.8 3321.9 3516.5 3762.8 28262.4 28508.7 28675.3 30356.0 31080.2 3944.9 3965.3 3971.2 4000.5 4111.5 259058.0 260478.0 260992.0 261168.7 262723.0 48624.8 49334.8 55912.0 56261.7 59766.0 57513.7 57663.7 57816.4 57933.4 57956.7 15794.7 16269.3 16278.2 16391.0 16396.6 12271.1 12410.1 12476.1 12605.6 12614.9 18920.3 19048.9 19156.3 19177.5 19210.0 7217.6 7413.9 7450.3 7461.3 7560.3 903.3 909.9 953.8 1043.7 1055.5 29031.9 30033.5 30704.2 30847.7 31018.7 1005.0 1020.8 1046.1 1121.1 1172.4 13963.2 14048.8 14112.2 14156.9 14252.4 307453.0 308424.0 310320.0 312840.0 313639.0 49525.0 49663.5 49696.5 49860.5 49952.8 1337.4 1343.6 1367.1 1367.6 1374.5 25919.2 27085.9 27345.7 27497.0 28889.1 42565.6 43006.4 43559.3 48312.3 49300.3 193988.0 194162.0 195060.0 195274.0 196001.0 26970.3 28638.7 28893.1 29132.3 29160.3 31877.8 35063.9 40064.6 40937.2 41254.4 34789.6 34842.5 35178.1 35841.6 36178.3 34166.8 34286.8 34343.8 34635.3 34722.8 34201.1 34486.0 34867.5 36836.3 36981.3 32414.7 34346.8 34497.8 34625.3 34911.5 25594.7 25598.6 25834.7 25885.4 25949.7 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | [#2] jquery.html Cycles:180 Average:29206.77 Median:17768.75 stddev:92174.99 (518.7%) stddev-sans-first:92408.09 04:18:54 INFO - PROCESS | 777 | Values: 350.8 357.6 358.0 358.5 360.9 13450.3 13750.4 15533.8 15733.9 16081.0 15700.8 16012.3 16757.6 16775.7 16789.1 5189.6 5512.8 5521.3 5521.6 5533.6 4045.9 4133.3 5457.2 5707.1 5918.3 5815.2 5838.5 5846.1 5863.9 5871.5 5738.0 5992.3 6015.2 6022.1 6024.7 5255.5 5256.6 5260.4 5280.0 5287.2 12440.7 12446.1 16172.6 19143.2 19721.2 2103.7 2115.0 2120.0 2148.7 2237.5 9098.5 9249.6 9403.6 11370.3 11680.2 1677.7 1763.4 1817.7 1886.3 1887.0 56594.4 60172.4 60766.0 61875.1 62963.7 10141.5 10255.8 10270.5 10274.0 10344.7 13634.6 13641.7 13648.1 13653.0 13661.3 7658.6 7887.5 7906.8 7930.6 7933.6 7792.4 7821.1 7821.1 7878.1 7899.4 4244.0 4347.7 4474.0 4503.1 4522.5 1625.9 1667.5 1814.6 1854.2 1856.8 855.6 930.7 989.9 1001.8 1035.5 14946.9 16335.3 16704.5 17230.8 17522.1 923.8 926.6 948.7 948.9 964.3 9500.2 9547.9 10066.7 10197.6 10222.9 554631.0 556636.0 569009.9 570283.0 570337.0 78190.0 79666.0 82170.0 82245.0 82401.0 1030.8 1050.6 1052.2 1167.5 1193.7 15198.8 15639.5 15890.9 15997.5 16059.6 34030.7 34352.1 34833.5 34989.5 35186.6 41777.0 42487.0 43049.4 43926.6 46384.9 9094.6 9411.1 9549.0 9558.7 9573.5 11142.1 11172.7 11274.7 12603.2 12713.4 14124.3 14327.8 14334.7 14440.4 15115.0 14467.5 14676.6 14727.9 14739.7 14816.7 14087.0 14381.9 14493.0 14504.2 14900.3 8967.9 9045.3 9422.9 9581.7 9764.9 9288.1 13262.6 14039.5 14349.6 14500.9 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | [#3] mootools.html Cycles:180 Average:5203.14 Median:6266.06 stddev:2667.57 (42.6%) stddev-sans-first:2658.94 04:18:54 INFO - PROCESS | 777 | Values: 1303.3 1442.6 1443.6 1595.7 1805.2 6716.9 7280.8 7394.0 7397.1 7410.9 7208.4 7408.1 7420.1 7421.9 7423.5 2225.2 2260.3 2265.3 2268.9 2269.9 2224.3 2254.0 2289.1 2290.9 2295.6 2229.3 2242.0 2250.8 2251.2 2278.5 2202.1 2220.4 2244.3 2247.6 2252.6 2233.3 2260.0 2260.6 2261.7 2262.3 6491.0 6592.0 7382.7 7455.1 7470.1 4355.7 4453.8 4467.2 4482.2 4487.0 2891.6 2894.9 2971.0 2972.7 3018.7 958.1 968.0 976.8 993.9 1021.6 10349.5 10374.7 10402.5 10404.7 10432.9 4126.5 4174.2 4193.1 4232.8 4237.4 8924.3 8934.5 8945.8 8960.2 8960.9 4600.0 4657.3 4658.1 4661.8 4662.7 4210.7 4253.3 4257.6 4257.6 4258.7 3438.5 3475.7 3491.7 3493.2 3523.3 1120.0 1129.3 1130.3 1132.4 1134.5 1279.5 1305.1 1317.4 1340.6 1345.3 7069.9 7109.8 7152.7 7153.1 7161.9 481.9 491.9 493.6 496.2 501.4 5243.5 5587.6 5635.9 5650.1 5652.8 8258.3 8458.8 8654.5 8687.0 8690.0 8368.7 8378.7 8391.5 8408.4 8458.5 6850.4 6963.1 6964.0 7014.9 7017.8 6633.0 6656.2 6668.3 6668.3 6710.9 7823.7 7904.7 7929.4 7966.9 8089.3 8193.4 8208.3 8319.5 8333.4 8367.2 6474.2 6627.6 6635.9 6639.2 6639.8 7119.6 7156.0 7160.0 7160.6 7166.9 6580.7 6608.7 6616.7 6694.4 6745.9 6504.1 6521.6 6568.7 6582.8 6625.7 6563.8 6566.0 6600.8 6603.9 6635.7 6291.0 6322.9 6325.6 6331.3 6333.2 6191.0 6227.8 6237.0 6239.5 6241.1 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | [#4] prototype.html Cycles:180 Average:5247.32 Median:5959.95 stddev:1587.54 (26.6%) stddev-sans-first:1548.46 04:18:54 INFO - PROCESS | 777 | Values: 327.9 331.0 332.3 336.6 340.6 5763.9 5853.2 5905.3 5910.2 5932.2 5740.4 5864.4 5878.2 5886.9 5893.1 4556.6 4556.8 4564.0 4567.0 4570.1 4361.8 4453.3 4454.5 4464.8 4556.0 4426.5 4470.0 4505.0 4507.7 4508.6 4491.4 4496.6 4497.4 4501.5 4519.5 3991.5 3993.1 3994.9 3995.2 4003.7 5518.7 5649.3 5656.4 5683.7 5691.8 5206.9 5212.0 5212.9 5214.5 5218.9 5986.4 6249.4 6254.3 6258.4 6261.4 4197.8 4217.2 4324.0 4328.2 4329.4 6443.7 6483.8 6486.2 6510.5 6530.6 4420.9 4427.9 4430.9 4432.8 4434.2 4418.7 4441.5 4488.3 4494.1 4510.7 5166.8 5229.6 5231.1 5234.1 5234.7 6239.7 6264.2 6273.6 6281.8 6283.2 1563.3 1586.8 1588.1 1588.7 1592.4 1053.4 1056.9 1061.3 1077.1 1084.8 5957.5 5978.0 5981.9 5984.9 5985.0 6464.8 6467.9 6473.7 6473.9 6481.3 5962.4 5962.8 5974.0 5981.4 5981.4 3419.1 3517.7 3533.2 3535.1 3536.8 6775.4 6777.7 6779.8 6786.0 6790.4 6699.7 6707.1 6712.3 6714.1 6714.2 6599.0 6755.6 6757.6 6767.4 6769.5 6292.8 6399.6 6483.6 6502.9 6508.0 6317.2 6459.1 6472.5 6485.5 6490.7 6735.6 6738.9 6740.8 6744.6 6755.3 4313.0 4414.6 4456.0 4471.0 4485.4 6451.9 6502.2 6509.6 6511.3 6523.1 6315.7 6318.0 6324.6 6327.4 6328.2 6195.9 6299.0 6302.6 6305.5 6310.8 6180.2 6183.5 6184.5 6200.7 6201.0 6276.7 6329.3 6331.5 6334.9 6336.1 6075.2 6137.8 6171.2 6194.2 6208.3 04:18:54 INFO - PROCESS | 777 | 04:18:54 INFO - PROCESS | 777 | [#5] yui.html Cycles:180 Average:13390.96 Median:44629.39 stddev:14933.57 (33.5%) stddev-sans-first:14945.53 04:18:54 INFO - PROCESS | 777 | Values: 801.0 821.1 839.1 853.8 867.5 13313.5 13520.1 13553.1 13553.3 13581.2 12829.6 12945.8 12964.5 12964.9 14531.3 826.4 838.8 840.2 841.2 841.3 835.0 846.6 846.8 848.1 849.6 863.4 872.7 875.1 875.5 876.7 868.8 872.4 873.8 874.5 880.5 641.3 642.0 642.9 643.4 643.5 14211.1 14292.1 14361.3 14369.4 14452.6 12096.8 12150.8 12209.9 12251.6 12679.8 10335.4 10369.3 10408.1 10656.3 10767.6 3444.2 3474.6 3491.3 3590.7 3596.4 43682.1 44324.8 45743.5 47649.0 48880.3 9178.2 9259.7 9264.5 9481.7 9910.4 17534.0 17543.0 17551.8 17905.1 18145.0 7137.1 7467.4 7581.6 7659.9 7682.2 4065.7 4069.3 4081.9 4149.9 4151.3 3020.7 3073.0 3075.5 3077.4 3080.4 547.4 548.7 549.2 556.8 565.3 539.5 547.4 573.5 656.4 657.7 8842.0 8858.5 8918.0 8925.8 9035.8 565.1 646.5 686.3 691.2 719.7 4025.7 4038.9 4056.4 4140.2 4244.2 53125.5 53485.2 54383.5 54548.0 55974.0 43521.0 45482.0 47715.3 48850.3 49047.5 37940.4 40452.6 43626.3 43870.3 44934.0 9027.4 9051.6 9152.3 9178.0 9199.8 33869.0 34673.8 34933.5 35081.8 35138.3 39059.6 42677.1 43095.4 43272.8 43353.8 9506.3 11237.2 11272.0 11330.4 11538.8 12213.5 12274.3 12372.5 12560.9 12923.6 11561.5 11736.1 11892.7 12170.5 12297.1 10777.5 10859.5 11136.8 11239.6 11340.5 11448.6 11785.2 11785.6 12159.7 12176.2 9514.6 9673.5 9760.2 9867.4 9968.9 8793.6 9187.3 9605.2 9787.7 9826.8 04:18:54 INFO - PROCESS | 777 | -------- Summary: end -------- 04:18:54 INFO - PROCESS | 777 | 04:18:55 INFO - TEST-INFO | 777: exit 0 04:18:55 INFO - TEST-OK | dromaeo_css | took 1112398ms 04:18:55 INFO - TEST-START | kraken 04:18:55 INFO - operating with platform_type : linux_ 04:18:55 INFO - Initialising browser for kraken test... 04:18:55 INFO - TEST-INFO | started process 974 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBnfdqc/profile http://localhost:43734/getInfo.html) 04:18:59 INFO - PROCESS | 974 | __metrics Screen width/height:1600/1200 04:18:59 INFO - PROCESS | 974 | colorDepth:24 04:18:59 INFO - PROCESS | 974 | Browser inner width/height: 1024/697 04:18:59 INFO - PROCESS | 974 | __metrics 04:18:59 INFO - PROCESS | 974 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:18:59 INFO - PROCESS | 974 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:59 INFO - PROCESS | 974 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:19:00 INFO - TEST-INFO | 974: exit 0 04:19:00 INFO - Browser initialized. 04:19:00 INFO - Running cycle 1/1 for kraken test... 04:19:00 INFO - TEST-INFO | started process 1060 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBnfdqc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:12 INFO - PROCESS | 1060 | RSS: Main: 147341312 04:19:12 INFO - PROCESS | 1060 | 04:19:14 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:15 INFO - PROCESS | 1060 | RSS: Main: 183410688 04:19:15 INFO - PROCESS | 1060 | 04:19:17 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-dft) 04:19:18 INFO - PROCESS | 1060 | RSS: Main: 171503616 04:19:18 INFO - PROCESS | 1060 | 04:19:21 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-fft) 04:19:21 INFO - PROCESS | 1060 | RSS: Main: 159047680 04:19:21 INFO - PROCESS | 1060 | 04:19:23 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-oscillator) 04:19:24 INFO - PROCESS | 1060 | RSS: Main: 160534528 04:19:24 INFO - PROCESS | 1060 | 04:19:26 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:26 INFO - PROCESS | 1060 | RSS: Main: 163110912 04:19:26 INFO - PROCESS | 1060 | 04:19:29 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43734/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:30 INFO - PROCESS | 1060 | RSS: Main: 162156544 04:19:30 INFO - PROCESS | 1060 | 04:19:33 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43734/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:34 INFO - PROCESS | 1060 | RSS: Main: 163762176 04:19:34 INFO - PROCESS | 1060 | 04:19:37 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43734/tests/kraken/driver.html?testName=json-parse-financial) 04:19:37 INFO - PROCESS | 1060 | RSS: Main: 161947648 04:19:37 INFO - PROCESS | 1060 | 04:19:39 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:39 INFO - PROCESS | 1060 | RSS: Main: 174780416 04:19:39 INFO - PROCESS | 1060 | 04:19:41 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:42 INFO - PROCESS | 1060 | RSS: Main: 172040192 04:19:42 INFO - PROCESS | 1060 | 04:19:44 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:44 INFO - PROCESS | 1060 | RSS: Main: 180781056 04:19:44 INFO - PROCESS | 1060 | 04:19:47 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:47 INFO - PROCESS | 1060 | RSS: Main: 190054400 04:19:47 INFO - PROCESS | 1060 | 04:19:50 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:51 INFO - PROCESS | 1060 | RSS: Main: 188465152 04:19:51 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43734/tests/kraken/driver.html?testName=ai-astar) 04:19:52 INFO - PROCESS | 1060 | RSS: Main: 246890496 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | __start_tp_report 04:19:52 INFO - PROCESS | 1060 | _x_x_mozilla_page_load 04:19:52 INFO - PROCESS | 1060 | _x_x_mozilla_page_load_details 04:19:52 INFO - PROCESS | 1060 | |i|pagename|runs| 04:19:52 INFO - PROCESS | 1060 | |0;ai-astar;109;112;104;110;111;111;98;111;109;110 04:19:52 INFO - PROCESS | 1060 | |1;audio-beat-detection;151;126;148;165;131;149;148;125;163;125 04:19:52 INFO - PROCESS | 1060 | |2;audio-dft;160;161;161;160;161;160;161;163;161;163 04:19:52 INFO - PROCESS | 1060 | |3;audio-fft;72;75;87;102;74;75;73;98;93;73 04:19:52 INFO - PROCESS | 1060 | |4;audio-oscillator;96;96;144;95;96;96;143;95;97;151 04:19:52 INFO - PROCESS | 1060 | |5;imaging-gaussian-blur;109;110;109;110;110;109;110;109;109;110 04:19:52 INFO - PROCESS | 1060 | |6;imaging-darkroom;146;145;146;145;145;146;145;145;146;145 04:19:52 INFO - PROCESS | 1060 | |7;imaging-desaturate;95;95;96;96;96;96;96;96;96;96 04:19:52 INFO - PROCESS | 1060 | |8;json-parse-financial;58;56;56;56;57;56;56;60;60;55 04:19:52 INFO - PROCESS | 1060 | |9;json-stringify-tinderbox;68;68;67;67;67;68;68;68;67;67 04:19:52 INFO - PROCESS | 1060 | |10;stanford-crypto-aes;84;86;85;84;91;92;84;84;86;85 04:19:52 INFO - PROCESS | 1060 | |11;stanford-crypto-ccm;122;115;121;114;114;123;124;119;117;124 04:19:52 INFO - PROCESS | 1060 | |12;stanford-crypto-pbkdf2;143;142;156;141;150;141;151;157;155;146 04:19:52 INFO - PROCESS | 1060 | |13;stanford-crypto-sha256-iterative;67;68;66;67;68;66;68;70;68;69 04:19:52 INFO - PROCESS | 1060 | __end_tp_report 04:19:52 INFO - PROCESS | 1060 | __start_cc_report 04:19:52 INFO - PROCESS | 1060 | _x_x_mozilla_cycle_collect,936 04:19:52 INFO - PROCESS | 1060 | __end_cc_report 04:19:52 INFO - PROCESS | 1060 | __startTimestamp1451996392982__endTimestamp 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | ------- Summary: start ------- 04:19:52 INFO - PROCESS | 1060 | Number of tests: 14 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#0] ai-astar Cycles:10 Average:108.50 Median:111.00 stddev:4.30 (3.9%) stddev-sans-first:4.56 04:19:52 INFO - PROCESS | 1060 | Values: 109.0 112.0 104.0 110.0 111.0 111.0 98.0 111.0 109.0 110.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:148.50 stddev:15.33 (10.3%) stddev-sans-first:15.99 04:19:52 INFO - PROCESS | 1060 | Values: 151.0 126.0 148.0 165.0 131.0 149.0 148.0 125.0 163.0 125.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 04:19:52 INFO - PROCESS | 1060 | Values: 160.0 161.0 161.0 160.0 161.0 160.0 161.0 163.0 161.0 163.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:11.67 (15.6%) stddev-sans-first:11.78 04:19:52 INFO - PROCESS | 1060 | Values: 72.0 75.0 87.0 102.0 74.0 75.0 73.0 98.0 93.0 73.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.00 stddev:24.31 (25.3%) stddev-sans-first:25.18 04:19:52 INFO - PROCESS | 1060 | Values: 96.0 96.0 144.0 95.0 96.0 96.0 143.0 95.0 97.0 151.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:19:52 INFO - PROCESS | 1060 | Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:19:52 INFO - PROCESS | 1060 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:19:52 INFO - PROCESS | 1060 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:1.76 (3.1%) stddev-sans-first:1.83 04:19:52 INFO - PROCESS | 1060 | Values: 58.0 56.0 56.0 56.0 57.0 56.0 56.0 60.0 60.0 55.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:19:52 INFO - PROCESS | 1060 | Values: 68.0 68.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 67.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:2.96 (3.5%) stddev-sans-first:3.04 04:19:52 INFO - PROCESS | 1060 | Values: 84.0 86.0 85.0 84.0 91.0 92.0 84.0 84.0 86.0 85.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:121.50 stddev:4.06 (3.3%) stddev-sans-first:4.18 04:19:52 INFO - PROCESS | 1060 | Values: 122.0 115.0 121.0 114.0 114.0 123.0 124.0 119.0 117.0 124.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:150.50 stddev:6.41 (4.3%) stddev-sans-first:6.51 04:19:52 INFO - PROCESS | 1060 | Values: 143.0 142.0 156.0 141.0 150.0 141.0 151.0 157.0 155.0 146.0 04:19:52 INFO - PROCESS | 1060 | 04:19:52 INFO - PROCESS | 1060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 04:19:53 INFO - PROCESS | 1060 | Values: 67.0 68.0 66.0 67.0 68.0 66.0 68.0 70.0 68.0 69.0 04:19:53 INFO - PROCESS | 1060 | -------- Summary: end -------- 04:19:53 INFO - PROCESS | 1060 | 04:19:53 INFO - TEST-INFO | 1060: exit 0 04:19:53 INFO - TEST-OK | kraken | took 58599ms 04:19:53 INFO - TEST-START | v8_7 04:19:53 INFO - operating with platform_type : linux_ 04:19:53 INFO - Initialising browser for v8_7 test... 04:19:53 INFO - TEST-INFO | started process 1387 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmDF5X_/profile http://localhost:43734/getInfo.html) 04:19:57 INFO - PROCESS | 1387 | __metrics Screen width/height:1600/1200 04:19:57 INFO - PROCESS | 1387 | colorDepth:24 04:19:57 INFO - PROCESS | 1387 | Browser inner width/height: 1024/697 04:19:57 INFO - PROCESS | 1387 | __metrics 04:19:57 INFO - PROCESS | 1387 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:19:57 INFO - PROCESS | 1387 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:19:58 INFO - TEST-INFO | 1387: exit 0 04:19:58 INFO - Browser initialized. 04:19:58 INFO - Running cycle 1/1 for v8_7 test... 04:19:58 INFO - TEST-INFO | started process 1473 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmDF5X_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:10 INFO - PROCESS | 1473 | RSS: Main: 149725184 04:20:10 INFO - PROCESS | 1473 | 04:20:31 INFO - PROCESS | 1473 | Cycle 1(1): loaded http://localhost:43734/tests/v8_7/run.html (next: http://localhost:43734/tests/v8_7/run.html) 04:20:32 INFO - PROCESS | 1473 | RSS: Main: 612319232 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | __start_tp_report 04:20:32 INFO - PROCESS | 1473 | _x_x_mozilla_page_load 04:20:32 INFO - PROCESS | 1473 | _x_x_mozilla_page_load_details 04:20:32 INFO - PROCESS | 1473 | |i|pagename|runs| 04:20:32 INFO - PROCESS | 1473 | |0;Richards;167.95431642593215 04:20:32 INFO - PROCESS | 1473 | |1;DeltaBlue;191.27773527161438 04:20:32 INFO - PROCESS | 1473 | |2;Encrypt;280.19052956010086 04:20:32 INFO - PROCESS | 1473 | |3;Decrypt;5256.544502617801 04:20:32 INFO - PROCESS | 1473 | |4;RayTrace;1113.5857461024498 04:20:32 INFO - PROCESS | 1473 | |5;Earley;789.8894154818325 04:20:32 INFO - PROCESS | 1473 | |6;Boyer;12256.09756097561 04:20:32 INFO - PROCESS | 1473 | |7;RegExp;25475 04:20:32 INFO - PROCESS | 1473 | |8;Splay;649.3843162670123 04:20:32 INFO - PROCESS | 1473 | |9;NavierStokes;4835.748792270531 04:20:32 INFO - PROCESS | 1473 | __end_tp_report 04:20:32 INFO - PROCESS | 1473 | __startTimestamp1451996432154__endTimestamp 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | ------- Summary: start ------- 04:20:32 INFO - PROCESS | 1473 | Number of tests: 10 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 168.0 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 191.3 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 280.2 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 5256.5 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#4] RayTrace Cycles:1 Average:1113.59 Median:1113.59 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 1113.6 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 789.9 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 12256.1 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 25475.0 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#8] Splay Cycles:1 Average:649.38 Median:649.38 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 649.4 04:20:32 INFO - PROCESS | 1473 | 04:20:32 INFO - PROCESS | 1473 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:20:32 INFO - PROCESS | 1473 | Values: 4835.7 04:20:32 INFO - PROCESS | 1473 | -------- Summary: end -------- 04:20:32 INFO - PROCESS | 1473 | 04:20:33 INFO - TEST-INFO | 1473: exit 0 04:20:33 INFO - TEST-OK | v8_7 | took 39215ms 04:20:33 INFO - SUITE-END | took 1210s 04:20:33 INFO - Completed test suite (00:20:10) 04:20:33 INFO - Working with test: dromaeo_css 04:20:33 INFO - Generating results file: dromaeo_css 04:20:33 INFO - Working with test: kraken 04:20:33 INFO - Generating results file: kraken 04:20:33 INFO - javascript benchmark 04:20:33 INFO - Working with test: v8_7 04:20:33 INFO - Generating results file: v8_7 04:20:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:20:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 04:20:33 INFO - process_Request line: dromaeo_css 6852.01 graph.html#tests=[[72,63,35]] 04:20:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:20:33 INFO - process_Request line: kraken 1502.30 graph.html#tests=[[232,63,35]] 04:20:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:20:33 INFO - process_Request line: v8_7 20815.87 graph.html#tests=[[230,63,35]] 04:20:33 INFO - RETURN: dromaeo_css: 6852.01 04:20:33 INFO - RETURN: kraken: 1502.30 04:20:33 INFO - RETURN: v8_7: 20815.87 04:20:33 INFO - javascript benchmark 04:20:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3095.8297293648848, 3133.6396314423846, 3135.3102317490157, 3173.984519829907, 3204.663510331415, 5099.898002039957, 5213.635045546808, 5222.843314700555, 5227.634065615403, 5287.365516138064, 5184.662996905198, 5221.843344699656, 5227.660202086861, 5280.287161233232, 5326.733663316838, 4732.787024583902, 4738.076075165344, 4760.3811504504365, 4775.832845850396, 4865.14859899518, 4818.325434439182, 4839.975800121012, 4851.9810839723705, 4889.584385327252, 4930.728809915453, 4663.836765713184, 4705.223638099709, 4759.976200119012, 4813.56677898989, 4817.421909370881, 4787.186178349689, 4796.880077998043, 4810.8316208932865, 4815.566599006072, 4820.855374338776, 4752.643551733634, 4756.28655701644, 4764.976175119137, 4766.189747742857, 4801.831935882262, 4944.456109827916, 5015.348004759395, 5034.320366750479, 5046.0, 5099.541041306263, 5598.356189038272, 5600.1599760035915, 5608.943910560883, 5612.214289999403, 5617.101263797814, 5648.265725455664, 5657.717114144276, 5658.886822263573, 5665.49010589049, 5668.376478587352, 5161.974190129025, 5217.243499692561, 5253.605979551549, 5255.816046438356, 5280.260763493114, 5818.243628328375, 5835.095560188178, 5863.0, 5868.794592189253, 5874.471297583153, 5568.053430916673, 5568.081266591048, 5569.832905012856, 5570.387257401682, 5572.888542229214, 5535.7785688572, 5568.749406276727, 5620.606557540933, 5651.321841378978, 5656.490915817596, 5573.331200255914, 5632.690202038927, 5637.802676906289, 5642.23829782974, 5685.976524225679, 5578.079616863172, 5593.049181639131, 5594.300712410949, 5595.4124816894455, 5596.4123767003875, 4234.9364759528635, 4345.891352716208, 4346.47842258931, 4351.3472979053395, 4387.780610969438, 3906.7851268180525, 3907.3357529219534, 3949.4865667463046, 3949.881503554898, 3951.5258169019326, 5195.48045195485, 5222.764975576109, 5266.34170728659, 5294.205869119586, 5301.390340110859, 5624.29696287964, 5644.8024319148635, 5648.491635752802, 5653.378128405872, 5653.660780353192, 5251.422343542207, 5266.1574148136115, 5269.973650131725, 5271.103912334912, 5319.8138065168305, 4677.204875171161, 4779.522047795263, 4814.566688998007, 4821.2045012573235, 4862.756862156878, 5755.942440575541, 5783.450572195635, 5804.680742559115, 5805.622634528742, 5805.8548536286935, 5471.2887324647545, 5605.523530499871, 5611.298587676541, 5622.971885140548, 5656.321241451053, 5704.885902281848, 5772.797952071657, 5789.623674461147, 5876.382979787061, 5925.05199168131, 5549.611527193058, 5557.638753481173, 5558.305211848519, 5567.137093750475, 5571.665700057847, 5508.862278443071, 5633.887322253614, 5636.689982051026, 5641.887162256814, 5642.689652069175, 5467.644603100945, 5473.863153421196, 5474.343078830566, 5516.227728118147, 5530.889382212253, 5464.153056276284, 5465.754041068241, 5468.7539060741565, 5472.2065300531995, 5485.725713714378, 5215.869603259949, 5304.257403963526, 5380.112281473513, 5393.6224464287125, 5440.129579267298, 5425.620206585501, 5487.862803429786, 5494.230807686847, 5503.449655034625, 5550.278463799842, 5370.865728356823, 5397.163439666858, 5401.540869026177, 5405.702686352289, 5438.211459338453], "unit": "score", "name": "dojo.html", "value": 5180.505624495274}, {"lowerIsBetter": false, "replicates": [513.1558586125823, 522.9111051121309, 525.5322762741162, 541.8564080518662, 547.8602956246159, 28334.149975500743, 35836.641633583655, 36305.27389452209, 36308.092297692536, 36383.454248186295, 40362.0, 40923.386149207785, 40924.0, 40930.38604420936, 40946.11011953867, 7384.889226661604, 7457.403407727396, 8378.12029736878, 8547.05982341945, 8548.230659240668, 10060.195184385268, 10265.794684106313, 10268.435236062014, 10270.589176432934, 10280.331778434378, 9818.11636952674, 9877.604895804196, 9916.90083099167, 9923.354981926188, 9929.602815887356, 7564.659590318422, 7645.350145237661, 9911.0, 10030.398176109456, 10278.383297002129, 9700.466474343908, 9744.95127524365, 9811.411315321104, 9855.408675479423, 9860.457674827881, 36449.453258201145, 36819.81590092032, 36850.262994739955, 36881.15594220305, 36913.261734765154, 3187.8406079696156, 3240.7893486923276, 3321.9003429897143, 3516.49010893419, 3762.7742335459684, 28262.434751305063, 28508.714912850814, 28675.283117922012, 30356.0, 31080.222994425094, 3944.921101577981, 3965.306071437487, 3971.225611005855, 4000.5399379071487, 4111.527174374955, 259058.0, 260478.0, 260992.0, 261168.6941565299, 262723.0, 48624.75687621539, 49334.75332623314, 55912.0, 56261.718691406284, 59766.02339765988, 57513.712431437576, 57663.711681441324, 57816.42183578195, 57933.420665793645, 57956.71021644865, 15794.684106317809, 16269.267882945296, 16278.186090695417, 16391.03307603095, 16396.590085247964, 12271.079669024859, 12410.131290809557, 12476.126671133115, 12605.621831345074, 12614.936925315315, 18920.33778817735, 19048.90475547641, 19156.32952846644, 19177.52056198606, 19210.0, 7217.603031833194, 7413.925860741431, 7450.254974502506, 7461.253874612496, 7560.319571238615, 903.2818908967387, 909.9044600316871, 953.814006268771, 1043.7390652336917, 1055.5380797595385, 29031.85484072566, 30033.549496757565, 30704.232394189876, 30847.69152308493, 31018.68981310203, 1005.0401866217744, 1020.806046851096, 1046.0951277145214, 1121.125522092769, 1172.3903570143648, 13963.162210267417, 14048.789268160986, 14112.223827689575, 14156.929215353857, 14252.358643861051, 307453.0, 308424.0, 310320.0, 312840.0, 313639.0, 49525.0, 49663.50336496589, 49696.50303496991, 49860.50139498631, 49952.75023624858, 1337.404854839587, 1343.603636927109, 1367.0840536840342, 1367.5623800383783, 1374.5051781358702, 25919.22242332733, 27085.864570677022, 27345.72654273432, 27497.0, 28889.133326000254, 42565.57434425616, 43006.35490467708, 43559.34660980151, 48312.275315869585, 49300.26049609187, 193988.0, 194162.0, 195060.0, 195274.0, 196001.0, 26970.32574185661, 28638.713612864438, 28893.133206003855, 29132.27169320784, 29160.27099322534, 31877.840610796797, 35063.948081557595, 40064.59935400609, 40937.181256375305, 41254.38118428166, 34789.62547506761, 34842.47736284009, 35178.12054698653, 35841.641583584875, 36178.27643447169, 34166.82916585401, 34286.82856585701, 34343.82828085843, 34635.307293853475, 34722.82638586892, 34201.144971375914, 34486.0, 34867.4769878447, 36836.26327473489, 36981.26037479182, 32414.675853242108, 34346.80521556657, 34497.82751086329, 34625.30749385049, 34911.476327854594, 25594.74405255998, 25598.61602075933, 25834.741652583234, 25885.352866178495, 25949.740502595487], "unit": "score", "name": "ext.html", "value": 18061.132822272644}, {"lowerIsBetter": false, "replicates": [350.84396912174384, 357.619135620564, 357.95167652366956, 358.546438754975, 360.90616439725665, 13450.260235687034, 13750.449982000708, 15533.844661553396, 15733.921330393361, 16081.0, 15700.842991570082, 16012.279447424864, 16757.581060473494, 16775.664486710288, 16789.061914165035, 5189.6107791915565, 5512.779488820463, 5521.282233309664, 5521.613487055908, 5533.6403133796375, 4045.858394956177, 4133.256013917494, 5457.181422786594, 5707.14392841073, 5918.348981612019, 5815.185873977646, 5838.503727183194, 5846.093855452412, 5863.941360586382, 5871.500922421599, 5738.0, 5992.3408425072985, 6015.157877897098, 6022.066579680157, 6024.698765061729, 5255.527002569749, 5256.605754568384, 5260.368755749335, 5280.0, 5287.233351164098, 12440.688982775413, 12446.06654500907, 16172.595685107848, 19143.234270629157, 19721.21115155392, 2103.684447332897, 2114.95770084599, 2119.973240169482, 2148.677698345245, 2237.5301186750803, 9098.454092754457, 9249.630014799468, 9403.62385504579, 11370.260933039408, 11680.247962805563, 1677.6728537935107, 1763.4268862619572, 1817.7091665333614, 1886.311496303853, 1886.962260754791, 56594.43405565933, 60172.39827601756, 60766.0, 61875.07187392148, 62963.685181574256, 10141.543630536644, 10255.846162307571, 10270.486475676187, 10274.0, 10344.689659310232, 13634.590962271148, 13641.658958525917, 13648.112872663245, 13653.0, 13661.316934153252, 7658.578778167254, 7887.487313324616, 7906.802329941797, 7930.5638189898955, 7933.603319834101, 7792.376609871197, 7821.100573434014, 7821.100573434128, 7878.054633444023, 7899.407544434075, 4243.957560424356, 4347.673924455678, 4473.977630111829, 4503.144402563503, 4522.525134860793, 1625.8699304055647, 1667.483080245128, 1814.5735752098246, 1854.2212270846278, 1856.8487537726696, 855.5978690015683, 930.6835675870101, 989.9109080182674, 1001.8447140693204, 1035.4563853976572, 14946.850531494763, 16335.26491307894, 16704.498865034067, 17230.827691723174, 17522.12389380526, 923.7598224461689, 926.5876684875301, 948.6757444261586, 948.8529277961927, 964.3490643815396, 9500.23998080152, 9547.90452095484, 10066.748331291776, 10197.592096316064, 10222.948885255526, 554631.0, 556636.0, 569009.8594084368, 570283.0, 570337.0, 78190.0, 79666.0, 82170.0, 82245.0, 82401.0, 1030.8196065688473, 1050.6007717067466, 1052.2476429353048, 1167.4688016952437, 1193.7015746063485, 15198.772018419511, 15639.452619158275, 15890.920545397661, 15997.520074397788, 16059.598510036874, 34030.65969340275, 34352.141196470286, 34833.47749783806, 34989.47515787316, 35186.648133518334, 41777.0, 42487.0, 43049.354259686756, 43926.560734393526, 46384.91267892886, 9094.59074341643, 9411.10594493522, 9549.0, 9558.665446709332, 9573.473458959545, 11142.052925501423, 11172.664820055412, 11274.718132046437, 12603.18079324841, 12713.364331783188, 14124.2937853109, 14327.78508322397, 14334.713305734036, 14440.422383104979, 15115.0, 14467.49363772305, 14676.55970320892, 14727.92636036813, 14739.705205896036, 14816.703665926405, 14087.0, 14381.9280903599, 14493.0, 14504.202268875313, 14900.254987250812, 8967.910320896708, 9045.276377889884, 9422.905770942478, 9581.664641737785, 9764.902350976683, 9288.117628825521, 13262.602121936357, 14039.50861719835, 14349.64125896861, 14500.85499144995], "unit": "score", "name": "jquery.html", "value": 8758.52205589699}, {"lowerIsBetter": false, "replicates": [1303.328785675378, 1442.6177063078283, 1443.5741456270403, 1595.744680851064, 1805.2147315917568, 6716.899246511306, 7280.817979550514, 7393.999999999994, 7397.075365579302, 7410.851782964338, 7208.387287080592, 7408.111026676806, 7420.072490938633, 7421.925780742191, 7423.480356375056, 2225.1544413122992, 2260.3219034289646, 2265.3090807303765, 2268.875211863347, 2269.909203631853, 2224.254874617005, 2253.966190507144, 2289.1186893046215, 2290.9312720618323, 2295.621222498286, 2229.3423440085135, 2242.0471299697647, 2250.8199344052437, 2251.223327951854, 2278.54429114177, 2202.053117159621, 2220.400491867195, 2244.2818298144603, 2247.5954328220914, 2252.6395776675736, 2233.3188377544843, 2260.028187879211, 2260.5930932432157, 2261.694671219397, 2262.3326118794994, 6490.967545162292, 6591.967040164816, 7382.7046918123215, 7455.142658594223, 7470.140933792629, 4355.695101342907, 4453.755043472608, 4467.24056910326, 4482.170798402306, 4486.955130448719, 2891.551809469536, 2894.8986785462407, 2971.0492642354457, 2972.7027297270315, 3018.7132222439054, 958.108958668438, 967.9516024198762, 976.7851072763981, 993.9105480506789, 1021.6168936648756, 10349.534270957825, 10374.740631484197, 10402.47987600617, 10404.739881502946, 10432.947835260851, 4126.546079931205, 4174.165166966619, 4193.1404062167185, 4232.809523571446, 4237.449131612871, 8924.330675199386, 8934.463932164092, 8945.821083578292, 8960.238379737795, 8960.910390896008, 4600.0, 4657.301404789308, 4658.114958157939, 4661.813527458931, 4662.650301227422, 4210.6841986851105, 4253.3194688849635, 4257.57424257578, 4257.638100761408, 4258.701890867672, 3438.4670376091744, 3475.687188153028, 3491.6857482826667, 3493.2314890724, 3523.2601153757996, 1119.9776004479866, 1129.2885482146196, 1130.2540323386525, 1132.4451019000794, 1134.5235001299475, 1279.5073896549895, 1305.092960392537, 1317.4071667749552, 1340.6246251049722, 1345.2869978911192, 7069.929300706927, 7109.786706398816, 7152.749653762094, 7153.141623005273, 7161.92838071623, 481.87712133406455, 491.9458859525449, 493.64210947063094, 496.18873142412417, 501.3557578511668, 5243.501867322599, 5587.636803607753, 5635.859103522363, 5650.124230744241, 5652.802151924663, 8258.339332853357, 8458.788530286793, 8654.480731156025, 8687.044425113232, 8690.04409514953, 8368.707095251759, 8378.706745263886, 8391.538465384463, 8408.369372297102, 8458.450200736932, 6850.417714494224, 6963.059986901805, 6964.0, 7014.859702805916, 7017.789466316019, 6633.0, 6656.2345330287635, 6668.299828517936, 6668.333166683293, 6710.899336510054, 7823.687052517836, 7904.723334683258, 7929.444938854225, 7966.920330796618, 8089.312408445113, 8193.426460147732, 8208.261256486945, 8319.542425166674, 8333.37499687538, 8367.163283671583, 6474.223093228843, 6627.602343859191, 6635.867282654416, 6639.203295604559, 6639.800805975829, 7119.572825630272, 7156.0, 7160.0, 7160.641967901688, 7166.928330716834, 6580.736770529125, 6608.669566521751, 6616.735330586723, 6694.430973367318, 6745.920652695545, 6504.089427480251, 6521.64130972801, 6568.7372505099265, 6582.8354291143105, 6625.701843416961, 6563.7702680405955, 6565.967170164118, 6600.8349791255605, 6603.9009414859775, 6635.734570617315, 6291.02489114188, 6322.873542529215, 6325.620462772248, 6331.303556608861, 6333.20834895638, 6190.969045154746, 6227.844303892439, 6237.033259844731, 6239.4696450800375, 6241.095041218907], "unit": "score", "name": "mootools.html", "value": 4243.0524106848325}, {"lowerIsBetter": false, "replicates": [327.8573820388131, 330.97352211823056, 332.3170883833721, 336.5927228054055, 340.63381864495676, 5763.855903602402, 5853.209816674747, 5905.291365036196, 5910.2316698829145, 5932.169496270526, 5740.425957404257, 5864.384239654839, 5878.23582934219, 5886.911696324559, 5893.086571581412, 4556.635469162459, 4556.84051058213, 4564.0, 4566.977165114178, 4570.063137056895, 4361.760103194339, 4453.332000199964, 4454.53227411122, 4464.776761161929, 4555.954440455603, 4426.490953540336, 4469.955300447003, 4505.0, 4507.72953622782, 4508.61676757476, 4491.438570178728, 4496.64026877849, 4497.437820272466, 4501.4598248210095, 4519.5480451954545, 3991.521017477892, 3993.0815912340327, 3994.9201015979515, 3995.220931918277, 4003.73975691582, 5518.696471694096, 5649.293838270216, 5656.4060773618585, 5683.687397193153, 5691.800786972478, 5206.895862082775, 5212.035773381898, 5212.895742085175, 5214.4524824893215, 5218.947810521884, 5986.401359864022, 6249.437550620466, 6254.312025677217, 6258.374162583751, 6261.436470717612, 4197.790110494494, 4217.177650358181, 4324.048709283952, 4328.199283132631, 4329.415528903589, 6443.742250309982, 6483.7730679425995, 6486.2216534016225, 6510.479161667103, 6530.575512591667, 4420.889477763081, 4427.889302767457, 4430.933535996963, 4432.844850430284, 4434.17967675981, 4418.734875907456, 4441.511433742286, 4488.326750987313, 4494.10117976406, 4510.661700372485, 5166.829931428734, 5229.555487783581, 5231.110711179109, 5234.084035293885, 5234.712090834964, 6239.688015599202, 6264.248290205204, 6273.592216505913, 6281.842953926189, 6283.214598175228, 1563.2574527099537, 1586.7857839191793, 1588.0709784775804, 1588.7458006718869, 1592.418767149982, 1053.4364115198332, 1056.8995945385177, 1061.2677252695614, 1077.1436707817304, 1084.815581351172, 5957.523398128226, 5978.0, 5981.850453738692, 5984.850378740479, 5985.042393217064, 6464.838379040468, 6467.935320646828, 6473.676316184172, 6473.870522589522, 6481.254655714559, 5962.3739507351975, 5962.821115366546, 5974.0, 5981.431763982415, 5981.431763982502, 3419.076849250688, 3517.700995415418, 3533.222691007974, 3535.098549869767, 3536.8408421620575, 6775.356341147583, 6777.661116944133, 6779.830504237433, 6786.0, 6790.354916282945, 6699.665016749143, 6707.094542236833, 6712.328767123248, 6714.093597364391, 6714.194296684429, 6599.0, 6755.628440435823, 6757.628330441873, 6767.39093481589, 6769.492288078315, 6292.842678933063, 6399.55203135776, 6483.610983340826, 6502.869942601216, 6508.0, 6317.210348706411, 6459.063435801876, 6472.546921715435, 6485.481161507162, 6490.740370385321, 6735.595864248161, 6738.898916516158, 6740.831479213059, 6744.5616034957575, 6755.290694477009, 4313.008008158204, 4414.580614841585, 4455.955440445684, 4471.038726673781, 4485.394471746403, 6451.870962580816, 6502.187226596676, 6509.576877502947, 6511.2512061113575, 6523.054157147092, 6315.684215789101, 6317.96841015792, 6324.557280990287, 6327.367263273636, 6328.177336946167, 6195.876082478235, 6299.0, 6302.590331628429, 6305.495560355253, 6310.842228944313, 6180.165677633462, 6183.505319574333, 6184.536159788124, 6200.689965501617, 6200.968995155175, 6276.6547839869245, 6329.303776584664, 6331.461825744679, 6334.873302534015, 6336.081268216175, 6075.179850720273, 6137.815865524041, 6171.166892469639, 6194.163787888578, 6208.2860471044605], "unit": "score", "name": "prototype.html", "value": 4731.916576911209}, {"lowerIsBetter": false, "replicates": [800.9759707208782, 821.1378053044302, 839.0853969173603, 853.7865533616588, 867.4838471109689, 13313.467461301549, 13520.121192122506, 13553.119047261922, 13553.254570998604, 13581.18512889226, 12829.550965716178, 12945.805812912813, 12964.48142074316, 12964.93517532411, 14531.346089425975, 826.409117481001, 838.7609531283586, 840.1724301562986, 841.2386789955101, 841.3437518735396, 835.0355339582792, 846.6147902704255, 846.8137009857852, 848.0755975986174, 849.6176720475811, 863.386995233385, 872.707642939616, 875.0724232313736, 875.5490922175085, 876.6931573949099, 868.8001759595297, 872.3544577012965, 873.8252349530088, 874.4753148111114, 880.4541184465672, 641.2529403245213, 641.9582727122722, 642.9196350456193, 643.4273496587994, 643.5109316919176, 14211.147331160164, 14292.142471451747, 14361.281935903267, 14369.353379097965, 14452.638684032878, 12096.758064838654, 12150.756984860342, 12209.877901220963, 12251.57119500822, 12679.809802852964, 10335.379877207317, 10369.274150809446, 10408.115310198567, 10656.254062215648, 10767.6231331903, 3444.156181735466, 3474.6351633078666, 3491.284286721216, 3590.6588874056924, 3596.352656521825, 43682.12635747299, 44324.77837610791, 45743.54256457426, 47649.0, 48880.26679599809, 9178.21985131258, 9259.72220833376, 9264.490453025013, 9481.668141615148, 9910.35582687123, 17534.03562804058, 17543.035133067548, 17551.82448175502, 17905.10474476271, 18145.0, 7137.1435427749, 7467.3652739516665, 7581.6209189540305, 7659.885101723478, 7682.1549629540705, 4065.6950728695465, 4069.2675318442966, 4081.918361632751, 4149.937750933738, 4151.335786274181, 3020.7281344679086, 3072.9692703072683, 3075.4617941860083, 3077.415291094685, 3080.4455198064566, 547.4443439908496, 548.7201527221146, 549.2228496677237, 556.7605929450294, 565.2651552981108, 539.5090467674476, 547.3896605285158, 573.4552175433272, 656.4026735670517, 657.6514447342915, 8842.0, 8858.512781797062, 8917.955410222907, 8925.776855578533, 9035.819283614292, 565.1325215793737, 646.4828137489989, 686.2705980928033, 691.1533371619726, 719.7013239505546, 4025.6980726445636, 4038.8586399475876, 4056.350983842571, 4140.15126898985, 4244.1723863846255, 53125.46874531283, 53485.1977220342, 54383.45616543863, 54548.0, 55974.0, 43521.0, 45482.0, 47715.28427073597, 48850.26724599134, 49047.50952490501, 37940.43089353662, 40452.59547404547, 43626.34560481595, 43870.34194487021, 44934.0, 9027.4132181408, 9051.637934482547, 9152.267818574364, 9178.0, 9199.816003680024, 33869.0, 34673.82663086769, 34933.47599786056, 35081.824590877906, 35138.29723405569, 39059.6094039056, 42677.14645707131, 43095.35356969585, 43272.783636081615, 43353.783231083646, 9506.334556580972, 11237.157213208879, 11272.0, 11330.433478326215, 11538.82691759641, 12213.511459541518, 12274.263544187377, 12372.505099795908, 12560.874391255971, 12923.612291631267, 11561.479599432218, 11736.06111511094, 11892.702682432662, 12170.513179472722, 12297.139200255897, 10777.515011824644, 10859.51132199037, 11136.832947505633, 11239.55041798319, 11340.546378144782, 11448.599299024494, 11785.233959792586, 11785.646430607096, 12159.696007599881, 12176.208546444454, 9514.571844267162, 9673.467959262309, 9760.219182465244, 9867.40795552269, 9968.900310996798, 8793.560321984003, 9187.265018798347, 9605.18355939753, 9787.706368808947, 9826.803463930824], "unit": "score", "name": "yui.html", "value": 6289.344910041248}], "name": "dromaeo_css", "value": 6852.013339918684}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 104.0, 110.0, 111.0, 111.0, 98.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 148.0, 165.0, 131.0, 149.0, 148.0, 125.0, 163.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 163.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 87.0, 102.0, 74.0, 75.0, 73.0, 98.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 144.0, 95.0, 96.0, 96.0, 143.0, 95.0, 97.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 60.0, 60.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 84.0, 91.0, 92.0, 84.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [122.0, 115.0, 121.0, 114.0, 114.0, 123.0, 124.0, 119.0, 117.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [143.0, 142.0, 156.0, 141.0, 150.0, 141.0, 151.0, 157.0, 155.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 68.0, 66.0, 68.0, 70.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1502.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [191.27773527161438], "unit": "score", "name": "DeltaBlue", "value": 345.66490400000004}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1113.5857461024498], "unit": "score", "name": "RayTrace", "value": 664.510122}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [649.3843162670123], "unit": "score", "name": "Splay", "value": 125.48963373253495}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20815.86906365266}]} 04:20:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20815.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1502.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6852.01"}}} 04:20:33 INFO - Return code: 0 04:20:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:20:33 INFO - # TBPL SUCCESS # 04:20:33 INFO - Running post-action listener: _resource_record_post_action 04:20:33 INFO - Running post-run listener: _resource_record_post_run 04:20:34 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551018496; Read time: 60; Write time: 525284 04:20:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241758208; Read time: 0; Write time: 281532 04:20:34 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308215808; Read time: 60; Write time: 243692 04:20:34 INFO - Running post-run listener: _upload_blobber_files 04:20:34 INFO - Blob upload gear active. 04:20:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:20:34 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 04:20:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:20:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:20:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:20:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:35 INFO - (blobuploader) - INFO - Done attempting. 04:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:36 INFO - (blobuploader) - INFO - Done attempting. 04:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:36 INFO - Return code: 0 04:20:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6965528f7e452631a9eb31db13104fe1db9dc622626a513590e401dc971bc71a7c42bd53d797c28750b37d696f369b4570dd682ec2bd78d416770654cf0a594a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6acf1db8f34e0eef813f97a88ee05563c94432cb05b13e989bbf3e8fb37e8dd2c177d1a2f3cdc480eb857ab167ae18796303058315a77cf590a66332d68fdc5"} 04:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:20:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:20:36 INFO - Contents: 04:20:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6965528f7e452631a9eb31db13104fe1db9dc622626a513590e401dc971bc71a7c42bd53d797c28750b37d696f369b4570dd682ec2bd78d416770654cf0a594a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6acf1db8f34e0eef813f97a88ee05563c94432cb05b13e989bbf3e8fb37e8dd2c177d1a2f3cdc480eb857ab167ae18796303058315a77cf590a66332d68fdc5"} 04:20:36 INFO - Copying logs to upload dir... 04:20:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.246477 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-05 04:20:36.402619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 04:20:36.406624) ========= 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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6965528f7e452631a9eb31db13104fe1db9dc622626a513590e401dc971bc71a7c42bd53d797c28750b37d696f369b4570dd682ec2bd78d416770654cf0a594a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6acf1db8f34e0eef813f97a88ee05563c94432cb05b13e989bbf3e8fb37e8dd2c177d1a2f3cdc480eb857ab167ae18796303058315a77cf590a66332d68fdc5"} build_url:https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/abvXWGz-TqynAPFKixJlOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6965528f7e452631a9eb31db13104fe1db9dc622626a513590e401dc971bc71a7c42bd53d797c28750b37d696f369b4570dd682ec2bd78d416770654cf0a594a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6acf1db8f34e0eef813f97a88ee05563c94432cb05b13e989bbf3e8fb37e8dd2c177d1a2f3cdc480eb857ab167ae18796303058315a77cf590a66332d68fdc5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 04:20:36.434829) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:20:36.435217) ========= 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=6d15e502d8e29d5d2676d664000001c3-1451995172.267749-612323063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004773 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:20:36.517605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 04:20:36.518041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 04:20:36.518461) ========= ========= Total master_lag: 0.24 =========