builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1452087924.61 results: success (0) buildid: 20160106030225 builduid: dbcf7ff382be4f0390432d3162c16352 revision: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.605917) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.606432) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.606755) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006420 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.636306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.636604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.654725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.655016) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.711567) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.711969) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.712408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.712722) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 05:45:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.6M=0s 2016-01-06 05:45:25 (73.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162072 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.887918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.888442) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020353 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.937973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 05:45:24.938371) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --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=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 05:45:25,249 truncating revision to first 12 chars 2016-01-06 05:45:25,249 Setting DEBUG logging. 2016-01-06 05:45:25,249 attempt 1/10 2016-01-06 05:45:25,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9d6ffc7a08b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 05:45:26,111 unpacking tar archive at: mozilla-central-9d6ffc7a08b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.511138 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 05:45:26.462296) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:26.462601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:26.472731) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:26.473132) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:26.473571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-06 05:45:26.473884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:26 INFO - MultiFileLogger online at 20160106 05:45:26 in /builds/slave/test-pgo 05:45:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:45:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:45:26 INFO - {'append_to_log': False, 05:45:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:45:26 INFO - 'blob_upload_branch': 'Firefox', 05:45:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:45:26 INFO - 'branch': 'Firefox', 05:45:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:26 INFO - 'config_files': ('talos/linux_config.py',), 05:45:26 INFO - 'default_actions': ('clobber', 05:45:26 INFO - 'read-buildbot-config', 05:45:26 INFO - 'download-and-extract', 05:45:26 INFO - 'populate-webroot', 05:45:26 INFO - 'create-virtualenv', 05:45:26 INFO - 'install', 05:45:26 INFO - 'run-tests'), 05:45:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:26 INFO - 'download_minidump_stackwalk': True, 05:45:26 INFO - 'download_symbols': 'ondemand', 05:45:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:26 INFO - 'installer_path': 'installer.exe', 05:45:26 INFO - 'log_level': 'info', 05:45:26 INFO - 'log_name': 'talos', 05:45:26 INFO - 'log_to_console': True, 05:45:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:26 INFO - 'opt_config_files': (), 05:45:26 INFO - 'pip_index': False, 05:45:26 INFO - 'sps_profile': False, 05:45:26 INFO - 'sps_profile_interval': 0, 05:45:26 INFO - 'suite': 'dromaeojs-e10s', 05:45:26 INFO - 'system_bits': '32', 05:45:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:26 INFO - 'title': 'talos-linux64-ix-036', 05:45:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:26 INFO - 'use_talos_json': True, 05:45:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:45:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:26 INFO - 'work_dir': 'build'} 05:45:26 INFO - ##### 05:45:26 INFO - ##### Running clobber step. 05:45:26 INFO - ##### 05:45:26 INFO - Running pre-action listener: _resource_record_pre_action 05:45:26 INFO - Running main action method: clobber 05:45:26 INFO - rmtree: /builds/slave/test-pgo/build 05:45:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:45:27 INFO - Running post-action listener: _resource_record_post_action 05:45:27 INFO - ##### 05:45:27 INFO - ##### Running read-buildbot-config step. 05:45:27 INFO - ##### 05:45:27 INFO - Running pre-action listener: _resource_record_pre_action 05:45:27 INFO - Running main action method: read_buildbot_config 05:45:27 INFO - Using buildbot properties: 05:45:27 INFO - { 05:45:27 INFO - "project": "", 05:45:27 INFO - "product": "firefox", 05:45:27 INFO - "script_repo_revision": "production", 05:45:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:45:27 INFO - "repository": "", 05:45:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:45:27 INFO - "buildid": "20160106030225", 05:45:27 INFO - "stage_platform": "linux64-pgo", 05:45:27 INFO - "basedir": "/builds/slave/test-pgo", 05:45:27 INFO - "nightly_build": "True", 05:45:27 INFO - "buildnumber": 604, 05:45:27 INFO - "slavename": "talos-linux64-ix-036", 05:45:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:45:27 INFO - "platform": "ubuntu64_hw", 05:45:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:27 INFO - "branch": "mozilla-central", 05:45:27 INFO - "repo_path": "mozilla-central", 05:45:27 INFO - "revision": "9d6ffc7a08b6b47056eefe1e652710a3849adbf7", 05:45:27 INFO - "pgo_build": "True", 05:45:27 INFO - "builduid": "dbcf7ff382be4f0390432d3162c16352", 05:45:27 INFO - "slavebuilddir": "test" 05:45:27 INFO - } 05:45:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:45:27 INFO - Running post-action listener: _resource_record_post_action 05:45:27 INFO - ##### 05:45:27 INFO - ##### Running download-and-extract step. 05:45:27 INFO - ##### 05:45:27 INFO - Running pre-action listener: _resource_record_pre_action 05:45:27 INFO - Running main action method: download_and_extract 05:45:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:27 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json 05:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json 05:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:45:28 INFO - Downloaded 1302 bytes. 05:45:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:45:28 INFO - Using the following test package requirements: 05:45:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:28 INFO - u'jsshell-linux-x86_64.zip'], 05:45:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:28 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:29 INFO - Downloaded 24054491 bytes. 05:45:29 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 05:45:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:29 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 05:45:30 INFO - Return code: 0 05:45:30 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 05:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:30 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:37 INFO - Downloaded 24054491 bytes. 05:45:37 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 05:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:37 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 05:45:39 INFO - Return code: 0 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:39 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:39 INFO - Downloaded 11132285 bytes. 05:45:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:45:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:45:40 INFO - Return code: 0 05:45: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')]} 05:45:40 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:44 INFO - Downloaded 55064197 bytes. 05:45:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:44 INFO - mkdir: /builds/slave/test-pgo/properties 05:45:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:45:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:45:44 INFO - Contents: 05:45:44 INFO - build_url:https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:44 INFO - Running post-action listener: _resource_record_post_action 05:45:44 INFO - Running post-action listener: set_extra_try_arguments 05:45:44 INFO - ##### 05:45:44 INFO - ##### Running populate-webroot step. 05:45:44 INFO - ##### 05:45:44 INFO - Running pre-action listener: _resource_record_pre_action 05:45:44 INFO - Running main action method: populate_webroot 05:45:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:44 INFO - '--tppagecycles', 05:45:44 INFO - '7'], 05:45:44 INFO - 'tests': ['tsvgm']}}, 05:45:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:45:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'tests': ['damp', 'tps']}, 05:45:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['damp', 'tps']}, 05:45:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:45:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:44 INFO - 'other': {'tests': ['a11yr', 05:45:44 INFO - 'ts_paint', 05:45:44 INFO - 'tpaint', 05:45:44 INFO - 'sessionrestore', 05:45:44 INFO - 'sessionrestore_no_auto_restore']}, 05:45:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['a11yr', 05:45:44 INFO - 'ts_paint', 05:45:44 INFO - 'tpaint', 05:45:44 INFO - 'sessionrestore', 05:45:44 INFO - 'sessionrestore_no_auto_restore']}, 05:45:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['a11yr', 05:45:44 INFO - 'ts_paint', 05:45:44 INFO - 'tpaint', 05:45:44 INFO - 'sessionrestore', 05:45:44 INFO - 'sessionrestore_no_auto_restore']}, 05:45:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['a11yr', 05:45:44 INFO - 'ts_paint', 05:45:44 INFO - 'tpaint', 05:45:44 INFO - 'sessionrestore', 05:45:44 INFO - 'sessionrestore_no_auto_restore']}, 05:45:44 INFO - 'other_l64': {'tests': ['a11yr', 05:45:44 INFO - 'ts_paint', 05:45:44 INFO - 'tpaint', 05:45:44 INFO - 'sessionrestore', 05:45:44 INFO - 'sessionrestore_no_auto_restore']}, 05:45:44 INFO - 'other_nol64': {'tests': ['a11yr', 05:45:44 INFO - 'ts_paint', 05:45:44 INFO - 'tpaint', 05:45:44 INFO - 'sessionrestore', 05:45:44 INFO - 'sessionrestore_no_auto_restore']}, 05:45:44 INFO - 'svgr': {'tests': ['tsvgx', 05:45:44 INFO - 'tsvgr_opacity', 05:45:44 INFO - 'tart', 05:45:44 INFO - 'tscrollx', 05:45:44 INFO - 'cart']}, 05:45:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['tsvgx', 05:45:44 INFO - 'tsvgr_opacity', 05:45:44 INFO - 'tart', 05:45:44 INFO - 'tscrollx', 05:45:44 INFO - 'cart']}, 05:45:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'tests': ['tp5o']}, 05:45:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'talos_options': ['--e10s'], 05:45:44 INFO - 'tests': ['tp5o']}, 05:45:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'talos_options': ['--xperf_path', 05:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:44 INFO - 'tests': ['tp5n']}, 05:45:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:44 INFO - 'talos_options': ['--e10s', 05:45:44 INFO - '--xperf_path', 05:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:44 INFO - 'tests': ['tp5n']}}, 05:45:44 INFO - 'talos.zip': {'path': '', 05:45:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:44 INFO - Running post-action listener: _resource_record_post_action 05:45:44 INFO - ##### 05:45:44 INFO - ##### Running create-virtualenv step. 05:45:44 INFO - ##### 05:45:44 INFO - Running pre-action listener: _resource_record_pre_action 05:45:44 INFO - Running main action method: create_virtualenv 05:45:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:45:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:45:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:45:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:44 INFO - Using real prefix '/usr' 05:45:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:45:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:47 INFO - Installing pip.................done. 05:45:47 INFO - Return code: 0 05:45:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:45: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 pip>=1.5 05:45:47 INFO - Using env: {'DISPLAY': ':0', 05:45:47 INFO - 'HOME': '/home/cltbld', 05:45:47 INFO - 'LANG': 'en_US.UTF-8', 05:45:47 INFO - 'LANGUAGE': 'en_US:en', 05:45:47 INFO - 'LOGNAME': 'cltbld', 05:45:47 INFO - 'MAIL': '/var/mail/cltbld', 05:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:47 INFO - 'MOZ_NO_REMOTE': '1', 05:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:47 INFO - 'NO_EM_RESTART': '1', 05:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:47 INFO - 'SHELL': '/bin/bash', 05:45:47 INFO - 'SHLVL': '1', 05:45:47 INFO - 'TERM': 'linux', 05:45:47 INFO - 'TMOUT': '86400', 05:45:47 INFO - 'USER': 'cltbld', 05:45:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:47 INFO - '_': '/tools/buildbot/bin/python'} 05:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:47 INFO - Cleaning up... 05:45:47 INFO - Return code: 0 05:45:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:45:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:45:47 INFO - Using env: {'DISPLAY': ':0', 05:45:47 INFO - 'HOME': '/home/cltbld', 05:45:47 INFO - 'LANG': 'en_US.UTF-8', 05:45:47 INFO - 'LANGUAGE': 'en_US:en', 05:45:47 INFO - 'LOGNAME': 'cltbld', 05:45:47 INFO - 'MAIL': '/var/mail/cltbld', 05:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:47 INFO - 'MOZ_NO_REMOTE': '1', 05:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:47 INFO - 'NO_EM_RESTART': '1', 05:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:47 INFO - 'SHELL': '/bin/bash', 05:45:47 INFO - 'SHLVL': '1', 05:45:47 INFO - 'TERM': 'linux', 05:45:47 INFO - 'TMOUT': '86400', 05:45:47 INFO - 'USER': 'cltbld', 05:45:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:47 INFO - '_': '/tools/buildbot/bin/python'} 05:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:47 INFO - Downloading/unpacking psutil>=0.7.1 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:45:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:45:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:49 INFO - Installing collected packages: psutil 05:45:49 INFO - Running setup.py install for psutil 05:45:49 INFO - building 'psutil._psutil_linux' extension 05:45:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:45:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:45:49 INFO - building 'psutil._psutil_posix' extension 05:45:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:45:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:49 INFO - Successfully installed psutil 05:45:49 INFO - Cleaning up... 05:45:49 INFO - Return code: 0 05:45:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:45:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:45:49 INFO - Using env: {'DISPLAY': ':0', 05:45:49 INFO - 'HOME': '/home/cltbld', 05:45:49 INFO - 'LANG': 'en_US.UTF-8', 05:45:49 INFO - 'LANGUAGE': 'en_US:en', 05:45:49 INFO - 'LOGNAME': 'cltbld', 05:45:49 INFO - 'MAIL': '/var/mail/cltbld', 05:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:49 INFO - 'MOZ_NO_REMOTE': '1', 05:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:49 INFO - 'NO_EM_RESTART': '1', 05:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:49 INFO - 'SHELL': '/bin/bash', 05:45:49 INFO - 'SHLVL': '1', 05:45:49 INFO - 'TERM': 'linux', 05:45:49 INFO - 'TMOUT': '86400', 05:45:49 INFO - 'USER': 'cltbld', 05:45:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:49 INFO - '_': '/tools/buildbot/bin/python'} 05:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:45:51 INFO - Installing collected packages: mozsystemmonitor 05:45:51 INFO - Running setup.py install for mozsystemmonitor 05:45:51 INFO - Successfully installed mozsystemmonitor 05:45:51 INFO - Cleaning up... 05:45:51 INFO - Return code: 0 05:45:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:45:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:51 INFO - Using env: {'DISPLAY': ':0', 05:45:51 INFO - 'HOME': '/home/cltbld', 05:45:51 INFO - 'LANG': 'en_US.UTF-8', 05:45:51 INFO - 'LANGUAGE': 'en_US:en', 05:45:51 INFO - 'LOGNAME': 'cltbld', 05:45:51 INFO - 'MAIL': '/var/mail/cltbld', 05:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:51 INFO - 'MOZ_NO_REMOTE': '1', 05:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:51 INFO - 'NO_EM_RESTART': '1', 05:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:51 INFO - 'SHELL': '/bin/bash', 05:45:51 INFO - 'SHLVL': '1', 05:45:51 INFO - 'TERM': 'linux', 05:45:51 INFO - 'TMOUT': '86400', 05:45:51 INFO - 'USER': 'cltbld', 05:45:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:51 INFO - '_': '/tools/buildbot/bin/python'} 05:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - Downloading docopt-0.6.1.tar.gz 05:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:54 INFO - Running setup.py install for blobuploader 05:45:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:54 INFO - Running setup.py install for requests 05:45:55 INFO - Running setup.py install for docopt 05:45:55 INFO - Successfully installed blobuploader requests docopt 05:45:55 INFO - Cleaning up... 05:45:55 INFO - Return code: 0 05:45:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:45:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:55 INFO - Using env: {'DISPLAY': ':0', 05:45:55 INFO - 'HOME': '/home/cltbld', 05:45:55 INFO - 'LANG': 'en_US.UTF-8', 05:45:55 INFO - 'LANGUAGE': 'en_US:en', 05:45:55 INFO - 'LOGNAME': 'cltbld', 05:45:55 INFO - 'MAIL': '/var/mail/cltbld', 05:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:55 INFO - 'MOZ_NO_REMOTE': '1', 05:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:55 INFO - 'NO_EM_RESTART': '1', 05:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:55 INFO - 'SHELL': '/bin/bash', 05:45:55 INFO - 'SHLVL': '1', 05:45:55 INFO - 'TERM': 'linux', 05:45:55 INFO - 'TMOUT': '86400', 05:45:55 INFO - 'USER': 'cltbld', 05:45:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:55 INFO - '_': '/tools/buildbot/bin/python'} 05:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:55 INFO - Running setup.py (path:/tmp/pip-lcnNg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:55 INFO - Running setup.py (path:/tmp/pip-YojktQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:55 INFO - Running setup.py (path:/tmp/pip-0FScfV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:55 INFO - Running setup.py (path:/tmp/pip-hGCnsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:55 INFO - Running setup.py (path:/tmp/pip-bxl55a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:55 INFO - Running setup.py (path:/tmp/pip-B7rZW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:55 INFO - Running setup.py (path:/tmp/pip-jQnlnI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:56 INFO - Running setup.py (path:/tmp/pip-fCdYkC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:56 INFO - Running setup.py (path:/tmp/pip-Kop0qj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:56 INFO - Running setup.py (path:/tmp/pip-Nv5eEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:56 INFO - Running setup.py (path:/tmp/pip-4xe3Wc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:56 INFO - Running setup.py (path:/tmp/pip-cxMqd5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:56 INFO - Running setup.py (path:/tmp/pip-CkSZlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:56 INFO - Running setup.py (path:/tmp/pip-wADT8w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:56 INFO - Running setup.py (path:/tmp/pip-Fr_R15-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:56 INFO - Running setup.py (path:/tmp/pip-8ERE1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:56 INFO - Running setup.py (path:/tmp/pip-SMF0J7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:56 INFO - Running setup.py install for manifestparser 05:45:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:56 INFO - Running setup.py install for mozcrash 05:45:56 INFO - Running setup.py install for mozdebug 05:45:57 INFO - Running setup.py install for mozdevice 05:45:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Running setup.py install for mozfile 05:45:57 INFO - Running setup.py install for mozhttpd 05:45:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Running setup.py install for mozinfo 05:45:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Running setup.py install for mozInstall 05:45:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Running setup.py install for mozleak 05:45:57 INFO - Running setup.py install for mozlog 05:45:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Running setup.py install for moznetwork 05:45:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:57 INFO - Running setup.py install for mozprocess 05:45:57 INFO - Running setup.py install for mozprofile 05:45:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:58 INFO - Running setup.py install for mozrunner 05:45:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:58 INFO - Running setup.py install for mozscreenshot 05:45:58 INFO - Running setup.py install for moztest 05:45:58 INFO - Running setup.py install for mozversion 05:45:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:58 INFO - Cleaning up... 05:45:58 INFO - Return code: 0 05:45:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:45:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:58 INFO - Using env: {'DISPLAY': ':0', 05:45:58 INFO - 'HOME': '/home/cltbld', 05:45:58 INFO - 'LANG': 'en_US.UTF-8', 05:45:58 INFO - 'LANGUAGE': 'en_US:en', 05:45:58 INFO - 'LOGNAME': 'cltbld', 05:45:58 INFO - 'MAIL': '/var/mail/cltbld', 05:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:58 INFO - 'MOZ_NO_REMOTE': '1', 05:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:58 INFO - 'NO_EM_RESTART': '1', 05:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:58 INFO - 'SHELL': '/bin/bash', 05:45:58 INFO - 'SHLVL': '1', 05:45:58 INFO - 'TERM': 'linux', 05:45:58 INFO - 'TMOUT': '86400', 05:45:58 INFO - 'USER': 'cltbld', 05:45:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:58 INFO - '_': '/tools/buildbot/bin/python'} 05:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:58 INFO - Running setup.py (path:/tmp/pip-6d1o9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:58 INFO - Running setup.py (path:/tmp/pip-SBVtXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:58 INFO - Running setup.py (path:/tmp/pip-y3b6fD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:58 INFO - Running setup.py (path:/tmp/pip-LMfFLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:59 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)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:59 INFO - Running setup.py (path:/tmp/pip-rSmEFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:59 INFO - Running setup.py (path:/tmp/pip-BoBSv_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:59 INFO - Running setup.py (path:/tmp/pip-2NqcER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:59 INFO - Running setup.py (path:/tmp/pip-8XuGGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:59 INFO - Running setup.py (path:/tmp/pip-XCPln3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:59 INFO - Running setup.py (path:/tmp/pip-gIyuer-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:59 INFO - Running setup.py (path:/tmp/pip-r4wbjB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:59 INFO - Running setup.py (path:/tmp/pip-6UTMhk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:59 INFO - Running setup.py (path:/tmp/pip-bxKKWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:59 INFO - Running setup.py (path:/tmp/pip-CmDTos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:59 INFO - Running setup.py (path:/tmp/pip-M1fjVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:59 INFO - Running setup.py (path:/tmp/pip-zDkCgb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:59 INFO - Running setup.py (path:/tmp/pip-qSNcZB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:00 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)) 05:46:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:01 INFO - Downloading blessings-1.5.1.tar.gz 05:46:01 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:01 INFO - Installing collected packages: blessings 05:46:01 INFO - Running setup.py install for blessings 05:46:01 INFO - Successfully installed blessings 05:46:01 INFO - Cleaning up... 05:46:01 INFO - Return code: 0 05:46:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:46:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:46:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:46:02 INFO - Reading from file tmpfile_stdout 05:46:02 INFO - Current package versions: 05:46:02 INFO - argparse == 1.2.1 05:46:02 INFO - blessings == 1.5.1 05:46:02 INFO - blobuploader == 1.2.4 05:46:02 INFO - docopt == 0.6.1 05:46:02 INFO - manifestparser == 1.1 05:46:02 INFO - mozInstall == 1.12 05:46:02 INFO - mozcrash == 0.16 05:46:02 INFO - mozdebug == 0.1 05:46:02 INFO - mozdevice == 0.47 05:46:02 INFO - mozfile == 1.2 05:46:02 INFO - mozhttpd == 0.7 05:46:02 INFO - mozinfo == 0.9 05:46:02 INFO - mozleak == 0.1 05:46:02 INFO - mozlog == 3.1 05:46:02 INFO - moznetwork == 0.27 05:46:02 INFO - mozprocess == 0.22 05:46:02 INFO - mozprofile == 0.28 05:46:02 INFO - mozrunner == 6.11 05:46:02 INFO - mozscreenshot == 0.1 05:46:02 INFO - mozsystemmonitor == 0.0 05:46:02 INFO - moztest == 0.7 05:46:02 INFO - mozversion == 1.4 05:46:02 INFO - psutil == 3.1.1 05:46:02 INFO - requests == 1.2.3 05:46:02 INFO - wsgiref == 0.1.2 05:46:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:46: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')]} 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:02 INFO - Using env: {'DISPLAY': ':0', 05:46:02 INFO - 'HOME': '/home/cltbld', 05:46:02 INFO - 'LANG': 'en_US.UTF-8', 05:46:02 INFO - 'LANGUAGE': 'en_US:en', 05:46:02 INFO - 'LOGNAME': 'cltbld', 05:46:02 INFO - 'MAIL': '/var/mail/cltbld', 05:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:02 INFO - 'MOZ_NO_REMOTE': '1', 05:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:02 INFO - 'NO_EM_RESTART': '1', 05:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:02 INFO - 'SHELL': '/bin/bash', 05:46:02 INFO - 'SHLVL': '1', 05:46:02 INFO - 'TERM': 'linux', 05:46:02 INFO - 'TMOUT': '86400', 05:46:02 INFO - 'USER': 'cltbld', 05:46:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:02 INFO - '_': '/tools/buildbot/bin/python'} 05:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:46:02 INFO - Cleaning up... 05:46:02 INFO - Return code: 0 05:46:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:46: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')]} 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:46:02 INFO - Using env: {'DISPLAY': ':0', 05:46:02 INFO - 'HOME': '/home/cltbld', 05:46:02 INFO - 'LANG': 'en_US.UTF-8', 05:46:02 INFO - 'LANGUAGE': 'en_US:en', 05:46:02 INFO - 'LOGNAME': 'cltbld', 05:46:02 INFO - 'MAIL': '/var/mail/cltbld', 05:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:02 INFO - 'MOZ_NO_REMOTE': '1', 05:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:02 INFO - 'NO_EM_RESTART': '1', 05:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:02 INFO - 'SHELL': '/bin/bash', 05:46:02 INFO - 'SHLVL': '1', 05:46:02 INFO - 'TERM': 'linux', 05:46:02 INFO - 'TMOUT': '86400', 05:46:02 INFO - 'USER': 'cltbld', 05:46:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:02 INFO - '_': '/tools/buildbot/bin/python'} 05:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:02 INFO - Downloading/unpacking jsonschema 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:46:04 INFO - Downloading/unpacking functools32 (from jsonschema) 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:46:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:04 INFO - warning: no files found matching '*.txt' 05:46:04 INFO - no previously-included directories found matching 'build' 05:46:04 INFO - no previously-included directories found matching 'dist' 05:46:04 INFO - no previously-included directories found matching '.git*' 05:46:04 INFO - Installing collected packages: jsonschema, functools32 05:46:04 INFO - Running setup.py install for functools32 05:46:04 INFO - warning: no files found matching '*.txt' 05:46:04 INFO - no previously-included directories found matching 'build' 05:46:04 INFO - no previously-included directories found matching 'dist' 05:46:04 INFO - no previously-included directories found matching '.git*' 05:46:04 INFO - Successfully installed jsonschema functools32 05:46:04 INFO - Cleaning up... 05:46:04 INFO - Return code: 0 05:46:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f630e0e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e29480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:46:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:46:04 INFO - Using env: {'DISPLAY': ':0', 05:46:04 INFO - 'HOME': '/home/cltbld', 05:46:04 INFO - 'LANG': 'en_US.UTF-8', 05:46:04 INFO - 'LANGUAGE': 'en_US:en', 05:46:04 INFO - 'LOGNAME': 'cltbld', 05:46:04 INFO - 'MAIL': '/var/mail/cltbld', 05:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:04 INFO - 'MOZ_NO_REMOTE': '1', 05:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:04 INFO - 'NO_EM_RESTART': '1', 05:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:04 INFO - 'SHELL': '/bin/bash', 05:46:04 INFO - 'SHLVL': '1', 05:46:04 INFO - 'TERM': 'linux', 05:46:04 INFO - 'TMOUT': '86400', 05:46:04 INFO - 'USER': 'cltbld', 05:46:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:04 INFO - '_': '/tools/buildbot/bin/python'} 05:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:04 INFO - Downloading/unpacking flake8 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:46:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:46:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:46:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:46:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:46:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:46:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:07 INFO - no previously-included directories found matching 'docs/_build' 05:46:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:46:07 INFO - Running setup.py install for pep8 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:07 INFO - no previously-included directories found matching 'docs/_build' 05:46:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:46:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:46:07 INFO - Cleaning up... 05:46:07 INFO - Return code: 0 05:46:07 INFO - Running post-action listener: _resource_record_post_action 05:46:07 INFO - Running post-action listener: _start_resource_monitoring 05:46:07 INFO - Starting resource monitoring. 05:46:07 INFO - ##### 05:46:07 INFO - ##### Running install step. 05:46:07 INFO - ##### 05:46:07 INFO - Running pre-action listener: _resource_record_pre_action 05:46:07 INFO - Running main action method: install 05:46:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:46:07 INFO - Reading from file tmpfile_stdout 05:46:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:46:07 INFO - Reading from file tmpfile_stdout 05:46:07 INFO - Output received: 05:46:07 INFO - Usage: mozinstall [options] installer 05:46:07 INFO - Options: 05:46:07 INFO - -h, --help show this help message and exit 05:46:07 INFO - -d DEST, --destination=DEST 05:46:07 INFO - Directory to install application into. [default: 05:46:07 INFO - "/builds/slave/test-pgo"] 05:46:07 INFO - --app=APP Application being installed. [default: firefox] 05:46:07 INFO - mkdir: /builds/slave/test-pgo/build/application 05:46:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:46:23 INFO - Reading from file tmpfile_stdout 05:46:23 INFO - Output received: 05:46:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:46:23 INFO - Running post-action listener: _resource_record_post_action 05:46:23 INFO - ##### 05:46:23 INFO - ##### Running run-tests step. 05:46:23 INFO - ##### 05:46:23 INFO - Running pre-action listener: _resource_record_pre_action 05:46:23 INFO - Running main action method: run_tests 05:46:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:46:23 INFO - Python 2.7.3 05:46:23 INFO - Return code: 0 05:46:23 INFO - grabbing minidump binary from tooltool 05:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:23 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 0x1eb8660>, '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 0x1eb9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:46:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:46:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:46:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:23 INFO - Return code: 0 05:46:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:46:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:46:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:46:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:46:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:46:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:46:24 INFO - Return code: 0 05:46:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:46:24 INFO - Using env: {'DISPLAY': ':0', 05:46:24 INFO - 'HOME': '/home/cltbld', 05:46:24 INFO - 'LANG': 'en_US.UTF-8', 05:46:24 INFO - 'LANGUAGE': 'en_US:en', 05:46:24 INFO - 'LOGNAME': 'cltbld', 05:46:24 INFO - 'MAIL': '/var/mail/cltbld', 05:46:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:24 INFO - 'MOZ_NO_REMOTE': '1', 05:46:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:24 INFO - 'NO_EM_RESTART': '1', 05:46:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:46:24 INFO - 'SHELL': '/bin/bash', 05:46:24 INFO - 'SHLVL': '1', 05:46:24 INFO - 'TERM': 'linux', 05:46:24 INFO - 'TMOUT': '86400', 05:46:24 INFO - 'USER': 'cltbld', 05:46:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352', 05:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:24 INFO - '_': '/tools/buildbot/bin/python'} 05:46:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:46:24 INFO - mozversion application_buildid: 20160106030225 05:46:24 INFO - mozversion application_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 05:46:24 INFO - mozversion application_display_name: Nightly 05:46:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:24 INFO - mozversion application_name: Firefox 05:46:24 INFO - mozversion application_remotingname: firefox 05:46:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:24 INFO - mozversion application_vendor: Mozilla 05:46:24 INFO - mozversion application_version: 46.0a1 05:46:24 INFO - mozversion platform_buildid: 20160106030225 05:46:24 INFO - mozversion platform_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 05:46:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:24 INFO - mozversion platform_version: 46.0a1 05:46:24 INFO - using testdate: 1452087984 05:46:24 INFO - actual date: 1452087984 05:46:24 INFO - starting webserver on 'localhost:33703' 05:46:24 INFO - SUITE-START | Running 3 tests 05:46:24 INFO - TEST-START | dromaeo_css 05:46:24 INFO - operating with platform_type : linux_ 05:46:24 INFO - Initialising browser for dromaeo_css test... 05:46:24 INFO - TEST-INFO | started process 15038 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptgdxcX/profile http://localhost:33703/getInfo.html) 05:46:29 INFO - PROCESS | 15038 | __metrics Screen width/height:1600/1200 05:46:29 INFO - PROCESS | 15038 | colorDepth:24 05:46:29 INFO - PROCESS | 15038 | Browser inner width/height: 1024/670 05:46:29 INFO - PROCESS | 15038 | __metrics 05:46:29 INFO - PROCESS | 15038 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:46:30 INFO - TEST-INFO | 15038: exit 0 05:46:30 INFO - Browser initialized. 05:46:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:30 INFO - TEST-INFO | started process 15171 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptgdxcX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:42 INFO - PROCESS | 15171 | RSS: Main: 150835200 05:46:42 INFO - PROCESS | 15171 | 05:47:32 INFO - PROCESS | 15171 | 1452088052090 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:40 INFO - PROCESS | 15171 | Cycle 1(1): loaded http://localhost:33703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33703/tests/dromaeo/cssquery-ext.html) 05:49:42 INFO - PROCESS | 15171 | RSS: Main: 157851648 05:49:42 INFO - PROCESS | 15171 | 05:52:44 INFO - PROCESS | 15171 | Cycle 1(1): loaded http://localhost:33703/tests/dromaeo/cssquery-ext.html (next: http://localhost:33703/tests/dromaeo/cssquery-jquery.html) 05:52:44 INFO - PROCESS | 15171 | RSS: Main: 152772608 05:52:44 INFO - PROCESS | 15171 | 05:55:46 INFO - PROCESS | 15171 | Cycle 1(1): loaded http://localhost:33703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33703/tests/dromaeo/cssquery-mootools.html) 05:55:47 INFO - PROCESS | 15171 | RSS: Main: 152973312 05:55:47 INFO - PROCESS | 15171 | 05:58:48 INFO - PROCESS | 15171 | Cycle 1(1): loaded http://localhost:33703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33703/tests/dromaeo/cssquery-prototype.html) 05:58:49 INFO - PROCESS | 15171 | RSS: Main: 151973888 05:58:49 INFO - PROCESS | 15171 | 06:01:51 INFO - PROCESS | 15171 | Cycle 1(1): loaded http://localhost:33703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33703/tests/dromaeo/cssquery-yui.html) 06:01:52 INFO - PROCESS | 15171 | RSS: Main: 151973888 06:01:52 INFO - PROCESS | 15171 | 06:04:54 INFO - PROCESS | 15171 | Cycle 1(1): loaded http://localhost:33703/tests/dromaeo/cssquery-yui.html (next: http://localhost:33703/tests/dromaeo/cssquery-dojo.html) 06:04:55 INFO - PROCESS | 15171 | RSS: Main: 154730496 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | __start_tp_report 06:04:55 INFO - PROCESS | 15171 | _x_x_mozilla_page_load 06:04:55 INFO - PROCESS | 15171 | _x_x_mozilla_page_load_details 06:04:55 INFO - PROCESS | 15171 | |i|pagename|runs| 06:04:55 INFO - PROCESS | 15171 | |0;dojo.html;3181.8409079546022;3222.146131275211;3248.252901832579;3252.7560432967534;3269.5095735639666;5222.060029194743;5281.260623512701;5288.60335474839;5330.760115794789;5337.492938170873;5320.76056577454;5335.466453354663;5412.404635490093;5512.228288039678;5524.779008839651;4905.999999999991;4922.704637721748;5010.649254552182;5033.194688849785;5059.190529515278;4881.243407271861;4921.064997650453;4963.25551167326;5001.274815151801;5048.6465947383695;4807.879803004917;4835.468098509161;4845.588125009378;4850.3937007873665;4870.634702397334;4859.246816743411;4886.486918873503;4891.997140586207;4909.944361962195;4911.8772030699165;4787.928181077286;4821.035792841446;4855.150348689001;4895.339129217546;4898.044881248158;5251;5278.313819203518;5286.920696189561;5297.364316282033;5346.679199248018;5778.537716982673;5798.42015798421;5799.304083509964;5802.680852553108;5805.7387417566315;5603.887922241533;5697.77208911643;5817.301923769132;5855.209546711225;5866.9706651466895;5433.891322173574;5441.619086663935;5445.591580631469;5450.209719590677;5465.07093794052;5889.617174883619;5890.528757699374;5892.882142357214;5905.822825315247;5936.1392598073035;5584.357798853184;5608.69152196625;5706.686132262766;5707.200991861143;5715.771369145271;5753.108268218432;5773.422657734277;5794.246747922743;5797.188393624896;5821.330546987151;5699.686517241508;5724.284464441945;5785.103308987113;5787.07406814916;5791.478766910998;5655.179998900218;5664.291963504562;5698;5708.20085188074;5737.655740655574;4453.487848897418;4468.262736648417;4473.2842745160615;4474.082813023388;4515.5484451554585;3906.2382835346834;3985.661218796377;3990.7206495545615;4019.799010049486;4038.1519880824767;5354.3842458117815;5446.400895901447;5466.070767969455;5467.917981230285;5486.561075113981;5847.795327163614;5858.912116318259;5860.2967643883;5861.3552509223955;5870.53035757147;5443.156310771837;5445.428230035868;5447.536959358499;5452.372977107683;5455.5908306877145;4855.781489832966;4860.6111511079025;4935.259711043373;4944.456109827916;4963.057019166346;5869.530437564899;5950.256217972754;5964.284285885721;6002.669853158118;6030.30651475086;5755.165501002415;5794.710264486843;5812.21535092757;5821.825345239649;5822.184894114743;5946;6005.189299444519;6036.7283472244735;6037.577369584087;6070.271567411939;5740.913886291625;5757.424257574209;5759;5769.74036168365;5778.682172480554;5831.096180092092;5862.970685146547;5868.295804503487;5871.412858714094;5875;5570.972145139248;5597.384287728428;5642.069058605448;5684.346300175367;5693.231413759255;5647.1529270609735;5669.914951275817;5689.089745640677;5694.430556944272;5703.771849125988;5573.693446860461;5586.38549759518;5586.581006424616;5597.580181486323;5608;5530.834074977757;5650.858728531655;5676.545876329967;5728.971355143198;5779.479846813807;5536.7785288588;5576.302962129734;5587.804426845041;5588.776448941997;5595.244641973281 06:04:55 INFO - PROCESS | 15171 | |1;ext.html;517.3352242368558;523.7800123947942;534.3961323704214;551.8316913341432;553.5765139668157;34597.48103778442;34948.825255873686;34955;34990.650093499054;34996.47505287423;37128.81435592825;37600.24799504008;37692.811535942354;37698.62301376985;37820;8302.045264794535;8434.789130271762;8438.240558349748;8451.704190353339;8520.275776558969;8259.587020648974;8379.622916968721;8384;8398.580070996457;8416.20046095623;8523.44597601157;8601.483910965331;8612.612432440555;8629.827403451927;8632.007319158283;8487.193716596914;8591.140885911422;8594.441361311494;8607.440516366416;8613.353998450142;8402.957985210034;8440.87338689914;8523.147685231428;8550.572471376407;8552.871706924401;38539.8073009636;39084.41373379402;39134.804325978184;39160.41259381112;39221.41167882484;3230.4831227003565;3336.833158342073;3429.159855835336;3480.1473638958364;3832.7891965941863;30603.23491912698;30968;30995.535066974015;31079.37841243185;31240.843795780875;3683.7421380503374;3918.628480031966;3929.0963078491823;4070.674346052309;4094.2016306820183;259135;264576;265772;265980;266313;60911.39088609057;61680.38319616836;62042;62149.37850621526;62215.37784622096;62375.6881215591;63789.681051594445;72661;72785.27214727891;72896.63551682314;14896.776548351783;15135.091894486366;15260.923695381452;15314.310856011283;15331.696805771635;11115.333080015225;11210.66368008961;11258.268212566321;11287.49206285719;11324.830127548094;21178.78821211799;21536.56926861454;21545.78454215469;21548.4612884676;21560.568788624452;8234.547099909563;8605;8623.525706086226;8651.826963460822;8686.695965641173;898.7528429681759;926.5228407370209;1033.7570670892335;1053.9262251642313;1069.8769641491172;28294.858525707652;28298.43403131926;28363.290917727223;28569.57145642817;28852.85573572161;982.9066238707311;1037.159900480613;1054.1619412567027;1062.462001534887;1169.7075731067234;14801.185934773475;14864.479743208936;14938.32777525014;15021.098734075991;15145.697086058217;302764;306059;307846;308000;308531;50085.24872126921;50650.49349506458;50685.23972140421;50690;50802;1269.796832506813;1282.6472720001887;1284.1973766396002;1316.9078164528391;1320.795276732108;26967.595486068116;27985;28245.71754282431;30444;30750.692493074785;47157.76421117873;47781.76109119432;47801.28298075462;47854;48062.27906581474;282393;283206;285636.29000405176;286317;286366;41535.7923210382;42791;42915;43645.345319820866;43843;39052.2189556213;39172.80413597914;39457.40813887851;39563;39731.20537589174;35521.644783551834;36071;36163.457548137325;36343.63656363508;36821.44767828431;36428.63571364252;36834.63165368312;37626.81186594049;38158.12371656823;39022;33348.66651333456;33504.16239593932;33908;33909.49135763015;34004;29457.852710736308;29726.70273297326;31100.377992440477;31503.84248078745;33923.83038084794;23659.290221293388;23996.160134395213;26324.4735105293;26770;26861.597076043483 06:04:55 INFO - PROCESS | 15171 | |2;jquery.html;342.652208008871;350.1543771791123;350.1928055831311;353.81955202846547;354.6612984599707;16347.83652163478;16673.33266673332;17313.74029389557;17482.475525734233;18159.54601134972;11040.33757974522;12083.939580302087;16479.752803707954;16481.34074637013;16637.750433743502;4736.573708366246;4999.350084489011;5019.598432125421;5034.295198672171;5040.420351659551;4924.28597853311;4956.3804524434445;4968.205087186051;4992.475790042048;5016.724080175589;5001.249812528114;5003.274525193845;5080.7967681292885;5207.791688332462;5225.399079105913;5062.291279220912;5137.178051511759;5156.561692256163;5170;5379.892402151935;5147.562457191143;5161.767720452589;5162.096633089194;5195.454477279907;5196.740162991873;12597.244165350108;12961.935190323988;19921.501962451053;20150.69773953392;20244;1961.597872436147;1975.8122978317037;2016.9596608067902;2078.449210959097;2186.3987403464175;9503.714888553355;9591.616335346578;9713;9794.853077203776;9843.360181588245;1813.6463389639025;1816.6185101128647;1822.2073398071882;1832.3403574713093;1861.1252711225702;60896.69551652257;62416;63349.683251583905;63894.36105638931;64490.677546611965;9976.80046399068;10261.333013354257;10275.126614237724;10377.584896604203;10519.94740026295;13495.730085398434;13575.389107490186;13635.181889086489;13653.522126725517;13664.180149191081;7336.193018767931;7363.521371110861;7405.925940740632;7415;7470.028896243453;6947.4789390795895;6983.3016698330775;6988.720451181997;7008.719651213996;7048.541844780073;4355.695101342939;4385.276429389179;4405.933910991338;4494.348319493721;4531.003179300615;1711.880168388201;1775.9112044397987;1826.2421095245325;1841.8986955717296;1936.7288579598867;796.5698522797741;830.9418340716092;989.2975987049132;1033.4677641014882;1039.656913218636;15440.536783896501;15764;15824.604384890239;15967.760483592756;17073.231704573325;861.0872475176333;897.2821742605889;938.8497840345512;952.5713428956997;963.7301555564453;9231.353805233703;9524.904750952403;9720.75698107553;10046.547905344278;10149.137323327452;485794;518909;519989;528443;534990;69761.65119174474;80765;82597;83343;84367;1121.9943900280446;1130.197559732599;1137.4824454872848;1148.8678801937717;1152.775208834286;14886.925565372103;14968.925155374154;15106.471273505815;15715.921420392824;15845.286962086964;19449.01295234502;33462.66537334595;34689.47965780465;36373.454398183516;36749.63250367462;46775.53224467848;48383.51616483931;48735;49219;50083;8944.329175311748;9296.674616388394;9445.574949127169;9506.334556580972;9538.189253913495;11446.94276528612;11458.484368203284;17640.823591763918;17672.734908976632;18118.818811811714;13835.654108647364;14077.366518506487;14257;14769.187694676895;14900.105993640416;14259.144451332953;14560;14880;14937.253137342872;15087.24563771829;15080.773788392964;15111.773323399937;15117.09297442157;15426.765858731498;15699.686006280039;9517.381370210915;9529.857052144085;9657.613695452103;9967.651132210338;10026.498675066363;10319.864814870209;13710.794338084737;14196.787048194079;14556.63608409756;15007.849921500645 06:04:55 INFO - PROCESS | 15171 | |3;mootools.html;1376.972460550789;1418.9006769526134;1528.8547587979144;1683.2425408566148;1687.3588036546112;6898.8275293117695;6912.58524488531;7047.823804404886;7130.465215108875;7217.097862767154;7070.611116388596;7094.11323584552;7120.50156489046;7148.928510714892;7155.14138303403;2164.610370133379;2191.6822060801255;2197.494576247464;2200.108955872874;2200.284907405092;2147.871127732333;2165.750938642053;2189.179057853305;2197.505561248722;2198.373463562885;2142.5179334649733;2178.6623073423566;2189.890505474728;2212.4026512841606;2213.9778602213933;2162.19998600518;2176.3688530326185;2183.672449132635;2187.803097721213;2195.1000089963118;2173.445771328317;2191.3206905859074;2195.5169862630355;2203.933881983543;2209.624363858148;6949.305069493061;6998.055262539543;7001.614911179883;7009.05377773999;7022.789316320519;4249.150169966019;4370.038591509863;4378.890527736832;4391.516933137353;4422.557744225552;2894.305366711995;2907.1133304342166;2913.242556935191;2949.365886334427;2957.4085182963495;930.2929773372285;991.6727479931677;993.6720882108887;1007.2848277722826;1012.9088382045651;9096;9126.726198214064;9180.816383672289;9197.494137822418;9281.489518076503;3834;3881.8059097045034;3921.7254792164276;3925.038365600446;3928.332183528807;7755.844883102306;7790.610469476617;7795.883061754078;7798.103218129874;7809.492382995087;4292.678049146327;4296.312589985588;4332.436783218224;4357.215701173819;4447.2439685253585;4023.879283621496;4031.012401961538;4042.838286468508;4043.838246470108;4055.6349928506575;3288.391647545212;3321.9833900830827;3328.73370130389;3341.465365541502;3346.330733853239;999.8250306196387;1007.969760907174;1021.8671572695501;1027.3527677563236;1029.0070082370548;1043.4626167523732;1051.894810518942;1085.7394225385851;1188.536470776398;1299.0971274964;6699.062131301622;6699.330066993261;6717.56335838169;6719.395254427027;6734.663266836638;1016.5679586175846;1028.6759670703705;1086.8587083679229;1090.4711215060688;1098.2257508456519;5327.440618735054;5365;5393.541548968382;5417.729113544307;5418.349798024262;8279.675251959658;8306.54314012735;8515.27620152294;8596.355273354524;8616.396852220285;8411.411201215857;8453.450525715809;8461.069282378934;8463.153684631488;8501.234888860032;6693.263740988487;6745.797626071226;6756.864862702719;6884.552504087218;6901.102856628606;6592.868142637216;6594.439472644879;6617.239017513048;6653.767118150841;6675.03212034262;7546.396288297033;7713.151553329241;7793.337566306701;7867.252611001945;7903.723369682033;7697.730579429693;7895.802604934693;7953.642086106023;7977.122516523062;7980.84038319242;6165.568410211242;6194.5973511721595;6214.9689251553455;6224.564280500322;6231.158793562811;6714.664266786739;6953.269906659728;6998.965005174941;7008.579485230903;7009.719611215494;6705.430038446787;6719.529632925648;6740.595564266159;6795.72817087311;6872.10662613857;5856.180134781049;6210.596311239755;6223.937760622336;6287.779927702509;6346.555741098079;6322.430981211713;6324.114623952558;6335;6349.333320001333;6359.4276515112015;5810.302763668386;5862.501687356452;5876.265466816648;5877.735501902339;5879.735411906389;5989.850253743692;6027.758889644365;6030.8793824122395;6206.255249370104;6210.254769427697 06:04:55 INFO - PROCESS | 15171 | |4;prototype.html;330.139985338194;330.4910437925594;336.98146601936884;341.6685814759683;343.97076248518874;6166.229221347332;6190.257169139704;6200.224971878515;6307.747690092391;6329.525285603587;6123.357047510014;6171.753129874811;6192.071189321604;6209.751609935597;6213.502919766419;4735.195016847127;4739.431268247815;4754.54831790981;4762.499937506564;4763.0950119477275;4751.3348131261655;4759.452662943754;4763.476017638074;4778.450478195017;4779.952200477986;4639.234526303156;4716.97641511792;4718.598919091882;4734.218853889121;4734.573888350048;4688.929666055012;4690.4371475422995;4698.718076915379;4729;4730.219513780222;4090.7341022833716;4091.345384738457;4098.959010409917;4100.630943215125;4102.815373308208;5880.705964701748;5894.469497745224;5911.379305172981;5912.17229587858;5932.2584676915385;5373.6775793452125;5481.424450432727;5488.9725551372385;5491.588130890159;5522.6134170608075;6624.503162262849;6633.170853643294;6633.867322653568;6640.402363787234;6658.966705166443;4472.977635111836;4482.25192175052;4484.910301793979;4489.124620698965;4497.235469970113;6688.130543029423;6831.351021652985;6884.070650462224;6928.1339832520935;6957.9215221640725;4558.566936141061;4603.838865639686;4604.240300350471;4606.262997920317;4607.3089036644105;4645.535446455395;4665.906681866411;4676.602488788491;4698.1778188816825;4731.881702957385;5498.532624726943;5499;5505.697186654692;5508.421615730371;5520.006398848165;6517.9348206517325;6663.533552651268;6669.866602667919;6671.33286671329;6709.228438729511;1614.612493001671;1659.3777333499938;1667.3914021382109;1674.8995060296422;1683.410806217814;1098.5715570927346;1099.3403957625521;1109.3122264196088;1115.2304909612342;1123.9213255072066;6146.508279337642;6265.937340626627;6285.748570057147;6305.369463053658;6308.400701933309;6788.9660551696925;6792.320767923168;6816.318368163144;6817;6835.69239384219;6155.399596104955;6240.188775459162;6270.592411493239;6280.434760871543;6285.937140628535;3672.1737609037755;3687.1150923778637;3702.241040586673;3702.315071711742;3715.256948610289;7110.146782386147;7112.431005519649;7118.893216601755;7120.679569419389;7124.43004559634;6845.657717114124;6996.440284777205;7008.7546935857;7014.5440546364325;7021.613811240329;7096.432285417154;7098.432125429953;7103.538270012433;7105.502614817016;7130.073090498202;6756.223034350916;6764.154480689914;6784.728610855511;6827.761028363983;6830.009648601024;6624.105745724266;6691.364320389555;6730.730770769114;6755.594664320157;6781.423578995643;7181.281871812777;7205.963970180325;7211.819704507429;7221.494495385273;7232.349088582053;4610.861674149781;4616.907661846812;4646.4191976003;4672.7897244624755;4684.882877928079;6761.91809310508;6908;6934.826629334307;6944.826379340557;6957.304269573002;6697.966510167418;6746.763863264762;6761.898571521333;6777.1189745332795;6807.761728339485;6692.464602831859;6752.5948443093575;6757.391834734897;6765.627890466071;6779.254282029072;6447.0007148892;6605.603663780189;6605.702743376463;6611.570247933869;6624.503162262753;6775.9672098371275;6791.592504449749;6793.72825086991;6796.422304104009;6802.217744959393;6589.24223714279;6605.57063790852;6620.536562440583;6634.203895532567;6642 06:04:55 INFO - PROCESS | 15171 | |5;yui.html;783.5494590610397;793.1196372027052;798.2217338095357;815.0748899998501;818.1041759273595;12428;12648.430820613072;12891.162074465165;12960.092793504458;13073.280969546671;11477.253978491392;13131.146475479087;13219.942404607633;13222.20666759995;13235;780.7696729464807;796.8725003999361;799.1209669363683;802.2539038694013;817.7751118442446;811.427943299975;813.8128230506987;814.1776805426503;814.238686827815;819.9303059239971;833.6540335760652;833.6790335720731;840.8528507511191;841.3899922556159;845.8604330285496;836.0343802907652;838.1241602525375;839.3620848155385;840.5503055865083;842.4650347029681;615.2033117113349;618.5330075792748;622.2874808344466;623.0218556865723;624.7750809708501;11963.46164422603;12045.217060891015;12051.758964820654;12069.155159138863;12121.93939030308;11781.293122412682;11802;12065.457054432572;12102.697432564168;12148.514059437612;9999.200063994864;10088.495575221283;10103.949480252551;10208.234382421273;10245.180385569136;3432.5375123052354;3516.472529120627;3558.62634423387;3572.3034008368118;3587.461880717887;47691.76154119207;48466;48600.75699621515;48639.270410943864;48651;9054.049324820931;9359.532023398802;9402.482863442576;9628.085331893459;9707.951460242653;17330.74003889943;17366.739498907526;17371;17380.65238695219;17390.3043878246;7238.638068096574;7290.3438690518105;7406.296401841816;7496.887546686804;7578.052743407075;4012.1574469361176;4019.664112993798;4035.858744943913;4073.0086300962557;4124.896877578085;2865.985670071678;2913;2923.8684259208385;2924.6782853886057;2925.3271747498193;538.8545092824916;540.1735344922275;545.1033050631768;547.8575570351737;557.7545879812869;508.4661105838928;580.3575880258858;606.3845197124922;675.0818886314609;687.4251853912223;8455.915440845636;8774.561271936378;8834;8957.283417326598;8981.595828187747;511.4425276448689;535.267459618649;589.381149792716;661.3915198017835;683.641088428579;3900.317444447267;4076.6331030207425;4079.1229885574744;4143.7928103594695;4230.111676547898;52850.207246891325;52944.470555293956;53051;53131.20303195455;54781;48294;48308.27537586939;48478.51521484811;49154.75422622864;49255.261171081744;43295.783521082194;44571.33143002792;45170.77414612972;45582;45705.31442028372;8348.540830254395;8798.780030499289;8917.554122293988;8969.282457403522;9092.408993415407;34016.14959626029;34074.829625851715;34559.82720086384;34894.30211395809;35021;43245.567544324156;44757;45090.323645146;45105.774471128745;45236.773816130706;10078.049844793004;10164.542595583365;10417.739556511147;10451.372917624967;10535.683929482127;11248.887511124783;11568.419321562682;11686.94156529246;12019.579314723942;12260;11270.323780573191;11302;11379.658610241706;11430.768692977297;11513.53945842157;10109.595616175271;10263.846042309222;10722.088622467178;11000.889991099986;11546.249493782878;10108.444035577819;10226.897731022595;10772.569097236335;11135.10919126484;11203.60787372438;9163.71339761237;9257.629694812133;9367.20378767785;9420.905790942003;9742.512874356396;9051.32115091384;9855.11303982645;9888.242467862454;10045.49772511357;10050.396976181453 06:04:55 INFO - PROCESS | 15171 | __end_tp_report 06:04:55 INFO - PROCESS | 15171 | __start_cc_report 06:04:55 INFO - PROCESS | 15171 | _x_x_mozilla_cycle_collect,314 06:04:55 INFO - PROCESS | 15171 | __end_cc_report 06:04:55 INFO - PROCESS | 15171 | __startTimestamp1452089095012__endTimestamp 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | ------- Summary: start ------- 06:04:55 INFO - PROCESS | 15171 | Number of tests: 6 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | [#0] dojo.html Cycles:165 Average:5372.38 Median:5586.58 stddev:598.37 (10.7%) stddev-sans-first:575.00 06:04:55 INFO - PROCESS | 15171 | Values: 3181.8 3222.1 3248.3 3252.8 3269.5 5222.1 5281.3 5288.6 5330.8 5337.5 5320.8 5335.5 5412.4 5512.2 5524.8 4906.0 4922.7 5010.6 5033.2 5059.2 4881.2 4921.1 4963.3 5001.3 5048.6 4807.9 4835.5 4845.6 4850.4 4870.6 4859.2 4886.5 4892.0 4909.9 4911.9 4787.9 4821.0 4855.2 4895.3 4898.0 5251.0 5278.3 5286.9 5297.4 5346.7 5778.5 5798.4 5799.3 5802.7 5805.7 5603.9 5697.8 5817.3 5855.2 5867.0 5433.9 5441.6 5445.6 5450.2 5465.1 5889.6 5890.5 5892.9 5905.8 5936.1 5584.4 5608.7 5706.7 5707.2 5715.8 5753.1 5773.4 5794.2 5797.2 5821.3 5699.7 5724.3 5785.1 5787.1 5791.5 5655.2 5664.3 5698.0 5708.2 5737.7 4453.5 4468.3 4473.3 4474.1 4515.5 3906.2 3985.7 3990.7 4019.8 4038.2 5354.4 5446.4 5466.1 5467.9 5486.6 5847.8 5858.9 5860.3 5861.4 5870.5 5443.2 5445.4 5447.5 5452.4 5455.6 4855.8 4860.6 4935.3 4944.5 4963.1 5869.5 5950.3 5964.3 6002.7 6030.3 5755.2 5794.7 5812.2 5821.8 5822.2 5946.0 6005.2 6036.7 6037.6 6070.3 5740.9 5757.4 5759.0 5769.7 5778.7 5831.1 5863.0 5868.3 5871.4 5875.0 5571.0 5597.4 5642.1 5684.3 5693.2 5647.2 5669.9 5689.1 5694.4 5703.8 5573.7 5586.4 5586.6 5597.6 5608.0 5530.8 5650.9 5676.5 5729.0 5779.5 5536.8 5576.3 5587.8 5588.8 5595.2 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | [#1] ext.html Cycles:180 Average:46009.85 Median:36625.04 stddev:74631.37 (203.8%) stddev-sans-first:74762.56 06:04:55 INFO - PROCESS | 15171 | Values: 517.3 523.8 534.4 551.8 553.6 34597.5 34948.8 34955.0 34990.7 34996.5 37128.8 37600.2 37692.8 37698.6 37820.0 8302.0 8434.8 8438.2 8451.7 8520.3 8259.6 8379.6 8384.0 8398.6 8416.2 8523.4 8601.5 8612.6 8629.8 8632.0 8487.2 8591.1 8594.4 8607.4 8613.4 8403.0 8440.9 8523.1 8550.6 8552.9 38539.8 39084.4 39134.8 39160.4 39221.4 3230.5 3336.8 3429.2 3480.1 3832.8 30603.2 30968.0 30995.5 31079.4 31240.8 3683.7 3918.6 3929.1 4070.7 4094.2 259135.0 264576.0 265772.0 265980.0 266313.0 60911.4 61680.4 62042.0 62149.4 62215.4 62375.7 63789.7 72661.0 72785.3 72896.6 14896.8 15135.1 15260.9 15314.3 15331.7 11115.3 11210.7 11258.3 11287.5 11324.8 21178.8 21536.6 21545.8 21548.5 21560.6 8234.5 8605.0 8623.5 8651.8 8686.7 898.8 926.5 1033.8 1053.9 1069.9 28294.9 28298.4 28363.3 28569.6 28852.9 982.9 1037.2 1054.2 1062.5 1169.7 14801.2 14864.5 14938.3 15021.1 15145.7 302764.0 306059.0 307846.0 308000.0 308531.0 50085.2 50650.5 50685.2 50690.0 50802.0 1269.8 1282.6 1284.2 1316.9 1320.8 26967.6 27985.0 28245.7 30444.0 30750.7 47157.8 47781.8 47801.3 47854.0 48062.3 282393.0 283206.0 285636.3 286317.0 286366.0 41535.8 42791.0 42915.0 43645.3 43843.0 39052.2 39172.8 39457.4 39563.0 39731.2 35521.6 36071.0 36163.5 36343.6 36821.4 36428.6 36834.6 37626.8 38158.1 39022.0 33348.7 33504.2 33908.0 33909.5 34004.0 29457.9 29726.7 31100.4 31503.8 33923.8 23659.3 23996.2 26324.5 26770.0 26861.6 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | [#2] jquery.html Cycles:180 Average:28075.16 Median:354.24 stddev:84735.04 (23920.2%) stddev-sans-first:84947.16 06:04:55 INFO - PROCESS | 15171 | Values: 342.7 350.2 350.2 353.8 354.7 16347.8 16673.3 17313.7 17482.5 18159.5 11040.3 12083.9 16479.8 16481.3 16637.8 4736.6 4999.4 5019.6 5034.3 5040.4 4924.3 4956.4 4968.2 4992.5 5016.7 5001.2 5003.3 5080.8 5207.8 5225.4 5062.3 5137.2 5156.6 5170.0 5379.9 5147.6 5161.8 5162.1 5195.5 5196.7 12597.2 12961.9 19921.5 20150.7 20244.0 1961.6 1975.8 2017.0 2078.4 2186.4 9503.7 9591.6 9713.0 9794.9 9843.4 1813.6 1816.6 1822.2 1832.3 1861.1 60896.7 62416.0 63349.7 63894.4 64490.7 9976.8 10261.3 10275.1 10377.6 10519.9 13495.7 13575.4 13635.2 13653.5 13664.2 7336.2 7363.5 7405.9 7415.0 7470.0 6947.5 6983.3 6988.7 7008.7 7048.5 4355.7 4385.3 4405.9 4494.3 4531.0 1711.9 1775.9 1826.2 1841.9 1936.7 796.6 830.9 989.3 1033.5 1039.7 15440.5 15764.0 15824.6 15967.8 17073.2 861.1 897.3 938.8 952.6 963.7 9231.4 9524.9 9720.8 10046.5 10149.1 485794.0 518909.0 519989.0 528443.0 534990.0 69761.7 80765.0 82597.0 83343.0 84367.0 1122.0 1130.2 1137.5 1148.9 1152.8 14886.9 14968.9 15106.5 15715.9 15845.3 19449.0 33462.7 34689.5 36373.5 36749.6 46775.5 48383.5 48735.0 49219.0 50083.0 8944.3 9296.7 9445.6 9506.3 9538.2 11446.9 11458.5 17640.8 17672.7 18118.8 13835.7 14077.4 14257.0 14769.2 14900.1 14259.1 14560.0 14880.0 14937.3 15087.2 15080.8 15111.8 15117.1 15426.8 15699.7 9517.4 9529.9 9657.6 9967.7 10026.5 10319.9 13710.8 14196.8 14556.6 15007.8 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | [#3] mootools.html Cycles:180 Average:5005.20 Median:6180.08 stddev:2504.21 (40.5%) stddev-sans-first:2496.38 06:04:55 INFO - PROCESS | 15171 | Values: 1377.0 1418.9 1528.9 1683.2 1687.4 6898.8 6912.6 7047.8 7130.5 7217.1 7070.6 7094.1 7120.5 7148.9 7155.1 2164.6 2191.7 2197.5 2200.1 2200.3 2147.9 2165.8 2189.2 2197.5 2198.4 2142.5 2178.7 2189.9 2212.4 2214.0 2162.2 2176.4 2183.7 2187.8 2195.1 2173.4 2191.3 2195.5 2203.9 2209.6 6949.3 6998.1 7001.6 7009.1 7022.8 4249.2 4370.0 4378.9 4391.5 4422.6 2894.3 2907.1 2913.2 2949.4 2957.4 930.3 991.7 993.7 1007.3 1012.9 9096.0 9126.7 9180.8 9197.5 9281.5 3834.0 3881.8 3921.7 3925.0 3928.3 7755.8 7790.6 7795.9 7798.1 7809.5 4292.7 4296.3 4332.4 4357.2 4447.2 4023.9 4031.0 4042.8 4043.8 4055.6 3288.4 3322.0 3328.7 3341.5 3346.3 999.8 1008.0 1021.9 1027.4 1029.0 1043.5 1051.9 1085.7 1188.5 1299.1 6699.1 6699.3 6717.6 6719.4 6734.7 1016.6 1028.7 1086.9 1090.5 1098.2 5327.4 5365.0 5393.5 5417.7 5418.3 8279.7 8306.5 8515.3 8596.4 8616.4 8411.4 8453.5 8461.1 8463.2 8501.2 6693.3 6745.8 6756.9 6884.6 6901.1 6592.9 6594.4 6617.2 6653.8 6675.0 7546.4 7713.2 7793.3 7867.3 7903.7 7697.7 7895.8 7953.6 7977.1 7980.8 6165.6 6194.6 6215.0 6224.6 6231.2 6714.7 6953.3 6999.0 7008.6 7009.7 6705.4 6719.5 6740.6 6795.7 6872.1 5856.2 6210.6 6223.9 6287.8 6346.6 6322.4 6324.1 6335.0 6349.3 6359.4 5810.3 5862.5 5876.3 5877.7 5879.7 5989.9 6027.8 6030.9 6206.3 6210.3 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | [#4] prototype.html Cycles:180 Average:5536.94 Median:6253.06 stddev:1693.26 (27.1%) stddev-sans-first:1652.30 06:04:55 INFO - PROCESS | 15171 | Values: 330.1 330.5 337.0 341.7 344.0 6166.2 6190.3 6200.2 6307.7 6329.5 6123.4 6171.8 6192.1 6209.8 6213.5 4735.2 4739.4 4754.5 4762.5 4763.1 4751.3 4759.5 4763.5 4778.5 4780.0 4639.2 4717.0 4718.6 4734.2 4734.6 4688.9 4690.4 4698.7 4729.0 4730.2 4090.7 4091.3 4099.0 4100.6 4102.8 5880.7 5894.5 5911.4 5912.2 5932.3 5373.7 5481.4 5489.0 5491.6 5522.6 6624.5 6633.2 6633.9 6640.4 6659.0 4473.0 4482.3 4484.9 4489.1 4497.2 6688.1 6831.4 6884.1 6928.1 6957.9 4558.6 4603.8 4604.2 4606.3 4607.3 4645.5 4665.9 4676.6 4698.2 4731.9 5498.5 5499.0 5505.7 5508.4 5520.0 6517.9 6663.5 6669.9 6671.3 6709.2 1614.6 1659.4 1667.4 1674.9 1683.4 1098.6 1099.3 1109.3 1115.2 1123.9 6146.5 6265.9 6285.7 6305.4 6308.4 6789.0 6792.3 6816.3 6817.0 6835.7 6155.4 6240.2 6270.6 6280.4 6285.9 3672.2 3687.1 3702.2 3702.3 3715.3 7110.1 7112.4 7118.9 7120.7 7124.4 6845.7 6996.4 7008.8 7014.5 7021.6 7096.4 7098.4 7103.5 7105.5 7130.1 6756.2 6764.2 6784.7 6827.8 6830.0 6624.1 6691.4 6730.7 6755.6 6781.4 7181.3 7206.0 7211.8 7221.5 7232.3 4610.9 4616.9 4646.4 4672.8 4684.9 6761.9 6908.0 6934.8 6944.8 6957.3 6698.0 6746.8 6761.9 6777.1 6807.8 6692.5 6752.6 6757.4 6765.6 6779.3 6447.0 6605.6 6605.7 6611.6 6624.5 6776.0 6791.6 6793.7 6796.4 6802.2 6589.2 6605.6 6620.5 6634.2 6642.0 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - PROCESS | 15171 | [#5] yui.html Cycles:180 Average:13368.65 Median:46698.54 stddev:15408.69 (33.0%) stddev-sans-first:15422.93 06:04:55 INFO - PROCESS | 15171 | Values: 783.5 793.1 798.2 815.1 818.1 12428.0 12648.4 12891.2 12960.1 13073.3 11477.3 13131.1 13219.9 13222.2 13235.0 780.8 796.9 799.1 802.3 817.8 811.4 813.8 814.2 814.2 819.9 833.7 833.7 840.9 841.4 845.9 836.0 838.1 839.4 840.6 842.5 615.2 618.5 622.3 623.0 624.8 11963.5 12045.2 12051.8 12069.2 12121.9 11781.3 11802.0 12065.5 12102.7 12148.5 9999.2 10088.5 10103.9 10208.2 10245.2 3432.5 3516.5 3558.6 3572.3 3587.5 47691.8 48466.0 48600.8 48639.3 48651.0 9054.0 9359.5 9402.5 9628.1 9708.0 17330.7 17366.7 17371.0 17380.7 17390.3 7238.6 7290.3 7406.3 7496.9 7578.1 4012.2 4019.7 4035.9 4073.0 4124.9 2866.0 2913.0 2923.9 2924.7 2925.3 538.9 540.2 545.1 547.9 557.8 508.5 580.4 606.4 675.1 687.4 8455.9 8774.6 8834.0 8957.3 8981.6 511.4 535.3 589.4 661.4 683.6 3900.3 4076.6 4079.1 4143.8 4230.1 52850.2 52944.5 53051.0 53131.2 54781.0 48294.0 48308.3 48478.5 49154.8 49255.3 43295.8 44571.3 45170.8 45582.0 45705.3 8348.5 8798.8 8917.6 8969.3 9092.4 34016.1 34074.8 34559.8 34894.3 35021.0 43245.6 44757.0 45090.3 45105.8 45236.8 10078.0 10164.5 10417.7 10451.4 10535.7 11248.9 11568.4 11686.9 12019.6 12260.0 11270.3 11302.0 11379.7 11430.8 11513.5 10109.6 10263.8 10722.1 11000.9 11546.2 10108.4 10226.9 10772.6 11135.1 11203.6 9163.7 9257.6 9367.2 9420.9 9742.5 9051.3 9855.1 9888.2 10045.5 10050.4 06:04:55 INFO - PROCESS | 15171 | -------- Summary: end -------- 06:04:55 INFO - PROCESS | 15171 | 06:04:55 INFO - TEST-INFO | 15171: exit 0 06:04:55 INFO - TEST-OK | dromaeo_css | took 1110752ms 06:04:55 INFO - TEST-START | kraken 06:04:55 INFO - operating with platform_type : linux_ 06:04:55 INFO - Initialising browser for kraken test... 06:04:55 INFO - TEST-INFO | started process 15415 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpalTkNx/profile http://localhost:33703/getInfo.html) 06:05:00 INFO - PROCESS | 15415 | __metrics Screen width/height:1600/1200 06:05:00 INFO - PROCESS | 15415 | colorDepth:24 06:05:00 INFO - PROCESS | 15415 | Browser inner width/height: 1024/670 06:05:00 INFO - PROCESS | 15415 | __metrics 06:05:00 INFO - PROCESS | 15415 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:05:01 INFO - TEST-INFO | 15415: exit 0 06:05:01 INFO - Browser initialized. 06:05:01 INFO - Running cycle 1/1 for kraken test... 06:05:01 INFO - TEST-INFO | started process 15539 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpalTkNx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:13 INFO - PROCESS | 15539 | RSS: Main: 150745088 06:05:13 INFO - PROCESS | 15539 | 06:05:15 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33703/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:16 INFO - PROCESS | 15539 | RSS: Main: 151015424 06:05:16 INFO - PROCESS | 15539 | 06:05:18 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33703/tests/kraken/driver.html?testName=audio-dft) 06:05:19 INFO - PROCESS | 15539 | RSS: Main: 151588864 06:05:19 INFO - PROCESS | 15539 | 06:05:22 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33703/tests/kraken/driver.html?testName=audio-fft) 06:05:23 INFO - PROCESS | 15539 | RSS: Main: 146898944 06:05:23 INFO - PROCESS | 15539 | 06:05:25 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33703/tests/kraken/driver.html?testName=audio-oscillator) 06:05:25 INFO - PROCESS | 15539 | RSS: Main: 146141184 06:05:25 INFO - PROCESS | 15539 | 06:05:28 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:28 INFO - PROCESS | 15539 | RSS: Main: 146452480 06:05:28 INFO - PROCESS | 15539 | 06:05:31 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33703/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:32 INFO - PROCESS | 15539 | RSS: Main: 147673088 06:05:32 INFO - PROCESS | 15539 | 06:05:35 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33703/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:36 INFO - PROCESS | 15539 | RSS: Main: 149192704 06:05:36 INFO - PROCESS | 15539 | 06:05:39 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33703/tests/kraken/driver.html?testName=json-parse-financial) 06:05:39 INFO - PROCESS | 15539 | RSS: Main: 147968000 06:05:39 INFO - PROCESS | 15539 | 06:05:41 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:41 INFO - PROCESS | 15539 | RSS: Main: 147234816 06:05:41 INFO - PROCESS | 15539 | 06:05:43 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:44 INFO - PROCESS | 15539 | RSS: Main: 148131840 06:05:44 INFO - PROCESS | 15539 | 06:05:46 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:46 INFO - PROCESS | 15539 | RSS: Main: 148209664 06:05:46 INFO - PROCESS | 15539 | 06:05:49 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:50 INFO - PROCESS | 15539 | RSS: Main: 148144128 06:05:50 INFO - PROCESS | 15539 | 06:05:52 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:53 INFO - PROCESS | 15539 | RSS: Main: 148217856 06:05:53 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:33703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33703/tests/kraken/driver.html?testName=ai-astar) 06:05:55 INFO - PROCESS | 15539 | RSS: Main: 147914752 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | __start_tp_report 06:05:55 INFO - PROCESS | 15539 | _x_x_mozilla_page_load 06:05:55 INFO - PROCESS | 15539 | _x_x_mozilla_page_load_details 06:05:55 INFO - PROCESS | 15539 | |i|pagename|runs| 06:05:55 INFO - PROCESS | 15539 | |0;ai-astar;113;109;114;112;114;123;114;113;112;112 06:05:55 INFO - PROCESS | 15539 | |1;audio-beat-detection;164;130;153;161;129;154;157;124;165;127 06:05:55 INFO - PROCESS | 15539 | |2;audio-dft;164;167;163;162;161;162;164;172;166;163 06:05:55 INFO - PROCESS | 15539 | |3;audio-fft;72;71;72;79;71;132;73;73;71;71 06:05:55 INFO - PROCESS | 15539 | |4;audio-oscillator;97;98;138;97;97;97;137;97;98;144 06:05:55 INFO - PROCESS | 15539 | |5;imaging-gaussian-blur;109;110;109;111;111;109;109;111;109;110 06:05:55 INFO - PROCESS | 15539 | |6;imaging-darkroom;147;147;149;148;150;148;147;147;148;146 06:05:55 INFO - PROCESS | 15539 | |7;imaging-desaturate;96;96;97;97;96;97;96;97;97;96 06:05:55 INFO - PROCESS | 15539 | |8;json-parse-financial;61;61;62;61;65;66;60;61;60;61 06:05:55 INFO - PROCESS | 15539 | |9;json-stringify-tinderbox;73;67;68;68;68;69;68;68;68;70 06:05:55 INFO - PROCESS | 15539 | |10;stanford-crypto-aes;86;86;88;95;96;86;86;85;86;85 06:05:55 INFO - PROCESS | 15539 | |11;stanford-crypto-ccm;119;125;118;128;123;118;125;118;125;128 06:05:55 INFO - PROCESS | 15539 | |12;stanford-crypto-pbkdf2;146;157;158;157;157;148;156;156;165;144 06:05:55 INFO - PROCESS | 15539 | |13;stanford-crypto-sha256-iterative;73;73;71;72;74;71;73;72;75;74 06:05:55 INFO - PROCESS | 15539 | __end_tp_report 06:05:55 INFO - PROCESS | 15539 | __start_cc_report 06:05:55 INFO - PROCESS | 15539 | _x_x_mozilla_cycle_collect,746 06:05:55 INFO - PROCESS | 15539 | __end_cc_report 06:05:55 INFO - PROCESS | 15539 | __startTimestamp1452089155265__endTimestamp 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | ------- Summary: start ------- 06:05:55 INFO - PROCESS | 15539 | Number of tests: 14 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.50 stddev:3.63 (3.2%) stddev-sans-first:3.84 06:05:55 INFO - PROCESS | 15539 | Values: 113.0 109.0 114.0 112.0 114.0 123.0 114.0 113.0 112.0 112.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:155.50 stddev:16.77 (10.8%) stddev-sans-first:16.54 06:05:55 INFO - PROCESS | 15539 | Values: 164.0 130.0 153.0 161.0 129.0 154.0 157.0 124.0 165.0 127.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.24 (2.0%) stddev-sans-first:3.43 06:05:55 INFO - PROCESS | 15539 | Values: 164.0 167.0 163.0 162.0 161.0 162.0 164.0 172.0 166.0 163.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#3] audio-fft Cycles:10 Average:78.50 Median:72.00 stddev:18.95 (26.3%) stddev-sans-first:19.95 06:05:55 INFO - PROCESS | 15539 | Values: 72.0 71.0 72.0 79.0 71.0 132.0 73.0 73.0 71.0 71.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:97.00 stddev:20.55 (21.2%) stddev-sans-first:21.26 06:05:55 INFO - PROCESS | 15539 | Values: 97.0 98.0 138.0 97.0 97.0 97.0 137.0 97.0 98.0 144.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 06:05:55 INFO - PROCESS | 15539 | Values: 109.0 110.0 109.0 111.0 111.0 109.0 109.0 111.0 109.0 110.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 06:05:55 INFO - PROCESS | 15539 | Values: 147.0 147.0 149.0 148.0 150.0 148.0 147.0 147.0 148.0 146.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:05:55 INFO - PROCESS | 15539 | Values: 96.0 96.0 97.0 97.0 96.0 97.0 96.0 97.0 97.0 96.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:61.00 stddev:2.04 (3.4%) stddev-sans-first:2.15 06:05:55 INFO - PROCESS | 15539 | Values: 61.0 61.0 62.0 61.0 65.0 66.0 60.0 61.0 60.0 61.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:1.70 (2.5%) stddev-sans-first:0.83 06:05:55 INFO - PROCESS | 15539 | Values: 73.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 70.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:86.00 stddev:4.09 (4.8%) stddev-sans-first:4.28 06:05:55 INFO - PROCESS | 15539 | Values: 86.0 86.0 88.0 95.0 96.0 86.0 86.0 85.0 86.0 85.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:125.00 stddev:4.11 (3.3%) stddev-sans-first:4.14 06:05:55 INFO - PROCESS | 15539 | Values: 119.0 125.0 118.0 128.0 123.0 118.0 125.0 118.0 125.0 128.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:157.00 stddev:6.42 (4.1%) stddev-sans-first:6.04 06:05:55 INFO - PROCESS | 15539 | Values: 146.0 157.0 158.0 157.0 157.0 148.0 156.0 156.0 165.0 144.0 06:05:55 INFO - PROCESS | 15539 | 06:05:55 INFO - PROCESS | 15539 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.39 06:05:55 INFO - PROCESS | 15539 | Values: 73.0 73.0 71.0 72.0 74.0 71.0 73.0 72.0 75.0 74.0 06:05:55 INFO - PROCESS | 15539 | -------- Summary: end -------- 06:05:55 INFO - PROCESS | 15539 | 06:05:56 INFO - TEST-INFO | 15539: exit 0 06:05:56 INFO - TEST-OK | kraken | took 60449ms 06:05:56 INFO - TEST-START | v8_7 06:05:56 INFO - operating with platform_type : linux_ 06:05:56 INFO - Initialising browser for v8_7 test... 06:05:56 INFO - TEST-INFO | started process 15826 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKduR2r/profile http://localhost:33703/getInfo.html) 06:06:00 INFO - PROCESS | 15826 | __metrics Screen width/height:1600/1200 06:06:00 INFO - PROCESS | 15826 | colorDepth:24 06:06:00 INFO - PROCESS | 15826 | Browser inner width/height: 1024/670 06:06:00 INFO - PROCESS | 15826 | __metrics 06:06:00 INFO - PROCESS | 15826 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:06:01 INFO - TEST-INFO | 15826: exit 0 06:06:01 INFO - Browser initialized. 06:06:01 INFO - Running cycle 1/1 for v8_7 test... 06:06:01 INFO - TEST-INFO | started process 15949 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKduR2r/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:13 INFO - PROCESS | 15949 | RSS: Main: 150831104 06:06:13 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | Cycle 1(1): loaded http://localhost:33703/tests/v8_7/run.html (next: http://localhost:33703/tests/v8_7/run.html) 06:06:35 INFO - PROCESS | 15949 | RSS: Main: 146743296 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | __start_tp_report 06:06:35 INFO - PROCESS | 15949 | _x_x_mozilla_page_load 06:06:35 INFO - PROCESS | 15949 | _x_x_mozilla_page_load_details 06:06:35 INFO - PROCESS | 15949 | |i|pagename|runs| 06:06:35 INFO - PROCESS | 15949 | |0;Richards;166.27868307283006 06:06:35 INFO - PROCESS | 15949 | |1;DeltaBlue;191.27773527161438 06:06:35 INFO - PROCESS | 15949 | |2;Encrypt;281.61081385525205 06:06:35 INFO - PROCESS | 15949 | |3;Decrypt;5261.780104712042 06:06:35 INFO - PROCESS | 15949 | |4;RayTrace;1067.2358591248667 06:06:35 INFO - PROCESS | 15949 | |5;Earley;722.0216606498195 06:06:35 INFO - PROCESS | 15949 | |6;Boyer;12219.512195121952 06:06:35 INFO - PROCESS | 15949 | |7;RegExp;25250 06:06:35 INFO - PROCESS | 15949 | |8;Splay;602.0469596628537 06:06:35 INFO - PROCESS | 15949 | |9;NavierStokes;4835.748792270531 06:06:35 INFO - PROCESS | 15949 | __end_tp_report 06:06:35 INFO - PROCESS | 15949 | __startTimestamp1452089195318__endTimestamp 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | ------- Summary: start ------- 06:06:35 INFO - PROCESS | 15949 | Number of tests: 10 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 166.3 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 191.3 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#2] Encrypt Cycles:1 Average:281.61 Median:281.61 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 281.6 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#3] Decrypt Cycles:1 Average:5261.78 Median:5261.78 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 5261.8 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 1067.2 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 722.0 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 12219.5 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 25250.0 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#8] Splay Cycles:1 Average:602.05 Median:602.05 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 602.0 06:06:35 INFO - PROCESS | 15949 | 06:06:35 INFO - PROCESS | 15949 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:06:35 INFO - PROCESS | 15949 | Values: 4835.7 06:06:35 INFO - PROCESS | 15949 | -------- Summary: end -------- 06:06:35 INFO - PROCESS | 15949 | 06:06:36 INFO - TEST-INFO | 15949: exit 0 06:06:36 INFO - TEST-OK | v8_7 | took 40070ms 06:06:36 INFO - SUITE-END | took 1211s 06:06:36 INFO - Completed test suite (00:20:11) 06:06:36 INFO - Working with test: dromaeo_css 06:06:36 INFO - Generating results file: dromaeo_css 06:06:36 INFO - Working with test: kraken 06:06:36 INFO - Generating results file: kraken 06:06:36 INFO - javascript benchmark 06:06:36 INFO - Working with test: v8_7 06:06:36 INFO - Generating results file: v8_7 06:06:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:06:36 INFO - process_Request line: dromaeo_css 6910.03 graph.html#tests=[[72,1,43]] 06:06:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:36 INFO - process_Request line: kraken 1535.20 graph.html#tests=[[232,1,43]] 06:06:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:36 INFO - process_Request line: v8_7 21287.14 graph.html#tests=[[230,1,43]] 06:06:36 INFO - RETURN: dromaeo_css: 6910.03 06:06:36 INFO - RETURN: kraken: 1535.20 06:06:36 INFO - RETURN: v8_7: 21287.14 06:06:36 INFO - javascript benchmark 06:06:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3181.8409079546022, 3222.146131275211, 3248.252901832579, 3252.7560432967534, 3269.5095735639666, 5222.060029194743, 5281.260623512701, 5288.60335474839, 5330.760115794789, 5337.492938170873, 5320.76056577454, 5335.466453354663, 5412.404635490093, 5512.228288039678, 5524.779008839651, 4905.999999999991, 4922.704637721748, 5010.649254552182, 5033.194688849785, 5059.190529515278, 4881.243407271861, 4921.064997650453, 4963.25551167326, 5001.274815151801, 5048.6465947383695, 4807.879803004917, 4835.468098509161, 4845.588125009378, 4850.3937007873665, 4870.634702397334, 4859.246816743411, 4886.486918873503, 4891.997140586207, 4909.944361962195, 4911.8772030699165, 4787.928181077286, 4821.035792841446, 4855.150348689001, 4895.339129217546, 4898.044881248158, 5251.0, 5278.313819203518, 5286.920696189561, 5297.364316282033, 5346.679199248018, 5778.537716982673, 5798.42015798421, 5799.304083509964, 5802.680852553108, 5805.7387417566315, 5603.887922241533, 5697.77208911643, 5817.301923769132, 5855.209546711225, 5866.9706651466895, 5433.891322173574, 5441.619086663935, 5445.591580631469, 5450.209719590677, 5465.07093794052, 5889.617174883619, 5890.528757699374, 5892.882142357214, 5905.822825315247, 5936.1392598073035, 5584.357798853184, 5608.69152196625, 5706.686132262766, 5707.200991861143, 5715.771369145271, 5753.108268218432, 5773.422657734277, 5794.246747922743, 5797.188393624896, 5821.330546987151, 5699.686517241508, 5724.284464441945, 5785.103308987113, 5787.07406814916, 5791.478766910998, 5655.179998900218, 5664.291963504562, 5698.0, 5708.20085188074, 5737.655740655574, 4453.487848897418, 4468.262736648417, 4473.2842745160615, 4474.082813023388, 4515.5484451554585, 3906.2382835346834, 3985.661218796377, 3990.7206495545615, 4019.799010049486, 4038.1519880824767, 5354.3842458117815, 5446.400895901447, 5466.070767969455, 5467.917981230285, 5486.561075113981, 5847.795327163614, 5858.912116318259, 5860.2967643883, 5861.3552509223955, 5870.53035757147, 5443.156310771837, 5445.428230035868, 5447.536959358499, 5452.372977107683, 5455.5908306877145, 4855.781489832966, 4860.6111511079025, 4935.259711043373, 4944.456109827916, 4963.057019166346, 5869.530437564899, 5950.256217972754, 5964.284285885721, 6002.669853158118, 6030.30651475086, 5755.165501002415, 5794.710264486843, 5812.21535092757, 5821.825345239649, 5822.184894114743, 5946.0, 6005.189299444519, 6036.7283472244735, 6037.577369584087, 6070.271567411939, 5740.913886291625, 5757.424257574209, 5759.0, 5769.74036168365, 5778.682172480554, 5831.096180092092, 5862.970685146547, 5868.295804503487, 5871.412858714094, 5875.0, 5570.972145139248, 5597.384287728428, 5642.069058605448, 5684.346300175367, 5693.231413759255, 5647.1529270609735, 5669.914951275817, 5689.089745640677, 5694.430556944272, 5703.771849125988, 5573.693446860461, 5586.38549759518, 5586.581006424616, 5597.580181486323, 5608.0, 5530.834074977757, 5650.858728531655, 5676.545876329967, 5728.971355143198, 5779.479846813807, 5536.7785288588, 5576.302962129734, 5587.804426845041, 5588.776448941997, 5595.244641973281], "unit": "score", "name": "dojo.html", "value": 5333.444813870696}, {"lowerIsBetter": false, "replicates": [517.3352242368558, 523.7800123947942, 534.3961323704214, 551.8316913341432, 553.5765139668157, 34597.48103778442, 34948.825255873686, 34955.0, 34990.650093499054, 34996.47505287423, 37128.81435592825, 37600.24799504008, 37692.811535942354, 37698.62301376985, 37820.0, 8302.045264794535, 8434.789130271762, 8438.240558349748, 8451.704190353339, 8520.275776558969, 8259.587020648974, 8379.622916968721, 8384.0, 8398.580070996457, 8416.20046095623, 8523.44597601157, 8601.483910965331, 8612.612432440555, 8629.827403451927, 8632.007319158283, 8487.193716596914, 8591.140885911422, 8594.441361311494, 8607.440516366416, 8613.353998450142, 8402.957985210034, 8440.87338689914, 8523.147685231428, 8550.572471376407, 8552.871706924401, 38539.8073009636, 39084.41373379402, 39134.804325978184, 39160.41259381112, 39221.41167882484, 3230.4831227003565, 3336.833158342073, 3429.159855835336, 3480.1473638958364, 3832.7891965941863, 30603.23491912698, 30968.0, 30995.535066974015, 31079.37841243185, 31240.843795780875, 3683.7421380503374, 3918.628480031966, 3929.0963078491823, 4070.674346052309, 4094.2016306820183, 259135.0, 264576.0, 265772.0, 265980.0, 266313.0, 60911.39088609057, 61680.38319616836, 62042.0, 62149.37850621526, 62215.37784622096, 62375.6881215591, 63789.681051594445, 72661.0, 72785.27214727891, 72896.63551682314, 14896.776548351783, 15135.091894486366, 15260.923695381452, 15314.310856011283, 15331.696805771635, 11115.333080015225, 11210.66368008961, 11258.268212566321, 11287.49206285719, 11324.830127548094, 21178.78821211799, 21536.56926861454, 21545.78454215469, 21548.4612884676, 21560.568788624452, 8234.547099909563, 8605.0, 8623.525706086226, 8651.826963460822, 8686.695965641173, 898.7528429681759, 926.5228407370209, 1033.7570670892335, 1053.9262251642313, 1069.8769641491172, 28294.858525707652, 28298.43403131926, 28363.290917727223, 28569.57145642817, 28852.85573572161, 982.9066238707311, 1037.159900480613, 1054.1619412567027, 1062.462001534887, 1169.7075731067234, 14801.185934773475, 14864.479743208936, 14938.32777525014, 15021.098734075991, 15145.697086058217, 302764.0, 306059.0, 307846.0, 308000.0, 308531.0, 50085.24872126921, 50650.49349506458, 50685.23972140421, 50690.0, 50802.0, 1269.796832506813, 1282.6472720001887, 1284.1973766396002, 1316.9078164528391, 1320.795276732108, 26967.595486068116, 27985.0, 28245.71754282431, 30444.0, 30750.692493074785, 47157.76421117873, 47781.76109119432, 47801.28298075462, 47854.0, 48062.27906581474, 282393.0, 283206.0, 285636.29000405176, 286317.0, 286366.0, 41535.7923210382, 42791.0, 42915.0, 43645.345319820866, 43843.0, 39052.2189556213, 39172.80413597914, 39457.40813887851, 39563.0, 39731.20537589174, 35521.644783551834, 36071.0, 36163.457548137325, 36343.63656363508, 36821.44767828431, 36428.63571364252, 36834.63165368312, 37626.81186594049, 38158.12371656823, 39022.0, 33348.66651333456, 33504.16239593932, 33908.0, 33909.49135763015, 34004.0, 29457.852710736308, 29726.70273297326, 31100.377992440477, 31503.84248078745, 33923.83038084794, 23659.290221293388, 23996.160134395213, 26324.4735105293, 26770.0, 26861.597076043483], "unit": "score", "name": "ext.html", "value": 18479.32827365647}, {"lowerIsBetter": false, "replicates": [342.652208008871, 350.1543771791123, 350.1928055831311, 353.81955202846547, 354.6612984599707, 16347.83652163478, 16673.33266673332, 17313.74029389557, 17482.475525734233, 18159.54601134972, 11040.33757974522, 12083.939580302087, 16479.752803707954, 16481.34074637013, 16637.750433743502, 4736.573708366246, 4999.350084489011, 5019.598432125421, 5034.295198672171, 5040.420351659551, 4924.28597853311, 4956.3804524434445, 4968.205087186051, 4992.475790042048, 5016.724080175589, 5001.249812528114, 5003.274525193845, 5080.7967681292885, 5207.791688332462, 5225.399079105913, 5062.291279220912, 5137.178051511759, 5156.561692256163, 5170.0, 5379.892402151935, 5147.562457191143, 5161.767720452589, 5162.096633089194, 5195.454477279907, 5196.740162991873, 12597.244165350108, 12961.935190323988, 19921.501962451053, 20150.69773953392, 20244.0, 1961.597872436147, 1975.8122978317037, 2016.9596608067902, 2078.449210959097, 2186.3987403464175, 9503.714888553355, 9591.616335346578, 9713.0, 9794.853077203776, 9843.360181588245, 1813.6463389639025, 1816.6185101128647, 1822.2073398071882, 1832.3403574713093, 1861.1252711225702, 60896.69551652257, 62416.0, 63349.683251583905, 63894.36105638931, 64490.677546611965, 9976.80046399068, 10261.333013354257, 10275.126614237724, 10377.584896604203, 10519.94740026295, 13495.730085398434, 13575.389107490186, 13635.181889086489, 13653.522126725517, 13664.180149191081, 7336.193018767931, 7363.521371110861, 7405.925940740632, 7415.0, 7470.028896243453, 6947.4789390795895, 6983.3016698330775, 6988.720451181997, 7008.719651213996, 7048.541844780073, 4355.695101342939, 4385.276429389179, 4405.933910991338, 4494.348319493721, 4531.003179300615, 1711.880168388201, 1775.9112044397987, 1826.2421095245325, 1841.8986955717296, 1936.7288579598867, 796.5698522797741, 830.9418340716092, 989.2975987049132, 1033.4677641014882, 1039.656913218636, 15440.536783896501, 15764.0, 15824.604384890239, 15967.760483592756, 17073.231704573325, 861.0872475176333, 897.2821742605889, 938.8497840345512, 952.5713428956997, 963.7301555564453, 9231.353805233703, 9524.904750952403, 9720.75698107553, 10046.547905344278, 10149.137323327452, 485794.0, 518909.0, 519989.0, 528443.0, 534990.0, 69761.65119174474, 80765.0, 82597.0, 83343.0, 84367.0, 1121.9943900280446, 1130.197559732599, 1137.4824454872848, 1148.8678801937717, 1152.775208834286, 14886.925565372103, 14968.925155374154, 15106.471273505815, 15715.921420392824, 15845.286962086964, 19449.01295234502, 33462.66537334595, 34689.47965780465, 36373.454398183516, 36749.63250367462, 46775.53224467848, 48383.51616483931, 48735.0, 49219.0, 50083.0, 8944.329175311748, 9296.674616388394, 9445.574949127169, 9506.334556580972, 9538.189253913495, 11446.94276528612, 11458.484368203284, 17640.823591763918, 17672.734908976632, 18118.818811811714, 13835.654108647364, 14077.366518506487, 14257.0, 14769.187694676895, 14900.105993640416, 14259.144451332953, 14560.0, 14880.0, 14937.253137342872, 15087.24563771829, 15080.773788392964, 15111.773323399937, 15117.09297442157, 15426.765858731498, 15699.686006280039, 9517.381370210915, 9529.857052144085, 9657.613695452103, 9967.651132210338, 10026.498675066363, 10319.864814870209, 13710.794338084737, 14196.787048194079, 14556.63608409756, 15007.849921500645], "unit": "score", "name": "jquery.html", "value": 8688.547483366272}, {"lowerIsBetter": false, "replicates": [1376.972460550789, 1418.9006769526134, 1528.8547587979144, 1683.2425408566148, 1687.3588036546112, 6898.8275293117695, 6912.58524488531, 7047.823804404886, 7130.465215108875, 7217.097862767154, 7070.611116388596, 7094.11323584552, 7120.50156489046, 7148.928510714892, 7155.14138303403, 2164.610370133379, 2191.6822060801255, 2197.494576247464, 2200.108955872874, 2200.284907405092, 2147.871127732333, 2165.750938642053, 2189.179057853305, 2197.505561248722, 2198.373463562885, 2142.5179334649733, 2178.6623073423566, 2189.890505474728, 2212.4026512841606, 2213.9778602213933, 2162.19998600518, 2176.3688530326185, 2183.672449132635, 2187.803097721213, 2195.1000089963118, 2173.445771328317, 2191.3206905859074, 2195.5169862630355, 2203.933881983543, 2209.624363858148, 6949.305069493061, 6998.055262539543, 7001.614911179883, 7009.05377773999, 7022.789316320519, 4249.150169966019, 4370.038591509863, 4378.890527736832, 4391.516933137353, 4422.557744225552, 2894.305366711995, 2907.1133304342166, 2913.242556935191, 2949.365886334427, 2957.4085182963495, 930.2929773372285, 991.6727479931677, 993.6720882108887, 1007.2848277722826, 1012.9088382045651, 9096.0, 9126.726198214064, 9180.816383672289, 9197.494137822418, 9281.489518076503, 3834.0, 3881.8059097045034, 3921.7254792164276, 3925.038365600446, 3928.332183528807, 7755.844883102306, 7790.610469476617, 7795.883061754078, 7798.103218129874, 7809.492382995087, 4292.678049146327, 4296.312589985588, 4332.436783218224, 4357.215701173819, 4447.2439685253585, 4023.879283621496, 4031.012401961538, 4042.838286468508, 4043.838246470108, 4055.6349928506575, 3288.391647545212, 3321.9833900830827, 3328.73370130389, 3341.465365541502, 3346.330733853239, 999.8250306196387, 1007.969760907174, 1021.8671572695501, 1027.3527677563236, 1029.0070082370548, 1043.4626167523732, 1051.894810518942, 1085.7394225385851, 1188.536470776398, 1299.0971274964, 6699.062131301622, 6699.330066993261, 6717.56335838169, 6719.395254427027, 6734.663266836638, 1016.5679586175846, 1028.6759670703705, 1086.8587083679229, 1090.4711215060688, 1098.2257508456519, 5327.440618735054, 5365.0, 5393.541548968382, 5417.729113544307, 5418.349798024262, 8279.675251959658, 8306.54314012735, 8515.27620152294, 8596.355273354524, 8616.396852220285, 8411.411201215857, 8453.450525715809, 8461.069282378934, 8463.153684631488, 8501.234888860032, 6693.263740988487, 6745.797626071226, 6756.864862702719, 6884.552504087218, 6901.102856628606, 6592.868142637216, 6594.439472644879, 6617.239017513048, 6653.767118150841, 6675.03212034262, 7546.396288297033, 7713.151553329241, 7793.337566306701, 7867.252611001945, 7903.723369682033, 7697.730579429693, 7895.802604934693, 7953.642086106023, 7977.122516523062, 7980.84038319242, 6165.568410211242, 6194.5973511721595, 6214.9689251553455, 6224.564280500322, 6231.158793562811, 6714.664266786739, 6953.269906659728, 6998.965005174941, 7008.579485230903, 7009.719611215494, 6705.430038446787, 6719.529632925648, 6740.595564266159, 6795.72817087311, 6872.10662613857, 5856.180134781049, 6210.596311239755, 6223.937760622336, 6287.779927702509, 6346.555741098079, 6322.430981211713, 6324.114623952558, 6335.0, 6349.333320001333, 6359.4276515112015, 5810.302763668386, 5862.501687356452, 5876.265466816648, 5877.735501902339, 5879.735411906389, 5989.850253743692, 6027.758889644365, 6030.8793824122395, 6206.255249370104, 6210.254769427697], "unit": "score", "name": "mootools.html", "value": 4162.662899949532}, {"lowerIsBetter": false, "replicates": [330.139985338194, 330.4910437925594, 336.98146601936884, 341.6685814759683, 343.97076248518874, 6166.229221347332, 6190.257169139704, 6200.224971878515, 6307.747690092391, 6329.525285603587, 6123.357047510014, 6171.753129874811, 6192.071189321604, 6209.751609935597, 6213.502919766419, 4735.195016847127, 4739.431268247815, 4754.54831790981, 4762.499937506564, 4763.0950119477275, 4751.3348131261655, 4759.452662943754, 4763.476017638074, 4778.450478195017, 4779.952200477986, 4639.234526303156, 4716.97641511792, 4718.598919091882, 4734.218853889121, 4734.573888350048, 4688.929666055012, 4690.4371475422995, 4698.718076915379, 4729.0, 4730.219513780222, 4090.7341022833716, 4091.345384738457, 4098.959010409917, 4100.630943215125, 4102.815373308208, 5880.705964701748, 5894.469497745224, 5911.379305172981, 5912.17229587858, 5932.2584676915385, 5373.6775793452125, 5481.424450432727, 5488.9725551372385, 5491.588130890159, 5522.6134170608075, 6624.503162262849, 6633.170853643294, 6633.867322653568, 6640.402363787234, 6658.966705166443, 4472.977635111836, 4482.25192175052, 4484.910301793979, 4489.124620698965, 4497.235469970113, 6688.130543029423, 6831.351021652985, 6884.070650462224, 6928.1339832520935, 6957.9215221640725, 4558.566936141061, 4603.838865639686, 4604.240300350471, 4606.262997920317, 4607.3089036644105, 4645.535446455395, 4665.906681866411, 4676.602488788491, 4698.1778188816825, 4731.881702957385, 5498.532624726943, 5499.0, 5505.697186654692, 5508.421615730371, 5520.006398848165, 6517.9348206517325, 6663.533552651268, 6669.866602667919, 6671.33286671329, 6709.228438729511, 1614.612493001671, 1659.3777333499938, 1667.3914021382109, 1674.8995060296422, 1683.410806217814, 1098.5715570927346, 1099.3403957625521, 1109.3122264196088, 1115.2304909612342, 1123.9213255072066, 6146.508279337642, 6265.937340626627, 6285.748570057147, 6305.369463053658, 6308.400701933309, 6788.9660551696925, 6792.320767923168, 6816.318368163144, 6817.0, 6835.69239384219, 6155.399596104955, 6240.188775459162, 6270.592411493239, 6280.434760871543, 6285.937140628535, 3672.1737609037755, 3687.1150923778637, 3702.241040586673, 3702.315071711742, 3715.256948610289, 7110.146782386147, 7112.431005519649, 7118.893216601755, 7120.679569419389, 7124.43004559634, 6845.657717114124, 6996.440284777205, 7008.7546935857, 7014.5440546364325, 7021.613811240329, 7096.432285417154, 7098.432125429953, 7103.538270012433, 7105.502614817016, 7130.073090498202, 6756.223034350916, 6764.154480689914, 6784.728610855511, 6827.761028363983, 6830.009648601024, 6624.105745724266, 6691.364320389555, 6730.730770769114, 6755.594664320157, 6781.423578995643, 7181.281871812777, 7205.963970180325, 7211.819704507429, 7221.494495385273, 7232.349088582053, 4610.861674149781, 4616.907661846812, 4646.4191976003, 4672.7897244624755, 4684.882877928079, 6761.91809310508, 6908.0, 6934.826629334307, 6944.826379340557, 6957.304269573002, 6697.966510167418, 6746.763863264762, 6761.898571521333, 6777.1189745332795, 6807.761728339485, 6692.464602831859, 6752.5948443093575, 6757.391834734897, 6765.627890466071, 6779.254282029072, 6447.0007148892, 6605.603663780189, 6605.702743376463, 6611.570247933869, 6624.503162262753, 6775.9672098371275, 6791.592504449749, 6793.72825086991, 6796.422304104009, 6802.217744959393, 6589.24223714279, 6605.57063790852, 6620.536562440583, 6634.203895532567, 6642.0], "unit": "score", "name": "prototype.html", "value": 4980.867410283027}, {"lowerIsBetter": false, "replicates": [783.5494590610397, 793.1196372027052, 798.2217338095357, 815.0748899998501, 818.1041759273595, 12428.0, 12648.430820613072, 12891.162074465165, 12960.092793504458, 13073.280969546671, 11477.253978491392, 13131.146475479087, 13219.942404607633, 13222.20666759995, 13235.0, 780.7696729464807, 796.8725003999361, 799.1209669363683, 802.2539038694013, 817.7751118442446, 811.427943299975, 813.8128230506987, 814.1776805426503, 814.238686827815, 819.9303059239971, 833.6540335760652, 833.6790335720731, 840.8528507511191, 841.3899922556159, 845.8604330285496, 836.0343802907652, 838.1241602525375, 839.3620848155385, 840.5503055865083, 842.4650347029681, 615.2033117113349, 618.5330075792748, 622.2874808344466, 623.0218556865723, 624.7750809708501, 11963.46164422603, 12045.217060891015, 12051.758964820654, 12069.155159138863, 12121.93939030308, 11781.293122412682, 11802.0, 12065.457054432572, 12102.697432564168, 12148.514059437612, 9999.200063994864, 10088.495575221283, 10103.949480252551, 10208.234382421273, 10245.180385569136, 3432.5375123052354, 3516.472529120627, 3558.62634423387, 3572.3034008368118, 3587.461880717887, 47691.76154119207, 48466.0, 48600.75699621515, 48639.270410943864, 48651.0, 9054.049324820931, 9359.532023398802, 9402.482863442576, 9628.085331893459, 9707.951460242653, 17330.74003889943, 17366.739498907526, 17371.0, 17380.65238695219, 17390.3043878246, 7238.638068096574, 7290.3438690518105, 7406.296401841816, 7496.887546686804, 7578.052743407075, 4012.1574469361176, 4019.664112993798, 4035.858744943913, 4073.0086300962557, 4124.896877578085, 2865.985670071678, 2913.0, 2923.8684259208385, 2924.6782853886057, 2925.3271747498193, 538.8545092824916, 540.1735344922275, 545.1033050631768, 547.8575570351737, 557.7545879812869, 508.4661105838928, 580.3575880258858, 606.3845197124922, 675.0818886314609, 687.4251853912223, 8455.915440845636, 8774.561271936378, 8834.0, 8957.283417326598, 8981.595828187747, 511.4425276448689, 535.267459618649, 589.381149792716, 661.3915198017835, 683.641088428579, 3900.317444447267, 4076.6331030207425, 4079.1229885574744, 4143.7928103594695, 4230.111676547898, 52850.207246891325, 52944.470555293956, 53051.0, 53131.20303195455, 54781.0, 48294.0, 48308.27537586939, 48478.51521484811, 49154.75422622864, 49255.261171081744, 43295.783521082194, 44571.33143002792, 45170.77414612972, 45582.0, 45705.31442028372, 8348.540830254395, 8798.780030499289, 8917.554122293988, 8969.282457403522, 9092.408993415407, 34016.14959626029, 34074.829625851715, 34559.82720086384, 34894.30211395809, 35021.0, 43245.567544324156, 44757.0, 45090.323645146, 45105.774471128745, 45236.773816130706, 10078.049844793004, 10164.542595583365, 10417.739556511147, 10451.372917624967, 10535.683929482127, 11248.887511124783, 11568.419321562682, 11686.94156529246, 12019.579314723942, 12260.0, 11270.323780573191, 11302.0, 11379.658610241706, 11430.768692977297, 11513.53945842157, 10109.595616175271, 10263.846042309222, 10722.088622467178, 11000.889991099986, 11546.249493782878, 10108.444035577819, 10226.897731022595, 10772.569097236335, 11135.10919126484, 11203.60787372438, 9163.71339761237, 9257.629694812133, 9367.20378767785, 9420.905790942003, 9742.512874356396, 9051.32115091384, 9855.11303982645, 9888.242467862454, 10045.49772511357, 10050.396976181453], "unit": "score", "name": "yui.html", "value": 6130.846979891618}], "name": "dromaeo_css", "value": 6910.025846006697}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 112.0, 114.0, 123.0, 114.0, 113.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [164.0, 130.0, 153.0, 161.0, 129.0, 154.0, 157.0, 124.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [164.0, 167.0, 163.0, 162.0, 161.0, 162.0, 164.0, 172.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 79.0, 71.0, 132.0, 73.0, 73.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 138.0, 97.0, 97.0, 97.0, 137.0, 97.0, 98.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 111.0, 111.0, 109.0, 109.0, 111.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 149.0, 148.0, 150.0, 148.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 62.0, 61.0, 65.0, 66.0, 60.0, 61.0, 60.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 61.8}, {"lowerIsBetter": true, "replicates": [73.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 95.0, 96.0, 86.0, 86.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 118.0, 128.0, 123.0, 118.0, 125.0, 118.0, 125.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [146.0, 157.0, 158.0, 157.0, 157.0, 148.0, 156.0, 156.0, 165.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 72.0, 74.0, 71.0, 73.0, 72.0, 75.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.8}], "name": "kraken", "value": 1535.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [191.27773527161438], "unit": "score", "name": "DeltaBlue", "value": 345.66490400000004}, {"lowerIsBetter": false, "replicates": [281.61081385525205], "unit": "score", "name": "Encrypt", "value": 945.2087309999996}, {"lowerIsBetter": false, "replicates": [5261.780104712042], "unit": "score", "name": "Decrypt", "value": 50.58763283582091}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [722.0216606498195], "unit": "score", "name": "Earley", "value": 923.0512549999999}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [602.0469596628537], "unit": "score", "name": "Splay", "value": 135.35655099999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21287.144935203156}]} 06:06:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21287.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1535.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6910.03"}}} 06:06:36 INFO - Return code: 0 06:06:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:06:36 INFO - # TBPL SUCCESS # 06:06:36 INFO - Running post-action listener: _resource_record_post_action 06:06:36 INFO - Running post-run listener: _resource_record_post_run 06:06:37 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 557793280; Read time: 24; Write time: 607800 06:06:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 238551040; Read time: 0; Write time: 259676 06:06:37 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 319242240; Read time: 24; Write time: 348124 06:06:37 INFO - Running post-run listener: _upload_blobber_files 06:06:37 INFO - Blob upload gear active. 06:06:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:06:37 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:06:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:06:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:06:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:38 INFO - (blobuploader) - INFO - Done attempting. 06:06:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:39 INFO - (blobuploader) - INFO - Done attempting. 06:06:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:39 INFO - Return code: 0 06:06:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:06:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374a74808983832ef246bd0885529327427d75b5b58cc3962d28073be4d1468a0b24d35d5b90fda6407f4e50570f53290ce009d9e06a274d93545fc2965ea913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf96f95224260f29e7817017bcc26d7c4e138646dad308490599e4e2a97758e0d02d75a1c28acc54bb47aeabc78a4ba73103f5770805648963377a0a2a043f9b"} 06:06:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:06:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:06:39 INFO - Contents: 06:06:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374a74808983832ef246bd0885529327427d75b5b58cc3962d28073be4d1468a0b24d35d5b90fda6407f4e50570f53290ce009d9e06a274d93545fc2965ea913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf96f95224260f29e7817017bcc26d7c4e138646dad308490599e4e2a97758e0d02d75a1c28acc54bb47aeabc78a4ba73103f5770805648963377a0a2a043f9b"} 06:06:39 INFO - Copying logs to upload dir... 06:06:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.252717 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-06 06:06:39.747448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:39.751494) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374a74808983832ef246bd0885529327427d75b5b58cc3962d28073be4d1468a0b24d35d5b90fda6407f4e50570f53290ce009d9e06a274d93545fc2965ea913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf96f95224260f29e7817017bcc26d7c4e138646dad308490599e4e2a97758e0d02d75a1c28acc54bb47aeabc78a4ba73103f5770805648963377a0a2a043f9b"} build_url:https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374a74808983832ef246bd0885529327427d75b5b58cc3962d28073be4d1468a0b24d35d5b90fda6407f4e50570f53290ce009d9e06a274d93545fc2965ea913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf96f95224260f29e7817017bcc26d7c4e138646dad308490599e4e2a97758e0d02d75a1c28acc54bb47aeabc78a4ba73103f5770805648963377a0a2a043f9b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:39.776686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:39.777063) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452085649.198424-777542352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:39.861857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 06:06:39.862205) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 06:06:39.862494) ========= ========= Total master_lag: 0.25 =========