builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1453067392.12 results: success (0) buildid: 20160117111941 builduid: b068b392c4594524aa3117f4c90bb993 revision: 57a677703c20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.115370) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.115843) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.116132) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006442 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.139400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.139726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.165162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.165535) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023132 ========= master_lag: 0.29 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.480311) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.480611) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.480998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.481271) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-17 13:49:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.30M=0.009s 2016-01-17 13:49:53 (1.30 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180044 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.679717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.680057) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.070223 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:52.760243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-17 13:49:52.760587) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 57a677703c20 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 57a677703c20 --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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-17 13:49:53,367 Setting DEBUG logging. 2016-01-17 13:49:53,367 attempt 1/10 2016-01-17 13:49:53,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/57a677703c20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-17 13:49:54,537 unpacking tar archive at: mozilla-inbound-57a677703c20/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-17 13:49:54.240522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:54.240862) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004526 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:54.290389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:54.290766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:54.301278) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:54.301523) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 13:49:54.301890) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-17 13:49:54.302165) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:49:55 INFO - MultiFileLogger online at 20160117 13:49:55 in /builds/slave/test-pgo 13:49:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:49:55 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:49:55 INFO - {'append_to_log': False, 13:49:55 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:49:55 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:49:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:49:55 INFO - 'branch': 'Mozilla-Inbound', 13:49:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:49:55 INFO - 'config_files': ('talos/linux_config.py',), 13:49:55 INFO - 'default_actions': ('clobber', 13:49:55 INFO - 'read-buildbot-config', 13:49:55 INFO - 'download-and-extract', 13:49:55 INFO - 'populate-webroot', 13:49:55 INFO - 'create-virtualenv', 13:49:55 INFO - 'install', 13:49:55 INFO - 'run-tests'), 13:49:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:49:55 INFO - 'download_minidump_stackwalk': True, 13:49:55 INFO - 'download_symbols': 'ondemand', 13:49:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:49:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:49:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:49:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:49:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:49:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:49:55 INFO - 'installer_path': 'installer.exe', 13:49:55 INFO - 'log_level': 'info', 13:49:55 INFO - 'log_name': 'talos', 13:49:55 INFO - 'log_to_console': True, 13:49:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:49:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:49:55 INFO - 'opt_config_files': (), 13:49:55 INFO - 'pip_index': False, 13:49:55 INFO - 'sps_profile': False, 13:49:55 INFO - 'sps_profile_interval': 0, 13:49:55 INFO - 'suite': 'dromaeojs-e10s', 13:49:55 INFO - 'system_bits': '32', 13:49:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:49:55 INFO - 'title': 'talos-linux64-ix-061', 13:49:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:49:55 INFO - 'use_talos_json': True, 13:49:55 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:49:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:49:55 INFO - 'work_dir': 'build'} 13:49:55 INFO - ##### 13:49:55 INFO - ##### Running clobber step. 13:49:55 INFO - ##### 13:49:55 INFO - Running pre-action listener: _resource_record_pre_action 13:49:55 INFO - Running main action method: clobber 13:49:55 INFO - rmtree: /builds/slave/test-pgo/build 13:49:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:49:56 INFO - Running post-action listener: _resource_record_post_action 13:49:56 INFO - ##### 13:49:56 INFO - ##### Running read-buildbot-config step. 13:49:56 INFO - ##### 13:49:56 INFO - Running pre-action listener: _resource_record_pre_action 13:49:56 INFO - Running main action method: read_buildbot_config 13:49:56 INFO - Using buildbot properties: 13:49:56 INFO - { 13:49:56 INFO - "project": "", 13:49:56 INFO - "product": "firefox", 13:49:56 INFO - "script_repo_revision": "production", 13:49:56 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:49:56 INFO - "repository": "", 13:49:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:49:56 INFO - "buildid": "20160117111941", 13:49:56 INFO - "pgo_build": "True", 13:49:56 INFO - "basedir": "/builds/slave/test-pgo", 13:49:56 INFO - "buildnumber": 256, 13:49:56 INFO - "slavename": "talos-linux64-ix-061", 13:49:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:49:56 INFO - "platform": "ubuntu64_hw", 13:49:56 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:49:56 INFO - "branch": "mozilla-inbound", 13:49:56 INFO - "repo_path": "integration/mozilla-inbound", 13:49:56 INFO - "revision": "57a677703c20", 13:49:56 INFO - "stage_platform": "linux64-pgo", 13:49:56 INFO - "builduid": "b068b392c4594524aa3117f4c90bb993", 13:49:56 INFO - "slavebuilddir": "test" 13:49:56 INFO - } 13:49:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:49:56 INFO - Running post-action listener: _resource_record_post_action 13:49:56 INFO - ##### 13:49:56 INFO - ##### Running download-and-extract step. 13:49:56 INFO - ##### 13:49:56 INFO - Running pre-action listener: _resource_record_pre_action 13:49:56 INFO - Running main action method: download_and_extract 13:49:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:56 INFO - https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:49:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/test_packages.json 13:49:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/test_packages.json 13:49:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:49:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:49:56 INFO - Downloaded 1448 bytes. 13:49:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:49:56 INFO - Using the following test package requirements: 13:49:56 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:49:56 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:49:56 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:49:56 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'jsshell-linux-x86_64.zip'], 13:49:56 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:49:56 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:49:56 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:49:56 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:49:56 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:49:56 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:49:56 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:49:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:49:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:56 INFO - https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:49:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:49:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:49:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:49:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:49:59 INFO - Downloaded 22483745 bytes. 13:49:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:49:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:50:00 INFO - Return code: 0 13:50:00 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 13:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:00 INFO - https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:50:03 INFO - Downloaded 22483745 bytes. 13:50:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:50:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:50:04 INFO - Return code: 0 13:50: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')]} 13:50:04 INFO - https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:50:09 INFO - Downloaded 11132144 bytes. 13:50:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:50:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 13:50:09 INFO - Return code: 0 13:50:09 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')]} 13:50:09 INFO - https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:50:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:50:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:50:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bO00V-oDQsSYofx9y6g8Lw/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 13:50:12 INFO - Downloaded 55945475 bytes. 13:50:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:50:12 INFO - mkdir: /builds/slave/test-pgo/properties 13:50:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:50:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:50:12 INFO - Contents: 13:50:12 INFO - build_url:https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:50:12 INFO - Running post-action listener: _resource_record_post_action 13:50:12 INFO - Running post-action listener: set_extra_try_arguments 13:50:12 INFO - ##### 13:50:12 INFO - ##### Running populate-webroot step. 13:50:12 INFO - ##### 13:50:12 INFO - Running pre-action listener: _resource_record_pre_action 13:50:12 INFO - Running main action method: populate_webroot 13:50:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:50:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:50:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:50:12 INFO - '--tppagecycles', 13:50:12 INFO - '7'], 13:50:12 INFO - 'tests': ['tsvgm']}}, 13:50:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:50:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:50:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:50:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:50:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'tests': ['damp', 'tps']}, 13:50:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['damp', 'tps']}, 13:50:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:50:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:50:12 INFO - 'other': {'tests': ['a11yr', 13:50:12 INFO - 'ts_paint', 13:50:12 INFO - 'tpaint', 13:50:12 INFO - 'sessionrestore', 13:50:12 INFO - 'sessionrestore_no_auto_restore']}, 13:50:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['a11yr', 13:50:12 INFO - 'ts_paint', 13:50:12 INFO - 'tpaint', 13:50:12 INFO - 'sessionrestore', 13:50:12 INFO - 'sessionrestore_no_auto_restore']}, 13:50:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['a11yr', 13:50:12 INFO - 'ts_paint', 13:50:12 INFO - 'tpaint', 13:50:12 INFO - 'sessionrestore', 13:50:12 INFO - 'sessionrestore_no_auto_restore']}, 13:50:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['a11yr', 13:50:12 INFO - 'ts_paint', 13:50:12 INFO - 'tpaint', 13:50:12 INFO - 'sessionrestore', 13:50:12 INFO - 'sessionrestore_no_auto_restore']}, 13:50:12 INFO - 'other_l64': {'tests': ['a11yr', 13:50:12 INFO - 'ts_paint', 13:50:12 INFO - 'tpaint', 13:50:12 INFO - 'sessionrestore', 13:50:12 INFO - 'sessionrestore_no_auto_restore']}, 13:50:12 INFO - 'other_nol64': {'tests': ['a11yr', 13:50:12 INFO - 'ts_paint', 13:50:12 INFO - 'tpaint', 13:50:12 INFO - 'sessionrestore', 13:50:12 INFO - 'sessionrestore_no_auto_restore']}, 13:50:12 INFO - 'svgr': {'tests': ['tsvgx', 13:50:12 INFO - 'tsvgr_opacity', 13:50:12 INFO - 'tart', 13:50:12 INFO - 'tscrollx', 13:50:12 INFO - 'cart']}, 13:50:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['tsvgx', 13:50:12 INFO - 'tsvgr_opacity', 13:50:12 INFO - 'tart', 13:50:12 INFO - 'tscrollx', 13:50:12 INFO - 'cart']}, 13:50:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'tests': ['tp5o']}, 13:50:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'talos_options': ['--e10s'], 13:50:12 INFO - 'tests': ['tp5o']}, 13:50:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'talos_options': ['--xperf_path', 13:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:12 INFO - 'tests': ['tp5n']}, 13:50:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:12 INFO - 'talos_options': ['--e10s', 13:50:12 INFO - '--xperf_path', 13:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:12 INFO - 'tests': ['tp5n']}}, 13:50:12 INFO - 'talos.zip': {'path': '', 13:50:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:50:12 INFO - Running post-action listener: _resource_record_post_action 13:50:12 INFO - ##### 13:50:12 INFO - ##### Running create-virtualenv step. 13:50:12 INFO - ##### 13:50:12 INFO - Running pre-action listener: _resource_record_pre_action 13:50:12 INFO - Running main action method: create_virtualenv 13:50:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:50:12 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 13:50:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:50:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:50:12 INFO - Using real prefix '/usr' 13:50:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:50:13 INFO - Installing distribute.............................................................................................................................................................................................done. 13:50:15 INFO - Installing pip.................done. 13:50:15 INFO - Return code: 0 13:50:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:50:15 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')]} 13:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:15 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')]} 13:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:15 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:15 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 13:50:15 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 13:50:15 INFO - Using env: {'DISPLAY': ':0', 13:50:15 INFO - 'HOME': '/home/cltbld', 13:50:15 INFO - 'LANG': 'en_US.UTF-8', 13:50:15 INFO - 'LANGUAGE': 'en_US:en', 13:50:15 INFO - 'LOGNAME': 'cltbld', 13:50:15 INFO - 'MAIL': '/var/mail/cltbld', 13:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:15 INFO - 'MOZ_NO_REMOTE': '1', 13:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:15 INFO - 'NO_EM_RESTART': '1', 13:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:15 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:15 INFO - 'SHELL': '/bin/bash', 13:50:15 INFO - 'SHLVL': '1', 13:50:15 INFO - 'TERM': 'linux', 13:50:15 INFO - 'TMOUT': '86400', 13:50:15 INFO - 'USER': 'cltbld', 13:50:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:15 INFO - '_': '/tools/buildbot/bin/python'} 13:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:15 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 13:50:15 INFO - Cleaning up... 13:50:15 INFO - Return code: 0 13:50:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:50:15 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')]} 13:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:15 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')]} 13:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:15 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:15 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 13:50:15 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 13:50:15 INFO - Using env: {'DISPLAY': ':0', 13:50:15 INFO - 'HOME': '/home/cltbld', 13:50:15 INFO - 'LANG': 'en_US.UTF-8', 13:50:15 INFO - 'LANGUAGE': 'en_US:en', 13:50:15 INFO - 'LOGNAME': 'cltbld', 13:50:15 INFO - 'MAIL': '/var/mail/cltbld', 13:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:15 INFO - 'MOZ_NO_REMOTE': '1', 13:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:15 INFO - 'NO_EM_RESTART': '1', 13:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:15 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:15 INFO - 'SHELL': '/bin/bash', 13:50:15 INFO - 'SHLVL': '1', 13:50:15 INFO - 'TERM': 'linux', 13:50:15 INFO - 'TMOUT': '86400', 13:50:15 INFO - 'USER': 'cltbld', 13:50:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:15 INFO - '_': '/tools/buildbot/bin/python'} 13:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:15 INFO - Downloading/unpacking psutil>=0.7.1 13:50:15 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 13:50:15 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 13:50:15 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 13:50:15 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 13:50:15 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 13:50:15 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 13:50:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:50:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:50:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:17 INFO - Installing collected packages: psutil 13:50:17 INFO - Running setup.py install for psutil 13:50:17 INFO - building 'psutil._psutil_linux' extension 13:50:17 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 13:50:17 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 13:50:17 INFO - building 'psutil._psutil_posix' extension 13:50:17 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 13:50:17 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 13:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:18 INFO - Successfully installed psutil 13:50:18 INFO - Cleaning up... 13:50:18 INFO - Return code: 0 13:50:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:50:18 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')]} 13:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:18 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')]} 13:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:18 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:18 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 13:50:18 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 13:50:18 INFO - Using env: {'DISPLAY': ':0', 13:50:18 INFO - 'HOME': '/home/cltbld', 13:50:18 INFO - 'LANG': 'en_US.UTF-8', 13:50:18 INFO - 'LANGUAGE': 'en_US:en', 13:50:18 INFO - 'LOGNAME': 'cltbld', 13:50:18 INFO - 'MAIL': '/var/mail/cltbld', 13:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:18 INFO - 'MOZ_NO_REMOTE': '1', 13:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:18 INFO - 'NO_EM_RESTART': '1', 13:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:18 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:18 INFO - 'SHELL': '/bin/bash', 13:50:18 INFO - 'SHLVL': '1', 13:50:18 INFO - 'TERM': 'linux', 13:50:18 INFO - 'TMOUT': '86400', 13:50:18 INFO - 'USER': 'cltbld', 13:50:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:18 INFO - '_': '/tools/buildbot/bin/python'} 13:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:50:18 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 13:50:18 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 13:50:18 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 13:50:18 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 13:50:18 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 13:50:18 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 13:50:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:50:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:50:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:50:20 INFO - Installing collected packages: mozsystemmonitor 13:50:20 INFO - Running setup.py install for mozsystemmonitor 13:50:20 INFO - Successfully installed mozsystemmonitor 13:50:20 INFO - Cleaning up... 13:50:20 INFO - Return code: 0 13:50:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:50:20 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')]} 13:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:20 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')]} 13:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:20 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:20 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 13:50:20 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 13:50:20 INFO - Using env: {'DISPLAY': ':0', 13:50:20 INFO - 'HOME': '/home/cltbld', 13:50:20 INFO - 'LANG': 'en_US.UTF-8', 13:50:20 INFO - 'LANGUAGE': 'en_US:en', 13:50:20 INFO - 'LOGNAME': 'cltbld', 13:50:20 INFO - 'MAIL': '/var/mail/cltbld', 13:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:20 INFO - 'MOZ_NO_REMOTE': '1', 13:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:20 INFO - 'NO_EM_RESTART': '1', 13:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:20 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:20 INFO - 'SHELL': '/bin/bash', 13:50:20 INFO - 'SHLVL': '1', 13:50:20 INFO - 'TERM': 'linux', 13:50:20 INFO - 'TMOUT': '86400', 13:50:20 INFO - 'USER': 'cltbld', 13:50:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:20 INFO - '_': '/tools/buildbot/bin/python'} 13:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:50:20 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 13:50:20 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 13:50:20 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 13:50:20 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 13:50:20 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 13:50:20 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 13:50:22 INFO - Downloading blobuploader-1.2.4.tar.gz 13:50:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:50:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:50:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:50:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:50:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 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 13:50:22 INFO - Downloading docopt-0.6.1.tar.gz 13:50:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:50:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:50:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:50:22 INFO - Running setup.py install for blobuploader 13:50:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:50:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:50:23 INFO - Running setup.py install for requests 13:50:23 INFO - Running setup.py install for docopt 13:50:23 INFO - Successfully installed blobuploader requests docopt 13:50:23 INFO - Cleaning up... 13:50:23 INFO - Return code: 0 13:50:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:50: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')]} 13:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:23 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:23 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 13:50:23 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 13:50:23 INFO - Using env: {'DISPLAY': ':0', 13:50:23 INFO - 'HOME': '/home/cltbld', 13:50:23 INFO - 'LANG': 'en_US.UTF-8', 13:50:23 INFO - 'LANGUAGE': 'en_US:en', 13:50:23 INFO - 'LOGNAME': 'cltbld', 13:50:23 INFO - 'MAIL': '/var/mail/cltbld', 13:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:23 INFO - 'MOZ_NO_REMOTE': '1', 13:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:23 INFO - 'NO_EM_RESTART': '1', 13:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:23 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:23 INFO - 'SHELL': '/bin/bash', 13:50:23 INFO - 'SHLVL': '1', 13:50:23 INFO - 'TERM': 'linux', 13:50:23 INFO - 'TMOUT': '86400', 13:50:23 INFO - 'USER': 'cltbld', 13:50:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:23 INFO - '_': '/tools/buildbot/bin/python'} 13:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:50:23 INFO - Running setup.py (path:/tmp/pip-49dieE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:50:23 INFO - Running setup.py (path:/tmp/pip-Ol6IPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:50:23 INFO - Running setup.py (path:/tmp/pip-S4YeZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:50:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:50:23 INFO - Running setup.py (path:/tmp/pip-9APa1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:50:24 INFO - Running setup.py (path:/tmp/pip-2DFIvG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:50:24 INFO - Running setup.py (path:/tmp/pip-yf3Vet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:50:24 INFO - Running setup.py (path:/tmp/pip-F9KtU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:50:24 INFO - Running setup.py (path:/tmp/pip-R9aKtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:50:24 INFO - Running setup.py (path:/tmp/pip-HLwLmY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:50:24 INFO - Running setup.py (path:/tmp/pip-wNPxtc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:50:24 INFO - Running setup.py (path:/tmp/pip-tNk3P5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:50:24 INFO - Running setup.py (path:/tmp/pip-_y_0VV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:50:24 INFO - Running setup.py (path:/tmp/pip-WEXcfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:50:24 INFO - Running setup.py (path:/tmp/pip-BSczBC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:50:24 INFO - Running setup.py (path:/tmp/pip-8gq3De-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:50:24 INFO - Running setup.py (path:/tmp/pip-2U6NhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:50:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:50:24 INFO - Running setup.py (path:/tmp/pip-hIkvJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:50:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:50:24 INFO - Running setup.py install for manifestparser 13:50:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Running setup.py install for mozcrash 13:50:25 INFO - Running setup.py install for mozdebug 13:50:25 INFO - Running setup.py install for mozdevice 13:50:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Running setup.py install for mozfile 13:50:25 INFO - Running setup.py install for mozhttpd 13:50:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Running setup.py install for mozinfo 13:50:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Running setup.py install for mozInstall 13:50:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Running setup.py install for mozleak 13:50:25 INFO - Running setup.py install for mozlog 13:50:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:50:25 INFO - Running setup.py install for moznetwork 13:50:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:50:26 INFO - Running setup.py install for mozprocess 13:50:26 INFO - Running setup.py install for mozprofile 13:50:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:50:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:50:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:50:26 INFO - Running setup.py install for mozrunner 13:50:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:50:26 INFO - Running setup.py install for mozscreenshot 13:50:26 INFO - Running setup.py install for moztest 13:50:26 INFO - Running setup.py install for mozversion 13:50:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:50:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:50:26 INFO - Cleaning up... 13:50:26 INFO - Return code: 0 13:50:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:26 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:26 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 13:50:26 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 13:50:26 INFO - Using env: {'DISPLAY': ':0', 13:50:26 INFO - 'HOME': '/home/cltbld', 13:50:26 INFO - 'LANG': 'en_US.UTF-8', 13:50:26 INFO - 'LANGUAGE': 'en_US:en', 13:50:26 INFO - 'LOGNAME': 'cltbld', 13:50:26 INFO - 'MAIL': '/var/mail/cltbld', 13:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:26 INFO - 'MOZ_NO_REMOTE': '1', 13:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:26 INFO - 'NO_EM_RESTART': '1', 13:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:26 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:26 INFO - 'SHELL': '/bin/bash', 13:50:26 INFO - 'SHLVL': '1', 13:50:26 INFO - 'TERM': 'linux', 13:50:26 INFO - 'TMOUT': '86400', 13:50:26 INFO - 'USER': 'cltbld', 13:50:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:26 INFO - '_': '/tools/buildbot/bin/python'} 13:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:50:26 INFO - Running setup.py (path:/tmp/pip-wTznuI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:50:27 INFO - Running setup.py (path:/tmp/pip-vbAI1D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:50:27 INFO - Running setup.py (path:/tmp/pip-gmINcb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:50:27 INFO - Running setup.py (path:/tmp/pip-oSYIdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:50:27 INFO - Running setup.py (path:/tmp/pip-Nr1V52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:50:27 INFO - Running setup.py (path:/tmp/pip-ld8FBH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:50:27 INFO - Running setup.py (path:/tmp/pip-opi9Jx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:50:27 INFO - Running setup.py (path:/tmp/pip-O5PvWo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:50:27 INFO - Running setup.py (path:/tmp/pip-Tg8KJu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:50:27 INFO - Running setup.py (path:/tmp/pip-CdJMGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:50:27 INFO - Running setup.py (path:/tmp/pip-g1I1nd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:50:27 INFO - Running setup.py (path:/tmp/pip-AgY2Oz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:50:27 INFO - Running setup.py (path:/tmp/pip-Q9iIGu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:50:27 INFO - Running setup.py (path:/tmp/pip-y3L2Cc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:50:27 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)) 13:50:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:50:27 INFO - Running setup.py (path:/tmp/pip-RmvG9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:50:28 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)) 13:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:50:28 INFO - Running setup.py (path:/tmp/pip-k7wS3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:50:28 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)) 13:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:50:28 INFO - Running setup.py (path:/tmp/pip-x97c57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:50:28 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)) 13:50:28 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)) 13:50:28 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)) 13:50:28 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)) 13:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:50:28 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 13:50:28 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 13:50:28 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 13:50:28 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 13:50:28 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 13:50:28 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 13:50:29 INFO - Downloading blessings-1.5.1.tar.gz 13:50:29 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 13:50:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:50:29 INFO - Installing collected packages: blessings 13:50:29 INFO - Running setup.py install for blessings 13:50:30 INFO - Successfully installed blessings 13:50:30 INFO - Cleaning up... 13:50:30 INFO - Return code: 0 13:50:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:50:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:50:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:50:30 INFO - Reading from file tmpfile_stdout 13:50:30 INFO - Current package versions: 13:50:30 INFO - argparse == 1.2.1 13:50:30 INFO - blessings == 1.5.1 13:50:30 INFO - blobuploader == 1.2.4 13:50:30 INFO - docopt == 0.6.1 13:50:30 INFO - manifestparser == 1.1 13:50:30 INFO - mozInstall == 1.12 13:50:30 INFO - mozcrash == 0.16 13:50:30 INFO - mozdebug == 0.1 13:50:30 INFO - mozdevice == 0.48 13:50:30 INFO - mozfile == 1.2 13:50:30 INFO - mozhttpd == 0.7 13:50:30 INFO - mozinfo == 0.9 13:50:30 INFO - mozleak == 0.1 13:50:30 INFO - mozlog == 3.1 13:50:30 INFO - moznetwork == 0.27 13:50:30 INFO - mozprocess == 0.22 13:50:30 INFO - mozprofile == 0.28 13:50:30 INFO - mozrunner == 6.11 13:50:30 INFO - mozscreenshot == 0.1 13:50:30 INFO - mozsystemmonitor == 0.0 13:50:30 INFO - moztest == 0.7 13:50:30 INFO - mozversion == 1.4 13:50:30 INFO - psutil == 3.1.1 13:50:30 INFO - requests == 1.2.3 13:50:30 INFO - wsgiref == 0.1.2 13:50:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:50: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')]} 13:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:30 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:30 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 13:50:30 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 13:50:30 INFO - Using env: {'DISPLAY': ':0', 13:50:30 INFO - 'HOME': '/home/cltbld', 13:50:30 INFO - 'LANG': 'en_US.UTF-8', 13:50:30 INFO - 'LANGUAGE': 'en_US:en', 13:50:30 INFO - 'LOGNAME': 'cltbld', 13:50:30 INFO - 'MAIL': '/var/mail/cltbld', 13:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:30 INFO - 'MOZ_NO_REMOTE': '1', 13:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:30 INFO - 'NO_EM_RESTART': '1', 13:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:30 INFO - 'SHELL': '/bin/bash', 13:50:30 INFO - 'SHLVL': '1', 13:50:30 INFO - 'TERM': 'linux', 13:50:30 INFO - 'TMOUT': '86400', 13:50:30 INFO - 'USER': 'cltbld', 13:50:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:30 INFO - '_': '/tools/buildbot/bin/python'} 13:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 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)) 13:50:30 INFO - Cleaning up... 13:50:30 INFO - Return code: 0 13:50:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:50: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')]} 13:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:30 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:30 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 13:50:30 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 13:50:30 INFO - Using env: {'DISPLAY': ':0', 13:50:30 INFO - 'HOME': '/home/cltbld', 13:50:30 INFO - 'LANG': 'en_US.UTF-8', 13:50:30 INFO - 'LANGUAGE': 'en_US:en', 13:50:30 INFO - 'LOGNAME': 'cltbld', 13:50:30 INFO - 'MAIL': '/var/mail/cltbld', 13:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:30 INFO - 'MOZ_NO_REMOTE': '1', 13:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:30 INFO - 'NO_EM_RESTART': '1', 13:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:30 INFO - 'SHELL': '/bin/bash', 13:50:30 INFO - 'SHLVL': '1', 13:50:30 INFO - 'TERM': 'linux', 13:50:30 INFO - 'TMOUT': '86400', 13:50:30 INFO - 'USER': 'cltbld', 13:50:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:30 INFO - '_': '/tools/buildbot/bin/python'} 13:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:30 INFO - Downloading/unpacking jsonschema 13:50:30 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 13:50:30 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 13:50:30 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 13:50:30 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 13:50:30 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 13:50:30 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 13:50:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:50:32 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 13:50:32 INFO - Downloading/unpacking functools32 (from jsonschema) 13:50:32 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 13:50:32 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 13:50:32 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 13:50:32 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 13:50:32 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 13:50:32 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 13:50:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:50:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:50:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:50:32 INFO - warning: no files found matching '*.txt' 13:50:32 INFO - no previously-included directories found matching 'build' 13:50:32 INFO - no previously-included directories found matching 'dist' 13:50:32 INFO - no previously-included directories found matching '.git*' 13:50:32 INFO - Installing collected packages: jsonschema, functools32 13:50:32 INFO - Running setup.py install for functools32 13:50:32 INFO - warning: no files found matching '*.txt' 13:50:32 INFO - no previously-included directories found matching 'build' 13:50:32 INFO - no previously-included directories found matching 'dist' 13:50:32 INFO - no previously-included directories found matching '.git*' 13:50:32 INFO - Successfully installed jsonschema functools32 13:50:32 INFO - Cleaning up... 13:50:32 INFO - Return code: 0 13:50:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:32 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 0x7f6232775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1964230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', '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 13:50:32 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 13:50:32 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 13:50:32 INFO - Using env: {'DISPLAY': ':0', 13:50:32 INFO - 'HOME': '/home/cltbld', 13:50:32 INFO - 'LANG': 'en_US.UTF-8', 13:50:32 INFO - 'LANGUAGE': 'en_US:en', 13:50:32 INFO - 'LOGNAME': 'cltbld', 13:50:32 INFO - 'MAIL': '/var/mail/cltbld', 13:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:32 INFO - 'MOZ_NO_REMOTE': '1', 13:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:32 INFO - 'NO_EM_RESTART': '1', 13:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:32 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:32 INFO - 'SHELL': '/bin/bash', 13:50:32 INFO - 'SHLVL': '1', 13:50:32 INFO - 'TERM': 'linux', 13:50:32 INFO - 'TMOUT': '86400', 13:50:32 INFO - 'USER': 'cltbld', 13:50:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:32 INFO - '_': '/tools/buildbot/bin/python'} 13:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:33 INFO - Downloading/unpacking flake8 13:50:33 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 13:50:33 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 13:50:33 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 13:50:33 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 13:50:33 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 13:50:33 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 13:50:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:50:34 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 13:50:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:50:34 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 13:50:34 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 13:50:34 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 13:50:34 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 13:50:34 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 13:50:34 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 13:50:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:50:35 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 13:50:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 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 13:50:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:50:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:50:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:50:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:50:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:50:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:50:35 INFO - no previously-included directories found matching 'docs/_build' 13:50:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:50:35 INFO - Running setup.py install for pep8 13:50:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:50:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:50:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:50:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:50:35 INFO - no previously-included directories found matching 'docs/_build' 13:50:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:50:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:50:35 INFO - Cleaning up... 13:50:35 INFO - Return code: 0 13:50:35 INFO - Running post-action listener: _resource_record_post_action 13:50:35 INFO - Running post-action listener: _start_resource_monitoring 13:50:35 INFO - Starting resource monitoring. 13:50:35 INFO - ##### 13:50:35 INFO - ##### Running install step. 13:50:35 INFO - ##### 13:50:35 INFO - Running pre-action listener: _resource_record_pre_action 13:50:35 INFO - Running main action method: install 13:50:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:50:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:50:36 INFO - Reading from file tmpfile_stdout 13:50:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:50:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:50:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:50:36 INFO - Reading from file tmpfile_stdout 13:50:36 INFO - Output received: 13:50:36 INFO - Usage: mozinstall [options] installer 13:50:36 INFO - Options: 13:50:36 INFO - -h, --help show this help message and exit 13:50:36 INFO - -d DEST, --destination=DEST 13:50:36 INFO - Directory to install application into. [default: 13:50:36 INFO - "/builds/slave/test-pgo"] 13:50:36 INFO - --app=APP Application being installed. [default: firefox] 13:50:36 INFO - mkdir: /builds/slave/test-pgo/build/application 13:50:36 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'] 13:50:36 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 13:50:52 INFO - Reading from file tmpfile_stdout 13:50:52 INFO - Output received: 13:50:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:50:52 INFO - Running post-action listener: _resource_record_post_action 13:50:52 INFO - ##### 13:50:52 INFO - ##### Running run-tests step. 13:50:52 INFO - ##### 13:50:52 INFO - Running pre-action listener: _resource_record_pre_action 13:50:52 INFO - Running main action method: run_tests 13:50:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:50:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:50:52 INFO - Python 2.7.3 13:50:52 INFO - Return code: 0 13:50:52 INFO - grabbing minidump binary from tooltool 13:50:52 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')]} 13:50:52 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 0x19f67f0>, '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 0x19622d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1962760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:50:52 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 13:50:52 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 13:50:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:52 INFO - Return code: 0 13:50:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:50:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:50:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:50:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:50:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:50:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:50:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:50:53 INFO - Return code: 0 13:50:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 13:50:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 13:50:53 INFO - Using env: {'DISPLAY': ':0', 13:50:53 INFO - 'HOME': '/home/cltbld', 13:50:53 INFO - 'LANG': 'en_US.UTF-8', 13:50:53 INFO - 'LANGUAGE': 'en_US:en', 13:50:53 INFO - 'LOGNAME': 'cltbld', 13:50:53 INFO - 'MAIL': '/var/mail/cltbld', 13:50:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:50:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:53 INFO - 'MOZ_NO_REMOTE': '1', 13:50:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:53 INFO - 'NO_EM_RESTART': '1', 13:50:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:50:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:50:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:50:53 INFO - 'SHELL': '/bin/bash', 13:50:53 INFO - 'SHLVL': '1', 13:50:53 INFO - 'TERM': 'linux', 13:50:53 INFO - 'TMOUT': '86400', 13:50:53 INFO - 'USER': 'cltbld', 13:50:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538', 13:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:53 INFO - '_': '/tools/buildbot/bin/python'} 13:50:53 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 13:50:53 INFO - mozversion application_buildid: 20160117111941 13:50:53 INFO - mozversion application_changeset: 57a677703c20e7c7c22d4662ecc9724ca9463231 13:50:53 INFO - mozversion application_display_name: Nightly 13:50:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:53 INFO - mozversion application_name: Firefox 13:50:53 INFO - mozversion application_remotingname: firefox 13:50:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:50:53 INFO - mozversion application_vendor: Mozilla 13:50:53 INFO - mozversion application_version: 46.0a1 13:50:53 INFO - mozversion platform_buildid: 20160117111941 13:50:53 INFO - mozversion platform_changeset: 57a677703c20e7c7c22d4662ecc9724ca9463231 13:50:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:50:53 INFO - mozversion platform_version: 46.0a1 13:50:53 INFO - using testdate: 1453067453 13:50:53 INFO - actual date: 1453067453 13:50:53 INFO - starting webserver on 'localhost:38113' 13:50:53 INFO - SUITE-START | Running 3 tests 13:50:53 INFO - TEST-START | dromaeo_css 13:50:53 INFO - operating with platform_type : linux_ 13:50:53 INFO - Initialising browser for dromaeo_css test... 13:50:53 INFO - TEST-INFO | started process 18289 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5tTx6M/profile http://localhost:38113/getInfo.html) 13:50:57 INFO - PROCESS | 18289 | 13:50:57 INFO - PROCESS | 18289 | (process:18372): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:50:58 INFO - PROCESS | 18289 | __metrics Screen width/height:1600/1200 13:50:58 INFO - PROCESS | 18289 | colorDepth:24 13:50:58 INFO - PROCESS | 18289 | Browser inner width/height: 1024/697 13:50:58 INFO - PROCESS | 18289 | __metrics 13:50:58 INFO - PROCESS | 18289 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:50:59 INFO - TEST-INFO | 18289: exit 0 13:50:59 INFO - Browser initialized. 13:50:59 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:59 INFO - TEST-INFO | started process 18420 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5tTx6M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:00 INFO - PROCESS | 18420 | -- checkerboarding starts below -- 13:51:00 INFO - PROCESS | 18420 | RENDERTRACE 0.110211 rect red 0 0 10 10 // viewport 13:51:00 INFO - PROCESS | 18420 | RENDERTRACE 16.6535 rect brown 0 0 10 10 // page 13:51:00 INFO - PROCESS | 18420 | RENDERTRACE 16.6754 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:51:00 INFO - PROCESS | 18420 | Checkerboarded for 1 frames (33.2362 ms), 100 peak, 2 severity. 13:51:00 INFO - PROCESS | 18420 | 13:51:00 INFO - PROCESS | 18420 | (process:18476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:51:11 INFO - PROCESS | 18420 | RSS: Main: 150482944 13:51:11 INFO - PROCESS | 18420 | 13:52:00 INFO - PROCESS | 18420 | 1453067520771 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] 13:54:09 INFO - PROCESS | 18420 | Cycle 1(1): loaded http://localhost:38113/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38113/tests/dromaeo/cssquery-ext.html) 13:54:10 INFO - PROCESS | 18420 | RSS: Main: 155664384 13:54:10 INFO - PROCESS | 18420 | 13:57:12 INFO - PROCESS | 18420 | Cycle 1(1): loaded http://localhost:38113/tests/dromaeo/cssquery-ext.html (next: http://localhost:38113/tests/dromaeo/cssquery-jquery.html) 13:57:13 INFO - PROCESS | 18420 | RSS: Main: 152682496 13:57:13 INFO - PROCESS | 18420 | 14:00:14 INFO - PROCESS | 18420 | Cycle 1(1): loaded http://localhost:38113/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38113/tests/dromaeo/cssquery-mootools.html) 14:00:15 INFO - PROCESS | 18420 | RSS: Main: 151683072 14:00:15 INFO - PROCESS | 18420 | 14:03:17 INFO - PROCESS | 18420 | Cycle 1(1): loaded http://localhost:38113/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38113/tests/dromaeo/cssquery-prototype.html) 14:03:17 INFO - PROCESS | 18420 | RSS: Main: 150466560 14:03:17 INFO - PROCESS | 18420 | 14:06:19 INFO - PROCESS | 18420 | Cycle 1(1): loaded http://localhost:38113/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38113/tests/dromaeo/cssquery-yui.html) 14:06:20 INFO - PROCESS | 18420 | RSS: Main: 150171648 14:06:20 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | Cycle 1(1): loaded http://localhost:38113/tests/dromaeo/cssquery-yui.html (next: http://localhost:38113/tests/dromaeo/cssquery-dojo.html) 14:09:23 INFO - PROCESS | 18420 | RSS: Main: 153104384 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | __start_tp_report 14:09:23 INFO - PROCESS | 18420 | _x_x_mozilla_page_load 14:09:23 INFO - PROCESS | 18420 | _x_x_mozilla_page_load_details 14:09:23 INFO - PROCESS | 18420 | |i|pagename|runs| 14:09:23 INFO - PROCESS | 18420 | |0;dojo.html;3239.6436391996886;3256.4301247281733;3286.852091655875;3304.8843290484824;3309.205790610254;5315.601329900263;5360.08878490656;5437.3475182978045;5444.156155795858;5453.045716999524;5371.865703357418;5375.946240537593;5446.101393270105;5485.369182544008;5537.916931246034;4920.114379411704;4967.205247160455;5074.467180946003;5076.873078173038;5081.263216833557;318.43227900059566;5014.924776128361;5016.899662006757;5096.413912400084;5125.3080834087295;4869.780859861315;4934.037862616791;4947.455779864212;5001.849944501652;5039.647224694273;4916.262560615901;4950.975245123787;4954.306397104372;4972.825951091694;4973.303737476756;4751.477337492873;4858.878528036792;4861.222204447272;4861.683990540603;4934.629902757308;5148.124818780816;5208.713520756357;5261.921071183897;5264.657797243167;5273.630845840793;5704.743286552115;5798.82603521895;5801.361850196475;5811.15738217956;5815.389384114649;5785.074388097884;5826.980278451254;5848.736806843703;5856.092305692625;5882.264716910387;5440.238366628675;5480.561555075625;5483.7806487740845;5490.6980116094;5537.003339398907;5975.790847320323;5984.790532331347;6011.158437818709;6018.909716354258;6036.396360363929;5695.145728140812;5712.314522257356;5772.249607551075;5787.710614469344;5795.1886735857015;5889.764409423661;5890.293164820163;5899.557533184942;5902.940970590239;5912.940870591239;5797.072468405035;5844.766209351578;5847.970760146172;5851.795187168429;5853.268341457318;5749.8275051748515;5806;5825.155352473952;5842.036064049469;5880;4500.932486012713;4501.504834468205;4509.616682581952;4511.571400716926;4541.591256786839;4003.079291762911;4014.979925100414;4018.618231268025;4049.7570145791346;4071.1043570414463;5427.43011983744;5510.035743744908;5516.586256030814;5550.944490555124;5614.045612245928;5872.148538461899;5918.822435326947;5927.792527261525;5935.821925342247;5943.108533719977;5397.35231772182;5527.834164975057;5530.917036244459;5532.004239236895;5551.555875529948;4942.975285123552;4978.77595508203;5027.120253955543;5027.2207807789855;5066.620003499752;6098.481088057165;6101.994596312771;6117.979653188387;6128.754849806047;6135.361474963699;5914.615549989237;5918.615290006136;5927.40725927421;5949.196858424058;5950.31571369298;5970.731317090655;6076.574639775174;6089.117078023751;6100.30868792748;6103.206583144163;5743.798967036134;5780.161876527964;5821.592488525932;5837.562182836219;5862.94137058624;5842.5325973921135;5874.647521148574;5878.706064696663;5895.056790913605;5901.380355062656;5686.232358631697;5692;5757.827265182052;5777.971110144423;5791.82624521265;5742.913856292075;5752.568557358131;5763.538916886555;5784.566157538117;5784.913226301524;5605.523530499953;5647.378788333198;5649.943500564942;5665.461781130786;5682.829515114553;5686.374498805046;5735.36910939788;5759.71201439918;5769.394213607511;5796.971015145066;5633.802816901389;5718.942810571841;5727;5727.570432217683;5746.310442746897 14:09:23 INFO - PROCESS | 18420 | |1;ext.html;508.69478313012223;531.4579129288126;540.8755986123192;549.6015388843086;557.3980101490391;35124.29751404974;35258.823705881434;35570.64429355706;35629.28741425173;35633;38423.42364864522;39136.21727565447;39155.41266880999;39211.21577568447;39213;8446.662133514652;8635.43869648474;8638.568071596426;8663.306935445149;8673.783155421133;8335.54154521501;8470.110638382974;8478.915210847905;8697.52163631;8709.21617054465;8637.39538232324;8723.476591404504;8741.562921853914;8744.562771861414;8750.6937257196;8581;8682.218600325969;8704.738857834212;8729.825403491895;8730;8594.785130371729;8725.214730674206;8726.69456569017;8732.69435569752;8737.082606326308;39023.219535609416;39040.414393784115;39229.80385098056;39409.80295098535;39446.40830387546;3271.2966712157;3309.619393769699;3400.4559270516597;3435.6736110069755;3553.378158822196;28632.570511442344;29438.411231775244;30009.399812003856;30206.244843879078;30949.690503094906;3491.8428670709877;3570.357335679577;3827.5789663137034;3883.359245724452;4013.635363976262;268167;268547;269899;271560;272463;49798.75100624546;51041.74479127581;55519.722401387735;55575.72212138913;55722.04972825931;61331.08003379953;61551.38448615546;62053;62054;62059;14197.574072777834;14216.431342746175;14374.496892608708;14396.784048239284;14478.85521144796;10429.165666746641;10468.424236667057;10515.94742026285;10531.262811603114;10539.525721342558;18170.45488635343;18200.1809918554;18328.725069123975;18367.08164591792;19115.61768764617;7294.562326260441;7427.145878224073;7465.104187497535;7512.812179695442;7581.848363032819;911.794846159622;981.5582987655583;1017.8574999499928;1072.399456304472;1137.419915842926;25134.497310053695;25468;25496.49007019849;25552.23343299704;25638;1055.4300677633992;1056.99471502642;1059.332620449112;1068.9854609999727;1135.9318440893574;13310.201387916755;13352.732945341038;13488.190708557519;13499.460021599223;13602.38789254466;324202;326799;329981;330915;333004;49584;49938.750306248236;49948.50051499438;50235.24647130296;50375;1346.6229455752405;1365.781474964001;1375.113052081402;1379.3861731529373;1383.8062671226037;25042.499150017262;25584.744152558982;25879.61180582255;25910.222693319232;26099.869500652374;40482.595174047885;40923.590764091976;40983.385249220686;41179;41512.58487415208;303626;308974;309389;309562;309982;30769.846150769103;31913.521297181025;32005;32245.35509289848;32281.67718322787;37071.258574827814;37714.245715086094;37904;38082.428763568016;38203;33590.16024599405;33734.03120581411;34258.48612270768;34745.30509389849;34953.300933981685;33879.49180762241;34168.14579635529;34786.65213347935;34802.651973479944;35020.29959400747;33986.15034624154;34483.82758086194;34785.1303717399;35184.47223291704;35542.93371198765;26385.340366490993;27669.723302766713;29365.26586835346;29437.411251774418;29702.40595188041;24024.27927162188;24287.878560607085;24453;24865;24966.62550061714 14:09:23 INFO - PROCESS | 18420 | |2;jquery.html;360.6267513123917;360.68980676618105;361.7756990665787;366.4942379516268;367.42131143449075;15656.530304090882;16159.676806463864;16792.160391980415;17044.40344587938;17644.059153493137;10818.972197641211;11092.389918554476;16245.350185992545;16255.51233462998;16261.837381626181;4715.457722361929;5004.84985450437;5006.4492905780335;5020.447750747433;5033.219850923095;4306.440162778835;4944.4313903900975;5059.11465493539;5067.0879241736475;5077.314562534066;4972.080165169437;5021.347224860781;5031.069252188338;5111.872203194931;5301.098813201765;5235.214717792323;5251.264822924793;5251.501107394792;5278.788848446076;5282.31329927109;5310.548603368718;5329;5329.333833270841;5330.893382132374;5334.119870221448;17904.55238619032;19418.70871936922;19977.400677979684;20127.597448050958;20160.19359225629;2028.300236418448;2042.5710600773855;2042.7548694156797;2083.9895800521053;2205.878676672782;8542.10307917672;9616.374935629161;12584.74830503394;12612.621621351374;12968.092233543655;1684.8820582559226;1808.7558179645844;1810.556413678644;1837.0722784993493;1854.6105317883125;55022;55817.72091139559;55884.44115558833;58118;58661.41338586559;9349.719508414759;9615.086566776145;9619.326647134634;9783.559739811582;9844.114029737359;12796.744065118646;12820.166689165175;12847;12925.935370323275;12947.158434701903;7038.472114591426;7048.682809273492;7116.0749102617365;7140.964295178491;7249.855002900018;6784.118064651662;6843.281455447106;6855.828604284933;6878.931210687829;6912.343327383891;3855;4131.421600975866;4175.123224122968;4202.705810593229;4228.873133805991;1762.4888782253258;1812.818718128203;1835.431016384925;1867.0571361462646;1876.6152938647544;891.8216356728681;899.8155378147464;941.4210260689764;954.8185844689625;963.9710808675751;14103.506377276746;15085.24573771307;15218.391264349302;15777.842221577866;16545;838.5010918503481;881.9029906710257;943.9244860411151;948.2650945517141;958.4105774948496;6401.64790936503;8824;8944.552772361356;9079.773005674911;9223.354365194373;560259;571691;581693;587322.0142388599;601956;42992.78503607524;48950;62630.37369626336;65626.34373656298;71835.99999999895;1131.3494740524231;1143.5654451308449;1149.1783374886995;1149.68383694483;1156.4564654612486;13940.860591394361;14079.627817822366;14094.647633809236;14217;14354.138751674933;30341.393172136875;30915.69084309128;31379.215519612193;31877.362452750353;32023.519647204845;42841;42969;43937.12125757531;44000.89997750082;44351.11297774091;7043.612601306977;7097.467689923174;7143.249958754256;7358.1538123116525;7477.626118694152;9720;10396.948015259875;10521.526531305957;10736.51685674131;10802.621908233488;8097.611204694512;8676.132386761274;9305.534723263674;9367.156955874005;9635.277354198322;9373.906260937303;9713.611455541983;9919.65281215154;9924.553395097382;10427.791444171226;9466.100720431548;9797.31418800677;9840.11438970496;9897.66381538483;10490.00344967227;6944.791656250321;7010.158780946319;7025.68384422692;7228.674709638184;7240.203577606564;8811.162939520735;9008.504532250789;9531.904680953101;9642.276829237695;9744.12302892743 14:09:23 INFO - PROCESS | 18420 | |3;mootools.html;1462.0423622527246;1470.6985068061044;1602.575317540851;1737.2008875917077;1741.6255505066415;7523.473356865022;7565.205653406389;7664.501807382516;7764.0683118025845;7775.727849525268;7763.495372800764;7803.687852485908;7851.214878512146;7876.2517560831775;7887.566183859885;2352.247280870118;2377.453185767266;2382.404398900275;2384.7138343398815;2386.7971222446113;2352.094443639203;2372.086746602562;2386.773256540626;2387.164492427654;2389.0682633772753;2293.71328583927;2320.9767902321014;2324;2324.5118525109665;2374.192774456684;2343.8359314847967;2360.5986982213067;2362.244081893786;2363.361892289081;2364.0661938534354;2277.3737222263844;2284.23478134825;2308.1575225042907;2309.457277539777;2319.976800231993;7444.627768611602;7478;7505.474616776828;7540.886886696704;7545.811354716121;4753.904921901577;4852.975735121302;4874.366332376804;4897.804087836482;4919.926201106986;3177.094528059492;3240.659730728287;3340.1816554944194;3352.765306428551;3367.4612062070196;1065.2010991756183;1072.426251955208;1877.098992483602;1880.4452686457528;1900.7624046994126;10479.528421221063;10504.474776261233;10597.73505662357;10599.417032063311;10623.52194151265;4354.281543545279;4361.223038634757;4404.933925991048;4430.645548356124;4455.754933478625;8672.826543469095;8674.392792504465;8675.349348798865;8711.0417854036;8711.91288087111;4834.395700537433;4847.563719265283;4853.684510506806;4909.631777616693;4925.950740492621;4472.396226509444;4518.683692141519;4537.4328208973875;4552.704074235164;4553.635709143261;3444.0873168610337;3469.687728104432;3488.4069708149677;3508.2281897982402;3517.191046059421;1066.1364294921138;1068.6687126990657;1069.6897899609025;1079.827227643589;1081.4808891732014;952.8951815300311;1003.3428104591504;1104.3815463340554;1147.4778975566264;1283.2172374851334;7068.823279417953;7070.151581810215;7172.390346820579;7175.533590316717;7184.928150718531;627.1439485102893;634.6953462338012;637.6811594202899;637.7767781276516;696.7178292791427;5542.861428464321;5564.19319198722;5692.37383887772;5709.286339207599;5818.5636077294375;8882;9179.403338782959;9208.953955230181;9233.169014788702;9289.721308360626;8985.146411090936;9037.954810226038;9065.32010099232;9124.908750912538;9215.078492150866;7163.820904477326;7236.312550307817;7236.457265705093;7252.746153884589;7303.379212766974;6901.827454313481;6963.7214511421;6995.615241161581;7041.753538626328;7070.434365250665;8026.8795968061695;8132.2680958714;8172.468789528662;8256.463329883538;8287.917120828955;8364.414490985817;8389.454685445426;8395.370347223861;8402.579871006303;8608.698695545625;6746.123004009447;6848.589084654936;6886.414654754402;6887.276835932155;6889.035535025201;7470.103587569526;7582.772516824504;7623.809404764704;7637.732679356196;7655;7156.105486814148;7241.239669834592;7251.057362542836;7358.337749602561;7413.592252426169;6384.265809431975;6839.726410943506;6909.516333856783;6953.4089602384365;6988.6505674715045;6696.531242813151;6724.596524208563;6731.663416829237;6732.831679208059;6774.525783195326;6071.423214794588;6201.937980620136;6229.221347331583;6261.4364707174755;6516.674166291761;6293.748250069946;6316.7157477914525;6351.047342898602;6351.618902865843;6360.045993101072 14:09:23 INFO - PROCESS | 18420 | |4;prototype.html;346.3298517368891;348.69837590484224;351.428927992013;352.1618547856104;354.00701033600745;6218.502519798417;6247.15663385444;6292.276388215357;6292.937070629298;6372.394622510866;6180.4746596539235;6201.782937597185;6243.188385509878;6249.812505624827;6272.341404152556;4809.7835597398025;4810.35060266863;4811.687240329385;4814.085323788469;4833.081714474256;4819.6867203631655;4825.083234185494;4826.565609095181;4828.0585285869265;4835.564799168074;4697.506761790014;4775;4781.8087276508895;4788.401449818773;4793.760311984404;4764.309175169616;4764.35681183041;4770.475247722782;4777.06847164803;4780.067886762083;4101.876943691694;4151.211269858717;4152.418661387408;4154.086101057763;4157.521884983235;5953.791617293374;5967.4629283364275;5983.072623743326;5994.340622531518;5998.970005149947;5393.2719082923695;5549.19536667181;5549.445055494459;5559.249501317311;5564.749586268627;6576.86846263072;6656.70044847983;6663.333666633346;6666.799996000128;6678.966605166943;4596.54034596541;4599.770011499445;4603.700759450625;4608.377868987677;4611.815527378934;6744.055832183498;6842.863142737117;6913.170419549636;6918.896216556705;6921.411680007205;4631.722096674143;4634.397528321297;4638.512956139624;4644.140833945731;4645.977884865324;4694.342792009122;4703.858884233478;4705.294205869079;4706.905861882811;4708.599769019672;5474.507294343528;5477.20580515823;5477.45225477457;5479.479449452296;5481.780728770885;6451;6634.734610615521;6666.666666666647;6672.099266599044;6684.930411134293;1633.2078941713496;1646.8929519581188;1678.2699525706357;1678.924448399825;1683.1836559268745;1079.3955384984433;1104.364990130678;1118.9104871610252;1124.2748427264369;1128.1257025805066;6220.875582488325;6263.091851681481;6264.123022776724;6268.028455589391;6289.40250676185;6686.431653309523;6712.160979877515;6750.1562304711915;6759.831004224835;6763.188417389944;6114.327423983358;6191.133241346215;6221.253449585988;6228.439440450381;6234;3665.157013886821;3679.2273622539565;3688.1517251032415;3692.2246328270826;3700.777953322809;6998.195207551095;7054.6472676365975;7093.787186384417;7108.928910710827;7111;6779.457643388517;6914.343137401939;6932.826679333057;6935.757248496379;6946.305369463114;7048.92951070493;7079.398251148607;7087.716491340392;7087.7519286825745;7103.964480177669;6781.898271525833;6786.185657721105;6787.117674702257;6787.626680532618;6799;6524.923387640986;6625.933740662532;6636.867262654623;6684.732610695518;6708.060871477899;6984.40632546219;7044.506884518035;7072.222055573986;7083.893741593777;7109.21798602143;4642.721436713808;4644.117617652635;4647.721136731671;4650.558196971282;4656.2084445645;6742.6628668567355;6769.695363708744;6784.507408370151;6789.2871248518195;6951.513394062569;6671.666416679243;6688.063671085954;6717.361850624183;6728;6742.42689371409;6644.202695676357;6663.967085101817;6677.599344039373;6692.196936367667;6710.060591517094;6458;6494.935050649622;6552.901706474311;6556;6559.967200163968;6709.530332876652;6713.328667133248;6735.4611631070375;6737.59574425536;6764.594124352555;6567.770128045496;6573.80278591643;6576.441002514648;6595.934040659724;6595.934040659724 14:09:23 INFO - PROCESS | 18420 | |5;yui.html;773.2538100732793;840.701550949413;847.5973912391614;849.4478588917203;876.6843936182977;14412;14721.631959201026;14722.558323250292;14723.411063557473;14759.18824464654;13574.389152488136;13575.049746517747;13600.795988060187;13642.863571364283;13668;769.9615019249057;774.2528460036064;777.6461709922;778.7391223939987;786.4769927997875;787.9921200788004;792.754246183682;795.9044914610255;795.9243871832167;798.884161796542;808.5835794565803;811.1928631012152;813.4387272781762;813.7884150120982;813.8168911994813;798.8282519258387;809.8866158737811;810.5744484145812;811.0551207842856;814.7515007922581;599.0804115682406;599.1462166412845;600.2347007565389;603.0411645483701;607.9756809727605;13841;13964.371603277878;13970.580882573538;13995.230262335568;13999;12600.936995314965;12692.11155219135;12776.552820651326;12919.418626161845;12930;10646.946765266202;10654;10662.413567253798;10749.570017199303;10950.39772812495;3608.873689420884;3636.3636363636256;3665.376885929372;3765.4540091686554;3773.2264885698364;48367;48672.75663621659;48868.266975995386;49022.754886225695;49033;9358.906410935939;9712.174465170398;9862.556184971694;9917.404955702681;9921.057499537532;17432.21555030027;17443.82556174422;17463.039532825816;17463.21415536304;17501.124943753017;7532.8493430132185;7620.5808680522;7703.268189521987;7740.458167928191;7994.6002699864775;4284.227250314982;4293.184294983943;4343.087951530151;4355.73865568067;4394.143142087326;3100.1784527100335;3113.875444982221;3135.5766971459016;3135.639401468815;3140.9685903140676;528.3501293409129;536.3965538768884;542.4656713137556;546.9097598896137;549.2338188227401;544.7494152689807;625.8060001399581;642.1651852591613;642.4250295985067;649.3344322069822;8557;8617.82764344722;8644.610992505352;8743.93891726966;8897.555122243992;518.9837481384847;585.7042193692158;636.1920361141417;683.3235097253782;690.5890994858051;3841.5390153181797;3895.4351619015083;3977.4829272195007;4273.252180868336;4552.271636538138;55008.449915500336;55256.72371638116;55290.44709552934;55488.44511554913;57263.71368143133;45922.77038614786;46055;46652.5334746655;46849.5315046852;47104.5289547107;44498;46218.30672539915;46513;46711;46814.06371872543;8434.367422443218;8605.96728392597;8809.955950220208;8834.779130521789;8936.151065648754;33228.33543329168;34017.65982340145;34692.653073468944;34977.47533787046;35262.11844703903;43735;43882.780586096866;43911.56088439203;43977.56022439735;44055.33916991184;10979.39613321243;11201.327920324806;11232.887671123512;11249;11325.093992480746;12129.332886691316;12273.754524909273;12327.876721232673;12386.132970691964;12432.75134497323;11362.091032717528;11376.829347559958;11388.715282118013;11706.297622142698;11830.58592949277;11526.596569120376;11583.942080289544;11689.941550292535;12021.254914826137;12131.939340303243;10531.21015923824;10558.524866381185;10604.681859544226;10645.361278323326;10663.573457061631;9105.817883642158;9393.671221507215;9523.762060441763;9546.284028698014;9649.469279189712;9073.410228335137;9651;9651.565679544297;9874.21006319507;9928.255380846322 14:09:23 INFO - PROCESS | 18420 | __end_tp_report 14:09:23 INFO - PROCESS | 18420 | __start_cc_report 14:09:23 INFO - PROCESS | 18420 | _x_x_mozilla_cycle_collect,315 14:09:23 INFO - PROCESS | 18420 | __end_cc_report 14:09:23 INFO - PROCESS | 18420 | __startTimestamp1453068563478__endTimestamp 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | ------- Summary: start ------- 14:09:23 INFO - PROCESS | 18420 | Number of tests: 6 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | [#0] dojo.html Cycles:165 Average:5412.59 Median:5686.37 stddev:728.43 (12.8%) stddev-sans-first:710.44 14:09:23 INFO - PROCESS | 18420 | Values: 3239.6 3256.4 3286.9 3304.9 3309.2 5315.6 5360.1 5437.3 5444.2 5453.0 5371.9 5375.9 5446.1 5485.4 5537.9 4920.1 4967.2 5074.5 5076.9 5081.3 318.4 5014.9 5016.9 5096.4 5125.3 4869.8 4934.0 4947.5 5001.8 5039.6 4916.3 4951.0 4954.3 4972.8 4973.3 4751.5 4858.9 4861.2 4861.7 4934.6 5148.1 5208.7 5261.9 5264.7 5273.6 5704.7 5798.8 5801.4 5811.2 5815.4 5785.1 5827.0 5848.7 5856.1 5882.3 5440.2 5480.6 5483.8 5490.7 5537.0 5975.8 5984.8 6011.2 6018.9 6036.4 5695.1 5712.3 5772.2 5787.7 5795.2 5889.8 5890.3 5899.6 5902.9 5912.9 5797.1 5844.8 5848.0 5851.8 5853.3 5749.8 5806.0 5825.2 5842.0 5880.0 4500.9 4501.5 4509.6 4511.6 4541.6 4003.1 4015.0 4018.6 4049.8 4071.1 5427.4 5510.0 5516.6 5550.9 5614.0 5872.1 5918.8 5927.8 5935.8 5943.1 5397.4 5527.8 5530.9 5532.0 5551.6 4943.0 4978.8 5027.1 5027.2 5066.6 6098.5 6102.0 6118.0 6128.8 6135.4 5914.6 5918.6 5927.4 5949.2 5950.3 5970.7 6076.6 6089.1 6100.3 6103.2 5743.8 5780.2 5821.6 5837.6 5862.9 5842.5 5874.6 5878.7 5895.1 5901.4 5686.2 5692.0 5757.8 5778.0 5791.8 5742.9 5752.6 5763.5 5784.6 5784.9 5605.5 5647.4 5649.9 5665.5 5682.8 5686.4 5735.4 5759.7 5769.4 5797.0 5633.8 5718.9 5727.0 5727.6 5746.3 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | [#1] ext.html Cycles:180 Average:45926.14 Median:34785.89 stddev:79535.11 (228.6%) stddev-sans-first:79685.13 14:09:23 INFO - PROCESS | 18420 | Values: 508.7 531.5 540.9 549.6 557.4 35124.3 35258.8 35570.6 35629.3 35633.0 38423.4 39136.2 39155.4 39211.2 39213.0 8446.7 8635.4 8638.6 8663.3 8673.8 8335.5 8470.1 8478.9 8697.5 8709.2 8637.4 8723.5 8741.6 8744.6 8750.7 8581.0 8682.2 8704.7 8729.8 8730.0 8594.8 8725.2 8726.7 8732.7 8737.1 39023.2 39040.4 39229.8 39409.8 39446.4 3271.3 3309.6 3400.5 3435.7 3553.4 28632.6 29438.4 30009.4 30206.2 30949.7 3491.8 3570.4 3827.6 3883.4 4013.6 268167.0 268547.0 269899.0 271560.0 272463.0 49798.8 51041.7 55519.7 55575.7 55722.0 61331.1 61551.4 62053.0 62054.0 62059.0 14197.6 14216.4 14374.5 14396.8 14478.9 10429.2 10468.4 10515.9 10531.3 10539.5 18170.5 18200.2 18328.7 18367.1 19115.6 7294.6 7427.1 7465.1 7512.8 7581.8 911.8 981.6 1017.9 1072.4 1137.4 25134.5 25468.0 25496.5 25552.2 25638.0 1055.4 1057.0 1059.3 1069.0 1135.9 13310.2 13352.7 13488.2 13499.5 13602.4 324202.0 326799.0 329981.0 330915.0 333004.0 49584.0 49938.8 49948.5 50235.2 50375.0 1346.6 1365.8 1375.1 1379.4 1383.8 25042.5 25584.7 25879.6 25910.2 26099.9 40482.6 40923.6 40983.4 41179.0 41512.6 303626.0 308974.0 309389.0 309562.0 309982.0 30769.8 31913.5 32005.0 32245.4 32281.7 37071.3 37714.2 37904.0 38082.4 38203.0 33590.2 33734.0 34258.5 34745.3 34953.3 33879.5 34168.1 34786.7 34802.7 35020.3 33986.2 34483.8 34785.1 35184.5 35542.9 26385.3 27669.7 29365.3 29437.4 29702.4 24024.3 24287.9 24453.0 24865.0 24966.6 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | [#2] jquery.html Cycles:180 Average:28006.81 Median:5046.17 stddev:94730.83 (1877.3%) stddev-sans-first:94973.83 14:09:23 INFO - PROCESS | 18420 | Values: 360.6 360.7 361.8 366.5 367.4 15656.5 16159.7 16792.2 17044.4 17644.1 10819.0 11092.4 16245.4 16255.5 16261.8 4715.5 5004.8 5006.4 5020.4 5033.2 4306.4 4944.4 5059.1 5067.1 5077.3 4972.1 5021.3 5031.1 5111.9 5301.1 5235.2 5251.3 5251.5 5278.8 5282.3 5310.5 5329.0 5329.3 5330.9 5334.1 17904.6 19418.7 19977.4 20127.6 20160.2 2028.3 2042.6 2042.8 2084.0 2205.9 8542.1 9616.4 12584.7 12612.6 12968.1 1684.9 1808.8 1810.6 1837.1 1854.6 55022.0 55817.7 55884.4 58118.0 58661.4 9349.7 9615.1 9619.3 9783.6 9844.1 12796.7 12820.2 12847.0 12925.9 12947.2 7038.5 7048.7 7116.1 7141.0 7249.9 6784.1 6843.3 6855.8 6878.9 6912.3 3855.0 4131.4 4175.1 4202.7 4228.9 1762.5 1812.8 1835.4 1867.1 1876.6 891.8 899.8 941.4 954.8 964.0 14103.5 15085.2 15218.4 15777.8 16545.0 838.5 881.9 943.9 948.3 958.4 6401.6 8824.0 8944.6 9079.8 9223.4 560259.0 571691.0 581693.0 587322.0 601956.0 42992.8 48950.0 62630.4 65626.3 71836.0 1131.3 1143.6 1149.2 1149.7 1156.5 13940.9 14079.6 14094.6 14217.0 14354.1 30341.4 30915.7 31379.2 31877.4 32023.5 42841.0 42969.0 43937.1 44000.9 44351.1 7043.6 7097.5 7143.2 7358.2 7477.6 9720.0 10396.9 10521.5 10736.5 10802.6 8097.6 8676.1 9305.5 9367.2 9635.3 9373.9 9713.6 9919.7 9924.6 10427.8 9466.1 9797.3 9840.1 9897.7 10490.0 6944.8 7010.2 7025.7 7228.7 7240.2 8811.2 9008.5 9531.9 9642.3 9744.1 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | [#3] mootools.html Cycles:180 Average:5421.23 Median:3475.71 stddev:2739.72 (78.8%) stddev-sans-first:2731.24 14:09:23 INFO - PROCESS | 18420 | Values: 1462.0 1470.7 1602.6 1737.2 1741.6 7523.5 7565.2 7664.5 7764.1 7775.7 7763.5 7803.7 7851.2 7876.3 7887.6 2352.2 2377.5 2382.4 2384.7 2386.8 2352.1 2372.1 2386.8 2387.2 2389.1 2293.7 2321.0 2324.0 2324.5 2374.2 2343.8 2360.6 2362.2 2363.4 2364.1 2277.4 2284.2 2308.2 2309.5 2320.0 7444.6 7478.0 7505.5 7540.9 7545.8 4753.9 4853.0 4874.4 4897.8 4919.9 3177.1 3240.7 3340.2 3352.8 3367.5 1065.2 1072.4 1877.1 1880.4 1900.8 10479.5 10504.5 10597.7 10599.4 10623.5 4354.3 4361.2 4404.9 4430.6 4455.8 8672.8 8674.4 8675.3 8711.0 8711.9 4834.4 4847.6 4853.7 4909.6 4926.0 4472.4 4518.7 4537.4 4552.7 4553.6 3444.1 3469.7 3488.4 3508.2 3517.2 1066.1 1068.7 1069.7 1079.8 1081.5 952.9 1003.3 1104.4 1147.5 1283.2 7068.8 7070.2 7172.4 7175.5 7184.9 627.1 634.7 637.7 637.8 696.7 5542.9 5564.2 5692.4 5709.3 5818.6 8882.0 9179.4 9209.0 9233.2 9289.7 8985.1 9038.0 9065.3 9124.9 9215.1 7163.8 7236.3 7236.5 7252.7 7303.4 6901.8 6963.7 6995.6 7041.8 7070.4 8026.9 8132.3 8172.5 8256.5 8287.9 8364.4 8389.5 8395.4 8402.6 8608.7 6746.1 6848.6 6886.4 6887.3 6889.0 7470.1 7582.8 7623.8 7637.7 7655.0 7156.1 7241.2 7251.1 7358.3 7413.6 6384.3 6839.7 6909.5 6953.4 6988.7 6696.5 6724.6 6731.7 6732.8 6774.5 6071.4 6201.9 6229.2 6261.4 6516.7 6293.7 6316.7 6351.0 6351.6 6360.0 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | [#4] prototype.html Cycles:180 Average:5531.40 Median:6248.48 stddev:1667.74 (26.7%) stddev-sans-first:1626.37 14:09:23 INFO - PROCESS | 18420 | Values: 346.3 348.7 351.4 352.2 354.0 6218.5 6247.2 6292.3 6292.9 6372.4 6180.5 6201.8 6243.2 6249.8 6272.3 4809.8 4810.4 4811.7 4814.1 4833.1 4819.7 4825.1 4826.6 4828.1 4835.6 4697.5 4775.0 4781.8 4788.4 4793.8 4764.3 4764.4 4770.5 4777.1 4780.1 4101.9 4151.2 4152.4 4154.1 4157.5 5953.8 5967.5 5983.1 5994.3 5999.0 5393.3 5549.2 5549.4 5559.2 5564.7 6576.9 6656.7 6663.3 6666.8 6679.0 4596.5 4599.8 4603.7 4608.4 4611.8 6744.1 6842.9 6913.2 6918.9 6921.4 4631.7 4634.4 4638.5 4644.1 4646.0 4694.3 4703.9 4705.3 4706.9 4708.6 5474.5 5477.2 5477.5 5479.5 5481.8 6451.0 6634.7 6666.7 6672.1 6684.9 1633.2 1646.9 1678.3 1678.9 1683.2 1079.4 1104.4 1118.9 1124.3 1128.1 6220.9 6263.1 6264.1 6268.0 6289.4 6686.4 6712.2 6750.2 6759.8 6763.2 6114.3 6191.1 6221.3 6228.4 6234.0 3665.2 3679.2 3688.2 3692.2 3700.8 6998.2 7054.6 7093.8 7108.9 7111.0 6779.5 6914.3 6932.8 6935.8 6946.3 7048.9 7079.4 7087.7 7087.8 7104.0 6781.9 6786.2 6787.1 6787.6 6799.0 6524.9 6625.9 6636.9 6684.7 6708.1 6984.4 7044.5 7072.2 7083.9 7109.2 4642.7 4644.1 4647.7 4650.6 4656.2 6742.7 6769.7 6784.5 6789.3 6951.5 6671.7 6688.1 6717.4 6728.0 6742.4 6644.2 6664.0 6677.6 6692.2 6710.1 6458.0 6494.9 6552.9 6556.0 6560.0 6709.5 6713.3 6735.5 6737.6 6764.6 6567.8 6573.8 6576.4 6595.9 6595.9 14:09:23 INFO - PROCESS | 18420 | 14:09:23 INFO - PROCESS | 18420 | [#5] yui.html Cycles:180 Average:13659.89 Median:46681.77 stddev:15466.91 (33.1%) stddev-sans-first:15480.03 14:09:23 INFO - PROCESS | 18420 | Values: 773.3 840.7 847.6 849.4 876.7 14412.0 14721.6 14722.6 14723.4 14759.2 13574.4 13575.0 13600.8 13642.9 13668.0 770.0 774.3 777.6 778.7 786.5 788.0 792.8 795.9 795.9 798.9 808.6 811.2 813.4 813.8 813.8 798.8 809.9 810.6 811.1 814.8 599.1 599.1 600.2 603.0 608.0 13841.0 13964.4 13970.6 13995.2 13999.0 12600.9 12692.1 12776.6 12919.4 12930.0 10646.9 10654.0 10662.4 10749.6 10950.4 3608.9 3636.4 3665.4 3765.5 3773.2 48367.0 48672.8 48868.3 49022.8 49033.0 9358.9 9712.2 9862.6 9917.4 9921.1 17432.2 17443.8 17463.0 17463.2 17501.1 7532.8 7620.6 7703.3 7740.5 7994.6 4284.2 4293.2 4343.1 4355.7 4394.1 3100.2 3113.9 3135.6 3135.6 3141.0 528.4 536.4 542.5 546.9 549.2 544.7 625.8 642.2 642.4 649.3 8557.0 8617.8 8644.6 8743.9 8897.6 519.0 585.7 636.2 683.3 690.6 3841.5 3895.4 3977.5 4273.3 4552.3 55008.4 55256.7 55290.4 55488.4 57263.7 45922.8 46055.0 46652.5 46849.5 47104.5 44498.0 46218.3 46513.0 46711.0 46814.1 8434.4 8606.0 8810.0 8834.8 8936.2 33228.3 34017.7 34692.7 34977.5 35262.1 43735.0 43882.8 43911.6 43977.6 44055.3 10979.4 11201.3 11232.9 11249.0 11325.1 12129.3 12273.8 12327.9 12386.1 12432.8 11362.1 11376.8 11388.7 11706.3 11830.6 11526.6 11583.9 11689.9 12021.3 12131.9 10531.2 10558.5 10604.7 10645.4 10663.6 9105.8 9393.7 9523.8 9546.3 9649.5 9073.4 9651.0 9651.6 9874.2 9928.3 14:09:23 INFO - PROCESS | 18420 | -------- Summary: end -------- 14:09:23 INFO - PROCESS | 18420 | 14:09:24 INFO - TEST-INFO | 18420: exit 0 14:09:24 INFO - TEST-OK | dromaeo_css | took 1110800ms 14:09:24 INFO - TEST-START | kraken 14:09:24 INFO - operating with platform_type : linux_ 14:09:24 INFO - Initialising browser for kraken test... 14:09:24 INFO - TEST-INFO | started process 18656 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDW_jRw/profile http://localhost:38113/getInfo.html) 14:09:27 INFO - PROCESS | 18656 | 14:09:27 INFO - PROCESS | 18656 | (process:18728): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:09:28 INFO - PROCESS | 18656 | __metrics Screen width/height:1600/1200 14:09:28 INFO - PROCESS | 18656 | colorDepth:24 14:09:28 INFO - PROCESS | 18656 | Browser inner width/height: 1024/697 14:09:28 INFO - PROCESS | 18656 | __metrics 14:09:28 INFO - PROCESS | 18656 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:09:29 INFO - TEST-INFO | 18656: exit 0 14:09:29 INFO - Browser initialized. 14:09:29 INFO - Running cycle 1/1 for kraken test... 14:09:29 INFO - TEST-INFO | started process 18776 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDW_jRw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:30 INFO - PROCESS | 18776 | -- checkerboarding starts below -- 14:09:30 INFO - PROCESS | 18776 | RENDERTRACE 0.03664 rect red 0 0 10 10 // viewport 14:09:30 INFO - PROCESS | 18776 | RENDERTRACE 12.0431 rect brown 0 0 10 10 // page 14:09:30 INFO - PROCESS | 18776 | RENDERTRACE 12.0717 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 14:09:30 INFO - PROCESS | 18776 | Checkerboarded for 1 frames (12.1258 ms), 100 peak, 1 severity. 14:09:31 INFO - PROCESS | 18776 | 14:09:31 INFO - PROCESS | 18776 | (process:18838): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:09:41 INFO - PROCESS | 18776 | RSS: Main: 150589440 14:09:41 INFO - PROCESS | 18776 | 14:09:44 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38113/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:44 INFO - PROCESS | 18776 | RSS: Main: 151003136 14:09:44 INFO - PROCESS | 18776 | 14:09:47 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38113/tests/kraken/driver.html?testName=audio-dft) 14:09:47 INFO - PROCESS | 18776 | RSS: Main: 154644480 14:09:47 INFO - PROCESS | 18776 | 14:09:50 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38113/tests/kraken/driver.html?testName=audio-fft) 14:09:51 INFO - PROCESS | 18776 | RSS: Main: 147513344 14:09:51 INFO - PROCESS | 18776 | 14:09:53 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38113/tests/kraken/driver.html?testName=audio-oscillator) 14:09:53 INFO - PROCESS | 18776 | RSS: Main: 147111936 14:09:53 INFO - PROCESS | 18776 | 14:09:56 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38113/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:56 INFO - PROCESS | 18776 | RSS: Main: 148201472 14:09:56 INFO - PROCESS | 18776 | 14:09:59 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38113/tests/kraken/driver.html?testName=imaging-darkroom) 14:10:00 INFO - PROCESS | 18776 | RSS: Main: 148131840 14:10:00 INFO - PROCESS | 18776 | 14:10:03 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38113/tests/kraken/driver.html?testName=imaging-desaturate) 14:10:04 INFO - PROCESS | 18776 | RSS: Main: 150282240 14:10:04 INFO - PROCESS | 18776 | 14:10:07 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38113/tests/kraken/driver.html?testName=json-parse-financial) 14:10:07 INFO - PROCESS | 18776 | RSS: Main: 151007232 14:10:07 INFO - PROCESS | 18776 | 14:10:09 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38113/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:10:09 INFO - PROCESS | 18776 | RSS: Main: 151179264 14:10:09 INFO - PROCESS | 18776 | 14:10:11 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:10:12 INFO - PROCESS | 18776 | RSS: Main: 150585344 14:10:12 INFO - PROCESS | 18776 | 14:10:14 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:10:15 INFO - PROCESS | 18776 | RSS: Main: 150962176 14:10:15 INFO - PROCESS | 18776 | 14:10:17 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:10:18 INFO - PROCESS | 18776 | RSS: Main: 151384064 14:10:18 INFO - PROCESS | 18776 | 14:10:20 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:10:21 INFO - PROCESS | 18776 | RSS: Main: 151478272 14:10:21 INFO - PROCESS | 18776 | 14:10:22 INFO - PROCESS | 18776 | Cycle 1(1): loaded http://localhost:38113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38113/tests/kraken/driver.html?testName=ai-astar) 14:10:23 INFO - PROCESS | 18776 | RSS: Main: 150224896 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | __start_tp_report 14:10:23 INFO - PROCESS | 18776 | _x_x_mozilla_page_load 14:10:23 INFO - PROCESS | 18776 | _x_x_mozilla_page_load_details 14:10:23 INFO - PROCESS | 18776 | |i|pagename|runs| 14:10:23 INFO - PROCESS | 18776 | |0;ai-astar;111;105;110;111;111;122;111;113;110;111 14:10:23 INFO - PROCESS | 18776 | |1;audio-beat-detection;151;127;155;158;130;154;161;127;158;128 14:10:23 INFO - PROCESS | 18776 | |2;audio-dft;166;163;161;162;161;161;162;167;166;162 14:10:23 INFO - PROCESS | 18776 | |3;audio-fft;74;70;72;75;74;137;71;74;71;73 14:10:23 INFO - PROCESS | 18776 | |4;audio-oscillator;97;95;139;95;96;96;138;96;96;133 14:10:23 INFO - PROCESS | 18776 | |5;imaging-gaussian-blur;110;111;110;111;111;110;111;110;110;110 14:10:23 INFO - PROCESS | 18776 | |6;imaging-darkroom;148;148;147;146;148;148;147;147;147;150 14:10:23 INFO - PROCESS | 18776 | |7;imaging-desaturate;96;96;96;96;96;96;97;99;100;96 14:10:23 INFO - PROCESS | 18776 | |8;json-parse-financial;61;60;59;60;60;62;59;62;67;57 14:10:23 INFO - PROCESS | 18776 | |9;json-stringify-tinderbox;67;68;67;68;67;67;68;68;68;68 14:10:23 INFO - PROCESS | 18776 | |10;stanford-crypto-aes;83;80;83;82;83;83;83;92;83;83 14:10:23 INFO - PROCESS | 18776 | |11;stanford-crypto-ccm;128;116;124;112;116;130;132;121;123;126 14:10:23 INFO - PROCESS | 18776 | |12;stanford-crypto-pbkdf2;133;145;131;143;146;141;142;154;140;130 14:10:23 INFO - PROCESS | 18776 | |13;stanford-crypto-sha256-iterative;67;68;71;66;67;66;66;66;80;67 14:10:23 INFO - PROCESS | 18776 | __end_tp_report 14:10:23 INFO - PROCESS | 18776 | __start_cc_report 14:10:23 INFO - PROCESS | 18776 | _x_x_mozilla_cycle_collect,744 14:10:23 INFO - PROCESS | 18776 | __end_cc_report 14:10:23 INFO - PROCESS | 18776 | __startTimestamp1453068623098__endTimestamp 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | ------- Summary: start ------- 14:10:23 INFO - PROCESS | 18776 | Number of tests: 14 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.22 (3.8%) stddev-sans-first:4.48 14:10:23 INFO - PROCESS | 18776 | Values: 111.0 105.0 110.0 111.0 111.0 122.0 111.0 113.0 110.0 111.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:154.50 stddev:14.81 (9.6%) stddev-sans-first:15.54 14:10:23 INFO - PROCESS | 18776 | Values: 151.0 127.0 155.0 158.0 130.0 154.0 161.0 127.0 158.0 128.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:2.33 (1.4%) stddev-sans-first:2.22 14:10:23 INFO - PROCESS | 18776 | Values: 166.0 163.0 161.0 162.0 161.0 161.0 162.0 167.0 166.0 162.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#3] audio-fft Cycles:10 Average:79.10 Median:73.50 stddev:20.41 (27.8%) stddev-sans-first:21.56 14:10:23 INFO - PROCESS | 18776 | Values: 74.0 70.0 72.0 75.0 74.0 137.0 71.0 74.0 71.0 73.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:96.00 stddev:19.78 (20.6%) stddev-sans-first:20.57 14:10:23 INFO - PROCESS | 18776 | Values: 97.0 95.0 139.0 95.0 96.0 96.0 138.0 96.0 96.0 133.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:10:23 INFO - PROCESS | 18776 | Values: 110.0 111.0 110.0 111.0 111.0 110.0 111.0 110.0 110.0 110.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 14:10:23 INFO - PROCESS | 18776 | Values: 148.0 148.0 147.0 146.0 148.0 148.0 147.0 147.0 147.0 150.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.48 (1.5%) stddev-sans-first:1.54 14:10:23 INFO - PROCESS | 18776 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 99.0 100.0 96.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.50 stddev:2.67 (4.4%) stddev-sans-first:2.83 14:10:23 INFO - PROCESS | 18776 | Values: 61.0 60.0 59.0 60.0 60.0 62.0 59.0 62.0 67.0 57.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 14:10:23 INFO - PROCESS | 18776 | Values: 67.0 68.0 67.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:3.14 (3.8%) stddev-sans-first:3.32 14:10:23 INFO - PROCESS | 18776 | Values: 83.0 80.0 83.0 82.0 83.0 83.0 83.0 92.0 83.0 83.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:125.00 stddev:6.56 (5.3%) stddev-sans-first:6.69 14:10:23 INFO - PROCESS | 18776 | Values: 128.0 116.0 124.0 112.0 116.0 130.0 132.0 121.0 123.0 126.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:142.50 stddev:7.44 (5.2%) stddev-sans-first:7.38 14:10:23 INFO - PROCESS | 18776 | Values: 133.0 145.0 131.0 143.0 146.0 141.0 142.0 154.0 140.0 130.0 14:10:23 INFO - PROCESS | 18776 | 14:10:23 INFO - PROCESS | 18776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.00 stddev:4.35 (6.5%) stddev-sans-first:4.59 14:10:23 INFO - PROCESS | 18776 | Values: 67.0 68.0 71.0 66.0 67.0 66.0 66.0 66.0 80.0 67.0 14:10:23 INFO - PROCESS | 18776 | -------- Summary: end -------- 14:10:23 INFO - PROCESS | 18776 | 14:10:24 INFO - TEST-INFO | 18776: exit 0 14:10:24 INFO - TEST-OK | kraken | took 59931ms 14:10:24 INFO - TEST-START | v8_7 14:10:24 INFO - operating with platform_type : linux_ 14:10:24 INFO - Initialising browser for v8_7 test... 14:10:24 INFO - TEST-INFO | started process 19065 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiVv2FN/profile http://localhost:38113/getInfo.html) 14:10:27 INFO - PROCESS | 19065 | 14:10:27 INFO - PROCESS | 19065 | (process:19136): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:10:28 INFO - PROCESS | 19065 | __metrics Screen width/height:1600/1200 14:10:28 INFO - PROCESS | 19065 | colorDepth:24 14:10:28 INFO - PROCESS | 19065 | Browser inner width/height: 1024/697 14:10:28 INFO - PROCESS | 19065 | __metrics 14:10:28 INFO - PROCESS | 19065 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:10:29 INFO - TEST-INFO | 19065: exit 0 14:10:29 INFO - Browser initialized. 14:10:29 INFO - Running cycle 1/1 for v8_7 test... 14:10:29 INFO - TEST-INFO | started process 19184 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiVv2FN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:30 INFO - PROCESS | 19184 | -- checkerboarding starts below -- 14:10:30 INFO - PROCESS | 19184 | RENDERTRACE 0.035734 rect red 0 0 10 10 // viewport 14:10:30 INFO - PROCESS | 19184 | RENDERTRACE 6.92095 rect red 0 0 10 10 // viewport 14:10:30 INFO - PROCESS | 19184 | RENDERTRACE 24.8923 rect brown 0 0 10 10 // page 14:10:30 INFO - PROCESS | 19184 | RENDERTRACE 24.9113 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 14:10:30 INFO - PROCESS | 19184 | Checkerboarded for 2 frames (24.9424 ms), 100 peak, 691 severity. 14:10:31 INFO - PROCESS | 19184 | 14:10:31 INFO - PROCESS | 19184 | (process:19243): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:10:41 INFO - PROCESS | 19184 | RSS: Main: 150544384 14:10:41 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | Cycle 1(1): loaded http://localhost:38113/tests/v8_7/run.html (next: http://localhost:38113/tests/v8_7/run.html) 14:11:04 INFO - PROCESS | 19184 | RSS: Main: 146345984 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | __start_tp_report 14:11:04 INFO - PROCESS | 19184 | _x_x_mozilla_page_load 14:11:04 INFO - PROCESS | 19184 | _x_x_mozilla_page_load_details 14:11:04 INFO - PROCESS | 19184 | |i|pagename|runs| 14:11:04 INFO - PROCESS | 19184 | |0;Richards;167.33601070950468 14:11:04 INFO - PROCESS | 19184 | |1;DeltaBlue;187.72292096865027 14:11:04 INFO - PROCESS | 19184 | |2;Encrypt;278.8622420524261 14:11:04 INFO - PROCESS | 19184 | |3;Decrypt;5263.1578947368425 14:11:04 INFO - PROCESS | 19184 | |4;RayTrace;1072.961373390558 14:11:04 INFO - PROCESS | 19184 | |5;Earley;697.8367062107467 14:11:04 INFO - PROCESS | 19184 | |6;Boyer;12120.481927710844 14:11:04 INFO - PROCESS | 19184 | |7;RegExp;41918.36734693877 14:11:04 INFO - PROCESS | 19184 | |8;Splay;572.4098454493417 14:11:04 INFO - PROCESS | 19184 | |9;NavierStokes;4830.917874396136 14:11:04 INFO - PROCESS | 19184 | __end_tp_report 14:11:04 INFO - PROCESS | 19184 | __startTimestamp1453068664260__endTimestamp 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | ------- Summary: start ------- 14:11:04 INFO - PROCESS | 19184 | Number of tests: 10 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 167.3 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 187.7 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 278.9 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 5263.2 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 1073.0 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#5] Earley Cycles:1 Average:697.84 Median:697.84 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 697.8 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 12120.5 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#7] RegExp Cycles:1 Average:41918.37 Median:41918.37 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 41918.4 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#8] Splay Cycles:1 Average:572.41 Median:572.41 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 572.4 14:11:04 INFO - PROCESS | 19184 | 14:11:04 INFO - PROCESS | 19184 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 14:11:04 INFO - PROCESS | 19184 | Values: 4830.9 14:11:04 INFO - PROCESS | 19184 | -------- Summary: end -------- 14:11:04 INFO - PROCESS | 19184 | 14:11:05 INFO - TEST-INFO | 19184: exit 0 14:11:05 INFO - TEST-OK | v8_7 | took 41087ms 14:11:05 INFO - SUITE-END | took 1211s 14:11:05 INFO - Completed test suite (00:20:11) 14:11:05 INFO - Working with test: dromaeo_css 14:11:05 INFO - Generating results file: dromaeo_css 14:11:05 INFO - Working with test: kraken 14:11:05 INFO - Generating results file: kraken 14:11:05 INFO - javascript benchmark 14:11:05 INFO - Working with test: v8_7 14:11:05 INFO - Generating results file: v8_7 14:11:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:11:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 14:11:05 INFO - process_Request line: dromaeo_css 6876.20 graph.html#tests=[[72,63,43]] 14:11:05 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:11:05 INFO - process_Request line: kraken 1505.00 graph.html#tests=[[232,63,43]] 14:11:05 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:11:05 INFO - process_Request line: v8_7 20490.68 graph.html#tests=[[230,63,43]] 14:11:05 INFO - RETURN: dromaeo_css: 6876.20 14:11:05 INFO - RETURN: kraken: 1505.00 14:11:05 INFO - RETURN: v8_7: 20490.68 14:11:05 INFO - javascript benchmark 14:11:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3239.6436391996886, 3256.4301247281733, 3286.852091655875, 3304.8843290484824, 3309.205790610254, 5315.601329900263, 5360.08878490656, 5437.3475182978045, 5444.156155795858, 5453.045716999524, 5371.865703357418, 5375.946240537593, 5446.101393270105, 5485.369182544008, 5537.916931246034, 4920.114379411704, 4967.205247160455, 5074.467180946003, 5076.873078173038, 5081.263216833557, 318.43227900059566, 5014.924776128361, 5016.899662006757, 5096.413912400084, 5125.3080834087295, 4869.780859861315, 4934.037862616791, 4947.455779864212, 5001.849944501652, 5039.647224694273, 4916.262560615901, 4950.975245123787, 4954.306397104372, 4972.825951091694, 4973.303737476756, 4751.477337492873, 4858.878528036792, 4861.222204447272, 4861.683990540603, 4934.629902757308, 5148.124818780816, 5208.713520756357, 5261.921071183897, 5264.657797243167, 5273.630845840793, 5704.743286552115, 5798.82603521895, 5801.361850196475, 5811.15738217956, 5815.389384114649, 5785.074388097884, 5826.980278451254, 5848.736806843703, 5856.092305692625, 5882.264716910387, 5440.238366628675, 5480.561555075625, 5483.7806487740845, 5490.6980116094, 5537.003339398907, 5975.790847320323, 5984.790532331347, 6011.158437818709, 6018.909716354258, 6036.396360363929, 5695.145728140812, 5712.314522257356, 5772.249607551075, 5787.710614469344, 5795.1886735857015, 5889.764409423661, 5890.293164820163, 5899.557533184942, 5902.940970590239, 5912.940870591239, 5797.072468405035, 5844.766209351578, 5847.970760146172, 5851.795187168429, 5853.268341457318, 5749.8275051748515, 5806.0, 5825.155352473952, 5842.036064049469, 5880.0, 4500.932486012713, 4501.504834468205, 4509.616682581952, 4511.571400716926, 4541.591256786839, 4003.079291762911, 4014.979925100414, 4018.618231268025, 4049.7570145791346, 4071.1043570414463, 5427.43011983744, 5510.035743744908, 5516.586256030814, 5550.944490555124, 5614.045612245928, 5872.148538461899, 5918.822435326947, 5927.792527261525, 5935.821925342247, 5943.108533719977, 5397.35231772182, 5527.834164975057, 5530.917036244459, 5532.004239236895, 5551.555875529948, 4942.975285123552, 4978.77595508203, 5027.120253955543, 5027.2207807789855, 5066.620003499752, 6098.481088057165, 6101.994596312771, 6117.979653188387, 6128.754849806047, 6135.361474963699, 5914.615549989237, 5918.615290006136, 5927.40725927421, 5949.196858424058, 5950.31571369298, 5970.731317090655, 6076.574639775174, 6089.117078023751, 6100.30868792748, 6103.206583144163, 5743.798967036134, 5780.161876527964, 5821.592488525932, 5837.562182836219, 5862.94137058624, 5842.5325973921135, 5874.647521148574, 5878.706064696663, 5895.056790913605, 5901.380355062656, 5686.232358631697, 5692.0, 5757.827265182052, 5777.971110144423, 5791.82624521265, 5742.913856292075, 5752.568557358131, 5763.538916886555, 5784.566157538117, 5784.913226301524, 5605.523530499953, 5647.378788333198, 5649.943500564942, 5665.461781130786, 5682.829515114553, 5686.374498805046, 5735.36910939788, 5759.71201439918, 5769.394213607511, 5796.971015145066, 5633.802816901389, 5718.942810571841, 5727.0, 5727.570432217683, 5746.310442746897], "unit": "score", "name": "dojo.html", "value": 5367.577240251298}, {"lowerIsBetter": false, "replicates": [508.69478313012223, 531.4579129288126, 540.8755986123192, 549.6015388843086, 557.3980101490391, 35124.29751404974, 35258.823705881434, 35570.64429355706, 35629.28741425173, 35633.0, 38423.42364864522, 39136.21727565447, 39155.41266880999, 39211.21577568447, 39213.0, 8446.662133514652, 8635.43869648474, 8638.568071596426, 8663.306935445149, 8673.783155421133, 8335.54154521501, 8470.110638382974, 8478.915210847905, 8697.52163631, 8709.21617054465, 8637.39538232324, 8723.476591404504, 8741.562921853914, 8744.562771861414, 8750.6937257196, 8581.0, 8682.218600325969, 8704.738857834212, 8729.825403491895, 8730.0, 8594.785130371729, 8725.214730674206, 8726.69456569017, 8732.69435569752, 8737.082606326308, 39023.219535609416, 39040.414393784115, 39229.80385098056, 39409.80295098535, 39446.40830387546, 3271.2966712157, 3309.619393769699, 3400.4559270516597, 3435.6736110069755, 3553.378158822196, 28632.570511442344, 29438.411231775244, 30009.399812003856, 30206.244843879078, 30949.690503094906, 3491.8428670709877, 3570.357335679577, 3827.5789663137034, 3883.359245724452, 4013.635363976262, 268167.0, 268547.0, 269899.0, 271560.0, 272463.0, 49798.75100624546, 51041.74479127581, 55519.722401387735, 55575.72212138913, 55722.04972825931, 61331.08003379953, 61551.38448615546, 62053.0, 62054.0, 62059.0, 14197.574072777834, 14216.431342746175, 14374.496892608708, 14396.784048239284, 14478.85521144796, 10429.165666746641, 10468.424236667057, 10515.94742026285, 10531.262811603114, 10539.525721342558, 18170.45488635343, 18200.1809918554, 18328.725069123975, 18367.08164591792, 19115.61768764617, 7294.562326260441, 7427.145878224073, 7465.104187497535, 7512.812179695442, 7581.848363032819, 911.794846159622, 981.5582987655583, 1017.8574999499928, 1072.399456304472, 1137.419915842926, 25134.497310053695, 25468.0, 25496.49007019849, 25552.23343299704, 25638.0, 1055.4300677633992, 1056.99471502642, 1059.332620449112, 1068.9854609999727, 1135.9318440893574, 13310.201387916755, 13352.732945341038, 13488.190708557519, 13499.460021599223, 13602.38789254466, 324202.0, 326799.0, 329981.0, 330915.0, 333004.0, 49584.0, 49938.750306248236, 49948.50051499438, 50235.24647130296, 50375.0, 1346.6229455752405, 1365.781474964001, 1375.113052081402, 1379.3861731529373, 1383.8062671226037, 25042.499150017262, 25584.744152558982, 25879.61180582255, 25910.222693319232, 26099.869500652374, 40482.595174047885, 40923.590764091976, 40983.385249220686, 41179.0, 41512.58487415208, 303626.0, 308974.0, 309389.0, 309562.0, 309982.0, 30769.846150769103, 31913.521297181025, 32005.0, 32245.35509289848, 32281.67718322787, 37071.258574827814, 37714.245715086094, 37904.0, 38082.428763568016, 38203.0, 33590.16024599405, 33734.03120581411, 34258.48612270768, 34745.30509389849, 34953.300933981685, 33879.49180762241, 34168.14579635529, 34786.65213347935, 34802.651973479944, 35020.29959400747, 33986.15034624154, 34483.82758086194, 34785.1303717399, 35184.47223291704, 35542.93371198765, 26385.340366490993, 27669.723302766713, 29365.26586835346, 29437.411251774418, 29702.40595188041, 24024.27927162188, 24287.878560607085, 24453.0, 24865.0, 24966.62550061714], "unit": "score", "name": "ext.html", "value": 17760.817102775105}, {"lowerIsBetter": false, "replicates": [360.6267513123917, 360.68980676618105, 361.7756990665787, 366.4942379516268, 367.42131143449075, 15656.530304090882, 16159.676806463864, 16792.160391980415, 17044.40344587938, 17644.059153493137, 10818.972197641211, 11092.389918554476, 16245.350185992545, 16255.51233462998, 16261.837381626181, 4715.457722361929, 5004.84985450437, 5006.4492905780335, 5020.447750747433, 5033.219850923095, 4306.440162778835, 4944.4313903900975, 5059.11465493539, 5067.0879241736475, 5077.314562534066, 4972.080165169437, 5021.347224860781, 5031.069252188338, 5111.872203194931, 5301.098813201765, 5235.214717792323, 5251.264822924793, 5251.501107394792, 5278.788848446076, 5282.31329927109, 5310.548603368718, 5329.0, 5329.333833270841, 5330.893382132374, 5334.119870221448, 17904.55238619032, 19418.70871936922, 19977.400677979684, 20127.597448050958, 20160.19359225629, 2028.300236418448, 2042.5710600773855, 2042.7548694156797, 2083.9895800521053, 2205.878676672782, 8542.10307917672, 9616.374935629161, 12584.74830503394, 12612.621621351374, 12968.092233543655, 1684.8820582559226, 1808.7558179645844, 1810.556413678644, 1837.0722784993493, 1854.6105317883125, 55022.0, 55817.72091139559, 55884.44115558833, 58118.0, 58661.41338586559, 9349.719508414759, 9615.086566776145, 9619.326647134634, 9783.559739811582, 9844.114029737359, 12796.744065118646, 12820.166689165175, 12847.0, 12925.935370323275, 12947.158434701903, 7038.472114591426, 7048.682809273492, 7116.0749102617365, 7140.964295178491, 7249.855002900018, 6784.118064651662, 6843.281455447106, 6855.828604284933, 6878.931210687829, 6912.343327383891, 3855.0, 4131.421600975866, 4175.123224122968, 4202.705810593229, 4228.873133805991, 1762.4888782253258, 1812.818718128203, 1835.431016384925, 1867.0571361462646, 1876.6152938647544, 891.8216356728681, 899.8155378147464, 941.4210260689764, 954.8185844689625, 963.9710808675751, 14103.506377276746, 15085.24573771307, 15218.391264349302, 15777.842221577866, 16545.0, 838.5010918503481, 881.9029906710257, 943.9244860411151, 948.2650945517141, 958.4105774948496, 6401.64790936503, 8824.0, 8944.552772361356, 9079.773005674911, 9223.354365194373, 560259.0, 571691.0, 581693.0, 587322.0142388599, 601956.0, 42992.78503607524, 48950.0, 62630.37369626336, 65626.34373656298, 71835.99999999895, 1131.3494740524231, 1143.5654451308449, 1149.1783374886995, 1149.68383694483, 1156.4564654612486, 13940.860591394361, 14079.627817822366, 14094.647633809236, 14217.0, 14354.138751674933, 30341.393172136875, 30915.69084309128, 31379.215519612193, 31877.362452750353, 32023.519647204845, 42841.0, 42969.0, 43937.12125757531, 44000.89997750082, 44351.11297774091, 7043.612601306977, 7097.467689923174, 7143.249958754256, 7358.1538123116525, 7477.626118694152, 9720.0, 10396.948015259875, 10521.526531305957, 10736.51685674131, 10802.621908233488, 8097.611204694512, 8676.132386761274, 9305.534723263674, 9367.156955874005, 9635.277354198322, 9373.906260937303, 9713.611455541983, 9919.65281215154, 9924.553395097382, 10427.791444171226, 9466.100720431548, 9797.31418800677, 9840.11438970496, 9897.66381538483, 10490.00344967227, 6944.791656250321, 7010.158780946319, 7025.68384422692, 7228.674709638184, 7240.203577606564, 8811.162939520735, 9008.504532250789, 9531.904680953101, 9642.276829237695, 9744.12302892743], "unit": "score", "name": "jquery.html", "value": 7925.816519460838}, {"lowerIsBetter": false, "replicates": [1462.0423622527246, 1470.6985068061044, 1602.575317540851, 1737.2008875917077, 1741.6255505066415, 7523.473356865022, 7565.205653406389, 7664.501807382516, 7764.0683118025845, 7775.727849525268, 7763.495372800764, 7803.687852485908, 7851.214878512146, 7876.2517560831775, 7887.566183859885, 2352.247280870118, 2377.453185767266, 2382.404398900275, 2384.7138343398815, 2386.7971222446113, 2352.094443639203, 2372.086746602562, 2386.773256540626, 2387.164492427654, 2389.0682633772753, 2293.71328583927, 2320.9767902321014, 2324.0, 2324.5118525109665, 2374.192774456684, 2343.8359314847967, 2360.5986982213067, 2362.244081893786, 2363.361892289081, 2364.0661938534354, 2277.3737222263844, 2284.23478134825, 2308.1575225042907, 2309.457277539777, 2319.976800231993, 7444.627768611602, 7478.0, 7505.474616776828, 7540.886886696704, 7545.811354716121, 4753.904921901577, 4852.975735121302, 4874.366332376804, 4897.804087836482, 4919.926201106986, 3177.094528059492, 3240.659730728287, 3340.1816554944194, 3352.765306428551, 3367.4612062070196, 1065.2010991756183, 1072.426251955208, 1877.098992483602, 1880.4452686457528, 1900.7624046994126, 10479.528421221063, 10504.474776261233, 10597.73505662357, 10599.417032063311, 10623.52194151265, 4354.281543545279, 4361.223038634757, 4404.933925991048, 4430.645548356124, 4455.754933478625, 8672.826543469095, 8674.392792504465, 8675.349348798865, 8711.0417854036, 8711.91288087111, 4834.395700537433, 4847.563719265283, 4853.684510506806, 4909.631777616693, 4925.950740492621, 4472.396226509444, 4518.683692141519, 4537.4328208973875, 4552.704074235164, 4553.635709143261, 3444.0873168610337, 3469.687728104432, 3488.4069708149677, 3508.2281897982402, 3517.191046059421, 1066.1364294921138, 1068.6687126990657, 1069.6897899609025, 1079.827227643589, 1081.4808891732014, 952.8951815300311, 1003.3428104591504, 1104.3815463340554, 1147.4778975566264, 1283.2172374851334, 7068.823279417953, 7070.151581810215, 7172.390346820579, 7175.533590316717, 7184.928150718531, 627.1439485102893, 634.6953462338012, 637.6811594202899, 637.7767781276516, 696.7178292791427, 5542.861428464321, 5564.19319198722, 5692.37383887772, 5709.286339207599, 5818.5636077294375, 8882.0, 9179.403338782959, 9208.953955230181, 9233.169014788702, 9289.721308360626, 8985.146411090936, 9037.954810226038, 9065.32010099232, 9124.908750912538, 9215.078492150866, 7163.820904477326, 7236.312550307817, 7236.457265705093, 7252.746153884589, 7303.379212766974, 6901.827454313481, 6963.7214511421, 6995.615241161581, 7041.753538626328, 7070.434365250665, 8026.8795968061695, 8132.2680958714, 8172.468789528662, 8256.463329883538, 8287.917120828955, 8364.414490985817, 8389.454685445426, 8395.370347223861, 8402.579871006303, 8608.698695545625, 6746.123004009447, 6848.589084654936, 6886.414654754402, 6887.276835932155, 6889.035535025201, 7470.103587569526, 7582.772516824504, 7623.809404764704, 7637.732679356196, 7655.0, 7156.105486814148, 7241.239669834592, 7251.057362542836, 7358.337749602561, 7413.592252426169, 6384.265809431975, 6839.726410943506, 6909.516333856783, 6953.4089602384365, 6988.6505674715045, 6696.531242813151, 6724.596524208563, 6731.663416829237, 6732.831679208059, 6774.525783195326, 6071.423214794588, 6201.937980620136, 6229.221347331583, 6261.4364707174755, 6516.674166291761, 6293.748250069946, 6316.7157477914525, 6351.047342898602, 6351.618902865843, 6360.045993101072], "unit": "score", "name": "mootools.html", "value": 4464.762506148549}, {"lowerIsBetter": false, "replicates": [346.3298517368891, 348.69837590484224, 351.428927992013, 352.1618547856104, 354.00701033600745, 6218.502519798417, 6247.15663385444, 6292.276388215357, 6292.937070629298, 6372.394622510866, 6180.4746596539235, 6201.782937597185, 6243.188385509878, 6249.812505624827, 6272.341404152556, 4809.7835597398025, 4810.35060266863, 4811.687240329385, 4814.085323788469, 4833.081714474256, 4819.6867203631655, 4825.083234185494, 4826.565609095181, 4828.0585285869265, 4835.564799168074, 4697.506761790014, 4775.0, 4781.8087276508895, 4788.401449818773, 4793.760311984404, 4764.309175169616, 4764.35681183041, 4770.475247722782, 4777.06847164803, 4780.067886762083, 4101.876943691694, 4151.211269858717, 4152.418661387408, 4154.086101057763, 4157.521884983235, 5953.791617293374, 5967.4629283364275, 5983.072623743326, 5994.340622531518, 5998.970005149947, 5393.2719082923695, 5549.19536667181, 5549.445055494459, 5559.249501317311, 5564.749586268627, 6576.86846263072, 6656.70044847983, 6663.333666633346, 6666.799996000128, 6678.966605166943, 4596.54034596541, 4599.770011499445, 4603.700759450625, 4608.377868987677, 4611.815527378934, 6744.055832183498, 6842.863142737117, 6913.170419549636, 6918.896216556705, 6921.411680007205, 4631.722096674143, 4634.397528321297, 4638.512956139624, 4644.140833945731, 4645.977884865324, 4694.342792009122, 4703.858884233478, 4705.294205869079, 4706.905861882811, 4708.599769019672, 5474.507294343528, 5477.20580515823, 5477.45225477457, 5479.479449452296, 5481.780728770885, 6451.0, 6634.734610615521, 6666.666666666647, 6672.099266599044, 6684.930411134293, 1633.2078941713496, 1646.8929519581188, 1678.2699525706357, 1678.924448399825, 1683.1836559268745, 1079.3955384984433, 1104.364990130678, 1118.9104871610252, 1124.2748427264369, 1128.1257025805066, 6220.875582488325, 6263.091851681481, 6264.123022776724, 6268.028455589391, 6289.40250676185, 6686.431653309523, 6712.160979877515, 6750.1562304711915, 6759.831004224835, 6763.188417389944, 6114.327423983358, 6191.133241346215, 6221.253449585988, 6228.439440450381, 6234.0, 3665.157013886821, 3679.2273622539565, 3688.1517251032415, 3692.2246328270826, 3700.777953322809, 6998.195207551095, 7054.6472676365975, 7093.787186384417, 7108.928910710827, 7111.0, 6779.457643388517, 6914.343137401939, 6932.826679333057, 6935.757248496379, 6946.305369463114, 7048.92951070493, 7079.398251148607, 7087.716491340392, 7087.7519286825745, 7103.964480177669, 6781.898271525833, 6786.185657721105, 6787.117674702257, 6787.626680532618, 6799.0, 6524.923387640986, 6625.933740662532, 6636.867262654623, 6684.732610695518, 6708.060871477899, 6984.40632546219, 7044.506884518035, 7072.222055573986, 7083.893741593777, 7109.21798602143, 4642.721436713808, 4644.117617652635, 4647.721136731671, 4650.558196971282, 4656.2084445645, 6742.6628668567355, 6769.695363708744, 6784.507408370151, 6789.2871248518195, 6951.513394062569, 6671.666416679243, 6688.063671085954, 6717.361850624183, 6728.0, 6742.42689371409, 6644.202695676357, 6663.967085101817, 6677.599344039373, 6692.196936367667, 6710.060591517094, 6458.0, 6494.935050649622, 6552.901706474311, 6556.0, 6559.967200163968, 6709.530332876652, 6713.328667133248, 6735.4611631070375, 6737.59574425536, 6764.594124352555, 6567.770128045496, 6573.80278591643, 6576.441002514648, 6595.934040659724, 6595.934040659724], "unit": "score", "name": "prototype.html", "value": 4987.454049852004}, {"lowerIsBetter": false, "replicates": [773.2538100732793, 840.701550949413, 847.5973912391614, 849.4478588917203, 876.6843936182977, 14412.0, 14721.631959201026, 14722.558323250292, 14723.411063557473, 14759.18824464654, 13574.389152488136, 13575.049746517747, 13600.795988060187, 13642.863571364283, 13668.0, 769.9615019249057, 774.2528460036064, 777.6461709922, 778.7391223939987, 786.4769927997875, 787.9921200788004, 792.754246183682, 795.9044914610255, 795.9243871832167, 798.884161796542, 808.5835794565803, 811.1928631012152, 813.4387272781762, 813.7884150120982, 813.8168911994813, 798.8282519258387, 809.8866158737811, 810.5744484145812, 811.0551207842856, 814.7515007922581, 599.0804115682406, 599.1462166412845, 600.2347007565389, 603.0411645483701, 607.9756809727605, 13841.0, 13964.371603277878, 13970.580882573538, 13995.230262335568, 13999.0, 12600.936995314965, 12692.11155219135, 12776.552820651326, 12919.418626161845, 12930.0, 10646.946765266202, 10654.0, 10662.413567253798, 10749.570017199303, 10950.39772812495, 3608.873689420884, 3636.3636363636256, 3665.376885929372, 3765.4540091686554, 3773.2264885698364, 48367.0, 48672.75663621659, 48868.266975995386, 49022.754886225695, 49033.0, 9358.906410935939, 9712.174465170398, 9862.556184971694, 9917.404955702681, 9921.057499537532, 17432.21555030027, 17443.82556174422, 17463.039532825816, 17463.21415536304, 17501.124943753017, 7532.8493430132185, 7620.5808680522, 7703.268189521987, 7740.458167928191, 7994.6002699864775, 4284.227250314982, 4293.184294983943, 4343.087951530151, 4355.73865568067, 4394.143142087326, 3100.1784527100335, 3113.875444982221, 3135.5766971459016, 3135.639401468815, 3140.9685903140676, 528.3501293409129, 536.3965538768884, 542.4656713137556, 546.9097598896137, 549.2338188227401, 544.7494152689807, 625.8060001399581, 642.1651852591613, 642.4250295985067, 649.3344322069822, 8557.0, 8617.82764344722, 8644.610992505352, 8743.93891726966, 8897.555122243992, 518.9837481384847, 585.7042193692158, 636.1920361141417, 683.3235097253782, 690.5890994858051, 3841.5390153181797, 3895.4351619015083, 3977.4829272195007, 4273.252180868336, 4552.271636538138, 55008.449915500336, 55256.72371638116, 55290.44709552934, 55488.44511554913, 57263.71368143133, 45922.77038614786, 46055.0, 46652.5334746655, 46849.5315046852, 47104.5289547107, 44498.0, 46218.30672539915, 46513.0, 46711.0, 46814.06371872543, 8434.367422443218, 8605.96728392597, 8809.955950220208, 8834.779130521789, 8936.151065648754, 33228.33543329168, 34017.65982340145, 34692.653073468944, 34977.47533787046, 35262.11844703903, 43735.0, 43882.780586096866, 43911.56088439203, 43977.56022439735, 44055.33916991184, 10979.39613321243, 11201.327920324806, 11232.887671123512, 11249.0, 11325.093992480746, 12129.332886691316, 12273.754524909273, 12327.876721232673, 12386.132970691964, 12432.75134497323, 11362.091032717528, 11376.829347559958, 11388.715282118013, 11706.297622142698, 11830.58592949277, 11526.596569120376, 11583.942080289544, 11689.941550292535, 12021.254914826137, 12131.939340303243, 10531.21015923824, 10558.524866381185, 10604.681859544226, 10645.361278323326, 10663.573457061631, 9105.817883642158, 9393.671221507215, 9523.762060441763, 9546.284028698014, 9649.469279189712, 9073.410228335137, 9651.0, 9651.565679544297, 9874.21006319507, 9928.255380846322], "unit": "score", "name": "yui.html", "value": 6281.963287098416}], "name": "dromaeo_css", "value": 6876.204221889373}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 111.0, 111.0, 122.0, 111.0, 113.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 155.0, 158.0, 130.0, 154.0, 161.0, 127.0, 158.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [166.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0, 167.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 72.0, 75.0, 74.0, 137.0, 71.0, 74.0, 71.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 139.0, 95.0, 96.0, 96.0, 138.0, 96.0, 96.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 99.0, 100.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 59.0, 60.0, 60.0, 62.0, 59.0, 62.0, 67.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 83.0, 82.0, 83.0, 83.0, 83.0, 92.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [128.0, 116.0, 124.0, 112.0, 116.0, 130.0, 132.0, 121.0, 123.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [133.0, 145.0, 131.0, 143.0, 146.0, 141.0, 142.0, 154.0, 140.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 71.0, 66.0, 67.0, 66.0, 66.0, 66.0, 80.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1505.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [697.8367062107467], "unit": "score", "name": "Earley", "value": 955.041479}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [41918.36734693877], "unit": "score", "name": "RegExp", "value": 21.732358812074008}, {"lowerIsBetter": false, "replicates": [572.4098454493417], "unit": "score", "name": "Splay", "value": 142.36477700000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20490.679549328157}]} 14:11:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20490.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1505.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6876.20"}}} 14:11:05 INFO - Return code: 0 14:11:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:11:05 INFO - # TBPL SUCCESS # 14:11:05 INFO - Running post-action listener: _resource_record_post_action 14:11:05 INFO - Running post-run listener: _resource_record_post_run 14:11:06 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 24576; Write bytes: 558411776; Read time: 204; Write time: 388396 14:11:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 243679232; Read time: 12; Write time: 207460 14:11:06 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 314732544; Read time: 192; Write time: 180936 14:11:06 INFO - Running post-run listener: _upload_blobber_files 14:11:06 INFO - Blob upload gear active. 14:11:06 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:11:06 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 14:11:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:11:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:11:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:07 INFO - (blobuploader) - INFO - Done attempting. 14:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:08 INFO - (blobuploader) - INFO - Done attempting. 14:11:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:08 INFO - Return code: 0 14:11:08 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:11:08 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7b70885d5ac9beefbf02d94c5afbaecfe06b551c3efbb8624daa3edb0e4a4e76905ea10f02324986ea93c240f02b6f3fdb19cdaa4d24268ce764d17b5d153ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/111e21f4a64706be89d1fd07c0390f9704086173fa4658f9cfe123db0db8cbb5b0d047ef66c036f9d92589ba6c511c14d352d117c95e75beaa28a4c511829491"} 14:11:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:11:08 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:11:08 INFO - Contents: 14:11:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e7b70885d5ac9beefbf02d94c5afbaecfe06b551c3efbb8624daa3edb0e4a4e76905ea10f02324986ea93c240f02b6f3fdb19cdaa4d24268ce764d17b5d153ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/111e21f4a64706be89d1fd07c0390f9704086173fa4658f9cfe123db0db8cbb5b0d047ef66c036f9d92589ba6c511c14d352d117c95e75beaa28a4c511829491"} 14:11:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:08 INFO - Copying logs to upload dir... 14:11:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:11:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.093774 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-17 14:11:08.403763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 14:11:08.407142) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 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/Mozilla-Inbound/sha512/e7b70885d5ac9beefbf02d94c5afbaecfe06b551c3efbb8624daa3edb0e4a4e76905ea10f02324986ea93c240f02b6f3fdb19cdaa4d24268ce764d17b5d153ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/111e21f4a64706be89d1fd07c0390f9704086173fa4658f9cfe123db0db8cbb5b0d047ef66c036f9d92589ba6c511c14d352d117c95e75beaa28a4c511829491"} build_url:https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/bO00V-oDQsSYofx9y6g8Lw/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/Mozilla-Inbound/sha512/e7b70885d5ac9beefbf02d94c5afbaecfe06b551c3efbb8624daa3edb0e4a4e76905ea10f02324986ea93c240f02b6f3fdb19cdaa4d24268ce764d17b5d153ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/111e21f4a64706be89d1fd07c0390f9704086173fa4658f9cfe123db0db8cbb5b0d047ef66c036f9d92589ba6c511c14d352d117c95e75beaa28a4c511829491"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 14:11:08.432034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 14:11:08.432375) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453067391.400135-1047700538 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-17 14:11:08.517540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 14:11:08.517856) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 14:11:08.518129) ========= ========= Total master_lag: 0.50 =========