builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1450925188.26 results: success (0) buildid: 20151223163032 builduid: af5b01cf535e4b57977bd64ca8811669 revision: 64671f01cb7bcd1c7113b464933f8f0d78b0a758 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.263861) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.265178) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.265728) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006335 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.298428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.298792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.313242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.313548) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004353 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.403573) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.404242) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.405051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.405507) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 18:46:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-12-23 18:46:28 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.597611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.597973) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015130 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.647961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:28.648378) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 64671f01cb7bcd1c7113b464933f8f0d78b0a758 --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 64671f01cb7bcd1c7113b464933f8f0d78b0a758 --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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 18:46:28,819 truncating revision to first 12 chars 2015-12-23 18:46:28,819 Setting DEBUG logging. 2015-12-23 18:46:28,819 attempt 1/10 2015-12-23 18:46:28,819 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/64671f01cb7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 18:46:29,152 unpacking tar archive at: mozilla-inbound-64671f01cb7b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:29.287520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:29.287934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:29.297236) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:29.297659) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 18:46:29.298166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-23 18:46:29.298502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --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', '--system-bits', '64', '--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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:46:29 INFO - MultiFileLogger online at 20151223 18:46:29 in /builds/slave/test-pgo 18:46:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:46:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:46:29 INFO - {'append_to_log': False, 18:46:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:46:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:46:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:46:29 INFO - 'branch': 'Mozilla-Inbound', 18:46:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:46:29 INFO - 'config_files': ('talos/linux_config.py',), 18:46:29 INFO - 'default_actions': ('clobber', 18:46:29 INFO - 'read-buildbot-config', 18:46:29 INFO - 'download-and-extract', 18:46:29 INFO - 'populate-webroot', 18:46:29 INFO - 'create-virtualenv', 18:46:29 INFO - 'install', 18:46:29 INFO - 'run-tests'), 18:46:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:46:29 INFO - 'download_minidump_stackwalk': True, 18:46:29 INFO - 'download_symbols': 'ondemand', 18:46:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:46:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:46:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:46:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:46:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:46:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:46:29 INFO - 'installer_path': 'installer.exe', 18:46:29 INFO - 'log_level': 'info', 18:46:29 INFO - 'log_name': 'talos', 18:46:29 INFO - 'log_to_console': True, 18:46:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:46:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:46:29 INFO - 'opt_config_files': (), 18:46:29 INFO - 'pip_index': False, 18:46:29 INFO - 'sps_profile': False, 18:46:29 INFO - 'sps_profile_interval': 0, 18:46:29 INFO - 'suite': 'dromaeojs-e10s', 18:46:29 INFO - 'system_bits': '64', 18:46:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:46:29 INFO - 'title': 'talos-linux64-ix-062', 18:46:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:46:29 INFO - 'use_talos_json': True, 18:46:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:46:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:46:29 INFO - 'work_dir': 'build'} 18:46:29 INFO - ##### 18:46:29 INFO - ##### Running clobber step. 18:46:29 INFO - ##### 18:46:29 INFO - Running pre-action listener: _resource_record_pre_action 18:46:29 INFO - Running main action method: clobber 18:46:29 INFO - rmtree: /builds/slave/test-pgo/build 18:46:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:46:29 INFO - Running post-action listener: _resource_record_post_action 18:46:29 INFO - ##### 18:46:29 INFO - ##### Running read-buildbot-config step. 18:46:29 INFO - ##### 18:46:29 INFO - Running pre-action listener: _resource_record_pre_action 18:46:29 INFO - Running main action method: read_buildbot_config 18:46:29 INFO - Using buildbot properties: 18:46:29 INFO - { 18:46:29 INFO - "project": "", 18:46:29 INFO - "product": "firefox", 18:46:29 INFO - "script_repo_revision": "production", 18:46:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:46:29 INFO - "repository": "", 18:46:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:46:29 INFO - "buildid": "20151223163032", 18:46:29 INFO - "pgo_build": "True", 18:46:29 INFO - "basedir": "/builds/slave/test-pgo", 18:46:29 INFO - "buildnumber": 543, 18:46:29 INFO - "slavename": "talos-linux64-ix-062", 18:46:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:46:29 INFO - "platform": "ubuntu64_hw", 18:46:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:46:29 INFO - "branch": "mozilla-inbound", 18:46:29 INFO - "repo_path": "integration/mozilla-inbound", 18:46:29 INFO - "revision": "64671f01cb7bcd1c7113b464933f8f0d78b0a758", 18:46:29 INFO - "stage_platform": "linux64-pgo", 18:46:29 INFO - "builduid": "af5b01cf535e4b57977bd64ca8811669", 18:46:29 INFO - "slavebuilddir": "test" 18:46:29 INFO - } 18:46:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:46:29 INFO - Running post-action listener: _resource_record_post_action 18:46:29 INFO - ##### 18:46:29 INFO - ##### Running download-and-extract step. 18:46:29 INFO - ##### 18:46:29 INFO - Running pre-action listener: _resource_record_pre_action 18:46:29 INFO - Running main action method: download_and_extract 18:46:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:29 INFO - https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/test_packages.json 18:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/test_packages.json 18:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:46:30 INFO - Downloaded 1302 bytes. 18:46:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:46:30 INFO - Using the following test package requirements: 18:46:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:46:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:30 INFO - u'jsshell-linux-x86_64.zip'], 18:46:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:46:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:46:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:46:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:46:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:46:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:30 INFO - https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:32 INFO - Downloaded 23189811 bytes. 18:46:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:33 INFO - Return code: 0 18:46:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:33 INFO - https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:42 INFO - Downloaded 23189811 bytes. 18:46:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:44 INFO - Return code: 0 18:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:44 INFO - https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:46:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:44 INFO - Downloaded 11132277 bytes. 18:46:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:46:45 INFO - Return code: 0 18:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:45 INFO - https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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 18:46:47 INFO - Downloaded 54879736 bytes. 18:46:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:47 INFO - mkdir: /builds/slave/test-pgo/properties 18:46:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:46:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:46:47 INFO - Contents: 18:46:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:47 INFO - Running post-action listener: _resource_record_post_action 18:46:47 INFO - Running post-action listener: set_extra_try_arguments 18:46:47 INFO - ##### 18:46:47 INFO - ##### Running populate-webroot step. 18:46:47 INFO - ##### 18:46:47 INFO - Running pre-action listener: _resource_record_pre_action 18:46:47 INFO - Running main action method: populate_webroot 18:46:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:47 INFO - '--tppagecycles', 18:46:47 INFO - '7'], 18:46:47 INFO - 'tests': ['tsvgm']}}, 18:46:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:46:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'tests': ['damp', 'tps']}, 18:46:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['damp', 'tps']}, 18:46:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:46:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:47 INFO - 'other': {'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore']}, 18:46:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore']}, 18:46:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore']}, 18:46:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore']}, 18:46:47 INFO - 'other_l64': {'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore']}, 18:46:47 INFO - 'other_nol64': {'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore']}, 18:46:47 INFO - 'svgr': {'tests': ['tsvgx', 18:46:47 INFO - 'tsvgr_opacity', 18:46:47 INFO - 'tart', 18:46:47 INFO - 'tscrollx', 18:46:47 INFO - 'cart']}, 18:46:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['tsvgx', 18:46:47 INFO - 'tsvgr_opacity', 18:46:47 INFO - 'tart', 18:46:47 INFO - 'tscrollx', 18:46:47 INFO - 'cart']}, 18:46:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'tests': ['tp5o']}, 18:46:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--e10s'], 18:46:47 INFO - 'tests': ['tp5o']}, 18:46:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--xperf_path', 18:46:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:47 INFO - 'tests': ['tp5n']}, 18:46:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--e10s', 18:46:47 INFO - '--xperf_path', 18:46:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:47 INFO - 'tests': ['tp5n']}}, 18:46:47 INFO - 'talos.zip': {'path': '', 18:46:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:47 INFO - Running post-action listener: _resource_record_post_action 18:46:47 INFO - ##### 18:46:47 INFO - ##### Running create-virtualenv step. 18:46:47 INFO - ##### 18:46:47 INFO - Running pre-action listener: _resource_record_pre_action 18:46:47 INFO - Running main action method: create_virtualenv 18:46:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:46:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:46:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:46:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:47 INFO - Using real prefix '/usr' 18:46:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:46:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:49 INFO - Installing pip.................done. 18:46:49 INFO - Return code: 0 18:46:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:46:49 INFO - Using env: {'DISPLAY': ':0', 18:46:49 INFO - 'HOME': '/home/cltbld', 18:46:49 INFO - 'LANG': 'en_US.UTF-8', 18:46:49 INFO - 'LANGUAGE': 'en_US:en', 18:46:49 INFO - 'LOGNAME': 'cltbld', 18:46:49 INFO - 'MAIL': '/var/mail/cltbld', 18:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:49 INFO - 'MOZ_NO_REMOTE': '1', 18:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:49 INFO - 'NO_EM_RESTART': '1', 18:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:49 INFO - 'SHELL': '/bin/bash', 18:46:49 INFO - 'SHLVL': '1', 18:46:49 INFO - 'TERM': 'linux', 18:46:49 INFO - 'TMOUT': '86400', 18:46:49 INFO - 'USER': 'cltbld', 18:46:49 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:49 INFO - '_': '/tools/buildbot/bin/python'} 18:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:46:50 INFO - Cleaning up... 18:46:50 INFO - Return code: 0 18:46:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:46:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:46:50 INFO - Using env: {'DISPLAY': ':0', 18:46:50 INFO - 'HOME': '/home/cltbld', 18:46:50 INFO - 'LANG': 'en_US.UTF-8', 18:46:50 INFO - 'LANGUAGE': 'en_US:en', 18:46:50 INFO - 'LOGNAME': 'cltbld', 18:46:50 INFO - 'MAIL': '/var/mail/cltbld', 18:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:50 INFO - 'MOZ_NO_REMOTE': '1', 18:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:50 INFO - 'NO_EM_RESTART': '1', 18:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:50 INFO - 'SHELL': '/bin/bash', 18:46:50 INFO - 'SHLVL': '1', 18:46:50 INFO - 'TERM': 'linux', 18:46:50 INFO - 'TMOUT': '86400', 18:46:50 INFO - 'USER': 'cltbld', 18:46:50 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:50 INFO - '_': '/tools/buildbot/bin/python'} 18:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:50 INFO - Downloading/unpacking psutil>=0.7.1 18:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:46:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:52 INFO - Installing collected packages: psutil 18:46:52 INFO - Running setup.py install for psutil 18:46:52 INFO - building 'psutil._psutil_linux' extension 18:46:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:46:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:46:52 INFO - building 'psutil._psutil_posix' extension 18:46:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:46:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:46:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:52 INFO - Successfully installed psutil 18:46:52 INFO - Cleaning up... 18:46:52 INFO - Return code: 0 18:46:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:46: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')]} 18:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:52 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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:52 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 18:46:52 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 18:46:52 INFO - Using env: {'DISPLAY': ':0', 18:46:52 INFO - 'HOME': '/home/cltbld', 18:46:52 INFO - 'LANG': 'en_US.UTF-8', 18:46:52 INFO - 'LANGUAGE': 'en_US:en', 18:46:52 INFO - 'LOGNAME': 'cltbld', 18:46:52 INFO - 'MAIL': '/var/mail/cltbld', 18:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:52 INFO - 'MOZ_NO_REMOTE': '1', 18:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:52 INFO - 'NO_EM_RESTART': '1', 18:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:52 INFO - 'SHELL': '/bin/bash', 18:46:52 INFO - 'SHLVL': '1', 18:46:52 INFO - 'TERM': 'linux', 18:46:52 INFO - 'TMOUT': '86400', 18:46:52 INFO - 'USER': 'cltbld', 18:46:52 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:52 INFO - '_': '/tools/buildbot/bin/python'} 18:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:46:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:46:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:46:54 INFO - Installing collected packages: mozsystemmonitor 18:46:54 INFO - Running setup.py install for mozsystemmonitor 18:46:54 INFO - Successfully installed mozsystemmonitor 18:46:54 INFO - Cleaning up... 18:46:54 INFO - Return code: 0 18:46:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:54 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 18:46:54 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 18:46:54 INFO - Using env: {'DISPLAY': ':0', 18:46:54 INFO - 'HOME': '/home/cltbld', 18:46:54 INFO - 'LANG': 'en_US.UTF-8', 18:46:54 INFO - 'LANGUAGE': 'en_US:en', 18:46:54 INFO - 'LOGNAME': 'cltbld', 18:46:54 INFO - 'MAIL': '/var/mail/cltbld', 18:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:54 INFO - 'MOZ_NO_REMOTE': '1', 18:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:54 INFO - 'NO_EM_RESTART': '1', 18:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:54 INFO - 'SHELL': '/bin/bash', 18:46:54 INFO - 'SHLVL': '1', 18:46:54 INFO - 'TERM': 'linux', 18:46:54 INFO - 'TMOUT': '86400', 18:46:54 INFO - 'USER': 'cltbld', 18:46:54 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:54 INFO - '_': '/tools/buildbot/bin/python'} 18:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:46:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:46:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:46:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:46:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:46:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:57 INFO - Downloading docopt-0.6.1.tar.gz 18:46:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:46:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:46:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:46:57 INFO - Running setup.py install for blobuploader 18:46:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:46:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:46:57 INFO - Running setup.py install for requests 18:46:57 INFO - Running setup.py install for docopt 18:46:57 INFO - Successfully installed blobuploader requests docopt 18:46:57 INFO - Cleaning up... 18:46:57 INFO - Return code: 0 18:46:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:57 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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:57 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 18:46:57 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 18:46:57 INFO - Using env: {'DISPLAY': ':0', 18:46:57 INFO - 'HOME': '/home/cltbld', 18:46:57 INFO - 'LANG': 'en_US.UTF-8', 18:46:57 INFO - 'LANGUAGE': 'en_US:en', 18:46:57 INFO - 'LOGNAME': 'cltbld', 18:46:57 INFO - 'MAIL': '/var/mail/cltbld', 18:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:57 INFO - 'MOZ_NO_REMOTE': '1', 18:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:57 INFO - 'NO_EM_RESTART': '1', 18:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:57 INFO - 'SHELL': '/bin/bash', 18:46:57 INFO - 'SHLVL': '1', 18:46:57 INFO - 'TERM': 'linux', 18:46:57 INFO - 'TMOUT': '86400', 18:46:57 INFO - 'USER': 'cltbld', 18:46:57 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:57 INFO - '_': '/tools/buildbot/bin/python'} 18:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:58 INFO - Running setup.py (path:/tmp/pip-1r_P3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:58 INFO - Running setup.py (path:/tmp/pip-QorDU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:58 INFO - Running setup.py (path:/tmp/pip-5DQtvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:58 INFO - Running setup.py (path:/tmp/pip-IKyTOr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:58 INFO - Running setup.py (path:/tmp/pip-gfA3jg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:58 INFO - Running setup.py (path:/tmp/pip-Z58h_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:58 INFO - Running setup.py (path:/tmp/pip-gNHf54-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:58 INFO - Running setup.py (path:/tmp/pip-hM6A6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:58 INFO - Running setup.py (path:/tmp/pip-FviNaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:58 INFO - Running setup.py (path:/tmp/pip-nEuEYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:58 INFO - Running setup.py (path:/tmp/pip-j7a9hq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:58 INFO - Running setup.py (path:/tmp/pip-ik1pI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:58 INFO - Running setup.py (path:/tmp/pip-JpP4v0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:59 INFO - Running setup.py (path:/tmp/pip-z1RY6n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:59 INFO - Running setup.py (path:/tmp/pip-wQPfL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:59 INFO - Running setup.py (path:/tmp/pip-5gQhCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:59 INFO - Running setup.py (path:/tmp/pip-eIb1eT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:46:59 INFO - Running setup.py install for manifestparser 18:46:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:46:59 INFO - Running setup.py install for mozcrash 18:46:59 INFO - Running setup.py install for mozdebug 18:46:59 INFO - Running setup.py install for mozdevice 18:46:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:46:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:46:59 INFO - Running setup.py install for mozfile 18:46:59 INFO - Running setup.py install for mozhttpd 18:46:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:46:59 INFO - Running setup.py install for mozinfo 18:47:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Running setup.py install for mozInstall 18:47:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Running setup.py install for mozleak 18:47:00 INFO - Running setup.py install for mozlog 18:47:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Running setup.py install for moznetwork 18:47:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Running setup.py install for mozprocess 18:47:00 INFO - Running setup.py install for mozprofile 18:47:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Running setup.py install for mozrunner 18:47:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:47:00 INFO - Running setup.py install for mozscreenshot 18:47:00 INFO - Running setup.py install for moztest 18:47:01 INFO - Running setup.py install for mozversion 18:47:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:47:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:47:01 INFO - Cleaning up... 18:47:01 INFO - Return code: 0 18:47:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:01 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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:01 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 18:47:01 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 18:47:01 INFO - Using env: {'DISPLAY': ':0', 18:47:01 INFO - 'HOME': '/home/cltbld', 18:47:01 INFO - 'LANG': 'en_US.UTF-8', 18:47:01 INFO - 'LANGUAGE': 'en_US:en', 18:47:01 INFO - 'LOGNAME': 'cltbld', 18:47:01 INFO - 'MAIL': '/var/mail/cltbld', 18:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:01 INFO - 'MOZ_NO_REMOTE': '1', 18:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:01 INFO - 'NO_EM_RESTART': '1', 18:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:01 INFO - 'SHELL': '/bin/bash', 18:47:01 INFO - 'SHLVL': '1', 18:47:01 INFO - 'TERM': 'linux', 18:47:01 INFO - 'TMOUT': '86400', 18:47:01 INFO - 'USER': 'cltbld', 18:47:01 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:01 INFO - '_': '/tools/buildbot/bin/python'} 18:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:01 INFO - Running setup.py (path:/tmp/pip-NXhYQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:01 INFO - Running setup.py (path:/tmp/pip-hAHdUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:01 INFO - Running setup.py (path:/tmp/pip-ajjQva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:01 INFO - Running setup.py (path:/tmp/pip-3U7zJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:01 INFO - Running setup.py (path:/tmp/pip-lmN4eM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:01 INFO - Running setup.py (path:/tmp/pip-eJHvmt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:01 INFO - Running setup.py (path:/tmp/pip-zCKe9R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:01 INFO - Running setup.py (path:/tmp/pip-OAvZH3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:01 INFO - Running setup.py (path:/tmp/pip-BgR9Tz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:02 INFO - Running setup.py (path:/tmp/pip-Bk_9H7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:02 INFO - Running setup.py (path:/tmp/pip-H_UkTy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:02 INFO - Running setup.py (path:/tmp/pip-v9ZjMY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:02 INFO - Running setup.py (path:/tmp/pip-n2wshL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:02 INFO - Running setup.py (path:/tmp/pip-kgoCBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:02 INFO - Running setup.py (path:/tmp/pip-4llvKw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:02 INFO - Running setup.py (path:/tmp/pip-G6Wc33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:02 INFO - Running setup.py (path:/tmp/pip-XH9DBc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:04 INFO - Downloading blessings-1.5.1.tar.gz 18:47:04 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 18:47:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:04 INFO - Installing collected packages: blessings 18:47:04 INFO - Running setup.py install for blessings 18:47:04 INFO - Successfully installed blessings 18:47:04 INFO - Cleaning up... 18:47:04 INFO - Return code: 0 18:47:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:47:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:04 INFO - Reading from file tmpfile_stdout 18:47:04 INFO - Current package versions: 18:47:04 INFO - argparse == 1.2.1 18:47:04 INFO - blessings == 1.5.1 18:47:04 INFO - blobuploader == 1.2.4 18:47:04 INFO - docopt == 0.6.1 18:47:04 INFO - manifestparser == 1.1 18:47:04 INFO - mozInstall == 1.12 18:47:04 INFO - mozcrash == 0.16 18:47:04 INFO - mozdebug == 0.1 18:47:04 INFO - mozdevice == 0.47 18:47:04 INFO - mozfile == 1.2 18:47:04 INFO - mozhttpd == 0.7 18:47:04 INFO - mozinfo == 0.9 18:47:04 INFO - mozleak == 0.1 18:47:04 INFO - mozlog == 3.1 18:47:04 INFO - moznetwork == 0.27 18:47:04 INFO - mozprocess == 0.22 18:47:04 INFO - mozprofile == 0.28 18:47:04 INFO - mozrunner == 6.11 18:47:04 INFO - mozscreenshot == 0.1 18:47:04 INFO - mozsystemmonitor == 0.0 18:47:04 INFO - moztest == 0.7 18:47:04 INFO - mozversion == 1.4 18:47:04 INFO - psutil == 3.1.1 18:47:04 INFO - requests == 1.2.3 18:47:04 INFO - wsgiref == 0.1.2 18:47:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:04 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 18:47:04 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 18:47:04 INFO - Using env: {'DISPLAY': ':0', 18:47:04 INFO - 'HOME': '/home/cltbld', 18:47:04 INFO - 'LANG': 'en_US.UTF-8', 18:47:04 INFO - 'LANGUAGE': 'en_US:en', 18:47:04 INFO - 'LOGNAME': 'cltbld', 18:47:04 INFO - 'MAIL': '/var/mail/cltbld', 18:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:04 INFO - 'MOZ_NO_REMOTE': '1', 18:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:04 INFO - 'NO_EM_RESTART': '1', 18:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:04 INFO - 'SHELL': '/bin/bash', 18:47:04 INFO - 'SHLVL': '1', 18:47:04 INFO - 'TERM': 'linux', 18:47:04 INFO - 'TMOUT': '86400', 18:47:04 INFO - 'USER': 'cltbld', 18:47:04 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:04 INFO - '_': '/tools/buildbot/bin/python'} 18:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:47:04 INFO - Cleaning up... 18:47:05 INFO - Return code: 0 18:47:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:05 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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:05 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 18:47:05 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 18:47:05 INFO - Using env: {'DISPLAY': ':0', 18:47:05 INFO - 'HOME': '/home/cltbld', 18:47:05 INFO - 'LANG': 'en_US.UTF-8', 18:47:05 INFO - 'LANGUAGE': 'en_US:en', 18:47:05 INFO - 'LOGNAME': 'cltbld', 18:47:05 INFO - 'MAIL': '/var/mail/cltbld', 18:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:05 INFO - 'MOZ_NO_REMOTE': '1', 18:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:05 INFO - 'NO_EM_RESTART': '1', 18:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:05 INFO - 'SHELL': '/bin/bash', 18:47:05 INFO - 'SHLVL': '1', 18:47:05 INFO - 'TERM': 'linux', 18:47:05 INFO - 'TMOUT': '86400', 18:47:05 INFO - 'USER': 'cltbld', 18:47:05 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:05 INFO - '_': '/tools/buildbot/bin/python'} 18:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:05 INFO - Downloading/unpacking jsonschema 18:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:06 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 18:47:06 INFO - Downloading/unpacking functools32 (from jsonschema) 18:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:47:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:07 INFO - warning: no files found matching '*.txt' 18:47:07 INFO - no previously-included directories found matching 'build' 18:47:07 INFO - no previously-included directories found matching 'dist' 18:47:07 INFO - no previously-included directories found matching '.git*' 18:47:07 INFO - Installing collected packages: jsonschema, functools32 18:47:07 INFO - Running setup.py install for functools32 18:47:07 INFO - warning: no files found matching '*.txt' 18:47:07 INFO - no previously-included directories found matching 'build' 18:47:07 INFO - no previously-included directories found matching 'dist' 18:47:07 INFO - no previously-included directories found matching '.git*' 18:47:07 INFO - Successfully installed jsonschema functools32 18:47:07 INFO - Cleaning up... 18:47:07 INFO - Return code: 0 18:47:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:07 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 0x7f9cead79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a59230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:07 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 18:47:07 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 18:47:07 INFO - Using env: {'DISPLAY': ':0', 18:47:07 INFO - 'HOME': '/home/cltbld', 18:47:07 INFO - 'LANG': 'en_US.UTF-8', 18:47:07 INFO - 'LANGUAGE': 'en_US:en', 18:47:07 INFO - 'LOGNAME': 'cltbld', 18:47:07 INFO - 'MAIL': '/var/mail/cltbld', 18:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:07 INFO - 'MOZ_NO_REMOTE': '1', 18:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:07 INFO - 'NO_EM_RESTART': '1', 18:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:07 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:07 INFO - 'SHELL': '/bin/bash', 18:47:07 INFO - 'SHLVL': '1', 18:47:07 INFO - 'TERM': 'linux', 18:47:07 INFO - 'TMOUT': '86400', 18:47:07 INFO - 'USER': 'cltbld', 18:47:07 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:07 INFO - '_': '/tools/buildbot/bin/python'} 18:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:07 INFO - Downloading/unpacking flake8 18:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:47:09 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 18:47:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:47:09 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 18:47:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:09 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 18:47:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:47:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:10 INFO - no previously-included directories found matching 'docs/_build' 18:47:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:47:10 INFO - Running setup.py install for pep8 18:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:10 INFO - no previously-included directories found matching 'docs/_build' 18:47:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:47:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:47:10 INFO - Cleaning up... 18:47:10 INFO - Return code: 0 18:47:10 INFO - Running post-action listener: _resource_record_post_action 18:47:10 INFO - Running post-action listener: _start_resource_monitoring 18:47:10 INFO - Starting resource monitoring. 18:47:10 INFO - ##### 18:47:10 INFO - ##### Running install step. 18:47:10 INFO - ##### 18:47:10 INFO - Running pre-action listener: _resource_record_pre_action 18:47:10 INFO - Running main action method: install 18:47:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:10 INFO - Reading from file tmpfile_stdout 18:47:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:47:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:47:10 INFO - Reading from file tmpfile_stdout 18:47:10 INFO - Output received: 18:47:10 INFO - Usage: mozinstall [options] installer 18:47:10 INFO - Options: 18:47:10 INFO - -h, --help show this help message and exit 18:47:10 INFO - -d DEST, --destination=DEST 18:47:10 INFO - Directory to install application into. [default: 18:47:10 INFO - "/builds/slave/test-pgo"] 18:47:10 INFO - --app=APP Application being installed. [default: firefox] 18:47:10 INFO - mkdir: /builds/slave/test-pgo/build/application 18:47:10 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'] 18:47:10 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 18:47:26 INFO - Reading from file tmpfile_stdout 18:47:26 INFO - Output received: 18:47:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:47:26 INFO - Running post-action listener: _resource_record_post_action 18:47:26 INFO - ##### 18:47:26 INFO - ##### Running run-tests step. 18:47:26 INFO - ##### 18:47:26 INFO - Running pre-action listener: _resource_record_pre_action 18:47:26 INFO - Running main action method: run_tests 18:47:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:47:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:47:26 INFO - Python 2.7.3 18:47:26 INFO - Return code: 0 18:47:26 INFO - grabbing minidump binary from tooltool 18:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7f0>, '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 0x1a572d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a57760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:47:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:47:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:47:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:26 INFO - Return code: 0 18:47:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:47:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:47:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:47:27 INFO - Return code: 0 18:47:27 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/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 18:47:27 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/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 18:47:27 INFO - Using env: {'DISPLAY': ':0', 18:47:27 INFO - 'HOME': '/home/cltbld', 18:47:27 INFO - 'LANG': 'en_US.UTF-8', 18:47:27 INFO - 'LANGUAGE': 'en_US:en', 18:47:27 INFO - 'LOGNAME': 'cltbld', 18:47:27 INFO - 'MAIL': '/var/mail/cltbld', 18:47:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:27 INFO - 'MOZ_NO_REMOTE': '1', 18:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:27 INFO - 'NO_EM_RESTART': '1', 18:47:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:47:27 INFO - 'SHELL': '/bin/bash', 18:47:27 INFO - 'SHLVL': '1', 18:47:27 INFO - 'TERM': 'linux', 18:47:27 INFO - 'TMOUT': '86400', 18:47:27 INFO - 'USER': 'cltbld', 18:47:27 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981', 18:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:27 INFO - '_': '/tools/buildbot/bin/python'} 18:47:27 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/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 18:47:27 INFO - mozversion application_buildid: 20151223163032 18:47:27 INFO - mozversion application_changeset: 64671f01cb7bcd1c7113b464933f8f0d78b0a758 18:47:27 INFO - mozversion application_display_name: Nightly 18:47:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:27 INFO - mozversion application_name: Firefox 18:47:27 INFO - mozversion application_remotingname: firefox 18:47:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:27 INFO - mozversion application_vendor: Mozilla 18:47:27 INFO - mozversion application_version: 46.0a1 18:47:27 INFO - mozversion platform_buildid: 20151223163032 18:47:27 INFO - mozversion platform_changeset: 64671f01cb7bcd1c7113b464933f8f0d78b0a758 18:47:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:27 INFO - mozversion platform_version: 46.0a1 18:47:27 INFO - using testdate: 1450925247 18:47:27 INFO - actual date: 1450925247 18:47:27 INFO - starting webserver on 'localhost:42485' 18:47:27 INFO - SUITE-START | Running 3 tests 18:47:27 INFO - TEST-START | dromaeo_css 18:47:27 INFO - operating with platform_type : linux_ 18:47:27 INFO - Initialising browser for dromaeo_css test... 18:47:27 INFO - TEST-INFO | started process 19265 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVGuM15/profile http://localhost:42485/getInfo.html) 18:47:32 INFO - PROCESS | 19265 | __metrics Screen width/height:1600/1200 18:47:32 INFO - PROCESS | 19265 | colorDepth:24 18:47:32 INFO - PROCESS | 19265 | Browser inner width/height: 1024/697 18:47:32 INFO - PROCESS | 19265 | __metrics 18:47:32 INFO - PROCESS | 19265 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:47:33 INFO - TEST-INFO | 19265: exit 0 18:47:33 INFO - Browser initialized. 18:47:33 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:33 INFO - TEST-INFO | started process 19402 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVGuM15/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:45 INFO - PROCESS | 19402 | RSS: Main: 151216128 18:47:45 INFO - PROCESS | 19402 | 18:48:34 INFO - PROCESS | 19402 | 1450925314740 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:50:43 INFO - PROCESS | 19402 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42485/tests/dromaeo/cssquery-ext.html) 18:50:44 INFO - PROCESS | 19402 | RSS: Main: 159244288 18:50:44 INFO - PROCESS | 19402 | 18:53:46 INFO - PROCESS | 19402 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-ext.html (next: http://localhost:42485/tests/dromaeo/cssquery-jquery.html) 18:53:47 INFO - PROCESS | 19402 | RSS: Main: 152174592 18:53:47 INFO - PROCESS | 19402 | 18:56:49 INFO - PROCESS | 19402 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42485/tests/dromaeo/cssquery-mootools.html) 18:56:49 INFO - PROCESS | 19402 | RSS: Main: 154914816 18:56:49 INFO - PROCESS | 19402 | 18:59:51 INFO - PROCESS | 19402 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42485/tests/dromaeo/cssquery-prototype.html) 18:59:51 INFO - PROCESS | 19402 | RSS: Main: 152010752 18:59:51 INFO - PROCESS | 19402 | 19:02:54 INFO - PROCESS | 19402 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42485/tests/dromaeo/cssquery-yui.html) 19:02:54 INFO - PROCESS | 19402 | RSS: Main: 152772608 19:02:54 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | Cycle 1(1): loaded http://localhost:42485/tests/dromaeo/cssquery-yui.html (next: http://localhost:42485/tests/dromaeo/cssquery-dojo.html) 19:05:57 INFO - PROCESS | 19402 | RSS: Main: 154923008 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | __start_tp_report 19:05:57 INFO - PROCESS | 19402 | _x_x_mozilla_page_load 19:05:57 INFO - PROCESS | 19402 | _x_x_mozilla_page_load_details 19:05:57 INFO - PROCESS | 19402 | |i|pagename|runs| 19:05:57 INFO - PROCESS | 19402 | |0;dojo.html;3159.8894038708645;3213.373392188524;3249.870005199792;3249.935001299974;3274.083256688128;5195.922061169085;5300.39045509766;5330.173823057427;5331.360236771588;5338.652987555816;5242.082635538784;5243.265942768006;5306.575473962083;5310.548603368708;5319.601029922762;4802.231642937122;4899.436564795059;4957.7769000395065;4966.453690094087;4992.226204938241;4811.085893680207;4863.440704318996;4920.532549407801;4921.286413470045;4971;4719;4755.738434386108;4840.201366774478;4853.490383509734;4923.70457772533;4848.369711937461;4854.368932038848;4872.878178045542;4904.509549045102;4908.116539022974;4817.253325734517;4824.951750482485;4826.22780355145;4847.224444088964;4848.854534363974;5032.245163225545;5032.370953630796;5104.566111880495;5139.61452891031;5187.974060129713;5669.348024977139;5672.631278966854;5695.174199741055;5699.629524080921;5711.40030296817;5726.484616384545;5743.913841292384;5748.7987920423;5749.821286636271;5754.395788442195;5183.3002544656365;5287.259783630295;5296.788128474856;5332.093544097513;5427.674339539641;5780.971095144498;5805.216295800013;5815.331236907809;5838.824835254949;5865.266841644794;5567.638103523258;5644.802431914945;5652.265205523256;5655.575831812548;5685.630434021776;5590;5591.245181900473;5610.410906854721;5672.893785711829;5711.771529138871;5630;5632.098864181711;5664.291963504562;5683.0338842396895;5691.203231547586;5547.611667183339;5631.71841407928;5633.549316054706;5676.801311954062;5685.687287199161;4366.71616344943;4376.6498680105515;4393.231184542692;4407.493138289138;4459.643228541709;3937.9803100984886;3948.0327319806256;3953.584873588289;3966.781826999485;3990.580988996114;5177.611679124006;5325.733713314319;5357.19642053695;5357.812476563302;5371.798306985431;5576.163575463632;5646.830595082154;5665.575081868794;5674.092145256739;5720.399358067426;5303.257543943851;5314.813981510629;5339.706316152571;5346.492083252085;5356.062689029404;4740.881477963009;4825.276208568743;4828.179209534387;4837.05677392905;4867.659263851497;5846.590738648339;5861.062230043172;5864.67744274069;5946.345901950782;5979.79070732531;5658.660480371191;5662.490375866192;5670.801521946877;5677.574181936288;5680.829575112753;5754.827355179351;5770.798022069207;5807.76768929255;5820.912686309794;5868.3251426086545;5449.455054494519;5494.313210848644;5561.888762224814;5640.492355688008;5667.943320566742;5696.8006119785605;5723.3418156912485;5723.7996670116345;5725.198472213977;5728.627639203439;5564.4991950724625;5571.4428557143965;5613.943860561342;5619.241402410622;5621.5221706155435;5422.891542169214;5460.34475862899;5568.721563921868;5622.465865742748;5656.462636049569;5458.4814442627885;5461.726913654381;5477.178423236546;5482.369527504388;5515.200295956984;5366.221897824872;5547.611667183259;5615.298087739033;5615.354234263112;5644.774209031757;5392.406835248198;5412.404635490172;5460.34475862899;5469.2616496772425;5512 19:05:57 INFO - PROCESS | 19402 | |1;ext.html;549.1204639223884;589.1516216648026;595.0657467775592;605.2766943502513;612.4793925163609;27872.86063569682;35557.2888542229;35604.82197589008;36140;36237;39431;39924.80037599815;39935.40096898549;39997.40003899944;40116;8456.746297611066;8577.099404562525;8606.956965215166;8626.18051285127;8658.956705216466;8361.790955226137;8400.033996090437;8415.242628163463;8429.831403371929;8467;8499.532525711084;8565.186307300797;8606.096359882185;8610.311175105977;8620.09489003655;8460.703875364363;8491.830163396759;8534.658613655447;8541.487510749375;8549.529775862326;8386.119457457002;8471.407001509897;8513.063563008063;8558.186972237627;8682.218600325938;39419.60580394188;39481.40777888334;39972.80013599913;40001.79999100015;40110.39834402486;3172.5558421820965;3346.715529179998;3374.5275661407422;3408.301298233856;3831.1954489556947;29162.854185728935;29301.41397172066;29338.706612934024;29495.85252073726;30241;3929.5677475477673;3944.881653550398;4024.3158663027357;4031.173609410064;4062.7562346259024;191266;192134.03932980384;194309;195172;195265;44697;44928;45029.54970450253;45061.54938450639;45218.77390613092;42762.57237427586;42825.35761963573;42982.35526467105;43047;43249.78375108104;14464.566063018126;14550.927245363706;14561.708765824624;14634.341454634567;14637.634059148606;11666.066714662807;11678.357690327113;11679.948804607626;11854.348010859485;11891.108166887518;14396.640083997983;14402.567922962327;14469.131852088909;14474.348654310581;14565;5818.156367326798;5847.707614619252;5877.324107727666;5892.7642894283745;5916.290045194604;966.5553845231132;977.9022097790164;987.5457289646843;1028.6039874648166;1152.3201311226417;28208.71791282102;28926.855365723037;29058.709412906024;29169;29192.562111568343;1005.6781829814389;1022.9693109206736;1056.1603525197486;1073.7047311989265;1174.5654107980101;13213.669658258428;13841.930790345983;14187.219702916233;14274;14309;290276;294114;294405;296601;298019;53293.46706532963;53725.731371343674;53880.73059634755;53925.460745392826;54057.72971135119;1324.0929962975392;1327.396034804162;1327.621627836062;1336.585658445885;1344.0927374022497;26866.32834179083;27114.864425677744;27607.309817253925;27689.723102768716;27699.723002769715;42403.575964239964;42767;42912.35631465468;42995;43036.35445468383;284461;285714;287273;287313;288694;31766.682333177298;42663.3600495999;43140.78429607832;43408.34887476627;43469.347959779996;38798.41802373023;39478.81563553098;39485.40771888482;39522.2095558093;39919.401208981304;36796.63203367932;36866.44700329444;37403.625963740014;37553.436698449;37980.810095949346;36236.27527449489;36896.81551592225;36903.81548092242;37216.44175337318;37752.24495510019;36189.81905090563;36306.27387452183;36583.634163658025;36637;38824.223515530095;31076.68923310738;32414.189645258113;33645.32709345848;33774.83112584421;34411.82794086014;25405.491890161724;25671.743282566935;25730.228093157235;25743.871280643478;25812.35469113287 19:05:57 INFO - PROCESS | 19402 | |2;jquery.html;356.7074998501228;361.29727679663034;362.514230930553;363.97088232941366;366.46679081935787;16152.111633860148;16894.493165205047;17480.825191748077;17708.73436898446;18072.367467138654;11215.495302711377;12310.322932238723;16113.355465781384;16149.91925040376;16199.1090490023;4438.489573699026;5445.83662490126;5455;5502.312210973629;5502.724863756816;5441.075017247058;5479.0959491683825;5480.287562616854;5485.561155107582;5500.202470641754;5032.396112466509;5060.13977623803;5147;5288.867778305535;5299.28459657947;5205.6876587404495;5207.140821764404;5281.8415447536445;5290.338707661543;5422.91865622016;5259.184826351921;5291.597726602454;5306.071437498461;5313.521783039545;5345.1714984177515;12256.509739610405;12431.93784031074;19111.61776764457;19998.300059497993;20691.689624655643;2237.7762223777654;2240.439890027493;2244.9775502244934;2296.2881506732965;2296.4258935266184;9823.410595364301;10385;12824.422900969386;13142.934285328512;13392.129511581814;1817.9818201817945;1918.5491409518752;1955.4426988308405;1986.6721990871488;1992.6911328744068;51126;53234.73382633062;53340.73329633366;53371;54669.45330546723;10016.148627366756;10021.198304135653;10079.143272821746;10085;10085.949570252102;12685.873141268654;12824.422900969479;12852.550160744517;12906.741865162645;12906.870931290567;7222.927770722331;7247.891281630779;7320.487565870338;7366.963165184247;7453.888191677129;6943.444524438033;7014.263502332284;7018.75434359795;7056.400205982446;7078.619669164464;4449.710768800018;4452.732836029849;4455.710378825366;4463.866084017484;4480.977595112004;1835.651226267005;1857.322077441724;1865.1327132883275;1865.6082222733107;1882.6611209982334;420.9873703788891;428.5992596921888;434.48947486702997;454.10314628608234;470.2006588799055;10497.527611257512;10850.67447976562;11019.283746556448;11477.540898363972;11478.483468243949;446.352788456739;448.99102017959456;455.1965780397601;457.45562780291345;467.51378566291356;6008.218931538872;6274.466670333073;6302.149209856702;6341.651209183539;6359.8092057238355;521752;522205;524299;533193;538143;74384.62807685927;76511.61744191243;76598;77235.61382193165;77260;481.14836738971826;487.5904240438049;491.0179640718563;491.63864559549415;491.7172625740142;10465.372077675363;10788.352698838095;13951.790723138958;14254.643633909236;14477.782833257721;34702.30595388129;34895.82552087223;35154.64845351514;35625.82187089048;35740.749073782295;42445.36331955085;43347.566524334354;44337.77831110824;44755.776221118685;44805;9542.141207291377;9557.61769529211;9750.512474376395;9809.509524523603;9857.260705446977;16958.32166713367;17370.305187792346;17663.38178163758;17761.11194440247;18700.532486687396;12126.575569855013;13877.79183312231;14526.346314416089;15108.169050702318;15491.922540387226;13968.720625587635;14246.572602821518;14262.215578143301;14473.421063157777;14671.119732816065;11833.82249266279;14967;15066.397344106113;15351.155686436907;15379.76930346068;9642.71071867817;9687.128158465772;9827.329354009693;10058.94970525172;10075.596976121165;14508.564743057725;14548.41806327735;14964.102153870803;15044.924775376054;15300.540983770505 19:05:57 INFO - PROCESS | 19402 | |3;mootools.html;1461.5030889497573;1465.5456808389404;1604.6790641871628;1735.06306594439;1765.6556971390585;6851.0408542803925;6915.5850648961095;7492.850142997137;7525.397968162548;7623.542587444757;7257.564546127236;7295.817604559876;7309.488335816495;7369.926300736991;7404.592747398904;2184.552166805805;2210.347947355526;2215.4904371994453;2217.800397964183;2220.0897631970897;2183.29043061005;2194.692743015979;2273.885795959984;2281.155972290255;2281.5779080870093;2201.361605134509;2226.0984301357976;2249.5838269920037;2266.9319920402413;2274.329072923483;2209.8784566848817;2220.844540882139;2233.9106435742633;2249.280230326296;2259.9887000565054;2239.7536271010176;2265.9320220393415;2267.818574514035;2270.28486026901;2276.4422716434415;7521.097468303784;7532.058492688414;7537.321641052332;7573.886391704129;7584.393248540104;4582.587567118942;4615.723056616614;4646.721196728207;4653.302004699289;4658.604018658418;2917.5331946888396;2956.52695568708;2998.745106665936;3003.2041509000132;3015.9095227143002;961.8893827209821;973.7468258252834;980;1000.5947591225492;1013.5135135135176;9931.801363972752;10026.498675066217;10061.195104391705;10103.242256830767;10141.89858101417;4147.502299723992;4187.958120418818;4223.598758117974;4243.766592837362;4267.295896177096;8655.6970506032;8676.566171691391;8698.173673501007;8702.82594348122;8704.434211776213;4673.205555055649;4680.485146633868;4682.648801339913;4704.976475117603;4708.741019243906;3794.3739283017994;3875.70932180082;4174.31123864559;4226.788660566959;4281.293586558245;3522.788632681996;3568.803715795656;3575.606683264839;3587.3542762303036;3594.4428613564937;1134.325076579434;1140.560884059643;1146.1747541769912;1159.1016961854461;1161.651504548632;1070.47011729193;1074.887136850635;1089.477051015501;1204.3195594489262;1326.840779106494;7105.005299258108;7315.597642129627;7332.120145582564;7366.815829604303;7395.445341599401;1022.8312328465869;1035.249444152983;1045.4981608827804;1119.2668801934747;1141.8572678415198;5568.053430916673;5578.832635020955;5588.776448942078;5601.551875849922;5645.125005624135;8673.566321683891;8963.924329080552;9051;9098.86351704725;9121.90878091224;9078.45529268246;9081.636734530677;9122.635094596275;9165.404248723811;9211.861822072675;7266.890996635055;7285.927140728631;7314.926850731425;7362.815929601696;7367.336939675455;7131.500794944304;7140.250273721184;7150.177729561167;7167.677454514455;7173.497855150089;8034.879476807736;8185.30424913889;8512;8523.062463128927;8547.059823419544;8344.37417193725;8403.663853445794;8429.747107586782;8506.872396913928;8560.743177704679;6421.389967953037;6596.736130554724;7170;7221.855562888818;7281.089863767029;7408.703651853865;7409.8147546311775;7457.2542745724995;7460.104787425544;7470.365018973448;6735;6791.966040169767;6837.3162683731225;6914.792556223321;6995.475339349671;6786.321367863175;6787.049813026081;6883.518153729191;6906.758263460755;6982.057422247932;6960.79117626472;7034.155901291878;7035.366816986496;7044.471664625071;7118.572885626879;6362.586431881913;6461.8061458156335;6463.709133088928;6478.255000674794;6483.870322593616;6511.446527045065;6515.478761699147;6532;6547.541672082908;6577.671116444063 19:05:57 INFO - PROCESS | 19402 | |4;prototype.html;342.10539439366056;348.83779042745135;350.561797752809;351.3763070549775;353.1048791314018;6256.562040657156;6256.937430625692;6294.213223347082;6355.110284560154;6496.480281577475;6272.3100458949475;6327.367263273682;6347.523935704818;6348.809535713936;6349.841253968653;4805.423349198101;4807.6153907687385;4824.252240902666;4824.517548245182;4825.855224343275;4810.927836082444;4819.807207711705;4838;4839.758012099399;4853.320535125085;4679.9298010529865;4752.952470475303;4766.976165119169;4784.736839473828;4795.904081918359;4757.09615173116;4764.642651801111;4767.237242041291;4781;4799.976000120012;4116.320807066831;4122.91754164918;4124.443200167999;4129.132882094764;4161.126163505667;5962.25471816023;5971.313298970587;5988.670623115727;6004;6016.699165041774;5347.491988261109;5500.889982200333;5539.058360078796;5544.362398324163;5554.666719996813;6699.665016749143;6702.36327548882;6711.161104861892;6713.966430167818;6719.865602687919;4515.458145022585;4520.412346394981;4526.1626599078945;4530.343100250445;4530.524294949048;6803.795886123424;6889.483288753313;6913.308669133096;6969.30306969299;6998.545094568888;4675.7895894684825;4704.1062198182235;4709.717416954925;4710.105080034782;4710.952890471051;4741.336212930192;4763.333133361332;4767;4773.64197685175;4790.568848803624;5501.037318469332;5528.281323428009;5542.307211598551;5542.473465020817;5545.7781688732;6490.837729056717;6584.539082264291;6642.63465509392;6666.333366663392;6673.4661227101715;1612.5565469495748;1641.499342700464;1663.96672066558;1665.0342801175289;1669.090345761563;1103;1104.5913012185542;1132.9773404531863;1137.0335215067291;1144.7481554058095;6312.558120931582;6323.715432805535;6348.809535713936;6357.809265722036;6377.139086223393;6732.932670673328;6777.695003724844;6822.897656535156;6836.965815170893;6849.828754281083;6154.138420621117;6294;6323.083152942798;6341.143945567382;6365.331640177715;3705.9073523161596;3715.535558055243;3717.423799311111;3738.140227747633;3749.531308586427;7048.577085374894;7136.678849451683;7139.571625702474;7155.964220178866;7175.641217939082;6962.303769622998;6969.16370035599;6981.5461994970165;7011.89482157768;7043.049188359609;7284.271572842779;7302.415806735448;7333.669984850694;7339.192688804227;7352.705891764376;6976.7558135465015;6988.336108069725;7005.369516743517;7017.824554386181;7040.542364746275;6814.897776533455;6907.171139463297;6918.411934985583;6929;6958.512904096867;7299.05112335393;7305.963470182615;7323.048003759477;7342.339189472973;7438.070241219848;4701.824543864034;4749.572538471554;4753.310769938409;4756.738379389167;4774.928376074431;6901.861962760616;6980.092587963735;7033.9296607033275;7041.295870412918;7047.189573199148;6716.865662686621;6729.831754205989;6767.458603311625;6787.083743694538;6791.04925310447;6645.401913827779;6693.598384096969;6733.461323094239;6748.898766518408;6800.727970881109;6442;6631.3700198481065;6639.3692599203;6645.501587380869;6655.500837437115;6755.763548275787;6770;6774.898376524257;6790.456763458813;6810.353016463428;6560.9343906562235;6600.438962688226;6606.8017959461295;6611.438027767694;6615.834604134935 19:05:57 INFO - PROCESS | 19402 | |5;yui.html;735.3896266099136;841.7600983719633;849.8682704180854;868.9478631282127;894.1326912894492;13350.732985340288;13520.188788672662;13526.053176277665;13559.661008474794;13654.658633534154;12789.872101278985;12794.23234605922;12802.423890924907;12870.678233044155;12946.74106517869;678.4470656415031;694.2536772969053;813.2639960835423;831.995840020799;832.8792325112855;823.9876401853977;840.7603832907622;840.9663613455455;841.0160112668193;842.8525008123585;870.8084221471298;874.2394117118116;880.3089574683875;881.497546398553;884.9734507964739;863.568215892054;867.8871746672955;871.3726117195672;872.6771094694972;875.8073223890734;637.3881074168758;638.3807706524664;639.5203597302024;640.702073535808;644.8323435906698;12903.419346129353;13086.672833179151;13198.14212076212;13227;13267.469301227939;11957.820632690517;12084.939575302154;12307.507699692002;12815.423305951255;13369.799453008212;10372.118369938564;10468.842967355497;10524.579181810434;10599.788004239872;10643.042126208678;3369.427197376452;3375.122468158272;3378.5438965739554;3406.5401170842115;3466.878659246914;43275.78362108201;43711;43921.78039109816;43956.340654890206;44131.338029929895;9291.21024712907;9346.252299815998;9383.108604682544;9470.147686708091;9474.90525094754;17623.735643965352;17679;17697.292108315523;17745.556361091076;17784.199711013036;7497.250274972459;7513.2111128331835;7591.8861217080685;7647.961760191163;7714.421418393531;4561.110583436198;4561.7262964222255;4590.632749380042;4631.328457373729;4735.313379559944;3132.7180553750272;3172.762042846796;3178.030700636282;3181.5704879841387;3184.2198661328125;580.2196046317696;582.9271341082365;585.3297973819953;598.7694737525997;606.7087797857054;645.3707635055783;684.3122661724934;685.9588424694534;692.8787462194197;711.2283172757512;8676.349273804364;9198.540072996324;9242.953785231031;9311.115444032941;9459.38513996588;524.7061645478544;546.8317379954124;699.4893727578794;713.9750108746169;732.7618523979728;4026.859059932947;4364.934525982113;4411.139827733626;4490.124425737015;4551.112533056088;59192;60764.39235607676;60777;60950.39049609536;61099.69450152721;54121.45878541164;54218.728906356;54820.72589637106;55085.72457137769;55134.448655513734;48231.75884120557;48643.5135648639;48995.510044899806;49527;49832.50167498351;9071;9091.863622045543;9184.540772961458;9219.953900230455;9447.574859131219;35430.29139417249;35697.28605427929;35903.46144807882;36200.27599447944;36823.44764828583;43141.56858431501;44967.7751611253;47492.28761568648;47825;47838;10973.670789876316;11110.44447777624;11184.496697648789;11250.66248012561;11357.829632555684;11748.236364636272;11785.292882427082;11807.350595717318;11809.704757381134;11831.11266654987;11857.940710296394;11863.58477453285;11864.347460889734;11929.403529823301;12141.817872731739;11818.586349477728;12014.519419223134;12104.576339828063;12135.453904574139;12151.453184606891;11585.768284634429;11615;11683.357415342238;11718.88281117178;11743.941280293544;9934.900650993397;10312.175025998053;10345.534450949575;10480.68557943263;10533.42066186367;9580.616775329188;9745.951270243604;9772.315937884565;10022.298439109192;10171.847422288523 19:05:57 INFO - PROCESS | 19402 | __end_tp_report 19:05:57 INFO - PROCESS | 19402 | __start_cc_report 19:05:57 INFO - PROCESS | 19402 | _x_x_mozilla_cycle_collect,304 19:05:57 INFO - PROCESS | 19402 | __end_cc_report 19:05:57 INFO - PROCESS | 19402 | __startTimestamp1450926357531__endTimestamp 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | ------- Summary: start ------- 19:05:57 INFO - PROCESS | 19402 | Number of tests: 6 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | [#0] dojo.html Cycles:165 Average:5277.84 Median:5460.34 stddev:569.77 (10.4%) stddev-sans-first:546.76 19:05:57 INFO - PROCESS | 19402 | Values: 3159.9 3213.4 3249.9 3249.9 3274.1 5195.9 5300.4 5330.2 5331.4 5338.7 5242.1 5243.3 5306.6 5310.5 5319.6 4802.2 4899.4 4957.8 4966.5 4992.2 4811.1 4863.4 4920.5 4921.3 4971.0 4719.0 4755.7 4840.2 4853.5 4923.7 4848.4 4854.4 4872.9 4904.5 4908.1 4817.3 4825.0 4826.2 4847.2 4848.9 5032.2 5032.4 5104.6 5139.6 5188.0 5669.3 5672.6 5695.2 5699.6 5711.4 5726.5 5743.9 5748.8 5749.8 5754.4 5183.3 5287.3 5296.8 5332.1 5427.7 5781.0 5805.2 5815.3 5838.8 5865.3 5567.6 5644.8 5652.3 5655.6 5685.6 5590.0 5591.2 5610.4 5672.9 5711.8 5630.0 5632.1 5664.3 5683.0 5691.2 5547.6 5631.7 5633.5 5676.8 5685.7 4366.7 4376.6 4393.2 4407.5 4459.6 3938.0 3948.0 3953.6 3966.8 3990.6 5177.6 5325.7 5357.2 5357.8 5371.8 5576.2 5646.8 5665.6 5674.1 5720.4 5303.3 5314.8 5339.7 5346.5 5356.1 4740.9 4825.3 4828.2 4837.1 4867.7 5846.6 5861.1 5864.7 5946.3 5979.8 5658.7 5662.5 5670.8 5677.6 5680.8 5754.8 5770.8 5807.8 5820.9 5868.3 5449.5 5494.3 5561.9 5640.5 5667.9 5696.8 5723.3 5723.8 5725.2 5728.6 5564.5 5571.4 5613.9 5619.2 5621.5 5422.9 5460.3 5568.7 5622.5 5656.5 5458.5 5461.7 5477.2 5482.4 5515.2 5366.2 5547.6 5615.3 5615.4 5644.8 5392.4 5412.4 5460.3 5469.3 5512.0 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | [#1] ext.html Cycles:180 Average:42341.98 Median:37060.13 stddev:68446.02 (184.7%) stddev-sans-first:68566.10 19:05:57 INFO - PROCESS | 19402 | Values: 549.1 589.2 595.1 605.3 612.5 27872.9 35557.3 35604.8 36140.0 36237.0 39431.0 39924.8 39935.4 39997.4 40116.0 8456.7 8577.1 8607.0 8626.2 8659.0 8361.8 8400.0 8415.2 8429.8 8467.0 8499.5 8565.2 8606.1 8610.3 8620.1 8460.7 8491.8 8534.7 8541.5 8549.5 8386.1 8471.4 8513.1 8558.2 8682.2 39419.6 39481.4 39972.8 40001.8 40110.4 3172.6 3346.7 3374.5 3408.3 3831.2 29162.9 29301.4 29338.7 29495.9 30241.0 3929.6 3944.9 4024.3 4031.2 4062.8 191266.0 192134.0 194309.0 195172.0 195265.0 44697.0 44928.0 45029.5 45061.5 45218.8 42762.6 42825.4 42982.4 43047.0 43249.8 14464.6 14550.9 14561.7 14634.3 14637.6 11666.1 11678.4 11679.9 11854.3 11891.1 14396.6 14402.6 14469.1 14474.3 14565.0 5818.2 5847.7 5877.3 5892.8 5916.3 966.6 977.9 987.5 1028.6 1152.3 28208.7 28926.9 29058.7 29169.0 29192.6 1005.7 1023.0 1056.2 1073.7 1174.6 13213.7 13841.9 14187.2 14274.0 14309.0 290276.0 294114.0 294405.0 296601.0 298019.0 53293.5 53725.7 53880.7 53925.5 54057.7 1324.1 1327.4 1327.6 1336.6 1344.1 26866.3 27114.9 27607.3 27689.7 27699.7 42403.6 42767.0 42912.4 42995.0 43036.4 284461.0 285714.0 287273.0 287313.0 288694.0 31766.7 42663.4 43140.8 43408.3 43469.3 38798.4 39478.8 39485.4 39522.2 39919.4 36796.6 36866.4 37403.6 37553.4 37980.8 36236.3 36896.8 36903.8 37216.4 37752.2 36189.8 36306.3 36583.6 36637.0 38824.2 31076.7 32414.2 33645.3 33774.8 34411.8 25405.5 25671.7 25730.2 25743.9 25812.4 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | [#2] jquery.html Cycles:180 Average:27733.45 Median:393.73 stddev:86208.27 (21895.4%) stddev-sans-first:86425.60 19:05:57 INFO - PROCESS | 19402 | Values: 356.7 361.3 362.5 364.0 366.5 16152.1 16894.5 17480.8 17708.7 18072.4 11215.5 12310.3 16113.4 16149.9 16199.1 4438.5 5445.8 5455.0 5502.3 5502.7 5441.1 5479.1 5480.3 5485.6 5500.2 5032.4 5060.1 5147.0 5288.9 5299.3 5205.7 5207.1 5281.8 5290.3 5422.9 5259.2 5291.6 5306.1 5313.5 5345.2 12256.5 12431.9 19111.6 19998.3 20691.7 2237.8 2240.4 2245.0 2296.3 2296.4 9823.4 10385.0 12824.4 13142.9 13392.1 1818.0 1918.5 1955.4 1986.7 1992.7 51126.0 53234.7 53340.7 53371.0 54669.5 10016.1 10021.2 10079.1 10085.0 10085.9 12685.9 12824.4 12852.6 12906.7 12906.9 7222.9 7247.9 7320.5 7367.0 7453.9 6943.4 7014.3 7018.8 7056.4 7078.6 4449.7 4452.7 4455.7 4463.9 4481.0 1835.7 1857.3 1865.1 1865.6 1882.7 421.0 428.6 434.5 454.1 470.2 10497.5 10850.7 11019.3 11477.5 11478.5 446.4 449.0 455.2 457.5 467.5 6008.2 6274.5 6302.1 6341.7 6359.8 521752.0 522205.0 524299.0 533193.0 538143.0 74384.6 76511.6 76598.0 77235.6 77260.0 481.1 487.6 491.0 491.6 491.7 10465.4 10788.4 13951.8 14254.6 14477.8 34702.3 34895.8 35154.6 35625.8 35740.7 42445.4 43347.6 44337.8 44755.8 44805.0 9542.1 9557.6 9750.5 9809.5 9857.3 16958.3 17370.3 17663.4 17761.1 18700.5 12126.6 13877.8 14526.3 15108.2 15491.9 13968.7 14246.6 14262.2 14473.4 14671.1 11833.8 14967.0 15066.4 15351.2 15379.8 9642.7 9687.1 9827.3 10058.9 10075.6 14508.6 14548.4 14964.1 15044.9 15300.5 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | [#3] mootools.html Cycles:180 Average:5351.10 Median:6481.06 stddev:2735.85 (42.2%) stddev-sans-first:2727.90 19:05:57 INFO - PROCESS | 19402 | Values: 1461.5 1465.5 1604.7 1735.1 1765.7 6851.0 6915.6 7492.9 7525.4 7623.5 7257.6 7295.8 7309.5 7369.9 7404.6 2184.6 2210.3 2215.5 2217.8 2220.1 2183.3 2194.7 2273.9 2281.2 2281.6 2201.4 2226.1 2249.6 2266.9 2274.3 2209.9 2220.8 2233.9 2249.3 2260.0 2239.8 2265.9 2267.8 2270.3 2276.4 7521.1 7532.1 7537.3 7573.9 7584.4 4582.6 4615.7 4646.7 4653.3 4658.6 2917.5 2956.5 2998.7 3003.2 3015.9 961.9 973.7 980.0 1000.6 1013.5 9931.8 10026.5 10061.2 10103.2 10141.9 4147.5 4188.0 4223.6 4243.8 4267.3 8655.7 8676.6 8698.2 8702.8 8704.4 4673.2 4680.5 4682.6 4705.0 4708.7 3794.4 3875.7 4174.3 4226.8 4281.3 3522.8 3568.8 3575.6 3587.4 3594.4 1134.3 1140.6 1146.2 1159.1 1161.7 1070.5 1074.9 1089.5 1204.3 1326.8 7105.0 7315.6 7332.1 7366.8 7395.4 1022.8 1035.2 1045.5 1119.3 1141.9 5568.1 5578.8 5588.8 5601.6 5645.1 8673.6 8963.9 9051.0 9098.9 9121.9 9078.5 9081.6 9122.6 9165.4 9211.9 7266.9 7285.9 7314.9 7362.8 7367.3 7131.5 7140.3 7150.2 7167.7 7173.5 8034.9 8185.3 8512.0 8523.1 8547.1 8344.4 8403.7 8429.7 8506.9 8560.7 6421.4 6596.7 7170.0 7221.9 7281.1 7408.7 7409.8 7457.3 7460.1 7470.4 6735.0 6792.0 6837.3 6914.8 6995.5 6786.3 6787.0 6883.5 6906.8 6982.1 6960.8 7034.2 7035.4 7044.5 7118.6 6362.6 6461.8 6463.7 6478.3 6483.9 6511.4 6515.5 6532.0 6547.5 6577.7 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | [#4] prototype.html Cycles:180 Average:5595.17 Median:6344.33 stddev:1708.91 (26.9%) stddev-sans-first:1667.60 19:05:57 INFO - PROCESS | 19402 | Values: 342.1 348.8 350.6 351.4 353.1 6256.6 6256.9 6294.2 6355.1 6496.5 6272.3 6327.4 6347.5 6348.8 6349.8 4805.4 4807.6 4824.3 4824.5 4825.9 4810.9 4819.8 4838.0 4839.8 4853.3 4679.9 4753.0 4767.0 4784.7 4795.9 4757.1 4764.6 4767.2 4781.0 4800.0 4116.3 4122.9 4124.4 4129.1 4161.1 5962.3 5971.3 5988.7 6004.0 6016.7 5347.5 5500.9 5539.1 5544.4 5554.7 6699.7 6702.4 6711.2 6714.0 6719.9 4515.5 4520.4 4526.2 4530.3 4530.5 6803.8 6889.5 6913.3 6969.3 6998.5 4675.8 4704.1 4709.7 4710.1 4711.0 4741.3 4763.3 4767.0 4773.6 4790.6 5501.0 5528.3 5542.3 5542.5 5545.8 6490.8 6584.5 6642.6 6666.3 6673.5 1612.6 1641.5 1664.0 1665.0 1669.1 1103.0 1104.6 1133.0 1137.0 1144.7 6312.6 6323.7 6348.8 6357.8 6377.1 6732.9 6777.7 6822.9 6837.0 6849.8 6154.1 6294.0 6323.1 6341.1 6365.3 3705.9 3715.5 3717.4 3738.1 3749.5 7048.6 7136.7 7139.6 7156.0 7175.6 6962.3 6969.2 6981.5 7011.9 7043.0 7284.3 7302.4 7333.7 7339.2 7352.7 6976.8 6988.3 7005.4 7017.8 7040.5 6814.9 6907.2 6918.4 6929.0 6958.5 7299.1 7306.0 7323.0 7342.3 7438.1 4701.8 4749.6 4753.3 4756.7 4774.9 6901.9 6980.1 7033.9 7041.3 7047.2 6716.9 6729.8 6767.5 6787.1 6791.0 6645.4 6693.6 6733.5 6748.9 6800.7 6442.0 6631.4 6639.4 6645.5 6655.5 6755.8 6770.0 6774.9 6790.5 6810.4 6560.9 6600.4 6606.8 6611.4 6615.8 19:05:57 INFO - PROCESS | 19402 | 19:05:57 INFO - PROCESS | 19402 | [#5] yui.html Cycles:180 Average:14084.66 Median:4610.98 stddev:16422.16 (356.2%) stddev-sans-first:16437.63 19:05:57 INFO - PROCESS | 19402 | Values: 735.4 841.8 849.9 868.9 894.1 13350.7 13520.2 13526.1 13559.7 13654.7 12789.9 12794.2 12802.4 12870.7 12946.7 678.4 694.3 813.3 832.0 832.9 824.0 840.8 841.0 841.0 842.9 870.8 874.2 880.3 881.5 885.0 863.6 867.9 871.4 872.7 875.8 637.4 638.4 639.5 640.7 644.8 12903.4 13086.7 13198.1 13227.0 13267.5 11957.8 12084.9 12307.5 12815.4 13369.8 10372.1 10468.8 10524.6 10599.8 10643.0 3369.4 3375.1 3378.5 3406.5 3466.9 43275.8 43711.0 43921.8 43956.3 44131.3 9291.2 9346.3 9383.1 9470.1 9474.9 17623.7 17679.0 17697.3 17745.6 17784.2 7497.3 7513.2 7591.9 7648.0 7714.4 4561.1 4561.7 4590.6 4631.3 4735.3 3132.7 3172.8 3178.0 3181.6 3184.2 580.2 582.9 585.3 598.8 606.7 645.4 684.3 686.0 692.9 711.2 8676.3 9198.5 9243.0 9311.1 9459.4 524.7 546.8 699.5 714.0 732.8 4026.9 4364.9 4411.1 4490.1 4551.1 59192.0 60764.4 60777.0 60950.4 61099.7 54121.5 54218.7 54820.7 55085.7 55134.4 48231.8 48643.5 48995.5 49527.0 49832.5 9071.0 9091.9 9184.5 9220.0 9447.6 35430.3 35697.3 35903.5 36200.3 36823.4 43141.6 44967.8 47492.3 47825.0 47838.0 10973.7 11110.4 11184.5 11250.7 11357.8 11748.2 11785.3 11807.4 11809.7 11831.1 11857.9 11863.6 11864.3 11929.4 12141.8 11818.6 12014.5 12104.6 12135.5 12151.5 11585.8 11615.0 11683.4 11718.9 11743.9 9934.9 10312.2 10345.5 10480.7 10533.4 9580.6 9746.0 9772.3 10022.3 10171.8 19:05:57 INFO - PROCESS | 19402 | -------- Summary: end -------- 19:05:57 INFO - PROCESS | 19402 | 19:05:58 INFO - TEST-INFO | 19402: exit 0 19:05:58 INFO - TEST-OK | dromaeo_css | took 1110413ms 19:05:58 INFO - TEST-START | kraken 19:05:58 INFO - operating with platform_type : linux_ 19:05:58 INFO - Initialising browser for kraken test... 19:05:58 INFO - TEST-INFO | started process 19646 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ5IreP/profile http://localhost:42485/getInfo.html) 19:06:02 INFO - PROCESS | 19646 | __metrics Screen width/height:1600/1200 19:06:02 INFO - PROCESS | 19646 | colorDepth:24 19:06:02 INFO - PROCESS | 19646 | Browser inner width/height: 1024/697 19:06:02 INFO - PROCESS | 19646 | __metrics 19:06:02 INFO - PROCESS | 19646 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:06:03 INFO - TEST-INFO | 19646: exit 0 19:06:03 INFO - Browser initialized. 19:06:03 INFO - Running cycle 1/1 for kraken test... 19:06:03 INFO - TEST-INFO | started process 19768 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ5IreP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:15 INFO - PROCESS | 19768 | RSS: Main: 151011328 19:06:15 INFO - PROCESS | 19768 | 19:06:17 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:18 INFO - PROCESS | 19768 | RSS: Main: 151654400 19:06:18 INFO - PROCESS | 19768 | 19:06:21 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-dft) 19:06:21 INFO - PROCESS | 19768 | RSS: Main: 151785472 19:06:21 INFO - PROCESS | 19768 | 19:06:24 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-fft) 19:06:25 INFO - PROCESS | 19768 | RSS: Main: 145813504 19:06:25 INFO - PROCESS | 19768 | 19:06:27 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42485/tests/kraken/driver.html?testName=audio-oscillator) 19:06:28 INFO - PROCESS | 19768 | RSS: Main: 146640896 19:06:28 INFO - PROCESS | 19768 | 19:06:30 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:30 INFO - PROCESS | 19768 | RSS: Main: 147161088 19:06:30 INFO - PROCESS | 19768 | 19:06:33 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42485/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:34 INFO - PROCESS | 19768 | RSS: Main: 147075072 19:06:34 INFO - PROCESS | 19768 | 19:06:37 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42485/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:38 INFO - PROCESS | 19768 | RSS: Main: 148164608 19:06:38 INFO - PROCESS | 19768 | 19:06:41 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42485/tests/kraken/driver.html?testName=json-parse-financial) 19:06:41 INFO - PROCESS | 19768 | RSS: Main: 148602880 19:06:41 INFO - PROCESS | 19768 | 19:06:43 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:44 INFO - PROCESS | 19768 | RSS: Main: 148099072 19:06:44 INFO - PROCESS | 19768 | 19:06:45 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:46 INFO - PROCESS | 19768 | RSS: Main: 148242432 19:06:46 INFO - PROCESS | 19768 | 19:06:48 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:06:49 INFO - PROCESS | 19768 | RSS: Main: 149225472 19:06:49 INFO - PROCESS | 19768 | 19:06:51 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:06:52 INFO - PROCESS | 19768 | RSS: Main: 149352448 19:06:52 INFO - PROCESS | 19768 | 19:06:54 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:06:55 INFO - PROCESS | 19768 | RSS: Main: 148439040 19:06:55 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | Cycle 1(1): loaded http://localhost:42485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42485/tests/kraken/driver.html?testName=ai-astar) 19:06:57 INFO - PROCESS | 19768 | RSS: Main: 148484096 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | __start_tp_report 19:06:57 INFO - PROCESS | 19768 | _x_x_mozilla_page_load 19:06:57 INFO - PROCESS | 19768 | _x_x_mozilla_page_load_details 19:06:57 INFO - PROCESS | 19768 | |i|pagename|runs| 19:06:57 INFO - PROCESS | 19768 | |0;ai-astar;112;106;114;112;112;125;113;111;117;113 19:06:57 INFO - PROCESS | 19768 | |1;audio-beat-detection;149;129;156;165;128;155;164;128;180;129 19:06:57 INFO - PROCESS | 19768 | |2;audio-dft;162;163;163;164;162;161;174;176;165;161 19:06:57 INFO - PROCESS | 19768 | |3;audio-fft;76;72;74;75;76;73;149;74;71;71 19:06:57 INFO - PROCESS | 19768 | |4;audio-oscillator;97;97;139;96;97;96;139;96;96;136 19:06:57 INFO - PROCESS | 19768 | |5;imaging-gaussian-blur;111;110;111;109;110;112;110;110;111;110 19:06:57 INFO - PROCESS | 19768 | |6;imaging-darkroom;148;147;153;147;150;148;146;147;146;150 19:06:57 INFO - PROCESS | 19768 | |7;imaging-desaturate;97;97;97;98;97;97;97;96;97;97 19:06:57 INFO - PROCESS | 19768 | |8;json-parse-financial;63;60;60;60;69;58;60;59;59;59 19:06:57 INFO - PROCESS | 19768 | |9;json-stringify-tinderbox;68;68;67;68;68;69;69;68;68;68 19:06:57 INFO - PROCESS | 19768 | |10;stanford-crypto-aes;88;94;88;87;87;93;97;86;86;87 19:06:57 INFO - PROCESS | 19768 | |11;stanford-crypto-ccm;124;124;124;125;127;131;117;121;116;132 19:06:57 INFO - PROCESS | 19768 | |12;stanford-crypto-pbkdf2;152;152;148;147;156;145;156;150;163;143 19:06:57 INFO - PROCESS | 19768 | |13;stanford-crypto-sha256-iterative;69;69;70;69;68;67;68;69;68;68 19:06:57 INFO - PROCESS | 19768 | __end_tp_report 19:06:57 INFO - PROCESS | 19768 | __start_cc_report 19:06:57 INFO - PROCESS | 19768 | _x_x_mozilla_cycle_collect,744 19:06:57 INFO - PROCESS | 19768 | __end_cc_report 19:06:57 INFO - PROCESS | 19768 | __startTimestamp1450926417367__endTimestamp 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | ------- Summary: start ------- 19:06:57 INFO - PROCESS | 19768 | Number of tests: 14 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.88 (4.3%) stddev-sans-first:5.15 19:06:57 INFO - PROCESS | 19768 | Values: 112.0 106.0 114.0 112.0 112.0 125.0 113.0 111.0 117.0 113.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.50 stddev:18.87 (12.1%) stddev-sans-first:20.01 19:06:57 INFO - PROCESS | 19768 | Values: 149.0 129.0 156.0 165.0 128.0 155.0 164.0 128.0 180.0 129.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#2] audio-dft Cycles:10 Average:165.10 Median:163.50 stddev:5.38 (3.3%) stddev-sans-first:5.59 19:06:57 INFO - PROCESS | 19768 | Values: 162.0 163.0 163.0 164.0 162.0 161.0 174.0 176.0 165.0 161.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.00 stddev:23.93 (32.3%) stddev-sans-first:25.31 19:06:57 INFO - PROCESS | 19768 | Values: 76.0 72.0 74.0 75.0 76.0 73.0 149.0 74.0 71.0 71.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:20.10 (20.9%) stddev-sans-first:20.86 19:06:57 INFO - PROCESS | 19768 | Values: 97.0 97.0 139.0 96.0 97.0 96.0 139.0 96.0 96.0 136.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 19:06:57 INFO - PROCESS | 19768 | Values: 111.0 110.0 111.0 109.0 110.0 112.0 110.0 110.0 111.0 110.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:2.20 (1.5%) stddev-sans-first:2.33 19:06:57 INFO - PROCESS | 19768 | Values: 148.0 147.0 153.0 147.0 150.0 148.0 146.0 147.0 146.0 150.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:06:57 INFO - PROCESS | 19768 | Values: 97.0 97.0 97.0 98.0 97.0 97.0 97.0 96.0 97.0 97.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.00 stddev:3.20 (5.3%) stddev-sans-first:3.28 19:06:57 INFO - PROCESS | 19768 | Values: 63.0 60.0 60.0 60.0 69.0 58.0 60.0 59.0 59.0 59.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 19:06:57 INFO - PROCESS | 19768 | Values: 68.0 68.0 67.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:88.00 stddev:3.89 (4.4%) stddev-sans-first:4.10 19:06:57 INFO - PROCESS | 19768 | Values: 88.0 94.0 88.0 87.0 87.0 93.0 97.0 86.0 86.0 87.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:5.22 (4.2%) stddev-sans-first:5.53 19:06:57 INFO - PROCESS | 19768 | Values: 124.0 124.0 124.0 125.0 127.0 131.0 117.0 121.0 116.0 132.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:152.00 stddev:5.98 (3.9%) stddev-sans-first:6.33 19:06:57 INFO - PROCESS | 19768 | Values: 152.0 152.0 148.0 147.0 156.0 145.0 156.0 150.0 163.0 143.0 19:06:57 INFO - PROCESS | 19768 | 19:06:57 INFO - PROCESS | 19768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 19:06:57 INFO - PROCESS | 19768 | Values: 69.0 69.0 70.0 69.0 68.0 67.0 68.0 69.0 68.0 68.0 19:06:57 INFO - PROCESS | 19768 | -------- Summary: end -------- 19:06:57 INFO - PROCESS | 19768 | 19:06:58 INFO - TEST-INFO | 19768: exit 0 19:06:58 INFO - TEST-OK | kraken | took 60118ms 19:06:58 INFO - TEST-START | v8_7 19:06:58 INFO - operating with platform_type : linux_ 19:06:58 INFO - Initialising browser for v8_7 test... 19:06:58 INFO - TEST-INFO | started process 20053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjIStGd/profile http://localhost:42485/getInfo.html) 19:07:02 INFO - PROCESS | 20053 | __metrics Screen width/height:1600/1200 19:07:02 INFO - PROCESS | 20053 | colorDepth:24 19:07:02 INFO - PROCESS | 20053 | Browser inner width/height: 1024/697 19:07:02 INFO - PROCESS | 20053 | __metrics 19:07:02 INFO - PROCESS | 20053 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:03 INFO - TEST-INFO | 20053: exit 0 19:07:03 INFO - Browser initialized. 19:07:03 INFO - Running cycle 1/1 for v8_7 test... 19:07:03 INFO - TEST-INFO | started process 20173 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjIStGd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:15 INFO - PROCESS | 20173 | RSS: Main: 151150592 19:07:15 INFO - PROCESS | 20173 | 19:07:36 INFO - PROCESS | 20173 | Cycle 1(1): loaded http://localhost:42485/tests/v8_7/run.html (next: http://localhost:42485/tests/v8_7/run.html) 19:07:37 INFO - PROCESS | 20173 | RSS: Main: 146386944 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | __start_tp_report 19:07:37 INFO - PROCESS | 20173 | _x_x_mozilla_page_load 19:07:37 INFO - PROCESS | 20173 | _x_x_mozilla_page_load_details 19:07:37 INFO - PROCESS | 20173 | |i|pagename|runs| 19:07:37 INFO - PROCESS | 20173 | |0;Richards;167.36401673640168 19:07:37 INFO - PROCESS | 20173 | |1;DeltaBlue;191.0949742021785 19:07:37 INFO - PROCESS | 20173 | |2;Encrypt;282.4060999717594 19:07:37 INFO - PROCESS | 20173 | |3;Decrypt;5207.253886010362 19:07:37 INFO - PROCESS | 20173 | |4;RayTrace;1091.703056768559 19:07:37 INFO - PROCESS | 20173 | |5;Earley;737.4631268436578 19:07:37 INFO - PROCESS | 20173 | |6;Boyer;12358.024691358025 19:07:37 INFO - PROCESS | 20173 | |7;RegExp;25275 19:07:37 INFO - PROCESS | 20173 | |8;Splay;547.1289274106175 19:07:37 INFO - PROCESS | 20173 | |9;NavierStokes;4916.666666666667 19:07:37 INFO - PROCESS | 20173 | __end_tp_report 19:07:37 INFO - PROCESS | 20173 | __startTimestamp1450926457118__endTimestamp 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | ------- Summary: start ------- 19:07:37 INFO - PROCESS | 20173 | Number of tests: 10 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 167.4 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 191.1 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#2] Encrypt Cycles:1 Average:282.41 Median:282.41 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 282.4 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#3] Decrypt Cycles:1 Average:5207.25 Median:5207.25 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 5207.3 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#4] RayTrace Cycles:1 Average:1091.70 Median:1091.70 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 1091.7 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#5] Earley Cycles:1 Average:737.46 Median:737.46 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 737.5 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 12358.0 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#7] RegExp Cycles:1 Average:25275.00 Median:25275.00 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 25275.0 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#8] Splay Cycles:1 Average:547.13 Median:547.13 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 547.1 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - PROCESS | 20173 | [#9] NavierStokes Cycles:1 Average:4916.67 Median:4916.67 stddev:0.00 (0.0%) 19:07:37 INFO - PROCESS | 20173 | Values: 4916.7 19:07:37 INFO - PROCESS | 20173 | -------- Summary: end -------- 19:07:37 INFO - PROCESS | 20173 | 19:07:37 INFO - TEST-INFO | 20173: exit 0 19:07:37 INFO - TEST-OK | v8_7 | took 39683ms 19:07:37 INFO - SUITE-END | took 1210s 19:07:38 INFO - Completed test suite (00:20:10) 19:07:38 INFO - Working with test: dromaeo_css 19:07:38 INFO - Generating results file: dromaeo_css 19:07:38 INFO - Working with test: kraken 19:07:38 INFO - Generating results file: kraken 19:07:38 INFO - javascript benchmark 19:07:38 INFO - Working with test: v8_7 19:07:38 INFO - Generating results file: v8_7 19:07:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 19:07:38 INFO - process_Request line: dromaeo_css 6880.74 graph.html#tests=[[72,63,43]] 19:07:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:38 INFO - process_Request line: kraken 1534.40 graph.html#tests=[[232,63,43]] 19:07:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:38 INFO - process_Request line: v8_7 21339.64 graph.html#tests=[[230,63,43]] 19:07:38 INFO - RETURN: dromaeo_css: 6880.74 19:07:38 INFO - RETURN: kraken: 1534.40 19:07:38 INFO - RETURN: v8_7: 21339.64 19:07:38 INFO - javascript benchmark 19:07:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3159.8894038708645, 3213.373392188524, 3249.870005199792, 3249.935001299974, 3274.083256688128, 5195.922061169085, 5300.39045509766, 5330.173823057427, 5331.360236771588, 5338.652987555816, 5242.082635538784, 5243.265942768006, 5306.575473962083, 5310.548603368708, 5319.601029922762, 4802.231642937122, 4899.436564795059, 4957.7769000395065, 4966.453690094087, 4992.226204938241, 4811.085893680207, 4863.440704318996, 4920.532549407801, 4921.286413470045, 4971.0, 4719.0, 4755.738434386108, 4840.201366774478, 4853.490383509734, 4923.70457772533, 4848.369711937461, 4854.368932038848, 4872.878178045542, 4904.509549045102, 4908.116539022974, 4817.253325734517, 4824.951750482485, 4826.22780355145, 4847.224444088964, 4848.854534363974, 5032.245163225545, 5032.370953630796, 5104.566111880495, 5139.61452891031, 5187.974060129713, 5669.348024977139, 5672.631278966854, 5695.174199741055, 5699.629524080921, 5711.40030296817, 5726.484616384545, 5743.913841292384, 5748.7987920423, 5749.821286636271, 5754.395788442195, 5183.3002544656365, 5287.259783630295, 5296.788128474856, 5332.093544097513, 5427.674339539641, 5780.971095144498, 5805.216295800013, 5815.331236907809, 5838.824835254949, 5865.266841644794, 5567.638103523258, 5644.802431914945, 5652.265205523256, 5655.575831812548, 5685.630434021776, 5590.0, 5591.245181900473, 5610.410906854721, 5672.893785711829, 5711.771529138871, 5630.0, 5632.098864181711, 5664.291963504562, 5683.0338842396895, 5691.203231547586, 5547.611667183339, 5631.71841407928, 5633.549316054706, 5676.801311954062, 5685.687287199161, 4366.71616344943, 4376.6498680105515, 4393.231184542692, 4407.493138289138, 4459.643228541709, 3937.9803100984886, 3948.0327319806256, 3953.584873588289, 3966.781826999485, 3990.580988996114, 5177.611679124006, 5325.733713314319, 5357.19642053695, 5357.812476563302, 5371.798306985431, 5576.163575463632, 5646.830595082154, 5665.575081868794, 5674.092145256739, 5720.399358067426, 5303.257543943851, 5314.813981510629, 5339.706316152571, 5346.492083252085, 5356.062689029404, 4740.881477963009, 4825.276208568743, 4828.179209534387, 4837.05677392905, 4867.659263851497, 5846.590738648339, 5861.062230043172, 5864.67744274069, 5946.345901950782, 5979.79070732531, 5658.660480371191, 5662.490375866192, 5670.801521946877, 5677.574181936288, 5680.829575112753, 5754.827355179351, 5770.798022069207, 5807.76768929255, 5820.912686309794, 5868.3251426086545, 5449.455054494519, 5494.313210848644, 5561.888762224814, 5640.492355688008, 5667.943320566742, 5696.8006119785605, 5723.3418156912485, 5723.7996670116345, 5725.198472213977, 5728.627639203439, 5564.4991950724625, 5571.4428557143965, 5613.943860561342, 5619.241402410622, 5621.5221706155435, 5422.891542169214, 5460.34475862899, 5568.721563921868, 5622.465865742748, 5656.462636049569, 5458.4814442627885, 5461.726913654381, 5477.178423236546, 5482.369527504388, 5515.200295956984, 5366.221897824872, 5547.611667183259, 5615.298087739033, 5615.354234263112, 5644.774209031757, 5392.406835248198, 5412.404635490172, 5460.34475862899, 5469.2616496772425, 5512.0], "unit": "score", "name": "dojo.html", "value": 5242.131067721439}, {"lowerIsBetter": false, "replicates": [549.1204639223884, 589.1516216648026, 595.0657467775592, 605.2766943502513, 612.4793925163609, 27872.86063569682, 35557.2888542229, 35604.82197589008, 36140.0, 36237.0, 39431.0, 39924.80037599815, 39935.40096898549, 39997.40003899944, 40116.0, 8456.746297611066, 8577.099404562525, 8606.956965215166, 8626.18051285127, 8658.956705216466, 8361.790955226137, 8400.033996090437, 8415.242628163463, 8429.831403371929, 8467.0, 8499.532525711084, 8565.186307300797, 8606.096359882185, 8610.311175105977, 8620.09489003655, 8460.703875364363, 8491.830163396759, 8534.658613655447, 8541.487510749375, 8549.529775862326, 8386.119457457002, 8471.407001509897, 8513.063563008063, 8558.186972237627, 8682.218600325938, 39419.60580394188, 39481.40777888334, 39972.80013599913, 40001.79999100015, 40110.39834402486, 3172.5558421820965, 3346.715529179998, 3374.5275661407422, 3408.301298233856, 3831.1954489556947, 29162.854185728935, 29301.41397172066, 29338.706612934024, 29495.85252073726, 30241.0, 3929.5677475477673, 3944.881653550398, 4024.3158663027357, 4031.173609410064, 4062.7562346259024, 191266.0, 192134.03932980384, 194309.0, 195172.0, 195265.0, 44697.0, 44928.0, 45029.54970450253, 45061.54938450639, 45218.77390613092, 42762.57237427586, 42825.35761963573, 42982.35526467105, 43047.0, 43249.78375108104, 14464.566063018126, 14550.927245363706, 14561.708765824624, 14634.341454634567, 14637.634059148606, 11666.066714662807, 11678.357690327113, 11679.948804607626, 11854.348010859485, 11891.108166887518, 14396.640083997983, 14402.567922962327, 14469.131852088909, 14474.348654310581, 14565.0, 5818.156367326798, 5847.707614619252, 5877.324107727666, 5892.7642894283745, 5916.290045194604, 966.5553845231132, 977.9022097790164, 987.5457289646843, 1028.6039874648166, 1152.3201311226417, 28208.71791282102, 28926.855365723037, 29058.709412906024, 29169.0, 29192.562111568343, 1005.6781829814389, 1022.9693109206736, 1056.1603525197486, 1073.7047311989265, 1174.5654107980101, 13213.669658258428, 13841.930790345983, 14187.219702916233, 14274.0, 14309.0, 290276.0, 294114.0, 294405.0, 296601.0, 298019.0, 53293.46706532963, 53725.731371343674, 53880.73059634755, 53925.460745392826, 54057.72971135119, 1324.0929962975392, 1327.396034804162, 1327.621627836062, 1336.585658445885, 1344.0927374022497, 26866.32834179083, 27114.864425677744, 27607.309817253925, 27689.723102768716, 27699.723002769715, 42403.575964239964, 42767.0, 42912.35631465468, 42995.0, 43036.35445468383, 284461.0, 285714.0, 287273.0, 287313.0, 288694.0, 31766.682333177298, 42663.3600495999, 43140.78429607832, 43408.34887476627, 43469.347959779996, 38798.41802373023, 39478.81563553098, 39485.40771888482, 39522.2095558093, 39919.401208981304, 36796.63203367932, 36866.44700329444, 37403.625963740014, 37553.436698449, 37980.810095949346, 36236.27527449489, 36896.81551592225, 36903.81548092242, 37216.44175337318, 37752.24495510019, 36189.81905090563, 36306.27387452183, 36583.634163658025, 36637.0, 38824.223515530095, 31076.68923310738, 32414.189645258113, 33645.32709345848, 33774.83112584421, 34411.82794086014, 25405.491890161724, 25671.743282566935, 25730.228093157235, 25743.871280643478, 25812.35469113287], "unit": "score", "name": "ext.html", "value": 17604.968517332283}, {"lowerIsBetter": false, "replicates": [356.7074998501228, 361.29727679663034, 362.514230930553, 363.97088232941366, 366.46679081935787, 16152.111633860148, 16894.493165205047, 17480.825191748077, 17708.73436898446, 18072.367467138654, 11215.495302711377, 12310.322932238723, 16113.355465781384, 16149.91925040376, 16199.1090490023, 4438.489573699026, 5445.83662490126, 5455.0, 5502.312210973629, 5502.724863756816, 5441.075017247058, 5479.0959491683825, 5480.287562616854, 5485.561155107582, 5500.202470641754, 5032.396112466509, 5060.13977623803, 5147.0, 5288.867778305535, 5299.28459657947, 5205.6876587404495, 5207.140821764404, 5281.8415447536445, 5290.338707661543, 5422.91865622016, 5259.184826351921, 5291.597726602454, 5306.071437498461, 5313.521783039545, 5345.1714984177515, 12256.509739610405, 12431.93784031074, 19111.61776764457, 19998.300059497993, 20691.689624655643, 2237.7762223777654, 2240.439890027493, 2244.9775502244934, 2296.2881506732965, 2296.4258935266184, 9823.410595364301, 10385.0, 12824.422900969386, 13142.934285328512, 13392.129511581814, 1817.9818201817945, 1918.5491409518752, 1955.4426988308405, 1986.6721990871488, 1992.6911328744068, 51126.0, 53234.73382633062, 53340.73329633366, 53371.0, 54669.45330546723, 10016.148627366756, 10021.198304135653, 10079.143272821746, 10085.0, 10085.949570252102, 12685.873141268654, 12824.422900969479, 12852.550160744517, 12906.741865162645, 12906.870931290567, 7222.927770722331, 7247.891281630779, 7320.487565870338, 7366.963165184247, 7453.888191677129, 6943.444524438033, 7014.263502332284, 7018.75434359795, 7056.400205982446, 7078.619669164464, 4449.710768800018, 4452.732836029849, 4455.710378825366, 4463.866084017484, 4480.977595112004, 1835.651226267005, 1857.322077441724, 1865.1327132883275, 1865.6082222733107, 1882.6611209982334, 420.9873703788891, 428.5992596921888, 434.48947486702997, 454.10314628608234, 470.2006588799055, 10497.527611257512, 10850.67447976562, 11019.283746556448, 11477.540898363972, 11478.483468243949, 446.352788456739, 448.99102017959456, 455.1965780397601, 457.45562780291345, 467.51378566291356, 6008.218931538872, 6274.466670333073, 6302.149209856702, 6341.651209183539, 6359.8092057238355, 521752.0, 522205.0, 524299.0, 533193.0, 538143.0, 74384.62807685927, 76511.61744191243, 76598.0, 77235.61382193165, 77260.0, 481.14836738971826, 487.5904240438049, 491.0179640718563, 491.63864559549415, 491.7172625740142, 10465.372077675363, 10788.352698838095, 13951.790723138958, 14254.643633909236, 14477.782833257721, 34702.30595388129, 34895.82552087223, 35154.64845351514, 35625.82187089048, 35740.749073782295, 42445.36331955085, 43347.566524334354, 44337.77831110824, 44755.776221118685, 44805.0, 9542.141207291377, 9557.61769529211, 9750.512474376395, 9809.509524523603, 9857.260705446977, 16958.32166713367, 17370.305187792346, 17663.38178163758, 17761.11194440247, 18700.532486687396, 12126.575569855013, 13877.79183312231, 14526.346314416089, 15108.169050702318, 15491.922540387226, 13968.720625587635, 14246.572602821518, 14262.215578143301, 14473.421063157777, 14671.119732816065, 11833.82249266279, 14967.0, 15066.397344106113, 15351.155686436907, 15379.76930346068, 9642.71071867817, 9687.128158465772, 9827.329354009693, 10058.94970525172, 10075.596976121165, 14508.564743057725, 14548.41806327735, 14964.102153870803, 15044.924775376054, 15300.540983770505], "unit": "score", "name": "jquery.html", "value": 8044.225387205837}, {"lowerIsBetter": false, "replicates": [1461.5030889497573, 1465.5456808389404, 1604.6790641871628, 1735.06306594439, 1765.6556971390585, 6851.0408542803925, 6915.5850648961095, 7492.850142997137, 7525.397968162548, 7623.542587444757, 7257.564546127236, 7295.817604559876, 7309.488335816495, 7369.926300736991, 7404.592747398904, 2184.552166805805, 2210.347947355526, 2215.4904371994453, 2217.800397964183, 2220.0897631970897, 2183.29043061005, 2194.692743015979, 2273.885795959984, 2281.155972290255, 2281.5779080870093, 2201.361605134509, 2226.0984301357976, 2249.5838269920037, 2266.9319920402413, 2274.329072923483, 2209.8784566848817, 2220.844540882139, 2233.9106435742633, 2249.280230326296, 2259.9887000565054, 2239.7536271010176, 2265.9320220393415, 2267.818574514035, 2270.28486026901, 2276.4422716434415, 7521.097468303784, 7532.058492688414, 7537.321641052332, 7573.886391704129, 7584.393248540104, 4582.587567118942, 4615.723056616614, 4646.721196728207, 4653.302004699289, 4658.604018658418, 2917.5331946888396, 2956.52695568708, 2998.745106665936, 3003.2041509000132, 3015.9095227143002, 961.8893827209821, 973.7468258252834, 980.0, 1000.5947591225492, 1013.5135135135176, 9931.801363972752, 10026.498675066217, 10061.195104391705, 10103.242256830767, 10141.89858101417, 4147.502299723992, 4187.958120418818, 4223.598758117974, 4243.766592837362, 4267.295896177096, 8655.6970506032, 8676.566171691391, 8698.173673501007, 8702.82594348122, 8704.434211776213, 4673.205555055649, 4680.485146633868, 4682.648801339913, 4704.976475117603, 4708.741019243906, 3794.3739283017994, 3875.70932180082, 4174.31123864559, 4226.788660566959, 4281.293586558245, 3522.788632681996, 3568.803715795656, 3575.606683264839, 3587.3542762303036, 3594.4428613564937, 1134.325076579434, 1140.560884059643, 1146.1747541769912, 1159.1016961854461, 1161.651504548632, 1070.47011729193, 1074.887136850635, 1089.477051015501, 1204.3195594489262, 1326.840779106494, 7105.005299258108, 7315.597642129627, 7332.120145582564, 7366.815829604303, 7395.445341599401, 1022.8312328465869, 1035.249444152983, 1045.4981608827804, 1119.2668801934747, 1141.8572678415198, 5568.053430916673, 5578.832635020955, 5588.776448942078, 5601.551875849922, 5645.125005624135, 8673.566321683891, 8963.924329080552, 9051.0, 9098.86351704725, 9121.90878091224, 9078.45529268246, 9081.636734530677, 9122.635094596275, 9165.404248723811, 9211.861822072675, 7266.890996635055, 7285.927140728631, 7314.926850731425, 7362.815929601696, 7367.336939675455, 7131.500794944304, 7140.250273721184, 7150.177729561167, 7167.677454514455, 7173.497855150089, 8034.879476807736, 8185.30424913889, 8512.0, 8523.062463128927, 8547.059823419544, 8344.37417193725, 8403.663853445794, 8429.747107586782, 8506.872396913928, 8560.743177704679, 6421.389967953037, 6596.736130554724, 7170.0, 7221.855562888818, 7281.089863767029, 7408.703651853865, 7409.8147546311775, 7457.2542745724995, 7460.104787425544, 7470.365018973448, 6735.0, 6791.966040169767, 6837.3162683731225, 6914.792556223321, 6995.475339349671, 6786.321367863175, 6787.049813026081, 6883.518153729191, 6906.758263460755, 6982.057422247932, 6960.79117626472, 7034.155901291878, 7035.366816986496, 7044.471664625071, 7118.572885626879, 6362.586431881913, 6461.8061458156335, 6463.709133088928, 6478.255000674794, 6483.870322593616, 6511.446527045065, 6515.478761699147, 6532.0, 6547.541672082908, 6577.671116444063], "unit": "score", "name": "mootools.html", "value": 4409.876721751392}, {"lowerIsBetter": false, "replicates": [342.10539439366056, 348.83779042745135, 350.561797752809, 351.3763070549775, 353.1048791314018, 6256.562040657156, 6256.937430625692, 6294.213223347082, 6355.110284560154, 6496.480281577475, 6272.3100458949475, 6327.367263273682, 6347.523935704818, 6348.809535713936, 6349.841253968653, 4805.423349198101, 4807.6153907687385, 4824.252240902666, 4824.517548245182, 4825.855224343275, 4810.927836082444, 4819.807207711705, 4838.0, 4839.758012099399, 4853.320535125085, 4679.9298010529865, 4752.952470475303, 4766.976165119169, 4784.736839473828, 4795.904081918359, 4757.09615173116, 4764.642651801111, 4767.237242041291, 4781.0, 4799.976000120012, 4116.320807066831, 4122.91754164918, 4124.443200167999, 4129.132882094764, 4161.126163505667, 5962.25471816023, 5971.313298970587, 5988.670623115727, 6004.0, 6016.699165041774, 5347.491988261109, 5500.889982200333, 5539.058360078796, 5544.362398324163, 5554.666719996813, 6699.665016749143, 6702.36327548882, 6711.161104861892, 6713.966430167818, 6719.865602687919, 4515.458145022585, 4520.412346394981, 4526.1626599078945, 4530.343100250445, 4530.524294949048, 6803.795886123424, 6889.483288753313, 6913.308669133096, 6969.30306969299, 6998.545094568888, 4675.7895894684825, 4704.1062198182235, 4709.717416954925, 4710.105080034782, 4710.952890471051, 4741.336212930192, 4763.333133361332, 4767.0, 4773.64197685175, 4790.568848803624, 5501.037318469332, 5528.281323428009, 5542.307211598551, 5542.473465020817, 5545.7781688732, 6490.837729056717, 6584.539082264291, 6642.63465509392, 6666.333366663392, 6673.4661227101715, 1612.5565469495748, 1641.499342700464, 1663.96672066558, 1665.0342801175289, 1669.090345761563, 1103.0, 1104.5913012185542, 1132.9773404531863, 1137.0335215067291, 1144.7481554058095, 6312.558120931582, 6323.715432805535, 6348.809535713936, 6357.809265722036, 6377.139086223393, 6732.932670673328, 6777.695003724844, 6822.897656535156, 6836.965815170893, 6849.828754281083, 6154.138420621117, 6294.0, 6323.083152942798, 6341.143945567382, 6365.331640177715, 3705.9073523161596, 3715.535558055243, 3717.423799311111, 3738.140227747633, 3749.531308586427, 7048.577085374894, 7136.678849451683, 7139.571625702474, 7155.964220178866, 7175.641217939082, 6962.303769622998, 6969.16370035599, 6981.5461994970165, 7011.89482157768, 7043.049188359609, 7284.271572842779, 7302.415806735448, 7333.669984850694, 7339.192688804227, 7352.705891764376, 6976.7558135465015, 6988.336108069725, 7005.369516743517, 7017.824554386181, 7040.542364746275, 6814.897776533455, 6907.171139463297, 6918.411934985583, 6929.0, 6958.512904096867, 7299.05112335393, 7305.963470182615, 7323.048003759477, 7342.339189472973, 7438.070241219848, 4701.824543864034, 4749.572538471554, 4753.310769938409, 4756.738379389167, 4774.928376074431, 6901.861962760616, 6980.092587963735, 7033.9296607033275, 7041.295870412918, 7047.189573199148, 6716.865662686621, 6729.831754205989, 6767.458603311625, 6787.083743694538, 6791.04925310447, 6645.401913827779, 6693.598384096969, 6733.461323094239, 6748.898766518408, 6800.727970881109, 6442.0, 6631.3700198481065, 6639.3692599203, 6645.501587380869, 6655.500837437115, 6755.763548275787, 6770.0, 6774.898376524257, 6790.456763458813, 6810.353016463428, 6560.9343906562235, 6600.438962688226, 6606.8017959461295, 6611.438027767694, 6615.834604134935], "unit": "score", "name": "prototype.html", "value": 5036.3015619642265}, {"lowerIsBetter": false, "replicates": [735.3896266099136, 841.7600983719633, 849.8682704180854, 868.9478631282127, 894.1326912894492, 13350.732985340288, 13520.188788672662, 13526.053176277665, 13559.661008474794, 13654.658633534154, 12789.872101278985, 12794.23234605922, 12802.423890924907, 12870.678233044155, 12946.74106517869, 678.4470656415031, 694.2536772969053, 813.2639960835423, 831.995840020799, 832.8792325112855, 823.9876401853977, 840.7603832907622, 840.9663613455455, 841.0160112668193, 842.8525008123585, 870.8084221471298, 874.2394117118116, 880.3089574683875, 881.497546398553, 884.9734507964739, 863.568215892054, 867.8871746672955, 871.3726117195672, 872.6771094694972, 875.8073223890734, 637.3881074168758, 638.3807706524664, 639.5203597302024, 640.702073535808, 644.8323435906698, 12903.419346129353, 13086.672833179151, 13198.14212076212, 13227.0, 13267.469301227939, 11957.820632690517, 12084.939575302154, 12307.507699692002, 12815.423305951255, 13369.799453008212, 10372.118369938564, 10468.842967355497, 10524.579181810434, 10599.788004239872, 10643.042126208678, 3369.427197376452, 3375.122468158272, 3378.5438965739554, 3406.5401170842115, 3466.878659246914, 43275.78362108201, 43711.0, 43921.78039109816, 43956.340654890206, 44131.338029929895, 9291.21024712907, 9346.252299815998, 9383.108604682544, 9470.147686708091, 9474.90525094754, 17623.735643965352, 17679.0, 17697.292108315523, 17745.556361091076, 17784.199711013036, 7497.250274972459, 7513.2111128331835, 7591.8861217080685, 7647.961760191163, 7714.421418393531, 4561.110583436198, 4561.7262964222255, 4590.632749380042, 4631.328457373729, 4735.313379559944, 3132.7180553750272, 3172.762042846796, 3178.030700636282, 3181.5704879841387, 3184.2198661328125, 580.2196046317696, 582.9271341082365, 585.3297973819953, 598.7694737525997, 606.7087797857054, 645.3707635055783, 684.3122661724934, 685.9588424694534, 692.8787462194197, 711.2283172757512, 8676.349273804364, 9198.540072996324, 9242.953785231031, 9311.115444032941, 9459.38513996588, 524.7061645478544, 546.8317379954124, 699.4893727578794, 713.9750108746169, 732.7618523979728, 4026.859059932947, 4364.934525982113, 4411.139827733626, 4490.124425737015, 4551.112533056088, 59192.0, 60764.39235607676, 60777.0, 60950.39049609536, 61099.69450152721, 54121.45878541164, 54218.728906356, 54820.72589637106, 55085.72457137769, 55134.448655513734, 48231.75884120557, 48643.5135648639, 48995.510044899806, 49527.0, 49832.50167498351, 9071.0, 9091.863622045543, 9184.540772961458, 9219.953900230455, 9447.574859131219, 35430.29139417249, 35697.28605427929, 35903.46144807882, 36200.27599447944, 36823.44764828583, 43141.56858431501, 44967.7751611253, 47492.28761568648, 47825.0, 47838.0, 10973.670789876316, 11110.44447777624, 11184.496697648789, 11250.66248012561, 11357.829632555684, 11748.236364636272, 11785.292882427082, 11807.350595717318, 11809.704757381134, 11831.11266654987, 11857.940710296394, 11863.58477453285, 11864.347460889734, 11929.403529823301, 12141.817872731739, 11818.586349477728, 12014.519419223134, 12104.576339828063, 12135.453904574139, 12151.453184606891, 11585.768284634429, 11615.0, 11683.357415342238, 11718.88281117178, 11743.941280293544, 9934.900650993397, 10312.175025998053, 10345.534450949575, 10480.68557943263, 10533.42066186367, 9580.616775329188, 9745.951270243604, 9772.315937884565, 10022.298439109192, 10171.847422288523], "unit": "score", "name": "yui.html", "value": 6435.888686900647}], "name": "dromaeo_css", "value": 6880.735134961964}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 114.0, 112.0, 112.0, 125.0, 113.0, 111.0, 117.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [149.0, 129.0, 156.0, 165.0, 128.0, 155.0, 164.0, 128.0, 180.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 164.0, 162.0, 161.0, 174.0, 176.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 74.0, 75.0, 76.0, 73.0, 149.0, 74.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 96.0, 97.0, 96.0, 139.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 109.0, 110.0, 112.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 153.0, 147.0, 150.0, 148.0, 146.0, 147.0, 146.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 98.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 60.0, 60.0, 69.0, 58.0, 60.0, 59.0, 59.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [88.0, 94.0, 88.0, 87.0, 87.0, 93.0, 97.0, 86.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [124.0, 124.0, 124.0, 125.0, 127.0, 131.0, 117.0, 121.0, 116.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [152.0, 152.0, 148.0, 147.0, 156.0, 145.0, 156.0, 150.0, 163.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1534.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [282.4060999717594], "unit": "score", "name": "Encrypt", "value": 942.5469209999999}, {"lowerIsBetter": false, "replicates": [5207.253886010362], "unit": "score", "name": "Decrypt", "value": 51.11734626865668}, {"lowerIsBetter": false, "replicates": [1091.703056768559], "unit": "score", "name": "RayTrace", "value": 677.8299240000001}, {"lowerIsBetter": false, "replicates": [737.4631268436578], "unit": "score", "name": "Earley", "value": 903.7238279999999}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [25275.0], "unit": "score", "name": "RegExp", "value": 36.042927794263136}, {"lowerIsBetter": false, "replicates": [547.1289274106175], "unit": "score", "name": "Splay", "value": 148.9429564356435}, {"lowerIsBetter": false, "replicates": [4916.666666666667], "unit": "score", "name": "NavierStokes", "value": 301.83050847457605}], "name": "v8_7", "value": 21339.641426639046}]} 19:07:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21339.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1534.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6880.74"}}} 19:07:38 INFO - Return code: 0 19:07:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:07:38 INFO - # TBPL SUCCESS # 19:07:38 INFO - Running post-action listener: _resource_record_post_action 19:07:38 INFO - Running post-run listener: _resource_record_post_run 19:07:39 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 12288; Write bytes: 558497792; Read time: 136; Write time: 361524 19:07:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 235208704; Read time: 116; Write time: 198016 19:07:39 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323289088; Read time: 20; Write time: 163508 19:07:39 INFO - Running post-run listener: _upload_blobber_files 19:07:39 INFO - Blob upload gear active. 19:07:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:07:39 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:07:39 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'] 19:07:39 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 19:07:39 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:07:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:07:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:40 INFO - (blobuploader) - INFO - Done attempting. 19:07:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:07:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:07:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:41 INFO - (blobuploader) - INFO - Done attempting. 19:07:41 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:41 INFO - Return code: 0 19:07:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:07:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f70674ed83530807859a2f1e12cace5c05973408e5f8e17d1e379d1621b7f38a1b9a5e5ddb857fd8cd282e412e18d3f86ac49184522f71f0e6048e82cc861155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c94d2e8387e36ca7d3f041c96a9463d36a9239d035d94fcf0fed93afa07ed7d48186701b83ccf17749aab97c22cd2a987e6816afc569944160b814dae95c96c6"} 19:07:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:07:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:07:41 INFO - Contents: 19:07:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f70674ed83530807859a2f1e12cace5c05973408e5f8e17d1e379d1621b7f38a1b9a5e5ddb857fd8cd282e412e18d3f86ac49184522f71f0e6048e82cc861155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c94d2e8387e36ca7d3f041c96a9463d36a9239d035d94fcf0fed93afa07ed7d48186701b83ccf17749aab97c22cd2a987e6816afc569944160b814dae95c96c6"} 19:07:41 INFO - Copying logs to upload dir... 19:07:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.198121 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-23 19:07:41.513339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 19:07:41.516444) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 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/f70674ed83530807859a2f1e12cace5c05973408e5f8e17d1e379d1621b7f38a1b9a5e5ddb857fd8cd282e412e18d3f86ac49184522f71f0e6048e82cc861155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c94d2e8387e36ca7d3f041c96a9463d36a9239d035d94fcf0fed93afa07ed7d48186701b83ccf17749aab97c22cd2a987e6816afc569944160b814dae95c96c6"} build_url:https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/Ti3dDEl2TceDwPpJnLGTAA/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/f70674ed83530807859a2f1e12cace5c05973408e5f8e17d1e379d1621b7f38a1b9a5e5ddb857fd8cd282e412e18d3f86ac49184522f71f0e6048e82cc861155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c94d2e8387e36ca7d3f041c96a9463d36a9239d035d94fcf0fed93afa07ed7d48186701b83ccf17749aab97c22cd2a987e6816afc569944160b814dae95c96c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 19:07:41.541710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:07:41.542063) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450924731.166689-2090423981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:07:41.625025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 19:07:41.625348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 19:07:41.625690) ========= ========= Total master_lag: 0.29 =========